[63.892997] Initializing watchdogs
[63.893059]   /dev/watchdog0
[63.907670] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[63.912238] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.914476] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.917926] [001/133] (960s left) kms_flip (wf_vblank-ts-check)
[64.037016] Starting subtest: wf_vblank-ts-check
[64.039565] Starting dynamic subtest: A-eDP1
[73.038077] Dynamic subtest A-eDP1: SUCCESS (8.960s)
[73.045606] Starting dynamic subtest: B-eDP1
[81.975322] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[81.987751] Starting dynamic subtest: C-eDP1
[90.902184] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[90.914523] Starting dynamic subtest: D-eDP1
[99.828816] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[99.831239] Subtest wf_vblank-ts-check: SUCCESS (35.739s)
[101.025137] [002/133] (923s left) kms_cursor_crc (cursor-onscreen-256x256)
[101.272793] Starting subtest: cursor-onscreen-256x256
[101.286053] Starting dynamic subtest: pipe-A-eDP-1
[103.418877] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.133s)
[103.445470] Starting dynamic subtest: pipe-D-eDP-1
[106.182990] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.742s)
[106.185461] Subtest cursor-onscreen-256x256: SUCCESS (4.911s)
[106.994884] [003/133] (917s left) gem_mmap_gtt (big-copy-odd)
[107.051165] Subtest big-copy-odd: SKIP (0.000s)
[107.110061] [004/133] (917s left) i915_pm_rpm (sysfs-read)
[109.048532] Starting subtest: sysfs-read
[110.196587] Subtest sysfs-read: SUCCESS (1.148s)
[110.570205] [005/133] (914s left) kms_universal_plane (disable-primary-vs-flip)
[110.671304] Starting subtest: disable-primary-vs-flip
[110.673559] Starting dynamic subtest: pipe-A-eDP-1
[112.249848] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.580s)
[112.258978] Starting dynamic subtest: pipe-B-eDP-1
[114.502300] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.251s)
[114.511533] Starting dynamic subtest: pipe-C-eDP-1
[116.668281] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.164s)
[116.676887] Starting dynamic subtest: pipe-D-eDP-1
[118.861642] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.194s)
[118.864075] Subtest disable-primary-vs-flip: SUCCESS (8.192s)
[119.657756] [006/133] (904s left) perf (gen12-group-exclusive-stream-ctx-handle)
[119.793275] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[119.820804] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[119.884583] [007/133] (904s left) kms_flip_event_leak (basic)
[120.928195] Starting subtest: basic
[120.930190] Starting dynamic subtest: pipe-A-eDP-1
[121.369060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[121.377396] Starting dynamic subtest: pipe-B-eDP-1
[122.483455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[122.491868] Starting dynamic subtest: pipe-C-eDP-1
[123.588458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[123.597078] Starting dynamic subtest: pipe-D-eDP-1
[124.713087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[124.715387] Subtest basic: SUCCESS (3.785s)
[125.590969] [008/133] (899s left) gem_exec_fence (syncobj-wait)
[126.050773] Starting subtest: syncobj-wait
[127.914364] Subtest syncobj-wait: SUCCESS (1.862s)
[128.265118] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[128.267945] [009/133] (896s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[128.374641] Starting subtest: primary-y-tiled-reflect-x-90
[128.379122] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[128.450646] [010/133] (896s left) kms_psr (fbc-psr-no-drrs)
[128.548978] Starting subtest: fbc-psr-no-drrs
[128.550922] Starting dynamic subtest: eDP-1
[128.554957] Dynamic subtest eDP-1: SKIP (0.000s)
[128.559742] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[128.619274] [011/133] (896s left) kms_chamelium_edid (hdmi-mode-timings)
[129.007824] Subtest hdmi-mode-timings: SKIP (0.000s)
[129.794969] [012/133] (895s left) gem_exec_flush (basic-wb-ro-before-default)
[129.856076] Starting subtest: basic-wb-ro-before-default
[135.339842] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[135.499661] [013/133] (889s left) gem_ccs (block-multicopy-inplace)
[135.565712] Starting subtest: block-multicopy-inplace
[135.570334] Subtest block-multicopy-inplace: SKIP (0.000s)
[135.663470] [014/133] (889s left) kms_invalid_mode (clock-too-high)
[135.758783] Starting subtest: clock-too-high
[135.761050] Starting dynamic subtest: pipe-A-eDP-1
[135.765438] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[135.773261] Starting dynamic subtest: pipe-B-eDP-1
[135.777275] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[135.785100] Starting dynamic subtest: pipe-C-eDP-1
[135.789533] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[135.800129] Starting dynamic subtest: pipe-D-eDP-1
[135.804541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[135.808957] Subtest clock-too-high: SKIP (0.003s)
[135.847893] [015/133] (889s left) perf (invalid-remove-userspace-config)
[135.940539] Starting subtest: invalid-remove-userspace-config
[135.949796] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[135.993691] [016/133] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[136.096595] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[136.101059] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[136.219086] [017/133] (888s left) gem_pxp (hw-rejects-pxp-buffer)
[136.332559] Starting subtest: hw-rejects-pxp-buffer
[136.336263] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[136.432630] [018/133] (888s left) vgem_basic (dmabuf-fence)
[136.477233] Starting subtest: dmabuf-fence
[136.478990] Subtest dmabuf-fence: SUCCESS (0.000s)
[136.530825] [019/133] (888s left) core_getclient (basic)
[136.578885] Starting subtest: basic
[136.580787] Subtest basic: SUCCESS (0.000s)
[136.694846] [020/133] (888s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[136.793708] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[136.797674] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[136.896267] [021/133] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[136.988078] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[136.990103] Starting dynamic subtest: pipe-A-default-mode
[139.764830] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[139.766872] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.775s)
[140.601664] [022/133] (884s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[140.661108] Starting subtest: invalid-signal-one-illegal-handle
[140.663558] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[140.769244] [023/133] (884s left) kms_getfb (getfb-handle-not-fb)
[140.860808] Starting subtest: getfb-handle-not-fb
[140.863083] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[140.969861] [024/133] (884s left) kms_color (invalid-ctm-matrix-sizes)
[141.052987] Starting subtest: invalid-ctm-matrix-sizes
[141.055256] Starting dynamic subtest: pipe-A
[141.057551] Dynamic subtest pipe-A: SUCCESS (0.002s)
[141.066253] Starting dynamic subtest: pipe-B
[141.068138] Dynamic subtest pipe-B: SUCCESS (0.003s)
[141.075291] Starting dynamic subtest: pipe-C
[141.077553] Dynamic subtest pipe-C: SUCCESS (0.004s)
[141.084920] Starting dynamic subtest: pipe-D
[141.087116] Dynamic subtest pipe-D: SUCCESS (0.004s)
[141.089314] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s)
[141.134425] [025/133] (884s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[141.222806] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[141.225044] Starting dynamic subtest: pipe-A-eDP-1
[143.484272] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.263s)
[143.492464] Starting dynamic subtest: pipe-B-eDP-1
[145.989123] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.503s)
[145.996621] Starting dynamic subtest: pipe-C-eDP-1
[148.198034] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.209s)
[148.206638] Starting dynamic subtest: pipe-D-eDP-1
[150.403233] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.204s)
[150.405196] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (9.182s)
[151.559289] [026/133] (873s left) i915_drm_fdinfo (memory-info-resident)
[151.609900] Starting subtest: memory-info-resident
[151.612386] Starting dynamic subtest: smem0
[154.137829] Dynamic subtest smem0: SUCCESS (2.530s)
[154.140023] Subtest memory-info-resident: SUCCESS (2.531s)
[154.218957] [027/133] (871s left) gem_pipe_control_store_loop (reused-buffer)
[154.278681] Starting subtest: reused-buffer
[156.494550] Subtest reused-buffer: SUCCESS (2.154s)
[156.552031] [028/133] (868s left) device_reset (unbind-reset-rebind)
[156.608860] Starting subtest: unbind-reset-rebind
[161.222459] Subtest unbind-reset-rebind: SUCCESS (4.586s)
[161.289765] [029/133] (864s left) kms_content_protection (lic-type-1)
[161.427496] Starting subtest: lic-type-1
[161.431948] Subtest lic-type-1: SKIP (0.000s)
[161.542106] [030/133] (864s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[161.646274] Starting subtest: 4-tiled-8bpp-rotate-90
[161.681724] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.035s)
[161.804909] [031/133] (863s left) kms_rotation_crc (primary-rotation-270)
[161.911244] Starting subtest: primary-rotation-270
[161.915376] Subtest primary-rotation-270: SKIP (0.001s)
[161.982964] [032/133] (863s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[164.031571] Starting subtest: modeset-non-lpsp-stress-no-wait
[164.072206] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.042s)
[164.408983] [033/133] (861s left) kms_async_flips (async-flip-hang)
[164.515722] Starting subtest: async-flip-hang
[164.888403] Starting dynamic subtest: pipe-A-eDP-1
[191.355806] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.455s)
[191.726597] Starting dynamic subtest: pipe-B-eDP-1
[207.407075] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.684s)
[207.801974] Starting dynamic subtest: pipe-C-eDP-1
[223.349511] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.543s)
[223.716798] Starting dynamic subtest: pipe-D-eDP-1
[239.350061] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.627s)
[239.353565] Subtest async-flip-hang: SUCCESS (74.820s)
[240.582056] [034/133] (785s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[240.706502] Starting subtest: cursorB-vs-flipB-legacy
[240.711009] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[240.852148] [035/133] (784s left) kms_lease (master-vs-lease)
[240.936138] Starting subtest: master-vs-lease
[240.938338] Subtest master-vs-lease: SUCCESS (0.001s)
[241.048555] [036/133] (784s left) kms_plane_multiple (tiling-y)
[241.138146] Starting subtest: tiling-y
[241.142222] Subtest tiling-y: SKIP (0.000s)
[241.208925] [037/133] (784s left) i915_hangman (engine-engine-hang)
[241.281319] Starting subtest: engine-engine-hang
[241.283162] Starting dynamic subtest: rcs0
[242.868711] Dynamic subtest rcs0: SUCCESS (1.587s)
[242.879386] Starting dynamic subtest: bcs0
[244.852505] Dynamic subtest bcs0: SUCCESS (1.981s)
[244.863069] Starting dynamic subtest: vcs0
[246.899226] Dynamic subtest vcs0: SUCCESS (2.044s)
[246.919879] Starting dynamic subtest: vcs1
[248.819052] Dynamic subtest vcs1: SUCCESS (1.917s)
[248.830151] Starting dynamic subtest: vecs0
[249.907486] Dynamic subtest vecs0: SUCCESS (1.085s)
[249.919056] Starting dynamic subtest: ccs0
[251.891049] Dynamic subtest ccs0: SUCCESS (1.981s)
[251.893594] Subtest engine-engine-hang: SUCCESS (10.611s)
[251.983814] [038/133] (773s left) gem_media_fill (media-fill)
[252.058044] Subtest media-fill: SKIP (0.000s)
[252.177248] [039/133] (773s left) kms_flip (2x-busy-flip)
[252.273273] Starting subtest: 2x-busy-flip
[252.281988] Subtest 2x-busy-flip: SKIP (0.011s)
[252.367461] [040/133] (773s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[252.465466] Starting subtest: yf-tiled-16bpp-rotate-90
[252.469511] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[252.547969] [041/133] (773s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[252.934476] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[253.776537] [042/133] (772s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[254.331578] Starting subtest: syncobj-timeline-invalid-wait
[254.337027] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[255.984875] [043/133] (770s left) gem_workarounds (basic-read)
[256.051209] Starting subtest: basic-read
[256.061081] Subtest basic-read: SUCCESS (0.013s)
[256.154593] [044/133] (770s left) syncobj_eventfd (invalid-illegal-eventfd)
[256.200709] Starting subtest: invalid-illegal-eventfd
[256.202807] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[256.308035] [045/133] (769s left) kms_plane_alpha_blend (alpha-7efc)
[256.411279] Starting subtest: alpha-7efc
[256.707533] Starting dynamic subtest: pipe-A-eDP-1
[257.334949] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[257.360085] Starting dynamic subtest: pipe-D-eDP-1
[258.629246] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.273s)
[258.631424] Subtest alpha-7efc: SUCCESS (2.215s)
[259.482842] [046/133] (766s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[259.574765] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[266.383910] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.812s)
[266.532556] [047/133] (759s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[266.626151] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[266.628401] Starting dynamic subtest: pipe-A-eDP-1
[266.684037] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[266.692271] Starting dynamic subtest: pipe-B-eDP-1
[266.746426] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[266.754606] Starting dynamic subtest: pipe-C-eDP-1
[266.808052] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[266.816228] Starting dynamic subtest: pipe-D-eDP-1
[266.870336] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[266.874664] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s)
[268.962950] [048/133] (757s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[269.049772] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[269.052134] Starting dynamic subtest: A-eDP1
[272.698056] Dynamic subtest A-eDP1: SUCCESS (3.645s)
[272.706892] Starting dynamic subtest: B-eDP1
[275.892631] Dynamic subtest B-eDP1: SUCCESS (3.192s)
[275.901108] Starting dynamic subtest: C-eDP1
[279.096903] Dynamic subtest C-eDP1: SUCCESS (3.205s)
[279.108565] Starting dynamic subtest: D-eDP1
[282.215077] Dynamic subtest D-eDP1: SUCCESS (3.118s)
[282.217434] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.168s)
[283.038562] [049/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[283.129221] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[283.133108] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[283.223790] [050/133] (743s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[283.327035] Starting subtest: fb-8bpc-vs-panel-8bpc
[283.329326] Starting dynamic subtest: pipe-A-eDP-1
[284.717585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.388s)
[284.719771] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.389s)
[285.589601] [051/133] (740s left) gem_pxp (fail-invalid-protected-context)
[285.721676] Starting subtest: fail-invalid-protected-context
[285.724292] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[285.854725] [052/133] (740s left) kms_force_connector_basic (prune-stale-modes)
[285.936616] Starting subtest: prune-stale-modes
[286.377467] Subtest prune-stale-modes: SUCCESS (0.443s)
[286.513970] [053/133] (740s left) gem_render_copy_redux (interruptible)
[286.566303] Starting subtest: interruptible
[286.832802] Subtest interruptible: SUCCESS (0.269s)
[286.940495] [054/133] (739s left) perf_pmu (faulting-read)
[286.977403] Starting subtest: faulting-read
[286.979499] Starting dynamic subtest: wb
[286.981519] Dynamic subtest wb: SUCCESS (0.001s)
[286.990801] Starting dynamic subtest: wc
[286.992898] Dynamic subtest wc: SUCCESS (0.000s)
[287.001449] Starting dynamic subtest: uc
[287.003290] Dynamic subtest uc: SUCCESS (0.000s)
[287.005058] Subtest faulting-read: SUCCESS (0.004s)
[287.097132] [055/133] (739s left) gem_ctx_isolation (clean)
[287.157567] Starting subtest: clean
[287.159658] Starting dynamic subtest: rcs0
[287.199705] Dynamic subtest rcs0: SUCCESS (0.042s)
[287.208673] Starting dynamic subtest: bcs0
[287.276104] Dynamic subtest bcs0: SUCCESS (0.075s)
[287.286216] Starting dynamic subtest: vcs0
[287.342690] Dynamic subtest vcs0: SUCCESS (0.065s)
[287.352586] Starting dynamic subtest: vcs1
[288.934116] Dynamic subtest vcs1: SUCCESS (1.590s)
[288.945356] Starting dynamic subtest: vecs0
[290.920507] Dynamic subtest vecs0: SUCCESS (1.985s)
[290.930694] Starting dynamic subtest: ccs0
[292.910316] Dynamic subtest ccs0: SUCCESS (1.989s)
[292.912737] Subtest clean: SUCCESS (5.753s)
[293.143451] [056/133] (733s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[293.267158] Starting subtest: flip-vs-cursor-busy-crc-atomic
[294.081869] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.811s)
[294.916910] [057/133] (731s left) gem_mmap_gtt (isolation)
[294.974433] Subtest isolation: SKIP (0.000s)
[295.030865] [058/133] (731s left) prime_busy (hang)
[295.082699] Starting subtest: hang
[295.085053] Starting dynamic subtest: rcs0
[321.462704] Dynamic subtest rcs0: SUCCESS (26.365s)
[321.474080] Starting dynamic subtest: bcs0
[328.547278] Dynamic subtest bcs0: SUCCESS (7.092s)
[328.557771] Starting dynamic subtest: vcs0
[335.582919] Dynamic subtest vcs0: SUCCESS (7.037s)
[335.594057] Starting dynamic subtest: vcs1
[342.564273] Dynamic subtest vcs1: SUCCESS (6.977s)
[342.574766] Starting dynamic subtest: vecs0
[349.545758] Dynamic subtest vecs0: SUCCESS (6.969s)
[349.556290] Starting dynamic subtest: ccs0
[363.442532] Dynamic subtest ccs0: SUCCESS (13.908s)
[363.444718] Subtest hang: SUCCESS (68.355s)
[363.560722] [059/133] (663s left) kms_cursor_crc (cursor-sliding-512x512)
[363.849579] Starting subtest: cursor-sliding-512x512
[363.854025] Subtest cursor-sliding-512x512: SKIP (0.001s)
[363.999591] [060/133] (662s left) gem_exec_balancer (sequential)
[364.059085] Starting subtest: sequential
[367.147807] Subtest sequential: SUCCESS (3.088s)
[367.468103] [061/133] (659s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[367.570061] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[374.605011] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.037s)
[374.729574] [062/133] (652s left) gem_softpin (full)
[374.797771] Starting subtest: full
[374.809758] Subtest full: SUCCESS (0.012s)
[374.941856] [063/133] (652s left) kms_psr (pr-sprite-plane-move)
[375.040958] Starting subtest: pr-sprite-plane-move
[375.045240] Subtest pr-sprite-plane-move: SKIP (0.000s)
[375.116437] [064/133] (651s left) gem_ctx_shared (q-in-order)
[375.168094] Starting subtest: Q-in-order
[375.170501] Starting dynamic subtest: rcs0
[375.264256] Dynamic subtest rcs0: SUCCESS (0.095s)
[375.280148] Starting dynamic subtest: vcs0
[375.354082] Dynamic subtest vcs0: SUCCESS (0.089s)
[375.369299] Starting dynamic subtest: vcs1
[375.434234] Dynamic subtest vcs1: SUCCESS (0.078s)
[375.453538] Starting dynamic subtest: vecs0
[375.508843] Dynamic subtest vecs0: SUCCESS (0.073s)
[375.525321] Starting dynamic subtest: ccs0
[375.589022] Dynamic subtest ccs0: SUCCESS (0.080s)
[375.591292] Subtest Q-in-order: SUCCESS (0.421s)
[377.014658] [065/133] (650s left) kms_chamelium_audio (hdmi-audio)
[377.393256] Subtest hdmi-audio: SKIP (0.000s)
[378.195739] [066/133] (648s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[378.258043] Starting subtest: single-wait-all-for-submit-available-submitted
[378.260431] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[378.351292] [067/133] (648s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[378.661608] Starting subtest: cursor-rapid-movement-512x170
[378.665965] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[378.796359] [068/133] (648s left) kms_big_fb (linear-64bpp-rotate-270)
[378.898320] Starting subtest: linear-64bpp-rotate-270
[378.917550] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[379.022943] [069/133] (648s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[379.139290] Starting subtest: flip-vs-cursor-atomic
[386.251949] Subtest flip-vs-cursor-atomic: SUCCESS (7.111s)
[387.117202] [070/133] (640s left) gem_exec_schedule (semaphore-power)
[387.305606] Subtest semaphore-power: SKIP (0.000s)
[387.482115] [071/133] (639s left) gem_ctx_persistence (legacy-engines-hang)
[387.546031] Starting subtest: legacy-engines-hang
[387.548360] Starting dynamic subtest: render
[387.661835] Dynamic subtest render: SUCCESS (0.115s)
[387.673814] Starting dynamic subtest: bsd1
[387.752017] Dynamic subtest bsd1: SUCCESS (0.087s)
[387.766438] Starting dynamic subtest: bsd2
[387.839987] Dynamic subtest bsd2: SUCCESS (0.085s)
[387.851340] Starting dynamic subtest: blt
[387.912774] Dynamic subtest blt: SUCCESS (0.070s)
[387.922978] Starting dynamic subtest: vebox
[388.030820] Dynamic subtest vebox: SUCCESS (0.115s)
[388.033943] Subtest legacy-engines-hang: SUCCESS (0.486s)
[388.110819] [072/133] (639s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[388.208206] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[388.210489] Starting dynamic subtest: pipe-A
[388.270624] Dynamic subtest pipe-A: SUCCESS (0.065s)
[388.281981] Starting dynamic subtest: pipe-B
[389.407350] Dynamic subtest pipe-B: SUCCESS (1.135s)
[389.418942] Starting dynamic subtest: pipe-C
[390.576139] Dynamic subtest pipe-C: SUCCESS (1.167s)
[390.585465] Starting dynamic subtest: pipe-D
[391.675396] Dynamic subtest pipe-D: SUCCESS (1.098s)
[391.677728] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.470s)
[392.820259] [073/133] (634s left) syncobj_timeline (multi-wait-for-submit-signaled)
[392.872567] Starting subtest: multi-wait-for-submit-signaled
[392.874596] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[392.964270] [074/133] (634s left) kms_atomic_interruptible (legacy-dpms)
[393.051172] Starting subtest: legacy-dpms
[393.053465] Starting dynamic subtest: pipe-A-eDP-1
[400.498302] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.447s)
[400.500547] Subtest legacy-dpms: SUCCESS (7.448s)
[401.300162] [075/133] (626s left) syncobj_basic (bad-pad-handle-to-fd)
[401.359655] Starting subtest: bad-pad-handle-to-fd
[401.361986] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[401.470618] [076/133] (626s left) drm_read (short-buffer-nonblock)
[401.658358] Starting subtest: short-buffer-nonblock
[401.660375] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[401.783866] [077/133] (625s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[401.917133] Starting subtest: cursorB-vs-flipB-varying-size
[401.921705] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[402.061444] [078/133] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[402.165731] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[402.170179] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.259775] [079/133] (625s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[402.370637] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[403.484645] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.112s)
[403.597860] [080/133] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[403.698202] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[408.071228] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.374s)
[409.219979] [081/133] (618s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[409.314595] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[409.318866] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[409.383626] [082/133] (618s left) kms_atomic (crtc-invalid-params)
[409.495532] Starting subtest: crtc-invalid-params
[409.497843] Starting dynamic subtest: pipe-A-eDP-1
[409.851647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[409.853565] Subtest crtc-invalid-params: SUCCESS (0.357s)
[410.703105] [083/133] (617s left) kms_flip (busy-flip)
[410.801714] Starting subtest: busy-flip
[410.804060] Starting dynamic subtest: A-eDP1
[412.485840] Dynamic subtest A-eDP1: SUCCESS (1.681s)
[412.496931] Starting dynamic subtest: B-eDP1
[414.190404] Dynamic subtest B-eDP1: SUCCESS (1.702s)
[414.201552] Starting dynamic subtest: C-eDP1
[415.877902] Dynamic subtest C-eDP1: SUCCESS (1.686s)
[415.888265] Starting dynamic subtest: D-eDP1
[417.571644] Dynamic subtest D-eDP1: SUCCESS (1.692s)
[417.576869] Subtest busy-flip: SUCCESS (6.774s)
[418.827070] [084/133] (609s left) gem_exec_params (cliprects-invalid)
[418.885105] Starting subtest: cliprects-invalid
[418.887264] Subtest cliprects-invalid: SUCCESS (0.000s)
[418.982731] [085/133] (608s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[419.074882] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[423.942174] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.871s)
[425.114953] [086/133] (602s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[425.170072] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[425.172420] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[425.261287] [087/133] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[425.360714] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[425.364792] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[425.439482] [088/133] (602s left) syncobj_timeline (wait-zero-handles)
[425.493181] Starting subtest: wait-zero-handles
[425.495518] Subtest wait-zero-handles: SUCCESS (0.000s)
[425.583254] [089/133] (602s left) kms_psr (fbc-pr-sprite-plane-onoff)
[425.671973] Starting subtest: fbc-pr-sprite-plane-onoff
[425.676496] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[425.782884] [090/133] (602s left) gen9_exec_parse (batch-without-end)
[425.845381] Subtest batch-without-end: SKIP (0.000s)
[425.919446] [091/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[426.022858] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[426.027305] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[426.130751] [092/133] (602s left) syncobj_wait (wait-for-submit-snapshot)
[426.175074] Starting subtest: wait-for-submit-snapshot
[426.255938] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[426.333887] [093/133] (601s left) gem_exec_suspend (basic-s0)
[426.391620] Starting subtest: basic-S0
[426.393747] Starting dynamic subtest: smem
[446.460085] Dynamic subtest smem: SUCCESS (7.482s)
[446.463017] Subtest basic-S0: SUCCESS (7.485s)
[451.725515] [094/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[451.846579] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[451.851075] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[451.962233] [095/133] (581s left) perf (invalid-open-flags)
[452.088440] Starting subtest: invalid-open-flags
[452.091011] Subtest invalid-open-flags: SUCCESS (0.000s)
[452.142966] [096/133] (581s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[452.267547] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[452.272014] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[452.396209] [097/133] (581s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[452.498381] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[452.502721] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[452.607908] [098/133] (581s left) kms_addfb_basic (unused-modifier)
[452.668931] Starting subtest: unused-modifier
[452.671228] Subtest unused-modifier: SUCCESS (0.000s)
[452.805429] [099/133] (580s left) perf (enable-disable)
[452.900216] Starting subtest: enable-disable
[452.902220] Starting dynamic subtest: 0-rcs0
[455.163268] Dynamic subtest 0-rcs0: SUCCESS (2.228s)
[455.174598] Starting dynamic subtest: 1-vcs1
[459.693476] Dynamic subtest 1-vcs1: SUCCESS (4.434s)
[459.696358] Subtest enable-disable: SUCCESS (6.664s)
[459.736567] [100/133] (573s left) gem_exec_whisper (basic-queues-forked-all)
[459.804260] Starting subtest: basic-queues-forked-all
[479.894386] Subtest basic-queues-forked-all: SUCCESS (20.029s)
[480.084810] [101/133] (553s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[480.134681] Starting subtest: y-tiled-to-vebox-yf-tiled
[480.139206] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[480.319706] [102/133] (553s left) kms_addfb_basic (bad-pitch-0)
[480.371660] Starting subtest: bad-pitch-0
[480.373784] Subtest bad-pitch-0: SUCCESS (0.000s)
[480.515080] [103/133] (553s left) gem_ctx_engines (execute-one)
[480.577554] Starting subtest: execute-one
[482.780755] Subtest execute-one: SUCCESS (2.205s)
[482.968126] [104/133] (550s left) gem_wait (invalid-buf)
[483.035310] Starting subtest: invalid-buf
[483.037640] Subtest invalid-buf: SUCCESS (0.000s)
[483.274426] [105/133] (550s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[483.372842] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[483.374972] Starting dynamic subtest: pipe-A-eDP-1
[483.461064] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[483.477753] Starting dynamic subtest: pipe-B-eDP-1
[484.647767] Dynamic subtest pipe-B-eDP-1: SKIP (1.186s)
[484.652194] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.278s)
[485.812428] [106/133] (548s left) kms_pm_dc (dc3co-vpb-simulation)
[486.904971] Starting subtest: dc3co-vpb-simulation
[496.184019] Subtest dc3co-vpb-simulation: SKIP (9.221s)
[496.260395] [107/133] (537s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[496.357374] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[499.928094] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.575s)
[501.122164] [108/133] (532s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[501.220092] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[501.224422] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[501.316756] [109/133] (532s left) kms_plane_scaling (invalid-parameters)
[501.421084] Starting subtest: invalid-parameters
[501.423344] Starting dynamic subtest: less-than-1-height-src
[501.438802] Dynamic subtest less-than-1-height-src: SUCCESS (0.016s)
[501.449726] Starting dynamic subtest: less-than-1-width-src
[501.451945] Dynamic subtest less-than-1-width-src: SUCCESS (0.014s)
[501.454192] Subtest invalid-parameters: SUCCESS (0.031s)
[501.564428] [110/133] (532s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[501.672020] Starting subtest: yf-tiled-8bpp-rotate-0
[501.676299] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[501.777842] [111/133] (532s left) kms_psr (psr-cursor-plane-move)
[501.864829] Starting subtest: psr-cursor-plane-move
[501.867044] Starting dynamic subtest: eDP-1
[503.570779] Dynamic subtest eDP-1: SUCCESS (1.706s)
[503.573090] Subtest psr-cursor-plane-move: SUCCESS (1.707s)
[504.409175] [112/133] (529s left) i915_suspend (basic-s3-without-i915)
[504.447349] Starting subtest: basic-s3-without-i915
[506.318341] Subtest basic-s3-without-i915: SKIP (1.851s)
[507.867570] [113/133] (526s left) gem_exec_schedule (noreorder)
[508.065799] Starting subtest: noreorder
[508.068139] Starting dynamic subtest: rcs0
[508.132419] Dynamic subtest rcs0: SUCCESS (0.067s)
[508.142400] Starting dynamic subtest: vcs0
[509.503295] Dynamic subtest vcs0: SUCCESS (1.367s)
[509.518643] Starting dynamic subtest: vcs1
[511.487778] Dynamic subtest vcs1: SUCCESS (1.982s)
[511.498809] Starting dynamic subtest: vecs0
[513.462038] Dynamic subtest vecs0: SUCCESS (1.971s)
[513.476193] Starting dynamic subtest: ccs0
[513.550794] Dynamic subtest ccs0: SUCCESS (0.087s)
[513.553572] Subtest noreorder: SUCCESS (5.485s)
[513.751285] [114/133] (520s left) gem_wait (await)
[513.800603] Starting subtest: await
[513.802975] Starting dynamic subtest: all-engines
[514.912889] Dynamic subtest all-engines: SUCCESS (1.111s)
[514.933455] Starting dynamic subtest: rcs0
[515.972630] Dynamic subtest rcs0: SUCCESS (1.056s)
[515.990787] Starting dynamic subtest: bcs0
[517.030286] Dynamic subtest bcs0: SUCCESS (1.055s)
[517.046937] Starting dynamic subtest: vcs0
[518.084321] Dynamic subtest vcs0: SUCCESS (1.051s)
[518.101928] Starting dynamic subtest: vcs1
[519.138307] Dynamic subtest vcs1: SUCCESS (1.052s)
[519.155149] Starting dynamic subtest: vecs0
[520.191360] Dynamic subtest vecs0: SUCCESS (1.050s)
[520.208501] Starting dynamic subtest: ccs0
[521.247434] Dynamic subtest ccs0: SUCCESS (1.054s)
[521.249866] Subtest await: SUCCESS (7.445s)
[521.447931] [115/133] (512s left) kms_getfb (getfb2-handle-protection)
[521.540700] Starting subtest: getfb2-handle-protection
[521.555506] Subtest getfb2-handle-protection: SUCCESS (0.016s)
[521.674411] [116/133] (512s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[521.779424] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[521.783576] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.889727] [117/133] (512s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[521.980733] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[522.054187] [118/133] (512s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[522.108146] Starting subtest: etime-multi-wait-for-submit-submitted
[522.215464] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[522.289800] [119/133] (512s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[522.373370] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[522.375716] Starting dynamic subtest: pipe-A-eDP-1
[522.399588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[522.411567] Starting dynamic subtest: pipe-B-eDP-1
[522.433564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[522.442427] Starting dynamic subtest: pipe-C-eDP-1
[522.465940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[522.474086] Starting dynamic subtest: pipe-D-eDP-1
[522.495908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[522.499942] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[524.848833] [120/133] (509s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[524.954095] Starting subtest: extended-pageflip-modeset-hang-oldfb
[524.956336] Starting dynamic subtest: pipe-A
[532.854993] Dynamic subtest pipe-A: SUCCESS (7.895s)
[532.864654] Starting dynamic subtest: pipe-D
[541.466784] Dynamic subtest pipe-D: SUCCESS (8.608s)
[541.469202] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.509s)
[542.323944] [121/133] (492s left) gem_exec_reloc (basic-write-read-active)
[542.384046] Subtest basic-write-read-active: SKIP (0.000s)
[542.462944] [122/133] (492s left) gem_exec_balancer (bonded-true-hang)
[542.726523] Starting subtest: bonded-true-hang
[542.731383] Subtest bonded-true-hang: SKIP (0.000s)
[542.839722] [123/133] (491s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[542.936865] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[542.939224] Starting dynamic subtest: pipe-A-eDP-1
[548.798953] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.864s)
[548.808470] Starting dynamic subtest: pipe-B-eDP-1
[555.470153] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.673s)
[555.472551] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.540s)
[556.327937] [124/133] (478s left) prime_vgem (fence-write-hang)
[556.415224] Subtest fence-write-hang: SKIP (0.000s)
[556.534141] [125/133] (478s left) kms_fb_coherency (memset-crc)
[556.620679] Starting subtest: memset-crc
[556.622887] Starting dynamic subtest: mmap-offset-wc
[557.020767] Dynamic subtest mmap-offset-wc: SUCCESS (0.397s)
[557.320703] Starting dynamic subtest: mmap-offset-uc
[563.467464] Dynamic subtest mmap-offset-uc: SUCCESS (6.156s)
[563.763198] Subtest memset-crc: SUCCESS (7.144s)
[564.597047] [126/133] (470s left) kms_vblank (wait-forked-busy-hang)
[564.687726] Starting subtest: wait-forked-busy-hang
[564.689965] Starting dynamic subtest: pipe-A-eDP-1
[591.228035] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.539s)
[591.241646] Starting dynamic subtest: pipe-D-eDP-1
[616.254052] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[616.256302] Subtest wait-forked-busy-hang: SUCCESS (51.559s)
[617.079085] [127/133] (417s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[617.186591] Starting subtest: multiplane-rotation-cropping-bottom
[634.604411] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.416s)
[634.722646] [128/133] (400s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[634.821025] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[634.824338] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[634.924950] [129/133] (399s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[635.012035] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[635.013938] Starting dynamic subtest: pipe-A-eDP-1
[635.030703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[635.040155] Starting dynamic subtest: pipe-B-eDP-1
[635.055607] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[635.063922] Starting dynamic subtest: pipe-C-eDP-1
[635.079370] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[635.087723] Starting dynamic subtest: pipe-D-eDP-1
[635.103538] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[635.105119] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[637.331370] [130/133] (397s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[637.418040] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[637.444159] Starting dynamic subtest: pipe-A-plane-0
[637.877407] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[637.886821] Starting dynamic subtest: pipe-A-plane-3
[638.155547] Dynamic subtest pipe-A-plane-3: SUCCESS (0.276s)
[639.234070] Starting dynamic subtest: pipe-B-plane-0
[639.682526] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[639.692189] Starting dynamic subtest: pipe-B-plane-3
[639.938092] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[640.266658] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.848s)
[641.112376] [131/133] (393s left) gem_exec_reloc (basic-cpu-gtt)
[641.181674] Subtest basic-cpu-gtt: SKIP (0.000s)
[641.262464] [132/133] (393s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[641.362000] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[648.262108] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.900s)
[648.394162] [133/133] (386s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[648.468022] Starting subtest: multi-wait-all-for-submit-submitted
[648.574084] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[648.654551] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_flip_event_leak
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: gem_ccs
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: core_getclient
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: gem_pipe_control_store_loop
results: parsing output: 27/ for test: device_reset
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_async_flips
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: i915_hangman
results: parsing output: 37/ for test: gem_media_fill
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_workarounds
results: parsing output: 43/ for test: syncobj_eventfd
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_dither
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_force_connector_basic
results: parsing output: 52/ for test: gem_render_copy_redux
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: gem_ctx_isolation
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: prime_busy
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_ctx_shared
results: parsing output: 64/ for test: kms_chamelium_audio
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: syncobj_basic
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_suspend
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_addfb_basic
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_ctx_engines
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_pm_dc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: i915_suspend
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_wait
results: parsing output: 114/ for test: kms_getfb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_busy
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_exec_balancer
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: kms_fb_coherency
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_rotation_crc
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_wait
Done.