[57.553067] Initializing watchdogs
[57.553163]   /dev/watchdog0
[57.568109] [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.572846] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.575373] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.578855] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[57.710815] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[57.712805] Starting dynamic subtest: pipe-A-eDP-1
[57.770631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[57.778795] Starting dynamic subtest: pipe-B-eDP-1
[57.833454] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[57.841684] Starting dynamic subtest: pipe-C-eDP-1
[57.895763] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[57.903909] Starting dynamic subtest: pipe-D-eDP-1
[57.957532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[57.959911] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.249s)
[60.121197] [002/133] (957s left) gem_softpin (zero)
[60.183360] Starting subtest: zero
[60.187928] Subtest zero: SUCCESS (0.005s)
[60.321981] [003/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.423960] Starting subtest: invalid-modeset-ultra-joiner
[60.428183] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.486825] [004/133] (957s left) gem_unfence_active_buffers
[60.631066] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[60.735068] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[60.739367] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.832322] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[60.927583] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[60.931629] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[61.008693] [007/133] (957s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[61.115226] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[61.119054] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[61.270706] [008/133] (957s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[61.358166] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[61.360503] Starting dynamic subtest: pipe-A-eDP-1
[61.382448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[61.391326] Starting dynamic subtest: pipe-B-eDP-1
[61.406907] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.414085] Starting dynamic subtest: pipe-C-eDP-1
[61.429913] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.438706] Starting dynamic subtest: pipe-D-eDP-1
[61.454848] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.457239] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[63.589810] [009/133] (954s left) syncobj_basic (bad-flags-fd-to-handle)
[63.647790] Starting subtest: bad-flags-fd-to-handle
[63.650178] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[63.732722] [010/133] (954s left) gem_userptr_blits (set-cache-level)
[63.791043] Starting subtest: set-cache-level
[63.795661] Subtest set-cache-level: SKIP (0.000s)
[63.911711] [011/133] (954s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[64.292116] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[65.103339] [012/133] (953s left) kms_flip (modeset-vs-vblank-race)
[65.208174] Starting subtest: modeset-vs-vblank-race
[65.210813] Starting dynamic subtest: A-eDP1
[69.940146] Dynamic subtest A-eDP1: SUCCESS (4.736s)
[69.952737] Starting dynamic subtest: B-eDP1
[74.662620] Dynamic subtest B-eDP1: SUCCESS (4.719s)
[74.672672] Starting dynamic subtest: C-eDP1
[79.389572] Dynamic subtest C-eDP1: SUCCESS (4.726s)
[79.399606] Starting dynamic subtest: D-eDP1
[84.017997] Dynamic subtest D-eDP1: SUCCESS (4.628s)
[84.020339] Subtest modeset-vs-vblank-race: SUCCESS (18.817s)
[85.179843] [013/133] (933s left) gem_pxp (display-protected-crc)
[85.320657] Starting subtest: display-protected-crc
[87.121298] Subtest display-protected-crc: SUCCESS (1.804s)
[87.235350] [014/133] (931s left) kms_cursor_crc (cursor-sliding-max-size)
[87.559873] Starting subtest: cursor-sliding-max-size
[87.566652] Subtest cursor-sliding-max-size: SKIP (0.000s)
[87.689191] [015/133] (930s left) prime_vgem (wait)
[87.796285] Starting subtest: wait
[87.798581] Starting dynamic subtest: rcs0
[87.840675] Dynamic subtest rcs0: SUCCESS (0.047s)
[87.848389] Starting dynamic subtest: bcs0
[87.886264] Dynamic subtest bcs0: SUCCESS (0.045s)
[87.893773] Starting dynamic subtest: vcs0
[87.933071] Dynamic subtest vcs0: SUCCESS (0.047s)
[87.940093] Starting dynamic subtest: vcs1
[87.981119] Dynamic subtest vcs1: SUCCESS (0.047s)
[87.988248] Starting dynamic subtest: vecs0
[88.028215] Dynamic subtest vecs0: SUCCESS (0.047s)
[88.035333] Starting dynamic subtest: ccs0
[88.078667] Dynamic subtest ccs0: SUCCESS (0.050s)
[88.080482] Subtest wait: SUCCESS (0.286s)
[88.187820] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[88.190836] [016/133] (930s left) kms_fence_pin_leak
[88.364096] [017/133] (930s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[88.461119] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[88.464866] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.553121] [018/133] (930s left) kms_chamelium_frames (dp-frame-dump)
[88.934690] Subtest dp-frame-dump: SKIP (0.000s)
[89.705259] [019/133] (929s left) gem_mmap (bad-offset)
[89.765548] Subtest bad-offset: SKIP (0.000s)
[89.822156] [020/133] (928s left) kms_cursor_crc (cursor-random-128x42)
[90.062781] Starting subtest: cursor-random-128x42
[90.109792] Subtest cursor-random-128x42: SKIP (0.044s)
[90.315584] [021/133] (928s left) kms_flip (flip-vs-fences)
[90.413438] Starting subtest: flip-vs-fences
[90.417579] Subtest flip-vs-fences: SKIP (0.000s)
[90.515655] [022/133] (928s left) kms_psr (fbc-pr-sprite-plane-move)
[90.608220] Starting subtest: fbc-pr-sprite-plane-move
[90.612356] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[90.696741] [023/133] (928s left) i915_drm_fdinfo (isolation)
[90.731751] Starting subtest: isolation
[90.733698] Starting dynamic subtest: rcs0
[90.764297] Dynamic subtest rcs0: SKIP (0.031s)
[90.771921] Starting dynamic subtest: bcs0
[90.775594] Dynamic subtest bcs0: SKIP (0.000s)
[90.783050] Starting dynamic subtest: vcs0
[90.786525] Dynamic subtest vcs0: SKIP (0.000s)
[90.793789] Starting dynamic subtest: vcs1
[90.797460] Dynamic subtest vcs1: SKIP (0.000s)
[90.807223] Starting dynamic subtest: vecs0
[90.810786] Dynamic subtest vecs0: SKIP (0.000s)
[90.817611] Starting dynamic subtest: ccs0
[90.821198] Dynamic subtest ccs0: SKIP (0.000s)
[90.825240] Subtest isolation: SKIP (0.034s)
[90.858727] [024/133] (928s left) gem_pxp (reject-modify-context-protection-off-1)
[90.924103] Starting subtest: reject-modify-context-protection-off-1
[90.925807] Subtest reject-modify-context-protection-off-1: SUCCESS (0.001s)
[91.033942] [025/133] (927s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[91.104084] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[91.107895] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[91.286435] [026/133] (927s left) i915_pm_rpm (debugfs-forcewake-user)
[93.036187] Starting subtest: debugfs-forcewake-user
[104.415195] Subtest debugfs-forcewake-user: SUCCESS (11.381s)
[104.795707] [027/133] (914s left) syncobj_timeline (wait-all-for-submit-snapshot)
[104.875242] Starting subtest: wait-all-for-submit-snapshot
[104.957827] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[105.032806] [028/133] (914s left) kms_hdr (bpc-switch)
[105.136635] Starting subtest: bpc-switch
[106.168567] Starting dynamic subtest: pipe-A-eDP-1
[109.665335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[109.667722] Subtest bpc-switch: SUCCESS (4.532s)
[109.787118] [029/133] (909s left) gem_userptr_blits (unsync-unmap)
[109.864165] Subtest unsync-unmap: SKIP (0.000s)
[110.007499] [030/133] (909s left) kms_cursor_crc (cursor-onscreen-256x256)
[110.257948] Starting subtest: cursor-onscreen-256x256
[110.263256] Starting dynamic subtest: pipe-A-eDP-1
[112.370708] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s)
[112.402700] Starting dynamic subtest: pipe-D-eDP-1
[115.149481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.750s)
[115.151936] Subtest cursor-onscreen-256x256: SUCCESS (4.889s)
[116.003733] [031/133] (903s left) syncobj_timeline (device-submit-unordered)
[116.066243] Starting subtest: device-submit-unordered
[116.068148] Subtest device-submit-unordered: SUCCESS (0.000s)
[116.177845] [032/133] (903s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[116.271227] Starting subtest: fbcpsr-rgb101010-draw-blt
[123.351209] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (7.082s)
[123.471075] [033/133] (895s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[123.572988] Starting subtest: fbc-pr-cursor-plane-update-sf
[123.578479] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[123.656247] [034/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[123.754454] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[123.758571] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[123.847656] [035/133] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.950342] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[124.585320] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.637s)
[124.760462] [036/133] (894s left) api_intel_bb (purge-bb)
[124.826258] Starting subtest: purge-bb
[124.831124] Subtest purge-bb: SUCCESS (0.005s)
[124.966192] [037/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[125.071461] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[132.406209] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.338s)
[132.552827] [038/133] (886s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[132.644838] Starting subtest: psr-rgb565-draw-render
[139.670964] Subtest psr-rgb565-draw-render: SUCCESS (7.031s)
[139.807508] [039/133] (879s left) perf (create-destroy-userspace-config)
[139.965374] Starting subtest: create-destroy-userspace-config
[139.983200] Subtest create-destroy-userspace-config: SUCCESS (0.016s)
[140.037793] [040/133] (879s left) perf (missing-sample-flags)
[140.132675] Starting subtest: missing-sample-flags
[140.135090] Subtest missing-sample-flags: SUCCESS (0.000s)
[140.178257] [041/133] (879s left) gem_exec_balancer (full-late-pulse)
[140.241064] Starting subtest: full-late-pulse
[144.783257] Subtest full-late-pulse: SUCCESS (4.545s)
[145.131568] [042/133] (874s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[145.224367] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[145.228650] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[145.299020] [043/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[145.387574] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[145.392066] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[145.491840] [044/133] (874s left) sw_sync (alloc_merge_fence)
[145.531955] Starting subtest: alloc_merge_fence
[145.534377] Subtest alloc_merge_fence: SUCCESS (0.000s)
[145.589038] [045/133] (874s left) kms_plane_multiple (tiling-y)
[145.690987] Starting subtest: tiling-y
[145.694989] Subtest tiling-y: SKIP (0.000s)
[145.764821] [046/133] (874s left) gem_mmap_wc (write-gtt-read-wc)
[145.827504] Subtest write-gtt-read-wc: SKIP (0.000s)
[145.893758] [047/133] (874s left) perf (gen12-group-exclusive-stream-ctx-handle)
[145.983689] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[146.008360] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[146.045727] [048/133] (873s left) gem_mmap_offset (isolation)
[147.896040] Starting subtest: isolation
[147.914690] Subtest isolation: SUCCESS (0.007s)
[148.020452] [049/133] (871s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[148.116582] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[148.120600] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[148.209347] [050/133] (871s left) gem_ctx_create (basic)
[148.269384] Starting subtest: basic
[148.271708] Subtest basic: SUCCESS (0.000s)
[148.464384] [051/133] (871s left) syncobj_wait (wait-any-interrupted)
[148.523544] Starting subtest: wait-any-interrupted
[148.633449] Subtest wait-any-interrupted: SUCCESS (0.109s)
[148.719866] [052/133] (871s left) gen9_exec_parse (bb-large)
[148.784108] Subtest bb-large: SKIP (0.000s)
[148.858515] [053/133] (871s left) syncobj_timeline (multi-wait-signaled)
[148.918434] Starting subtest: multi-wait-signaled
[148.920764] Subtest multi-wait-signaled: SUCCESS (0.000s)
[149.017806] [054/133] (871s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[149.142767] Starting subtest: multiplane-atomic-fence-wait
[149.461935] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[150.569340] [055/133] (869s left) kms_invalid_mode (zero-vdisplay)
[150.668304] Starting subtest: zero-vdisplay
[150.670709] Starting dynamic subtest: pipe-A-eDP-1
[150.954036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[150.963394] Starting dynamic subtest: pipe-B-eDP-1
[150.965673] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.973672] Starting dynamic subtest: pipe-C-eDP-1
[150.975972] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[150.984319] Starting dynamic subtest: pipe-D-eDP-1
[150.986569] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[150.988935] Subtest zero-vdisplay: SUCCESS (0.293s)
[151.789156] [056/133] (868s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[151.893695] Starting subtest: fbc-rgb101010-draw-blt
[156.489861] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.599s)
[157.598302] [057/133] (862s left) gen3_render_linear_blits
[157.717508] [058/133] (862s left) gem_exec_reloc (basic-concurrent0)
[157.771778] Subtest basic-concurrent0: SKIP (0.000s)
[157.833648] [059/133] (862s left) syncobj_wait (multi-wait-for-submit-signaled)
[157.887422] Starting subtest: multi-wait-for-submit-signaled
[157.889638] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[157.990523] [060/133] (862s left) kms_big_fb (4-tiled-addfb-size-overflow)
[158.100147] Starting subtest: 4-tiled-addfb-size-overflow
[158.102295] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[158.199582] [061/133] (862s left) sw_sync (alloc_fence)
[158.240387] Starting subtest: alloc_fence
[158.242629] Subtest alloc_fence: SUCCESS (0.000s)
[158.293743] [062/133] (862s left) kms_prime (d3hot)
[158.375725] Subtest D3hot: SKIP (0.000s)
[158.467028] [063/133] (862s left) perf_pmu (idle-no-semaphores)
[158.511952] Starting subtest: idle-no-semaphores
[158.514059] Starting dynamic subtest: rcs0
[159.068296] Dynamic subtest rcs0: SUCCESS (0.556s)
[159.078895] Starting dynamic subtest: bcs0
[159.599083] Dynamic subtest bcs0: SUCCESS (0.528s)
[159.610345] Starting dynamic subtest: vcs0
[160.116400] Dynamic subtest vcs0: SUCCESS (0.514s)
[160.126056] Starting dynamic subtest: vcs1
[160.633128] Dynamic subtest vcs1: SUCCESS (0.514s)
[160.643944] Starting dynamic subtest: vecs0
[161.149247] Dynamic subtest vecs0: SUCCESS (0.513s)
[161.160583] Starting dynamic subtest: ccs0
[161.666129] Dynamic subtest ccs0: SUCCESS (0.514s)
[161.668934] Subtest idle-no-semaphores: SUCCESS (3.156s)
[161.799252] [064/133] (858s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[161.912963] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[161.917328] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[162.003908] [065/133] (858s left) kms_pm_dc (dc9-dpms)
[163.097202] Starting subtest: dc9-dpms
[164.519967] Subtest dc9-dpms: SUCCESS (1.425s)
[164.592928] [066/133] (856s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[164.648216] Starting subtest: legacy-engines-hostile-preempt
[164.650281] Starting dynamic subtest: render
[164.720636] Dynamic subtest render: SUCCESS (0.074s)
[164.731571] Starting dynamic subtest: bsd1
[165.907227] Dynamic subtest bsd1: SUCCESS (1.183s)
[165.922816] Starting dynamic subtest: bsd2
[167.888648] Dynamic subtest bsd2: SUCCESS (1.978s)
[167.900265] Starting dynamic subtest: blt
[167.950191] Dynamic subtest blt: SUCCESS (0.059s)
[167.960874] Starting dynamic subtest: vebox
[169.934542] Dynamic subtest vebox: SUCCESS (1.981s)
[169.937611] Subtest legacy-engines-hostile-preempt: SUCCESS (5.288s)
[170.023904] [067/133] (850s left) gem_userptr_blits (create-destroy-sync)
[170.101640] Starting subtest: create-destroy-sync
[175.111679] Subtest create-destroy-sync: SUCCESS (5.009s)
[175.252470] [068/133] (845s left) kms_cursor_legacy (torture-move)
[175.366883] Starting subtest: torture-move
[175.369077] Starting dynamic subtest: pipe-A
[181.828658] Dynamic subtest pipe-A: SUCCESS (6.458s)
[181.841875] Starting dynamic subtest: pipe-B
[188.341137] Dynamic subtest pipe-B: SUCCESS (6.511s)
[188.352104] Starting dynamic subtest: pipe-C
[194.994894] Dynamic subtest pipe-C: SUCCESS (6.653s)
[195.010287] Starting dynamic subtest: pipe-D
[202.508435] Dynamic subtest pipe-D: SUCCESS (7.512s)
[202.517874] Starting dynamic subtest: all-pipes
[209.092814] Dynamic subtest all-pipes: SUCCESS (6.580s)
[209.095836] Subtest torture-move: SUCCESS (33.723s)
[209.252287] [069/133] (811s left) device_reset (cold-reset-bound)
[209.318151] Starting subtest: cold-reset-bound
[209.322066] Subtest cold-reset-bound: SKIP (0.000s)
[209.387317] [070/133] (811s left) syncobj_timeline (etime-multi-wait-submitted)
[209.435094] Starting subtest: etime-multi-wait-submitted
[209.535830] Subtest etime-multi-wait-submitted: SUCCESS (0.101s)
[209.616582] [071/133] (811s left) kms_async_flips (invalid-async-flip-atomic)
[209.719992] Starting subtest: invalid-async-flip-atomic
[210.094838] Starting dynamic subtest: pipe-A-eDP-1
[210.878613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[211.238788] Starting dynamic subtest: pipe-B-eDP-1
[212.026524] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.794s)
[212.393300] Starting dynamic subtest: pipe-C-eDP-1
[213.242165] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.857s)
[213.602935] Starting dynamic subtest: pipe-D-eDP-1
[214.373974] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[214.376391] Subtest invalid-async-flip-atomic: SUCCESS (4.656s)
[215.518551] [072/133] (805s left) gem_exec_schedule (preempt-hang)
[215.704822] Starting subtest: preempt-hang
[215.707204] Starting dynamic subtest: rcs0
[215.940653] Dynamic subtest rcs0: SUCCESS (0.237s)
[215.949092] Starting dynamic subtest: bcs0
[216.187073] Dynamic subtest bcs0: SUCCESS (0.246s)
[216.195330] Starting dynamic subtest: vcs0
[216.445876] Dynamic subtest vcs0: SUCCESS (0.255s)
[216.455663] Starting dynamic subtest: vcs1
[216.680887] Dynamic subtest vcs1: SUCCESS (0.236s)
[216.692883] Starting dynamic subtest: vecs0
[216.908932] Dynamic subtest vecs0: SUCCESS (0.227s)
[216.921350] Starting dynamic subtest: ccs0
[217.148854] Dynamic subtest ccs0: SUCCESS (0.237s)
[217.151105] Subtest preempt-hang: SUCCESS (1.447s)
[218.021537] [073/133] (803s left) gem_mmap (basic-small-bo)
[218.088495] Subtest basic-small-bo: SKIP (0.000s)
[218.147829] [074/133] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[218.243036] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[218.247233] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[218.339248] [075/133] (802s left) kms_plane (plane-position-covered)
[218.429518] Starting subtest: plane-position-covered
[218.969259] Starting dynamic subtest: pipe-A-plane-1
[220.216096] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s)
[220.224558] Starting dynamic subtest: pipe-A-plane-2
[221.471054] Dynamic subtest pipe-A-plane-2: SUCCESS (1.254s)
[221.479932] Starting dynamic subtest: pipe-A-plane-3
[222.817628] Dynamic subtest pipe-A-plane-3: SUCCESS (1.346s)
[222.826554] Starting dynamic subtest: pipe-A-plane-4
[224.142492] Dynamic subtest pipe-A-plane-4: SUCCESS (1.325s)
[224.151153] Starting dynamic subtest: pipe-A-plane-5
[224.169336] Dynamic subtest pipe-A-plane-5: SUCCESS (0.026s)
[225.372875] Starting dynamic subtest: pipe-B-plane-1
[226.708407] Dynamic subtest pipe-B-plane-1: SUCCESS (1.342s)
[226.717871] Starting dynamic subtest: pipe-B-plane-2
[228.022149] Dynamic subtest pipe-B-plane-2: SUCCESS (1.312s)
[228.031679] Starting dynamic subtest: pipe-B-plane-3
[229.335829] Dynamic subtest pipe-B-plane-3: SUCCESS (1.313s)
[229.344369] Starting dynamic subtest: pipe-B-plane-4
[230.601699] Dynamic subtest pipe-B-plane-4: SUCCESS (1.264s)
[230.612271] Starting dynamic subtest: pipe-B-plane-5
[230.640248] Dynamic subtest pipe-B-plane-5: SUCCESS (0.037s)
[230.642615] Subtest plane-position-covered: SUCCESS (12.211s)
[231.459831] [076/133] (789s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[231.581312] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[231.585310] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[231.652265] [077/133] (789s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[231.741955] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[231.744582] Starting dynamic subtest: pipe-A-eDP-1
[231.753793] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[231.765103] Starting dynamic subtest: pipe-B-eDP-1
[231.773753] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[231.782062] Starting dynamic subtest: pipe-C-eDP-1
[231.790314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[231.798486] Starting dynamic subtest: pipe-D-eDP-1
[231.806843] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[231.811077] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[234.020296] [078/133] (787s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[234.122759] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[234.125217] Starting dynamic subtest: pipe-A
[234.144959] Dynamic subtest pipe-A: SKIP (0.018s)
[234.154061] Starting dynamic subtest: pipe-B
[234.177520] Dynamic subtest pipe-B: SKIP (0.032s)
[234.186410] Starting dynamic subtest: pipe-C
[234.207415] Dynamic subtest pipe-C: SKIP (0.031s)
[234.216121] Starting dynamic subtest: pipe-D
[234.239109] Dynamic subtest pipe-D: SKIP (0.031s)
[234.242915] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.116s)
[234.340454] [079/133] (786s left) kms_color (deep-color)
[234.428983] Starting subtest: deep-color
[235.491689] Starting dynamic subtest: pipe-A-eDP-1-gamma
[236.251088] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.759s)
[236.259527] Starting dynamic subtest: pipe-A-eDP-1-degamma
[237.687218] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.436s)
[237.695691] Starting dynamic subtest: pipe-A-eDP-1-ctm
[239.088468] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.398s)
[239.878478] Starting dynamic subtest: pipe-B-eDP-1-gamma
[240.584893] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.710s)
[240.594251] Starting dynamic subtest: pipe-B-eDP-1-degamma
[242.077355] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.492s)
[242.085986] Starting dynamic subtest: pipe-B-eDP-1-ctm
[243.502616] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.424s)
[244.265579] Starting dynamic subtest: pipe-C-eDP-1-gamma
[244.956612] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.697s)
[244.967158] Starting dynamic subtest: pipe-C-eDP-1-degamma
[246.337334] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.376s)
[246.346644] Starting dynamic subtest: pipe-C-eDP-1-ctm
[247.755174] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.420s)
[248.570270] Starting dynamic subtest: pipe-D-eDP-1-gamma
[249.269698] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.705s)
[249.278411] Starting dynamic subtest: pipe-D-eDP-1-degamma
[250.733461] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.463s)
[250.743264] Starting dynamic subtest: pipe-D-eDP-1-ctm
[252.152410] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.418s)
[252.154801] Subtest deep-color: SUCCESS (17.724s)
[253.010099] [080/133] (768s left) kms_atomic_transition (plane-all-transition-nonblocking)
[253.100979] Starting subtest: plane-all-transition-nonblocking
[253.103311] Starting dynamic subtest: pipe-A-eDP-1
[255.594555] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[255.910421] Starting dynamic subtest: pipe-B-eDP-1
[259.144335] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.249s)
[259.448828] Subtest plane-all-transition-nonblocking: SUCCESS (6.347s)
[260.267682] [081/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[260.378932] Starting subtest: psr-2p-primscrn-cur-indfb-move
[260.383400] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[260.481525] [082/133] (760s left) i915_query (engine-info-invalid)
[260.537051] Starting subtest: engine-info-invalid
[260.539262] Subtest engine-info-invalid: SUCCESS (0.000s)
[260.643015] [083/133] (760s left) kms_rotation_crc (sprite-rotation-90)
[260.728111] Starting subtest: sprite-rotation-90
[260.732512] Subtest sprite-rotation-90: SKIP (0.001s)
[260.799064] [084/133] (760s left) gem_userptr_blits (coherency-sync)
[260.860307] Starting subtest: coherency-sync
[261.229820] Subtest coherency-sync: SKIP (0.331s)
[261.318551] [085/133] (760s left) api_intel_allocator (default-alignment)
[261.413567] Starting subtest: default-alignment
[261.415991] Subtest default-alignment: SUCCESS (0.003s)
[261.542052] [086/133] (760s left) kms_psr (pr-cursor-render)
[261.647809] Starting subtest: pr-cursor-render
[261.652065] Subtest pr-cursor-render: SKIP (0.000s)
[261.723577] [087/133] (759s left) gem_exec_flush (basic-wb-pro-default)
[261.789561] Starting subtest: basic-wb-pro-default
[267.260229] Subtest basic-wb-pro-default: SUCCESS (5.470s)
[267.447901] [088/133] (754s left) gem_eio (kms)
[267.740800] Starting subtest: kms
[286.321694] Subtest kms: SUCCESS (18.578s)
[286.447192] [089/133] (735s left) template (a)
[286.511077] Starting subtest: A
[286.512910] Subtest A: SUCCESS (0.000s)
[286.621794] [090/133] (735s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[286.730950] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[286.733216] Starting dynamic subtest: pipe-A-default-mode
[289.498480] Dynamic subtest pipe-A-default-mode: SUCCESS (2.765s)
[289.500790] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.768s)
[290.368407] [091/133] (731s left) gem_exec_schedule (semaphore-noskip)
[290.439509] Starting subtest: semaphore-noskip
[290.865568] Subtest semaphore-noskip: SUCCESS (0.433s)
[291.211857] [092/133] (730s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[291.330600] Starting subtest: basic-flip-before-cursor-legacy
[292.250025] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.917s)
[293.100333] [093/133] (728s left) fbdev (write)
[293.150392] Starting subtest: write
[293.514400] Subtest write: SUCCESS (0.362s)
[293.578817] [094/133] (728s left) kms_flip (2x-blocking-absolute-wf_vblank)
[293.668237] Starting subtest: 2x-blocking-absolute-wf_vblank
[293.677560] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[293.754800] [095/133] (728s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[293.814616] Starting subtest: multi-wait-for-submit-unsubmitted
[293.921035] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[293.997693] [096/133] (727s left) kms_big_fb (x-tiled-addfb)
[294.094202] Starting subtest: x-tiled-addfb
[294.096382] Subtest x-tiled-addfb: SUCCESS (0.000s)
[294.193680] [097/133] (727s left) kms_selftest (drm_cmdline_parser)
[294.234529] Starting subtest: drm_cmdline_parser
[294.248281] Starting dynamic subtest: drm_test_cmdline_force_d_only
[294.347117] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.098s)
[294.357295] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[294.440239] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.092s)
[294.451337] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[294.544259] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.104s)
[294.555044] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[294.622992] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.078s)
[294.635994] Starting dynamic subtest: drm_test_cmdline_force_e_only
[294.713412] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.089s)
[294.724082] Starting dynamic subtest: drm_test_cmdline_res
[294.822130] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.108s)
[294.832314] Starting dynamic subtest: drm_test_cmdline_res_vesa
[294.917083] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s)
[294.926324] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[295.013630] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.097s)
[295.022315] Starting dynamic subtest: drm_test_cmdline_res_rblank
[295.133288] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.121s)
[295.142116] Starting dynamic subtest: drm_test_cmdline_res_bpp
[295.229070] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s)
[295.239165] Starting dynamic subtest: drm_test_cmdline_res_refresh
[295.317607] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.088s)
[295.328935] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[295.421193] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.103s)
[295.429756] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[295.515922] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.094s)
[295.524537] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[295.602747] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.086s)
[295.611771] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[295.691480] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.088s)
[295.699894] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[295.792374] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.099s)
[295.802720] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[295.894680] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.102s)
[295.904777] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[295.995407] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.101s)
[296.004057] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[296.089588] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.093s)
[296.099569] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[296.193252] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.103s)
[296.203447] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[296.314893] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.119s)
[296.325461] Starting dynamic subtest: drm_test_cmdline_name
[296.410410] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.095s)
[296.420789] Starting dynamic subtest: drm_test_cmdline_name_bpp
[296.502328] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.092s)
[296.512759] Starting dynamic subtest: drm_test_cmdline_name_option
[296.590027] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.086s)
[296.600356] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[296.684949] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.094s)
[296.695597] Starting dynamic subtest: drm_test_cmdline_rotate_0
[296.780938] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.094s)
[296.789985] Starting dynamic subtest: drm_test_cmdline_rotate_90
[296.868132] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.086s)
[296.877062] Starting dynamic subtest: drm_test_cmdline_rotate_180
[296.958323] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.090s)
[296.967128] Starting dynamic subtest: drm_test_cmdline_rotate_270
[297.046969] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.087s)
[297.055885] Starting dynamic subtest: drm_test_cmdline_hmirror
[297.141343] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.095s)
[297.150157] Starting dynamic subtest: drm_test_cmdline_vmirror
[297.243093] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.100s)
[297.252613] Starting dynamic subtest: drm_test_cmdline_margin_options
[297.340501] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.098s)
[297.349440] Starting dynamic subtest: drm_test_cmdline_multiple_options
[297.416728] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.075s)
[297.425431] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[297.495836] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.078s)
[297.504587] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[297.605343] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.108s)
[297.613909] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[297.690816] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.086s)
[297.699618] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[297.786510] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.094s)
[297.795344] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[297.881907] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.095s)
[297.890338] Starting dynamic subtest: drm_test_cmdline_invalid
[297.987140] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.105s)
[297.995766] Starting dynamic subtest: drm_test_cmdline_tv_options
[298.087938] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.100s)
[298.089751] Subtest drm_cmdline_parser: SUCCESS (3.852s)
[298.263567] [098/133] (723s left) gem_exec_balancer (sequential)
[298.321501] Starting subtest: sequential
[301.418395] Subtest sequential: SUCCESS (3.096s)
[301.731155] [099/133] (720s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[301.827727] Starting subtest: fbc-psr2-sprite-mmap-cpu
[301.829936] Starting dynamic subtest: eDP-1
[301.834046] Dynamic subtest eDP-1: SKIP (0.000s)
[301.838201] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[301.917084] [100/133] (720s left) gem_exec_fence (nb-await)
[302.093043] Starting subtest: nb-await
[302.095252] Starting dynamic subtest: rcs0
[302.158512] Dynamic subtest rcs0: SUCCESS (0.068s)
[302.172695] Starting dynamic subtest: bcs0
[302.218859] Dynamic subtest bcs0: SUCCESS (0.057s)
[302.232852] Starting dynamic subtest: vcs0
[302.282784] Dynamic subtest vcs0: SUCCESS (0.061s)
[302.294261] Starting dynamic subtest: vcs1
[302.341711] Dynamic subtest vcs1: SUCCESS (0.057s)
[302.352539] Starting dynamic subtest: vecs0
[302.399866] Dynamic subtest vecs0: SUCCESS (0.057s)
[302.411728] Starting dynamic subtest: ccs0
[302.458964] Dynamic subtest ccs0: SUCCESS (0.056s)
[302.461793] Subtest nb-await: SUCCESS (0.369s)
[303.985997] [101/133] (718s left) sysfs_timeslice_duration (idempotent)
[304.052292] Starting subtest: idempotent
[304.054528] Starting dynamic subtest: vecs0
[304.056636] Dynamic subtest vecs0: SUCCESS (0.000s)
[304.066802] Starting dynamic subtest: ccs0
[304.068942] Dynamic subtest ccs0: SUCCESS (0.000s)
[304.077995] Starting dynamic subtest: vcs0
[304.080133] Dynamic subtest vcs0: SUCCESS (0.000s)
[304.089012] Starting dynamic subtest: bcs0
[304.091092] Dynamic subtest bcs0: SUCCESS (0.000s)
[304.100290] Starting dynamic subtest: rcs0
[304.102135] Dynamic subtest rcs0: SUCCESS (0.000s)
[304.111393] Starting dynamic subtest: vcs1
[304.113568] Dynamic subtest vcs1: SUCCESS (0.000s)
[304.115753] Subtest idempotent: SUCCESS (0.007s)
[304.154319] [102/133] (718s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[304.252095] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[304.256306] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[304.345758] [103/133] (717s left) gem_exec_store (basic)
[304.412205] Starting subtest: basic
[304.525151] Subtest basic: SUCCESS (0.114s)
[304.709897] [104/133] (717s left) intel_hwmon (hwmon-read)
[304.761354] Subtest hwmon-read: SKIP (0.000s)
[304.819711] [105/133] (717s left) i915_getparams_basic (basic-eu-total)
[304.884041] Starting subtest: basic-eu-total
[304.888719] Subtest basic-eu-total: SUCCESS (0.000s)
[304.978702] [106/133] (717s left) kms_big_fb (linear-16bpp-rotate-90)
[305.076413] Starting subtest: linear-16bpp-rotate-90
[305.095627] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[305.210052] [107/133] (717s left) kms_vblank (query-forked-busy)
[305.298069] Starting subtest: query-forked-busy
[305.299941] Starting dynamic subtest: pipe-A-eDP-1
[307.175303] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[307.189319] Starting dynamic subtest: pipe-D-eDP-1
[309.744788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[309.747091] Subtest query-forked-busy: SUCCESS (4.447s)
[310.555921] [108/133] (711s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[310.648754] Starting subtest: nonblocking-crc-frame-sequence
[310.650908] Starting dynamic subtest: pipe-A-eDP-1
[311.421832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.773s)
[311.431856] Starting dynamic subtest: pipe-B-eDP-1
[312.872634] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.449s)
[312.883286] Starting dynamic subtest: pipe-C-eDP-1
[314.266959] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[314.277757] Starting dynamic subtest: pipe-D-eDP-1
[315.613468] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[315.615787] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.966s)
[316.413229] [109/133] (706s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[316.529752] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[316.531965] Starting dynamic subtest: pipe-A-eDP-1
[322.365448] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.837s)
[322.375668] Starting dynamic subtest: pipe-B-eDP-1
[329.045300] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.679s)
[329.047749] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.520s)
[329.927944] [110/133] (692s left) kms_flip (2x-plain-flip-interruptible)
[330.033807] Starting subtest: 2x-plain-flip-interruptible
[330.046707] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[330.125564] [111/133] (692s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[330.225188] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[330.227424] Starting dynamic subtest: pipe-A-eDP-1
[341.207749] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.987s)
[341.219840] Starting dynamic subtest: pipe-B-eDP-1
[352.948690] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.737s)
[352.951131] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.727s)
[353.798904] [112/133] (668s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[353.891032] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[353.893315] Starting dynamic subtest: pipe-A-eDP-1
[354.483448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[354.495227] Starting dynamic subtest: pipe-B-eDP-1
[355.944977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.462s)
[355.955340] Starting dynamic subtest: pipe-C-eDP-1
[357.313373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.364s)
[357.324532] Starting dynamic subtest: pipe-D-eDP-1
[358.631074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[358.633041] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.714s)
[359.805180] [113/133] (662s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[359.930806] Starting subtest: cursorB-vs-flipA-varying-size
[359.935219] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[360.087725] [114/133] (662s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[360.187680] Starting subtest: pipe-fbc-rte
[360.194616] Starting dynamic subtest: pipe-B-eDP-1
[365.722427] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.539s)
[365.729634] Subtest pipe-fbc-rte: SUCCESS (5.541s)
[368.061349] [115/133] (654s left) syncobj_timeline (invalid-query-bad-pad)
[368.125696] Starting subtest: invalid-query-bad-pad
[368.128084] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[368.216755] [116/133] (654s left) gem_exercise_blt (fast-copy-emit)
[368.273769] Starting subtest: fast-copy-emit
[368.276171] Starting dynamic subtest: linear-smem-smem-emit
[368.296770] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.023s)
[368.308223] Starting dynamic subtest: xmajor-smem-smem-emit
[368.314464] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[368.325512] Starting dynamic subtest: tile4-smem-smem-emit
[368.332239] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[368.341555] Starting dynamic subtest: tile64-smem-smem-emit
[368.349173] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[368.351329] Subtest fast-copy-emit: SUCCESS (0.076s)
[368.465288] [117/133] (654s left) gem_ctx_persistence (engines-queued)
[368.524536] Starting subtest: engines-queued
[368.526661] Starting dynamic subtest: rcs0
[368.581437] Dynamic subtest rcs0: SUCCESS (0.056s)
[368.593258] Starting dynamic subtest: bcs0
[368.602302] Dynamic subtest bcs0: SUCCESS (0.019s)
[368.611362] Starting dynamic subtest: vcs0
[369.907477] Dynamic subtest vcs0: SUCCESS (1.302s)
[369.920427] Starting dynamic subtest: vcs1
[371.891275] Dynamic subtest vcs1: SUCCESS (1.982s)
[371.904564] Starting dynamic subtest: vecs0
[373.875586] Dynamic subtest vecs0: SUCCESS (1.981s)
[373.888920] Starting dynamic subtest: ccs0
[374.053787] Dynamic subtest ccs0: SUCCESS (0.177s)
[374.056371] Subtest engines-queued: SUCCESS (5.529s)
[374.185133] [118/133] (648s left) kms_big_fb (y-tiled-addfb)
[374.289087] Starting subtest: y-tiled-addfb
[374.293230] Subtest y-tiled-addfb: SKIP (0.000s)
[374.386450] [119/133] (648s left) gem_partial_pwrite_pread (write-display)
[374.452752] Subtest write-display: SKIP (0.000s)
[374.533022] [120/133] (648s left) kms_psr (psr2-sprite-plane-move)
[374.619679] Starting subtest: psr2-sprite-plane-move
[374.621994] Starting dynamic subtest: eDP-1
[376.390379] Dynamic subtest eDP-1: SUCCESS (1.769s)
[376.392359] Subtest psr2-sprite-plane-move: SUCCESS (1.770s)
[377.221456] [121/133] (645s left) gem_close_race (multigpu-basic-threads)
[377.284385] Starting subtest: multigpu-basic-threads
[377.289047] Subtest multigpu-basic-threads: SKIP (0.000s)
[377.509264] [122/133] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[377.604663] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[377.609178] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[377.696891] [123/133] (645s left) kms_content_protection (dp-mst-type-0)
[377.840438] Starting subtest: dp-mst-type-0
[377.845142] Subtest dp-mst-type-0: SKIP (0.000s)
[377.969266] [124/133] (645s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[378.065262] Starting subtest: fbcpsr-stridechange
[384.286362] Subtest fbcpsr-stridechange: SUCCESS (6.223s)
[384.422760] [125/133] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[384.520761] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[384.525214] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[384.619055] [126/133] (638s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[384.717818] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[384.720065] Starting dynamic subtest: pipe-A-eDP-1
[385.517116] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.791s)
[385.531503] Starting dynamic subtest: pipe-B-eDP-1
[387.152076] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.632s)
[387.162355] Starting dynamic subtest: pipe-C-eDP-1
[388.697122] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.545s)
[388.707415] Starting dynamic subtest: pipe-D-eDP-1
[390.202871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.503s)
[390.204795] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.476s)
[391.386562] [127/133] (631s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[391.484097] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[391.488549] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[391.589160] [128/133] (631s left) kms_psr (psr-sprite-render)
[391.680031] Starting subtest: psr-sprite-render
[391.682313] Starting dynamic subtest: eDP-1
[393.393469] Dynamic subtest eDP-1: SUCCESS (1.713s)
[393.395744] Subtest psr-sprite-render: SUCCESS (1.714s)
[394.236598] [129/133] (629s left) syncobj_wait (wait-all-for-submit-complex)
[394.303294] Starting subtest: wait-all-for-submit-complex
[394.516971] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[394.592009] [130/133] (628s left) gem_ctx_param (invalid-param-get)
[394.652177] Starting subtest: invalid-param-get
[394.654428] Subtest invalid-param-get: SUCCESS (0.001s)
[394.740327] [131/133] (628s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[394.852293] Starting subtest: basic-flip-before-cursor-varying-size
[395.792523] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.939s)
[396.676431] [132/133] (626s left) kms_chamelium_color (ctm-0-50)
[396.781079] Subtest ctm-0-50: SKIP (0.000s)
[396.828488] [133/133] (626s left) gem_ctx_param (invalid-ctx-get)
[396.874832] Starting subtest: invalid-ctx-get
[396.877253] Subtest invalid-ctx-get: SUCCESS (0.000s)
[396.951150] 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.