[57.535582] Initializing watchdogs
[57.535688]   /dev/watchdog0
[57.550119] [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]
[57.554599] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.556850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.560104] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[57.693619] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[57.696060] Starting dynamic subtest: pipe-A-eDP-1
[57.754657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[57.763210] Starting dynamic subtest: pipe-B-eDP-1
[57.816783] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[57.825513] Starting dynamic subtest: pipe-C-eDP-1
[57.877713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[57.886085] Starting dynamic subtest: pipe-D-eDP-1
[57.960831] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.082s)
[57.963369] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.270s)
[60.132016] [002/133] (957s left) gem_softpin (zero)
[60.191042] Starting subtest: zero
[60.198078] Subtest zero: SUCCESS (0.005s)
[60.328754] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.429476] Starting subtest: invalid-modeset-ultra-joiner
[60.434197] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.502866] [004/133] (957s left) gem_unfence_active_buffers
[60.654560] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[60.741505] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[60.745667] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.845224] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[60.950108] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[60.954553] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[61.042834] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[61.157617] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[61.161958] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[61.303173] [008/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.393975] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.396055] Starting dynamic subtest: pipe-A-eDP-1
[61.412552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.422485] Starting dynamic subtest: pipe-B-eDP-1
[61.438197] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.444969] Starting dynamic subtest: pipe-C-eDP-1
[61.461151] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.467100] Starting dynamic subtest: pipe-D-eDP-1
[61.483131] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.484707] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[63.621530] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[63.681924] Starting subtest: bad-flags-fd-to-handle
[63.684234] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[63.790519] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[63.852033] Starting subtest: set-cache-level
[63.856471] Subtest set-cache-level: SKIP (0.000s)
[63.968786] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[64.352860] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[65.129226] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[65.245478] Starting subtest: modeset-vs-vblank-race
[65.247789] Starting dynamic subtest: A-eDP1
[69.973968] Dynamic subtest A-eDP1: SUCCESS (4.727s)
[69.984056] Starting dynamic subtest: B-eDP1
[74.712052] Dynamic subtest B-eDP1: SUCCESS (4.735s)
[74.720847] Starting dynamic subtest: C-eDP1
[79.328445] Dynamic subtest C-eDP1: SUCCESS (4.614s)
[79.339048] Starting dynamic subtest: D-eDP1
[83.793900] Dynamic subtest D-eDP1: SUCCESS (4.464s)
[83.798456] Subtest modeset-vs-vblank-race: SUCCESS (18.549s)
[84.969957] [013/133] (933s left) gem_pxp (display-protected-crc)
[85.105419] Starting subtest: display-protected-crc
[86.708324] Subtest display-protected-crc: SUCCESS (1.605s)
[86.812036] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.115289] Starting subtest: cursor-sliding-max-size
[87.121639] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.245434] [015/133] (931s left) prime_vgem (wait)
[87.338653] Starting subtest: wait
[87.340651] Starting dynamic subtest: rcs0
[87.384868] Dynamic subtest rcs0: SUCCESS (0.047s)
[87.392113] Starting dynamic subtest: bcs0
[87.438537] Dynamic subtest bcs0: SUCCESS (0.053s)
[87.445783] Starting dynamic subtest: vcs0
[87.485817] Dynamic subtest vcs0: SUCCESS (0.047s)
[87.493052] Starting dynamic subtest: vcs1
[87.529773] Dynamic subtest vcs1: SUCCESS (0.044s)
[87.537090] Starting dynamic subtest: vecs0
[87.575693] Dynamic subtest vecs0: SUCCESS (0.046s)
[87.582741] Starting dynamic subtest: ccs0
[87.620593] Dynamic subtest ccs0: SUCCESS (0.044s)
[87.622683] Subtest wait: SUCCESS (0.284s)
[87.752822] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[87.755556] [016/133] (930s left) kms_fence_pin_leak
[87.912799] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[88.015437] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.019222] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.130780] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[88.501193] Subtest dp-frame-dump: SKIP (0.000s)
[89.272984] [019/133] (929s left) gem_mmap (bad-offset)
[89.334877] Subtest bad-offset: SKIP (0.000s)
[89.404399] [020/133] (929s left) kms_cursor_crc (cursor-random-128x42)
[89.634255] Starting subtest: cursor-random-128x42
[89.680075] Subtest cursor-random-128x42: SKIP (0.040s)
[89.913221] [021/133] (928s left) kms_flip (flip-vs-fences)
[90.009111] Starting subtest: flip-vs-fences
[90.013214] Subtest flip-vs-fences: SKIP (0.000s)
[90.114871] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[90.221471] Starting subtest: fbc-pr-sprite-plane-move
[90.225893] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[90.301667] [023/133] (928s left) i915_drm_fdinfo (isolation)
[90.343504] Starting subtest: isolation
[90.345501] Starting dynamic subtest: rcs0
[90.368071] Dynamic subtest rcs0: SKIP (0.023s)
[90.377066] Starting dynamic subtest: bcs0
[90.380541] Dynamic subtest bcs0: SKIP (0.000s)
[90.387427] Starting dynamic subtest: vcs0
[90.390835] Dynamic subtest vcs0: SKIP (0.000s)
[90.397505] Starting dynamic subtest: vcs1
[90.401046] Dynamic subtest vcs1: SKIP (0.001s)
[90.407447] Starting dynamic subtest: vecs0
[90.410997] Dynamic subtest vecs0: SKIP (0.001s)
[90.417403] Starting dynamic subtest: ccs0
[90.421033] Dynamic subtest ccs0: SKIP (0.000s)
[90.424565] Subtest isolation: SKIP (0.029s)
[90.457982] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[90.515153] Starting subtest: reject-modify-context-protection-off-1
[90.517157] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[90.616836] [025/133] (928s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[90.665089] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[90.668746] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[90.843551] [026/133] (928s left) i915_pm_rpm (debugfs-forcewake-user)
[93.074490] Starting subtest: debugfs-forcewake-user
[104.462966] Subtest debugfs-forcewake-user: SUCCESS (11.390s)
[104.861235] [027/133] (914s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.907046] Starting subtest: wait-all-for-submit-snapshot
[104.988829] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[105.058685] [028/133] (914s left) kms_hdr (bpc-switch)
[105.149227] Starting subtest: bpc-switch
[106.228709] Starting dynamic subtest: pipe-A-eDP-1
[109.717221] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s)
[109.719568] Subtest bpc-switch: SUCCESS (4.571s)
[109.818012] [029/133] (909s left) gem_userptr_blits (unsync-unmap)
[109.888311] Subtest unsync-unmap: SKIP (0.000s)
[110.007251] [030/133] (909s left) kms_cursor_crc (cursor-onscreen-256x256)
[110.260785] Starting subtest: cursor-onscreen-256x256
[110.265879] Starting dynamic subtest: pipe-A-eDP-1
[112.363966] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[112.393385] Starting dynamic subtest: pipe-D-eDP-1
[115.156933] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[115.159263] Subtest cursor-onscreen-256x256: SUCCESS (4.893s)
[115.960400] [031/133] (903s left) syncobj_timeline (device-submit-unordered)
[116.024784] Starting subtest: device-submit-unordered
[116.027082] Subtest device-submit-unordered: SUCCESS (0.000s)
[116.135023] [032/133] (903s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[116.241056] Starting subtest: fbcpsr-rgb101010-draw-blt
[123.001812] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.765s)
[123.116853] [033/133] (896s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[123.215081] Starting subtest: fbc-pr-cursor-plane-update-sf
[123.219607] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[123.294671] [034/133] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[123.396705] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[123.401267] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.495733] [035/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.597531] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[124.232468] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[124.416708] [036/133] (894s left) api_intel_bb (purge-bb)
[124.472038] Starting subtest: purge-bb
[124.474302] Subtest purge-bb: SUCCESS (0.004s)
[124.599269] [037/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[124.696788] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[131.863757] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.170s)
[131.989719] [038/133] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[132.095652] Starting subtest: psr-rgb565-draw-render
[139.135503] Subtest psr-rgb565-draw-render: SUCCESS (7.043s)
[139.245214] [039/133] (880s left) perf (create-destroy-userspace-config)
[139.372068] Starting subtest: create-destroy-userspace-config
[139.395898] Subtest create-destroy-userspace-config: SUCCESS (0.022s)
[139.441423] [040/133] (880s left) perf (missing-sample-flags)
[139.534758] Starting subtest: missing-sample-flags
[139.537138] Subtest missing-sample-flags: SUCCESS (0.000s)
[139.577121] [041/133] (880s left) gem_exec_balancer (full-late-pulse)
[139.641068] Starting subtest: full-late-pulse
[144.758696] Subtest full-late-pulse: SUCCESS (5.120s)
[145.069489] [042/133] (874s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[145.162679] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[145.166640] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[145.234384] [043/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[145.347085] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[145.351494] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[145.454323] [044/133] (874s left) sw_sync (alloc_merge_fence)
[145.494413] Starting subtest: alloc_merge_fence
[145.496650] Subtest alloc_merge_fence: SUCCESS (0.000s)
[145.552303] [045/133] (874s left) kms_plane_multiple (tiling-y)
[145.640183] Starting subtest: tiling-y
[145.644561] Subtest tiling-y: SKIP (0.000s)
[145.710288] [046/133] (874s left) gem_mmap_wc (write-gtt-read-wc)
[145.772991] Subtest write-gtt-read-wc: SKIP (0.000s)
[145.837085] [047/133] (874s left) perf (gen12-group-exclusive-stream-ctx-handle)
[145.920979] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[145.950270] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.028s)
[145.992142] [048/133] (873s left) gem_mmap_offset (isolation)
[147.897304] Starting subtest: isolation
[147.914820] Subtest isolation: SUCCESS (0.007s)
[147.999177] [049/133] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[148.097068] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[148.101335] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[148.184305] [050/133] (871s left) gem_ctx_create (basic)
[148.250824] Starting subtest: basic
[148.253309] Subtest basic: SUCCESS (0.000s)
[148.432387] [051/133] (871s left) syncobj_wait (wait-any-interrupted)
[148.491109] Starting subtest: wait-any-interrupted
[148.593276] Subtest wait-any-interrupted: SUCCESS (0.102s)
[148.680199] [052/133] (871s left) gen9_exec_parse (bb-large)
[148.733734] Subtest bb-large: SKIP (0.000s)
[148.806615] [053/133] (871s left) syncobj_timeline (multi-wait-signaled)
[148.870707] Starting subtest: multi-wait-signaled
[148.872984] Subtest multi-wait-signaled: SUCCESS (0.000s)
[148.977761] [054/133] (871s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[149.115576] Starting subtest: multiplane-atomic-fence-wait
[149.413594] Subtest multiplane-atomic-fence-wait: SUCCESS (0.296s)
[150.563937] [055/133] (869s left) kms_invalid_mode (zero-vdisplay)
[150.673288] Starting subtest: zero-vdisplay
[150.675614] Starting dynamic subtest: pipe-A-eDP-1
[150.958578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[150.968461] Starting dynamic subtest: pipe-B-eDP-1
[150.970515] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[150.978352] Starting dynamic subtest: pipe-C-eDP-1
[150.980629] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[150.988389] Starting dynamic subtest: pipe-D-eDP-1
[150.990908] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[150.993471] Subtest zero-vdisplay: SUCCESS (0.293s)
[151.800099] [056/133] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[151.894899] Starting subtest: fbc-rgb101010-draw-blt
[156.519981] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.628s)
[157.714899] [057/133] (862s left) gen3_render_linear_blits
[157.833550] [058/133] (862s left) gem_exec_reloc (basic-concurrent0)
[157.888386] Subtest basic-concurrent0: SKIP (0.000s)
[157.956339] [059/133] (862s left) syncobj_wait (multi-wait-for-submit-signaled)
[158.012422] Starting subtest: multi-wait-for-submit-signaled
[158.014692] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[158.109991] [060/133] (862s left) kms_big_fb (4-tiled-addfb-size-overflow)
[158.204603] Starting subtest: 4-tiled-addfb-size-overflow
[158.206687] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[158.294766] [061/133] (862s left) sw_sync (alloc_fence)
[158.329521] Starting subtest: alloc_fence
[158.331830] Subtest alloc_fence: SUCCESS (0.000s)
[158.385957] [062/133] (862s left) kms_prime (d3hot)
[158.468016] Subtest D3hot: SKIP (0.000s)
[158.573465] [063/133] (861s left) perf_pmu (idle-no-semaphores)
[158.615053] Starting subtest: idle-no-semaphores
[158.616970] Starting dynamic subtest: rcs0
[159.165626] Dynamic subtest rcs0: SUCCESS (0.550s)
[159.177243] Starting dynamic subtest: bcs0
[159.689341] Dynamic subtest bcs0: SUCCESS (0.522s)
[159.698999] Starting dynamic subtest: vcs0
[160.205415] Dynamic subtest vcs0: SUCCESS (0.514s)
[160.216726] Starting dynamic subtest: vcs1
[160.723657] Dynamic subtest vcs1: SUCCESS (0.515s)
[160.733881] Starting dynamic subtest: vecs0
[161.245547] Dynamic subtest vecs0: SUCCESS (0.519s)
[161.255374] Starting dynamic subtest: ccs0
[161.766748] Dynamic subtest ccs0: SUCCESS (0.518s)
[161.769418] Subtest idle-no-semaphores: SUCCESS (3.153s)
[161.878033] [064/133] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[161.987959] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[161.992460] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[162.061836] [065/133] (858s left) kms_pm_dc (dc9-dpms)
[163.165054] Starting subtest: dc9-dpms
[164.575310] Subtest dc9-dpms: SUCCESS (1.412s)
[164.661381] [066/133] (855s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[164.713498] Starting subtest: legacy-engines-hostile-preempt
[164.715770] Starting dynamic subtest: render
[164.790751] Dynamic subtest render: SUCCESS (0.077s)
[164.801891] Starting dynamic subtest: bsd1
[165.900453] Dynamic subtest bsd1: SUCCESS (1.106s)
[165.911505] Starting dynamic subtest: bsd2
[167.891412] Dynamic subtest bsd2: SUCCESS (1.988s)
[167.903967] Starting dynamic subtest: blt
[167.948785] Dynamic subtest blt: SUCCESS (0.056s)
[167.962034] Starting dynamic subtest: vebox
[169.916268] Dynamic subtest vebox: SUCCESS (1.963s)
[169.919523] Subtest legacy-engines-hostile-preempt: SUCCESS (5.202s)
[170.030279] [067/133] (850s left) gem_userptr_blits (create-destroy-sync)
[170.103414] Starting subtest: create-destroy-sync
[175.117192] Subtest create-destroy-sync: SUCCESS (5.013s)
[175.256566] [068/133] (845s left) kms_cursor_legacy (torture-move)
[175.402090] Starting subtest: torture-move
[175.404420] Starting dynamic subtest: pipe-A
[181.137204] Dynamic subtest pipe-A: SUCCESS (5.733s)
[181.147586] Starting dynamic subtest: pipe-B
[188.042839] Dynamic subtest pipe-B: SUCCESS (6.904s)
[188.053054] Starting dynamic subtest: pipe-C
[194.664642] Dynamic subtest pipe-C: SUCCESS (6.621s)
[194.674136] Starting dynamic subtest: pipe-D
[202.239923] Dynamic subtest pipe-D: SUCCESS (7.573s)
[202.250751] Starting dynamic subtest: all-pipes
[208.632274] Dynamic subtest all-pipes: SUCCESS (6.390s)
[208.634664] Subtest torture-move: SUCCESS (33.230s)
[208.790863] [069/133] (811s left) device_reset (cold-reset-bound)
[208.839833] Starting subtest: cold-reset-bound
[208.844310] Subtest cold-reset-bound: SKIP (0.000s)
[208.914580] [070/133] (811s left) syncobj_timeline (etime-multi-wait-submitted)
[208.968391] Starting subtest: etime-multi-wait-submitted
[209.073749] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[209.150374] [071/133] (811s left) kms_async_flips (invalid-async-flip-atomic)
[209.233919] Starting subtest: invalid-async-flip-atomic
[209.605498] Starting dynamic subtest: pipe-A-eDP-1
[210.443430] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s)
[210.807357] Starting dynamic subtest: pipe-B-eDP-1
[211.577653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[211.935679] Starting dynamic subtest: pipe-C-eDP-1
[212.701149] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[213.055830] Starting dynamic subtest: pipe-D-eDP-1
[213.818584] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[213.820873] Subtest invalid-async-flip-atomic: SUCCESS (4.586s)
[214.975548] [072/133] (805s left) gem_exec_schedule (preempt-hang)
[215.153873] Starting subtest: preempt-hang
[215.156966] Starting dynamic subtest: rcs0
[215.391982] Dynamic subtest rcs0: SUCCESS (0.237s)
[215.402205] Starting dynamic subtest: bcs0
[215.639599] Dynamic subtest bcs0: SUCCESS (0.245s)
[215.656227] Starting dynamic subtest: vcs0
[215.860494] Dynamic subtest vcs0: SUCCESS (0.222s)
[215.868527] Starting dynamic subtest: vcs1
[216.085148] Dynamic subtest vcs1: SUCCESS (0.223s)
[216.095063] Starting dynamic subtest: vecs0
[216.306230] Dynamic subtest vecs0: SUCCESS (0.221s)
[216.317409] Starting dynamic subtest: ccs0
[216.535646] Dynamic subtest ccs0: SUCCESS (0.227s)
[216.537859] Subtest preempt-hang: SUCCESS (1.382s)
[217.001309] [073/133] (803s left) gem_mmap (basic-small-bo)
[217.056679] Subtest basic-small-bo: SKIP (0.000s)
[217.126816] [074/133] (803s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[217.220482] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[217.224868] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[217.324294] [075/133] (803s left) kms_plane (plane-position-covered)
[217.421961] Starting subtest: plane-position-covered
[217.956795] Starting dynamic subtest: pipe-A-plane-1
[219.260638] Dynamic subtest pipe-A-plane-1: SUCCESS (1.304s)
[219.269945] Starting dynamic subtest: pipe-A-plane-2
[220.513551] Dynamic subtest pipe-A-plane-2: SUCCESS (1.252s)
[220.522440] Starting dynamic subtest: pipe-A-plane-3
[221.783896] Dynamic subtest pipe-A-plane-3: SUCCESS (1.271s)
[221.793271] Starting dynamic subtest: pipe-A-plane-4
[223.148686] Dynamic subtest pipe-A-plane-4: SUCCESS (1.361s)
[223.157583] Starting dynamic subtest: pipe-A-plane-5
[223.171883] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[224.357728] Starting dynamic subtest: pipe-B-plane-1
[225.670044] Dynamic subtest pipe-B-plane-1: SUCCESS (1.319s)
[225.679724] Starting dynamic subtest: pipe-B-plane-2
[227.024324] Dynamic subtest pipe-B-plane-2: SUCCESS (1.353s)
[227.032757] Starting dynamic subtest: pipe-B-plane-3
[228.318155] Dynamic subtest pipe-B-plane-3: SUCCESS (1.294s)
[228.326752] Starting dynamic subtest: pipe-B-plane-4
[229.677510] Dynamic subtest pipe-B-plane-4: SUCCESS (1.356s)
[229.688294] Starting dynamic subtest: pipe-B-plane-5
[229.703455] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[229.705792] Subtest plane-position-covered: SUCCESS (12.282s)
[230.528169] [076/133] (790s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[230.639648] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[230.643903] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[230.715513] [077/133] (790s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[230.810423] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[230.812735] Starting dynamic subtest: pipe-A-eDP-1
[230.822061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[230.831955] Starting dynamic subtest: pipe-B-eDP-1
[230.841298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[230.849986] Starting dynamic subtest: pipe-C-eDP-1
[230.858555] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[230.866621] Starting dynamic subtest: pipe-D-eDP-1
[230.875230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[230.879242] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[232.998866] [078/133] (788s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[233.096805] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[233.098926] Starting dynamic subtest: pipe-A
[233.120502] Dynamic subtest pipe-A: SKIP (0.020s)
[233.128936] Starting dynamic subtest: pipe-B
[233.154500] Dynamic subtest pipe-B: SKIP (0.031s)
[233.163129] Starting dynamic subtest: pipe-C
[233.188177] Dynamic subtest pipe-C: SKIP (0.032s)
[233.196412] Starting dynamic subtest: pipe-D
[233.218532] Dynamic subtest pipe-D: SKIP (0.031s)
[233.222659] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s)
[233.333916] [079/133] (787s left) kms_color (deep-color)
[233.431908] Starting subtest: deep-color
[234.472138] Starting dynamic subtest: pipe-A-eDP-1-gamma
[235.174514] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.702s)
[235.183858] Starting dynamic subtest: pipe-A-eDP-1-degamma
[236.559795] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.383s)
[236.568967] Starting dynamic subtest: pipe-A-eDP-1-ctm
[237.974667] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.413s)
[238.783459] Starting dynamic subtest: pipe-B-eDP-1-gamma
[239.504574] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.728s)
[239.513302] Starting dynamic subtest: pipe-B-eDP-1-degamma
[240.941382] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.435s)
[240.953604] Starting dynamic subtest: pipe-B-eDP-1-ctm
[242.370776] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.430s)
[243.159049] Starting dynamic subtest: pipe-C-eDP-1-gamma
[243.845421] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.697s)
[243.854743] Starting dynamic subtest: pipe-C-eDP-1-degamma
[245.205091] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.360s)
[245.214511] Starting dynamic subtest: pipe-C-eDP-1-ctm
[246.627557] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.419s)
[247.375395] Starting dynamic subtest: pipe-D-eDP-1-gamma
[248.068677] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.699s)
[248.077734] Starting dynamic subtest: pipe-D-eDP-1-degamma
[249.431504] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.359s)
[249.440866] Starting dynamic subtest: pipe-D-eDP-1-ctm
[250.874912] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.445s)
[250.877196] Subtest deep-color: SUCCESS (17.445s)
[251.781981] [080/133] (769s left) kms_atomic_transition (plane-all-transition-nonblocking)
[251.875061] Starting subtest: plane-all-transition-nonblocking
[251.877264] Starting dynamic subtest: pipe-A-eDP-1
[254.369212] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[254.676062] Starting dynamic subtest: pipe-B-eDP-1
[257.868367] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.201s)
[258.166570] Subtest plane-all-transition-nonblocking: SUCCESS (6.290s)
[258.994156] [081/133] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[259.111915] Starting subtest: psr-2p-primscrn-cur-indfb-move
[259.116479] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[259.222897] [082/133] (762s left) i915_query (engine-info-invalid)
[259.286169] Starting subtest: engine-info-invalid
[259.288092] Subtest engine-info-invalid: SUCCESS (0.000s)
[259.383107] [083/133] (761s left) kms_rotation_crc (sprite-rotation-90)
[259.488081] Starting subtest: sprite-rotation-90
[259.492552] Subtest sprite-rotation-90: SKIP (0.001s)
[259.561278] [084/133] (761s left) gem_userptr_blits (coherency-sync)
[259.634744] Starting subtest: coherency-sync
[260.049208] Subtest coherency-sync: SKIP (0.377s)
[260.153709] [085/133] (761s left) api_intel_allocator (default-alignment)
[260.254363] Starting subtest: default-alignment
[260.257320] Subtest default-alignment: SUCCESS (0.005s)
[260.369262] [086/133] (761s left) kms_psr (pr-cursor-render)
[260.472084] Starting subtest: pr-cursor-render
[260.476397] Subtest pr-cursor-render: SKIP (0.000s)
[260.546601] [087/133] (760s left) gem_exec_flush (basic-wb-pro-default)
[260.618100] Starting subtest: basic-wb-pro-default
[266.098305] Subtest basic-wb-pro-default: SUCCESS (5.480s)
[266.288723] [088/133] (755s left) gem_eio (kms)
[266.568065] Starting subtest: kms
[284.126071] Subtest kms: SUCCESS (17.556s)
[285.305804] [089/133] (736s left) template (a)
[285.361201] Starting subtest: A
[285.363098] Subtest A: SUCCESS (0.000s)
[285.458204] [090/133] (736s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[285.560768] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[285.562994] Starting dynamic subtest: pipe-A-default-mode
[288.281469] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[288.283877] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.723s)
[289.124413] [091/133] (732s left) gem_exec_schedule (semaphore-noskip)
[289.203472] Starting subtest: semaphore-noskip
[289.637051] Subtest semaphore-noskip: SUCCESS (0.438s)
[289.972397] [092/133] (731s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[290.088317] Starting subtest: basic-flip-before-cursor-legacy
[291.006753] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.916s)
[291.855660] [093/133] (729s left) fbdev (write)
[291.908918] Starting subtest: write
[292.267039] Subtest write: SUCCESS (0.359s)
[292.339123] [094/133] (729s left) kms_flip (2x-blocking-absolute-wf_vblank)
[292.434229] Starting subtest: 2x-blocking-absolute-wf_vblank
[292.441766] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[292.553552] [095/133] (729s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[292.603033] Starting subtest: multi-wait-for-submit-unsubmitted
[292.705834] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[292.783210] [096/133] (729s left) kms_big_fb (x-tiled-addfb)
[292.878758] Starting subtest: x-tiled-addfb
[292.880997] Subtest x-tiled-addfb: SUCCESS (0.000s)
[292.980460] [097/133] (728s left) kms_selftest (drm_cmdline_parser)
[293.022124] Starting subtest: drm_cmdline_parser
[293.036712] Starting dynamic subtest: drm_test_cmdline_force_d_only
[293.150288] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.112s)
[293.160016] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[293.260383] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.110s)
[293.269301] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[293.368184] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.106s)
[293.377976] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[293.481444] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.112s)
[293.490669] Starting dynamic subtest: drm_test_cmdline_force_e_only
[293.569696] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.086s)
[293.580060] Starting dynamic subtest: drm_test_cmdline_res
[293.662256] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.093s)
[293.672577] Starting dynamic subtest: drm_test_cmdline_res_vesa
[293.742485] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.081s)
[293.751159] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[293.839270] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.094s)
[293.849562] Starting dynamic subtest: drm_test_cmdline_res_rblank
[293.941057] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.102s)
[293.951421] Starting dynamic subtest: drm_test_cmdline_res_bpp
[294.028220] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.086s)
[294.036656] Starting dynamic subtest: drm_test_cmdline_res_refresh
[294.114050] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.086s)
[294.124109] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[294.197314] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.081s)
[294.208738] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[294.277306] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.078s)
[294.287761] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[294.376323] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.098s)
[294.386598] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[294.482318] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.106s)
[294.492086] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[294.583858] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.101s)
[294.593393] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[294.681524] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.098s)
[294.690949] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[294.763527] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.081s)
[294.773574] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[294.841469] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.077s)
[294.851210] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[294.935521] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.093s)
[294.945472] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[295.022069] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.086s)
[295.030170] Starting dynamic subtest: drm_test_cmdline_name
[295.105081] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.082s)
[295.113081] Starting dynamic subtest: drm_test_cmdline_name_bpp
[295.197273] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.091s)
[295.205218] Starting dynamic subtest: drm_test_cmdline_name_option
[295.289322] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.092s)
[295.298819] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[295.368497] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.078s)
[295.376755] Starting dynamic subtest: drm_test_cmdline_rotate_0
[295.468368] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.099s)
[295.478276] Starting dynamic subtest: drm_test_cmdline_rotate_90
[295.572643] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.103s)
[295.580983] Starting dynamic subtest: drm_test_cmdline_rotate_180
[295.678124] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.105s)
[295.686640] Starting dynamic subtest: drm_test_cmdline_rotate_270
[295.779302] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.099s)
[295.787575] Starting dynamic subtest: drm_test_cmdline_hmirror
[295.871366] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.090s)
[295.879746] Starting dynamic subtest: drm_test_cmdline_vmirror
[295.973894] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.102s)
[295.982580] Starting dynamic subtest: drm_test_cmdline_margin_options
[296.089597] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.115s)
[296.098229] Starting dynamic subtest: drm_test_cmdline_multiple_options
[296.174345] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.083s)
[296.182602] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[296.261543] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.087s)
[296.269702] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[296.359182] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.096s)
[296.369024] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[296.446705] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.087s)
[296.454827] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[296.543340] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.096s)
[296.551590] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[296.630614] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.085s)
[296.640496] Starting dynamic subtest: drm_test_cmdline_invalid
[296.723631] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.093s)
[296.732542] Starting dynamic subtest: drm_test_cmdline_tv_options
[296.823883] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.099s)
[296.825664] Subtest drm_cmdline_parser: SUCCESS (3.800s)
[296.982809] [098/133] (725s left) gem_exec_balancer (sequential)
[297.053303] Starting subtest: sequential
[300.136720] Subtest sequential: SUCCESS (3.082s)
[300.439504] [099/133] (721s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[300.538686] Starting subtest: fbc-psr2-sprite-mmap-cpu
[300.541080] Starting dynamic subtest: eDP-1
[300.545194] Dynamic subtest eDP-1: SKIP (0.000s)
[300.549412] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[300.616996] [100/133] (721s left) gem_exec_fence (nb-await)
[300.784544] Starting subtest: nb-await
[300.787073] Starting dynamic subtest: rcs0
[300.852261] Dynamic subtest rcs0: SUCCESS (0.066s)
[300.864938] Starting dynamic subtest: bcs0
[300.911895] Dynamic subtest bcs0: SUCCESS (0.057s)
[300.923910] Starting dynamic subtest: vcs0
[300.970860] Dynamic subtest vcs0: SUCCESS (0.057s)
[300.983222] Starting dynamic subtest: vcs1
[301.031842] Dynamic subtest vcs1: SUCCESS (0.058s)
[301.045733] Starting dynamic subtest: vecs0
[301.088895] Dynamic subtest vecs0: SUCCESS (0.057s)
[301.100205] Starting dynamic subtest: ccs0
[301.147139] Dynamic subtest ccs0: SUCCESS (0.056s)
[301.149958] Subtest nb-await: SUCCESS (0.365s)
[303.027187] [101/133] (719s left) sysfs_timeslice_duration (idempotent)
[303.085190] Starting subtest: idempotent
[303.087579] Starting dynamic subtest: vecs0
[303.090026] Dynamic subtest vecs0: SUCCESS (0.000s)
[303.100732] Starting dynamic subtest: ccs0
[303.102674] Dynamic subtest ccs0: SUCCESS (0.000s)
[303.111089] Starting dynamic subtest: vcs0
[303.112980] Dynamic subtest vcs0: SUCCESS (0.000s)
[303.121557] Starting dynamic subtest: bcs0
[303.123489] Dynamic subtest bcs0: SUCCESS (0.000s)
[303.132281] Starting dynamic subtest: rcs0
[303.134460] Dynamic subtest rcs0: SUCCESS (0.000s)
[303.143433] Starting dynamic subtest: vcs1
[303.145379] Dynamic subtest vcs1: SUCCESS (0.000s)
[303.147298] Subtest idempotent: SUCCESS (0.006s)
[303.197020] [102/133] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[303.293038] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[303.297398] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[303.385993] [103/133] (718s left) gem_exec_store (basic)
[303.452374] Starting subtest: basic
[303.556703] Subtest basic: SUCCESS (0.104s)
[303.757552] [104/133] (718s left) intel_hwmon (hwmon-read)
[303.822328] Subtest hwmon-read: SKIP (0.000s)
[303.887418] [105/133] (718s left) i915_getparams_basic (basic-eu-total)
[303.942045] Starting subtest: basic-eu-total
[303.946290] Subtest basic-eu-total: SUCCESS (0.000s)
[304.035241] [106/133] (718s left) kms_big_fb (linear-16bpp-rotate-90)
[304.124953] Starting subtest: linear-16bpp-rotate-90
[304.144572] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[304.247920] [107/133] (718s left) kms_vblank (query-forked-busy)
[304.344944] Starting subtest: query-forked-busy
[304.347170] Starting dynamic subtest: pipe-A-eDP-1
[306.234190] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[306.252645] Starting dynamic subtest: pipe-D-eDP-1
[308.803788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[308.806210] Subtest query-forked-busy: SUCCESS (4.461s)
[309.608236] [108/133] (712s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[309.696615] Starting subtest: nonblocking-crc-frame-sequence
[309.698884] Starting dynamic subtest: pipe-A-eDP-1
[310.437782] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[310.447234] Starting dynamic subtest: pipe-B-eDP-1
[311.824285] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[311.834179] Starting dynamic subtest: pipe-C-eDP-1
[313.215038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.390s)
[313.225078] Starting dynamic subtest: pipe-D-eDP-1
[314.565240] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.348s)
[314.567114] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.870s)
[315.452766] [109/133] (707s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[315.550270] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[315.552624] Starting dynamic subtest: pipe-A-eDP-1
[321.423079] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.877s)
[321.432845] Starting dynamic subtest: pipe-B-eDP-1
[328.057932] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.634s)
[328.060328] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.514s)
[328.935912] [110/133] (693s left) kms_flip (2x-plain-flip-interruptible)
[329.038056] Starting subtest: 2x-plain-flip-interruptible
[329.048687] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[329.141482] [111/133] (693s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[329.244813] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[329.247116] Starting dynamic subtest: pipe-A-eDP-1
[340.240460] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.998s)
[340.250894] Starting dynamic subtest: pipe-B-eDP-1
[351.937576] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.698s)
[351.940057] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.699s)
[352.800587] [112/133] (669s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[352.892273] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[352.894611] Starting dynamic subtest: pipe-A-eDP-1
[353.353284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[353.364914] Starting dynamic subtest: pipe-B-eDP-1
[354.719579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[354.731160] Starting dynamic subtest: pipe-C-eDP-1
[356.165158] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.441s)
[356.176693] Starting dynamic subtest: pipe-D-eDP-1
[357.570113] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[357.572326] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.652s)
[358.753522] [113/133] (663s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[358.877570] Starting subtest: cursorB-vs-flipA-varying-size
[358.882058] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[359.022430] [114/133] (663s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[359.121914] Starting subtest: pipe-fbc-rte
[359.128417] Starting dynamic subtest: pipe-B-eDP-1
[364.641698] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.522s)
[364.649280] Subtest pipe-fbc-rte: SUCCESS (5.524s)
[366.907292] [115/133] (655s left) syncobj_timeline (invalid-query-bad-pad)
[366.967398] Starting subtest: invalid-query-bad-pad
[366.969673] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[367.061822] [116/133] (655s left) gem_exercise_blt (fast-copy-emit)
[367.137035] Starting subtest: fast-copy-emit
[367.139471] Starting dynamic subtest: linear-smem-smem-emit
[367.158046] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[367.169293] Starting dynamic subtest: xmajor-smem-smem-emit
[367.174361] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[367.183370] Starting dynamic subtest: tile4-smem-smem-emit
[367.192083] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[367.200830] Starting dynamic subtest: tile64-smem-smem-emit
[367.208584] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[367.210935] Subtest fast-copy-emit: SUCCESS (0.072s)
[367.352166] [117/133] (655s left) gem_ctx_persistence (engines-queued)
[367.419230] Starting subtest: engines-queued
[367.421619] Starting dynamic subtest: rcs0
[367.495552] Dynamic subtest rcs0: SUCCESS (0.076s)
[367.507928] Starting dynamic subtest: bcs0
[367.530357] Dynamic subtest bcs0: SUCCESS (0.033s)
[367.539505] Starting dynamic subtest: vcs0
[368.885367] Dynamic subtest vcs0: SUCCESS (1.352s)
[368.897925] Starting dynamic subtest: vcs1
[370.868545] Dynamic subtest vcs1: SUCCESS (1.979s)
[370.880988] Starting dynamic subtest: vecs0
[372.852720] Dynamic subtest vecs0: SUCCESS (1.981s)
[372.864984] Starting dynamic subtest: ccs0
[373.029615] Dynamic subtest ccs0: SUCCESS (0.176s)
[373.032166] Subtest engines-queued: SUCCESS (5.610s)
[373.140681] [118/133] (649s left) kms_big_fb (y-tiled-addfb)
[373.243329] Starting subtest: y-tiled-addfb
[373.247472] Subtest y-tiled-addfb: SKIP (0.000s)
[373.356099] [119/133] (649s left) gem_partial_pwrite_pread (write-display)
[373.414579] Subtest write-display: SKIP (0.000s)
[373.484154] [120/133] (649s left) kms_psr (psr2-sprite-plane-move)
[373.566098] Starting subtest: psr2-sprite-plane-move
[373.568395] Starting dynamic subtest: eDP-1
[375.339555] Dynamic subtest eDP-1: SUCCESS (1.774s)
[375.341773] Subtest psr2-sprite-plane-move: SUCCESS (1.775s)
[376.179820] [121/133] (646s left) gem_close_race (multigpu-basic-threads)
[376.248844] Starting subtest: multigpu-basic-threads
[376.253591] Subtest multigpu-basic-threads: SKIP (0.000s)
[376.472355] [122/133] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[376.581162] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[376.585408] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[376.680089] [123/133] (646s left) kms_content_protection (dp-mst-type-0)
[376.814052] Starting subtest: dp-mst-type-0
[376.818814] Subtest dp-mst-type-0: SKIP (0.000s)
[376.928512] [124/133] (646s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[377.028480] Starting subtest: fbcpsr-stridechange
[383.195270] Subtest fbcpsr-stridechange: SUCCESS (6.170s)
[383.321140] [125/133] (639s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[383.414672] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[383.418798] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[383.516887] [126/133] (639s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[383.613219] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[383.615162] Starting dynamic subtest: pipe-A-eDP-1
[384.432545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.815s)
[384.441906] Starting dynamic subtest: pipe-B-eDP-1
[386.107094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.670s)
[386.117164] Starting dynamic subtest: pipe-C-eDP-1
[387.656675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.548s)
[387.667272] Starting dynamic subtest: pipe-D-eDP-1
[389.151549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.495s)
[389.153414] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.532s)
[390.351316] [127/133] (632s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[390.450859] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[390.455142] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[390.554923] [128/133] (632s left) kms_psr (psr-sprite-render)
[390.645294] Starting subtest: psr-sprite-render
[390.647607] Starting dynamic subtest: eDP-1
[392.363076] Dynamic subtest eDP-1: SUCCESS (1.718s)
[392.365408] Subtest psr-sprite-render: SUCCESS (1.719s)
[393.198075] [129/133] (630s left) syncobj_wait (wait-all-for-submit-complex)
[393.268588] Starting subtest: wait-all-for-submit-complex
[393.483986] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[393.575208] [130/133] (629s left) gem_ctx_param (invalid-param-get)
[393.639086] Starting subtest: invalid-param-get
[393.641448] Subtest invalid-param-get: SUCCESS (0.001s)
[393.749416] [131/133] (629s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[393.871472] Starting subtest: basic-flip-before-cursor-varying-size
[394.801527] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[395.625178] [132/133] (627s left) kms_chamelium_color (ctm-0-50)
[395.720110] Subtest ctm-0-50: SKIP (0.000s)
[395.763988] [133/133] (627s left) gem_ctx_param (invalid-ctx-get)
[395.816884] Starting subtest: invalid-ctx-get
[395.819245] Subtest invalid-ctx-get: SUCCESS (0.000s)
[395.900129] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: gem_unfence_active_buffers
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_legacy
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_pxp
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_fence_pin_leak
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_frames
results: parsing output: 18/ for test: gem_mmap
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_pxp
results: parsing output: 24/ for test: gem_render_copy
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_hdr
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: sw_sync
results: parsing output: 44/ for test: kms_plane_multiple
results: parsing output: 45/ for test: gem_mmap_wc
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_mmap_offset
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_create
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gen9_exec_parse
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_explicit_fence
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gen3_render_linear_blits
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_prime
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: device_reset
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_async_flips
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_color
results: parsing output: 79/ for test: kms_atomic_transition
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_exec_flush
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: template
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_selftest
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: sysfs_timeslice_duration
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: intel_hwmon
results: parsing output: 104/ for test: i915_getparams_basic
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_pipe_crc_basic
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_exercise_blt
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_ctx_param
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: gem_ctx_param
Done.