[56.724019] Initializing watchdogs
[56.724070]   /dev/watchdog0
[56.741466] [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]
[56.745971] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.748461] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.751968] [001/133] (960s left) kms_dsc (dsc-with-bpc-formats)
[56.878445] Starting subtest: dsc-with-bpc-formats
[56.989453] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[57.024098] [002/133] (960s left) gem_eio (in-flight-contexts-1us)
[57.174150] Starting subtest: in-flight-contexts-1us
[65.305801] Subtest in-flight-contexts-1us: SUCCESS (8.163s)
[65.438681] [003/133] (951s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[65.530497] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[65.532880] Starting dynamic subtest: pipe-A-eDP-1
[65.556242] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[65.566924] Starting dynamic subtest: pipe-B-eDP-1
[65.589041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[65.596795] Starting dynamic subtest: pipe-C-eDP-1
[65.618721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[65.627108] Starting dynamic subtest: pipe-D-eDP-1
[65.649456] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[65.653571] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[67.791131] [004/133] (949s left) gem_exec_alignment (pi-isolated)
[67.862978] Starting subtest: pi-isolated
[119.960325] Subtest pi-isolated: SUCCESS (52.108s)
[120.098819] [005/133] (897s left) kms_flip (plain-flip-fb-recreate-interruptible)
[120.252176] Starting subtest: plain-flip-fb-recreate-interruptible
[120.254538] Starting dynamic subtest: A-eDP1
[129.164055] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[129.175205] Starting dynamic subtest: B-eDP1
[137.985340] Dynamic subtest B-eDP1: SUCCESS (8.819s)
[137.996442] Starting dynamic subtest: C-eDP1
[146.802734] Dynamic subtest C-eDP1: SUCCESS (8.816s)
[146.811153] Starting dynamic subtest: D-eDP1
[155.617492] Dynamic subtest D-eDP1: SUCCESS (8.813s)
[155.621620] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.371s)
[156.787949] [006/133] (860s left) kms_pm_rpm (modeset-lpsp)
[158.416767] Starting subtest: modeset-lpsp
[159.874372] Subtest modeset-lpsp: SUCCESS (1.461s)
[159.997742] [007/133] (857s left) syncobj_timeline (invalid-signal-illegal-point)
[160.081886] Starting subtest: invalid-signal-illegal-point
[160.083949] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[160.193847] [008/133] (857s left) kms_dp_link_training (uhbr-mst)
[160.287105] Starting subtest: uhbr-mst
[160.295862] Subtest uhbr-mst: SKIP (0.000s)
[160.378612] [009/133] (857s left) syncobj_timeline (single-wait-available-signaled)
[160.432906] Starting subtest: single-wait-available-signaled
[160.435323] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[160.560416] [010/133] (857s left) kms_vblank (wait-busy-hang)
[160.654764] Starting subtest: wait-busy-hang
[160.657031] Starting dynamic subtest: pipe-A-eDP-1
[187.069523] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.413s)
[187.084197] Starting dynamic subtest: pipe-D-eDP-1
[202.056483] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.985s)
[202.058736] Subtest wait-busy-hang: SUCCESS (41.402s)
[202.905735] [011/133] (814s left) kms_flip (2x-flip-vs-rmfb)
[203.011487] Starting subtest: 2x-flip-vs-rmfb
[203.023174] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[203.111128] [012/133] (814s left) syncobj_timeline (32bits-limit)
[203.177816] Starting subtest: 32bits-limit
[203.180092] Subtest 32bits-limit: SUCCESS (0.001s)
[203.296579] [013/133] (814s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[203.360638] Starting subtest: invalid-bsd2-flag-on-vebox
[203.362558] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[203.459052] [014/133] (814s left) kms_plane_scaling (2x-scaler-multi-pipe)
[203.567599] Starting subtest: 2x-scaler-multi-pipe
[203.572436] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[203.676479] [015/133] (814s left) kms_frontbuffer_tracking (fbc-1p-rte)
[203.789365] Starting subtest: fbc-1p-rte
[209.313911] Subtest fbc-1p-rte: SUCCESS (5.530s)
[210.452820] [016/133] (807s left) i915_drm_fdinfo (virtual-idle)
[210.506423] Starting subtest: virtual-idle
[213.572096] Subtest virtual-idle: SUCCESS (3.065s)
[213.653472] [017/133] (804s left) gem_lmem_swapping (heavy-random)
[213.696355] Subtest heavy-random: SKIP (0.000s)
[213.742833] [018/133] (804s left) kms_plane (pixel-format-linear-modifier)
[213.848706] Starting subtest: pixel-format-linear-modifier
[213.876066] Starting dynamic subtest: pipe-A-plane-0
[217.530474] Dynamic subtest pipe-A-plane-0: SUCCESS (3.655s)
[217.542061] Starting dynamic subtest: pipe-A-plane-3
[219.208304] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[219.218487] Starting dynamic subtest: pipe-A-plane-5
[219.419464] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[220.526835] Starting dynamic subtest: pipe-B-plane-0
[224.051038] Dynamic subtest pipe-B-plane-0: SUCCESS (3.533s)
[224.060378] Starting dynamic subtest: pipe-B-plane-3
[225.806729] Dynamic subtest pipe-B-plane-3: SUCCESS (1.755s)
[225.816054] Starting dynamic subtest: pipe-B-plane-5
[226.017925] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[226.326244] Subtest pixel-format-linear-modifier: SUCCESS (12.479s)
[227.195912] [019/133] (790s left) sw_sync (sync_merge)
[227.240776] Starting subtest: sync_merge
[227.243117] Subtest sync_merge: SUCCESS (0.000s)
[227.310779] [020/133] (790s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[227.401223] Starting subtest: fbc-farfromfence-mmap-gtt
[227.405216] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[227.496338] [021/133] (790s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[227.555716] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[227.560168] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[227.731462] [022/133] (790s left) drm_read (short-buffer-wakeup)
[227.866672] Starting subtest: short-buffer-wakeup
[260.080958] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[260.237251] [023/133] (757s left) gem_exec_schedule (u-semaphore-noskip)
[260.312451] Starting subtest: u-semaphore-noskip
[260.710685] Subtest u-semaphore-noskip: SUCCESS (0.405s)
[261.039747] [024/133] (757s left) i915_pm_rpm (system-suspend-execbuf)
[262.565296] Starting subtest: system-suspend-execbuf
[321.811001] Subtest system-suspend-execbuf: SUCCESS (43.939s)
[322.179190] [025/133] (696s left) gem_exec_fence (submit67)
[322.354490] Starting subtest: submit67
[322.359335] Subtest submit67: SKIP (0.000s)
[323.765223] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[323.769368] [026/133] (694s left) gem_ccs (ctrl-surf-copy-new-ctx)
[323.833589] Starting subtest: ctrl-surf-copy-new-ctx
[323.837772] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[323.934102] [027/133] (694s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[324.036341] Starting subtest: x-tiled-8bpp-rotate-270
[324.058655] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[324.185526] [028/133] (694s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[324.282518] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[324.284780] Starting dynamic subtest: pipe-A-eDP-1
[324.307769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[324.320034] Starting dynamic subtest: pipe-B-eDP-1
[324.342138] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[324.351630] Starting dynamic subtest: pipe-C-eDP-1
[324.372666] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[324.381989] Starting dynamic subtest: pipe-D-eDP-1
[324.403774] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[324.407741] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[326.459260] [029/133] (691s left) prime_mmap (test_correct_cpu_write)
[326.521507] Starting subtest: test_correct_cpu_write
[326.523798] Starting dynamic subtest: test_correct_cpu_write-smem
[326.526135] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[326.528395] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[326.613743] [030/133] (691s left) kms_big_fb (linear-32bpp-rotate-0)
[326.729203] Starting subtest: linear-32bpp-rotate-0
[328.273766] Subtest linear-32bpp-rotate-0: SUCCESS (1.546s)
[328.405324] [031/133] (690s left) gem_readwrite (read-bad-handle)
[328.455428] Subtest read-bad-handle: SKIP (0.000s)
[328.515165] [032/133] (689s left) kms_flip (bo-too-big-interruptible)
[328.603423] Starting subtest: bo-too-big-interruptible
[328.605446] Starting dynamic subtest: A-eDP1
[329.899658] Dynamic subtest A-eDP1: SUCCESS (1.294s)
[329.914174] Starting dynamic subtest: B-eDP1
[331.127152] Dynamic subtest B-eDP1: SUCCESS (1.226s)
[331.138257] Starting dynamic subtest: C-eDP1
[332.363417] Dynamic subtest C-eDP1: SUCCESS (1.236s)
[332.373833] Starting dynamic subtest: D-eDP1
[333.690131] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[333.695137] Subtest bo-too-big-interruptible: SUCCESS (5.091s)
[334.912678] [033/133] (683s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[335.013633] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[335.015952] Starting dynamic subtest: pipe-A-eDP-1
[335.072012] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[335.081347] Starting dynamic subtest: pipe-B-eDP-1
[335.138243] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[335.149381] Starting dynamic subtest: pipe-C-eDP-1
[335.205794] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[335.216656] Starting dynamic subtest: pipe-D-eDP-1
[335.273768] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[335.278003] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[337.270312] [034/133] (681s left) gem_mmap_offset (basic-uaf)
[337.334967] Starting subtest: basic-uaf
[337.337018] Subtest basic-uaf: SUCCESS (0.001s)
[337.445042] [035/133] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[337.538560] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[337.542743] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[337.636847] [036/133] (681s left) gem_tiled_blits (basic)
[337.690975] Subtest basic: SKIP (0.000s)
[337.759333] [037/133] (680s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[337.868810] Starting subtest: pr-cursor-plane-update-sf
[337.873137] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[337.934500] [038/133] (680s left) kms_chamelium_color (ctm-0-50)
[338.023559] Subtest ctm-0-50: SKIP (0.000s)
[338.072166] [039/133] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[338.169714] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[342.599440] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.434s)
[343.761209] [040/133] (675s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[343.855588] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[343.857853] Starting dynamic subtest: pipe-A-eDP-1
[343.880289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[343.890143] Starting dynamic subtest: pipe-B-eDP-1
[343.911313] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[343.920681] Starting dynamic subtest: pipe-C-eDP-1
[343.941688] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[343.951258] Starting dynamic subtest: pipe-D-eDP-1
[343.972105] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[343.976232] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[346.024824] [041/133] (672s left) vgem_basic (sysfs)
[346.075187] Starting subtest: sysfs
[346.077065] Subtest sysfs: SUCCESS (0.000s)
[346.139445] [042/133] (672s left) perf_pmu (busy-double-start)
[346.183147] Starting subtest: busy-double-start
[346.185556] Starting dynamic subtest: rcs0
[349.823682] Dynamic subtest rcs0: FAIL (3.586s)
[349.834571] Starting dynamic subtest: bcs0
[353.335160] Dynamic subtest bcs0: SUCCESS (3.567s)
[353.347070] Starting dynamic subtest: vcs0
[357.206305] Dynamic subtest vcs0: SUCCESS (3.870s)
[357.218482] Starting dynamic subtest: vcs1
[361.176123] Dynamic subtest vcs1: SUCCESS (3.969s)
[361.188280] Starting dynamic subtest: vecs0
[365.227180] Dynamic subtest vecs0: SUCCESS (4.051s)
[365.240593] Starting dynamic subtest: ccs0
[368.861451] Dynamic subtest ccs0: FAIL (3.566s)
[368.863405] Subtest busy-double-start: FAIL (22.618s)
[368.903778] [043/133] (650s left) gem_mmap_gtt (cpuset-basic-small-copy)
[368.964962] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[369.029512] [044/133] (649s left) perf_pmu (init-wait)
[369.082621] Starting subtest: init-wait
[369.084947] Starting dynamic subtest: rcs0
[369.087303] Dynamic subtest rcs0: SUCCESS (0.002s)
[369.098939] Starting dynamic subtest: bcs0
[369.100822] Dynamic subtest bcs0: SUCCESS (0.000s)
[369.112427] Starting dynamic subtest: vcs0
[369.114312] Dynamic subtest vcs0: SUCCESS (0.001s)
[369.124376] Starting dynamic subtest: vcs1
[369.126559] Dynamic subtest vcs1: SUCCESS (0.001s)
[369.136569] Starting dynamic subtest: vecs0
[369.138364] Dynamic subtest vecs0: SUCCESS (0.000s)
[369.148419] Starting dynamic subtest: ccs0
[369.150641] Dynamic subtest ccs0: SUCCESS (0.000s)
[369.152775] Subtest init-wait: SUCCESS (0.007s)
[369.193364] [045/133] (649s left) kms_cursor_crc (cursor-tearing-position-change)
[369.335547] Starting subtest: cursor-tearing-position-change
[369.337892] Starting dynamic subtest: pipe-A-eDP-1
[370.018840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[370.029433] Starting dynamic subtest: pipe-D-eDP-1
[371.235272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[371.237623] Subtest cursor-tearing-position-change: SUCCESS (1.899s)
[372.075109] [046/133] (647s left) kms_flip (2x-plain-flip-interruptible)
[372.172664] Starting subtest: 2x-plain-flip-interruptible
[372.184504] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[372.264814] [047/133] (646s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[372.651232] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[373.509849] [048/133] (645s left) gem_ctx_param (non-root-set)
[373.567328] Starting subtest: non-root-set
[373.590284] Subtest non-root-set: SUCCESS (0.023s)
[373.676980] [049/133] (645s left) gem_mmap_wc (copy)
[373.735844] Subtest copy: SKIP (0.000s)
[373.797714] [050/133] (645s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[373.904557] Starting subtest: yf-tiled-64bpp-rotate-270
[373.909064] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[374.007085] [051/133] (645s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[374.138308] Starting subtest: basic-flip-before-cursor-varying-size
[375.086344] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.947s)
[375.925165] [052/133] (643s left) gem_exec_balancer (parallel-keep-in-fence)
[376.188538] Starting subtest: parallel-keep-in-fence
[377.338829] Subtest parallel-keep-in-fence: SUCCESS (1.151s)
[377.445498] [053/133] (641s left) kms_psr (pr-no-drrs)
[377.536426] Starting subtest: pr-no-drrs
[377.540755] Subtest pr-no-drrs: SKIP (0.000s)
[377.616025] [054/133] (641s left) kms_fbcon_fbt (fbc)
[377.680177] Starting subtest: fbc
[383.967761] Subtest fbc: SUCCESS (6.288s)
[385.063603] [055/133] (634s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[385.159839] Starting subtest: psr-rgb565-draw-blt
[392.218863] Subtest psr-rgb565-draw-blt: SUCCESS (7.062s)
[392.348020] [056/133] (627s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[392.406210] Starting subtest: invalid-multi-wait-all-unsubmitted
[392.408582] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[392.530245] [057/133] (627s left) gem_exec_balancer (invalid-bonds)
[392.589236] Starting subtest: invalid-bonds
[392.593757] Subtest invalid-bonds: SKIP (0.000s)
[392.909845] [058/133] (626s left) gem_exec_schedule (fairslice)
[392.987165] Starting subtest: fairslice
[392.989608] Starting dynamic subtest: rcs0
[394.999445] Dynamic subtest rcs0: SUCCESS (2.021s)
[395.011821] Starting dynamic subtest: bcs0
[397.075139] Dynamic subtest bcs0: SUCCESS (2.024s)
[397.086987] Starting dynamic subtest: vcs0
[399.044303] Dynamic subtest vcs0: SUCCESS (2.019s)
[399.055762] Starting dynamic subtest: vcs1
[401.111384] Dynamic subtest vcs1: SUCCESS (2.018s)
[401.123706] Starting dynamic subtest: vecs0
[403.082449] Dynamic subtest vecs0: SUCCESS (2.017s)
[403.094503] Starting dynamic subtest: ccs0
[405.150423] Dynamic subtest ccs0: SUCCESS (2.022s)
[405.152518] Subtest fairslice: SUCCESS (12.125s)
[405.406423] [059/133] (614s left) api_intel_bb (blit-noreloc-purge-cache)
[405.469944] Starting subtest: blit-noreloc-purge-cache
[405.485557] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[405.596838] [060/133] (614s left) syncobj_wait (wait-all-complex)
[405.646369] Starting subtest: wait-all-complex
[405.863522] Subtest wait-all-complex: SUCCESS (0.215s)
[405.941980] [061/133] (613s left) kms_lease (lease-unleased-crtc)
[406.031786] Starting subtest: lease-unleased-crtc
[406.034134] Starting dynamic subtest: pipe-A-eDP-1
[406.330564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[406.344458] Starting dynamic subtest: pipe-B-eDP-1
[407.072062] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.738s)
[407.086502] Starting dynamic subtest: pipe-C-eDP-1
[407.089104] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[407.099576] Starting dynamic subtest: pipe-D-eDP-1
[407.101870] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[407.104180] Subtest lease-unleased-crtc: SUCCESS (1.051s)
[407.452117] [062/133] (612s left) kms_chamelium_edid (dp-edid-read)
[407.841569] Subtest dp-edid-read: SKIP (0.000s)
[408.650374] [063/133] (611s left) sysfs_preempt_timeout (idempotent)
[408.705537] Starting subtest: idempotent
[408.707911] Starting dynamic subtest: vecs0
[408.710262] Dynamic subtest vecs0: SUCCESS (0.000s)
[408.722331] Starting dynamic subtest: ccs0
[408.724614] Dynamic subtest ccs0: SUCCESS (0.000s)
[408.735075] Starting dynamic subtest: vcs0
[408.737352] Dynamic subtest vcs0: SUCCESS (0.000s)
[408.747906] Starting dynamic subtest: bcs0
[408.750172] Dynamic subtest bcs0: SUCCESS (0.000s)
[408.760508] Starting dynamic subtest: rcs0
[408.762757] Dynamic subtest rcs0: SUCCESS (0.000s)
[408.772900] Starting dynamic subtest: vcs1
[408.774862] Dynamic subtest vcs1: SUCCESS (0.000s)
[408.776823] Subtest idempotent: SUCCESS (0.007s)
[408.831565] [064/133] (611s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[408.931506] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[408.935916] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[409.038445] [065/133] (610s left) gem_exec_flush (basic-uc-set-default)
[409.098198] Starting subtest: basic-uc-set-default
[414.583705] Subtest basic-uc-set-default: SUCCESS (5.457s)
[414.740758] [066/133] (605s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[414.850558] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[414.854934] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[414.953244] [067/133] (605s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[415.061070] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[415.063316] Starting dynamic subtest: pipe-A-default-mode
[416.233214] Dynamic subtest pipe-A-default-mode: SKIP (1.168s)
[416.240168] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.170s)
[416.388119] [068/133] (603s left) perf_pmu (semaphore-wait-idle)
[416.435429] Starting subtest: semaphore-wait-idle
[416.437455] Starting dynamic subtest: rcs0
[416.948033] Dynamic subtest rcs0: SUCCESS (0.513s)
[416.961946] Starting dynamic subtest: bcs0
[417.461691] Dynamic subtest bcs0: SUCCESS (0.510s)
[417.475301] Starting dynamic subtest: vcs0
[417.974433] Dynamic subtest vcs0: SUCCESS (0.510s)
[417.987549] Starting dynamic subtest: vcs1
[418.487565] Dynamic subtest vcs1: SUCCESS (0.510s)
[418.501300] Starting dynamic subtest: vecs0
[419.000848] Dynamic subtest vecs0: SUCCESS (0.510s)
[419.014223] Starting dynamic subtest: ccs0
[419.515922] Dynamic subtest ccs0: SUCCESS (0.512s)
[419.518569] Subtest semaphore-wait-idle: SUCCESS (3.084s)
[420.706058] [069/133] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[420.816806] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[420.821117] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[420.915282] [070/133] (599s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[421.006639] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[421.641811] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[421.809900] [071/133] (598s left) kms_addfb_basic (bad-pitch-63)
[421.860928] Starting subtest: bad-pitch-63
[421.862832] Subtest bad-pitch-63: SUCCESS (0.000s)
[422.012539] [072/133] (598s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[422.127368] Starting subtest: 2x-flip-vs-cursor-legacy
[422.133175] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[422.273417] [073/133] (598s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[422.328433] Starting subtest: saturated-hostile-nopreempt
[422.330803] Starting dynamic subtest: rcs0
[422.383536] Dynamic subtest rcs0: SKIP (0.055s)
[422.394140] Starting dynamic subtest: bcs0
[422.412100] Dynamic subtest bcs0: SKIP (0.027s)
[422.422254] Starting dynamic subtest: vcs0
[422.426956] Dynamic subtest vcs0: SKIP (0.012s)
[422.438044] Starting dynamic subtest: vcs1
[422.442259] Dynamic subtest vcs1: SKIP (0.011s)
[422.452034] Starting dynamic subtest: vecs0
[422.458875] Dynamic subtest vecs0: SKIP (0.019s)
[422.468559] Starting dynamic subtest: ccs0
[422.476780] Dynamic subtest ccs0: SKIP (0.018s)
[422.481685] Subtest saturated-hostile-nopreempt: SKIP (0.148s)
[422.550899] [074/133] (597s left) kms_pipe_crc_basic (hang-read-crc)
[422.646551] Starting subtest: hang-read-crc
[422.648372] Starting dynamic subtest: pipe-A-eDP-1
[424.777056] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[424.794215] Starting dynamic subtest: pipe-B-eDP-1
[427.574235] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.791s)
[427.585843] Starting dynamic subtest: pipe-C-eDP-1
[430.295138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.721s)
[430.306675] Starting dynamic subtest: pipe-D-eDP-1
[432.938055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s)
[432.940507] Subtest hang-read-crc: SUCCESS (10.293s)
[433.761155] [075/133] (586s left) gem_exec_reloc (basic-write-wc-active)
[433.824988] Subtest basic-write-wc-active: SKIP (0.000s)
[433.898534] [076/133] (586s left) kms_psr (psr2-sprite-blt)
[433.987649] Starting subtest: psr2-sprite-blt
[433.989877] Starting dynamic subtest: eDP-1
[435.766768] Dynamic subtest eDP-1: SUCCESS (1.780s)
[435.769046] Subtest psr2-sprite-blt: SUCCESS (1.781s)
[436.634743] [077/133] (583s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[436.725786] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[436.728121] Starting dynamic subtest: pipe-A
[437.885526] Dynamic subtest pipe-A: SUCCESS (1.162s)
[437.896355] Starting dynamic subtest: pipe-B
[440.078942] Dynamic subtest pipe-B: SUCCESS (2.193s)
[440.089941] Starting dynamic subtest: pipe-C
[441.222784] Dynamic subtest pipe-C: SUCCESS (1.142s)
[441.234254] Starting dynamic subtest: pipe-D
[442.448919] Dynamic subtest pipe-D: SUCCESS (1.227s)
[442.451173] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.727s)
[443.638969] [078/133] (576s left) gem_mmap_wc (read-write-distinct)
[443.691879] Subtest read-write-distinct: SKIP (0.000s)
[443.753225] [079/133] (576s left) kms_psr (fbc-psr-primary-mmap-gtt)
[443.855309] Starting subtest: fbc-psr-primary-mmap-gtt
[443.857582] Starting dynamic subtest: eDP-1
[443.861580] Dynamic subtest eDP-1: SKIP (0.000s)
[443.865625] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[443.948262] [080/133] (576s left) kms_cursor_crc (cursor-offscreen-64x21)
[444.148739] Starting subtest: cursor-offscreen-64x21
[444.197874] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[444.439908] [081/133] (576s left) kms_psr (fbc-pr-cursor-render)
[444.533424] Starting subtest: fbc-pr-cursor-render
[444.537867] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[444.607743] [082/133] (576s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[444.704574] Starting subtest: plane-upscale-20x20-with-pixel-format
[444.706368] Starting dynamic subtest: pipe-A
[445.752123] Dynamic subtest pipe-A: SUCCESS (1.049s)
[445.762604] Starting dynamic subtest: pipe-B
[447.843517] Dynamic subtest pipe-B: SUCCESS (2.091s)
[447.853777] Starting dynamic subtest: pipe-C
[449.049505] Dynamic subtest pipe-C: SUCCESS (1.204s)
[449.061075] Starting dynamic subtest: pipe-D
[450.195750] Dynamic subtest pipe-D: SUCCESS (1.146s)
[450.198014] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.495s)
[451.387393] [083/133] (569s left) kms_invalid_mode (uint-max-clock)
[451.502169] Starting subtest: uint-max-clock
[451.504417] Starting dynamic subtest: pipe-A-eDP-1
[451.785894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[451.797175] Starting dynamic subtest: pipe-B-eDP-1
[451.799107] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[451.809473] Starting dynamic subtest: pipe-C-eDP-1
[451.811671] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[451.823918] Starting dynamic subtest: pipe-D-eDP-1
[451.826303] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[451.828591] Subtest uint-max-clock: SUCCESS (0.292s)
[452.617483] [084/133] (568s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[452.745238] Starting subtest: verify-pxp-key-change-after-suspend-resume
[459.901786] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.161s)
[460.029129] [085/133] (560s left) gem_exec_suspend (basic-s0)
[460.101678] Starting subtest: basic-S0
[460.103585] Starting dynamic subtest: smem
[480.093861] Dynamic subtest smem: SUCCESS (6.555s)
[480.096841] Subtest basic-S0: SUCCESS (6.557s)
[480.282752] [086/133] (540s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[480.513425] Starting subtest: cursor-rapid-movement-128x42
[480.559726] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[480.750104] [087/133] (540s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[480.842548] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[480.847600] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[480.919634] [088/133] (540s left) gen9_exec_parse (bb-chained)
[480.988202] Subtest bb-chained: SKIP (0.000s)
[481.064716] [089/133] (539s left) gem_spin_batch (engines)
[481.128839] Starting subtest: engines
[481.131878] Starting dynamic subtest: rcs0
[484.365646] Dynamic subtest rcs0: SUCCESS (3.248s)
[484.379461] Starting dynamic subtest: bcs0
[487.649570] Dynamic subtest bcs0: SUCCESS (3.240s)
[487.663860] Starting dynamic subtest: vcs0
[490.886261] Dynamic subtest vcs0: SUCCESS (3.241s)
[490.899713] Starting dynamic subtest: vcs1
[494.120661] Dynamic subtest vcs1: SUCCESS (3.238s)
[494.135864] Starting dynamic subtest: vecs0
[497.358497] Dynamic subtest vecs0: SUCCESS (3.238s)
[497.371778] Starting dynamic subtest: ccs0
[500.596196] Dynamic subtest ccs0: SUCCESS (3.238s)
[500.599284] Subtest engines: SUCCESS (19.460s)
[500.775563] [090/133] (520s left) gem_ctx_exec (basic-close-race)
[500.835936] Starting subtest: basic-close-race
[506.609915] Subtest basic-close-race: SUCCESS (5.727s)
[506.687539] [091/133] (514s left) kms_content_protection (atomic-dpms-hdcp14)
[506.825260] Starting subtest: atomic-dpms-hdcp14
[506.830660] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[506.951408] [092/133] (514s left) kms_color (ctm-0-50)
[507.044714] Starting subtest: ctm-0-50
[507.047424] Starting dynamic subtest: pipe-A-eDP-1
[510.540420] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[510.552072] Starting dynamic subtest: pipe-B-eDP-1
[514.821835] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.280s)
[514.832536] Starting dynamic subtest: pipe-C-eDP-1
[518.860259] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.039s)
[518.872326] Starting dynamic subtest: pipe-D-eDP-1
[522.849904] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[522.852677] Subtest ctm-0-50: SUCCESS (15.807s)
[523.684634] [093/133] (497s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[523.802556] Starting subtest: extended-modeset-hang-oldfb-with-reset
[523.805341] Starting dynamic subtest: pipe-A
[535.848247] Dynamic subtest pipe-A: SUCCESS (12.048s)
[535.861130] Starting dynamic subtest: pipe-D
[548.312637] Dynamic subtest pipe-D: SUCCESS (12.462s)
[548.315721] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.514s)
[549.125724] [094/133] (472s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[549.242824] Starting subtest: 2x-long-cursor-vs-flip-atomic
[549.248560] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[549.394962] [095/133] (471s left) prime_mmap_coherency (read)
[549.445311] Starting subtest: read
[554.871032] Subtest read: SUCCESS (5.374s)
[554.939286] [096/133] (466s left) i915_drm_fdinfo (busy-hang)
[554.994084] Starting subtest: busy-hang
[554.996635] Starting dynamic subtest: rcs0
[555.024980] Dynamic subtest rcs0: SKIP (0.030s)
[555.037745] Starting dynamic subtest: bcs0
[555.043245] Dynamic subtest bcs0: SKIP (0.001s)
[555.054720] Starting dynamic subtest: vcs0
[555.059577] Dynamic subtest vcs0: SKIP (0.001s)
[555.069877] Starting dynamic subtest: vcs1
[555.074619] Dynamic subtest vcs1: SKIP (0.001s)
[555.084648] Starting dynamic subtest: vecs0
[555.089264] Dynamic subtest vecs0: SKIP (0.001s)
[555.099586] Starting dynamic subtest: ccs0
[555.104074] Dynamic subtest ccs0: SKIP (0.001s)
[555.108771] Subtest busy-hang: SKIP (0.039s)
[555.148736] [097/133] (466s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[555.261617] Starting subtest: fbcpsr-stridechange
[561.489617] Subtest fbcpsr-stridechange: SUCCESS (6.234s)
[561.602394] [098/133] (459s left) kms_cursor_crc (cursor-size-change)
[561.695529] Starting subtest: cursor-size-change
[561.698104] Starting dynamic subtest: pipe-A-eDP-1
[562.520198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[562.532511] Starting dynamic subtest: pipe-D-eDP-1
[564.011760] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.491s)
[564.014681] Subtest cursor-size-change: SUCCESS (2.318s)
[564.819822] [099/133] (456s left) kms_big_fb (4-tiled-addfb-size-overflow)
[564.921640] Starting subtest: 4-tiled-addfb-size-overflow
[564.924119] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[565.016693] [100/133] (456s left) kms_pm_rpm (cursor)
[567.256299] Starting subtest: cursor
[567.261367] Subtest cursor: SKIP (0.000s)
[567.635124] [101/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[567.732239] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[574.333316] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.605s)
[574.459874] [102/133] (447s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[574.564236] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[581.280646] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.716s)
[581.399430] [103/133] (440s left) api_intel_bb (destroy-bb)
[581.458863] Starting subtest: destroy-bb
[581.466891] Subtest destroy-bb: SUCCESS (0.011s)
[581.565621] [104/133] (440s left) gem_userptr_blits (probe)
[581.637151] Starting subtest: probe
[581.713771] Subtest probe: SUCCESS (0.076s)
[581.836815] [105/133] (439s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[581.943529] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[581.948559] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[582.014130] [106/133] (439s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[582.109157] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[588.903326] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.795s)
[589.030644] [107/133] (432s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[589.145859] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[589.151429] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[589.240732] [108/133] (432s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[589.339542] Starting subtest: primary-4-tiled-reflect-x-0
[596.677840] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.339s)
[597.877262] [109/133] (423s left) gem_pwrite (basic-self)
[597.934864] Subtest basic-self: SKIP (0.000s)
[597.998658] [110/133] (423s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[598.110578] Starting subtest: cursorA-vs-flipA-atomic
[609.234419] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[610.102405] [111/133] (411s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[610.160881] Starting subtest: multi-wait-for-submit-available-submitted
[610.163787] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[610.247160] [112/133] (411s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[610.339178] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[610.440514] [113/133] (411s left) gem_softpin (evict-snoop)
[610.501065] Starting subtest: evict-snoop
[610.506720] Subtest evict-snoop: SKIP (0.000s)
[610.613308] [114/133] (411s left) gem_exec_params (dr1-dirt)
[610.668869] Starting subtest: DR1-dirt
[610.671768] Subtest DR1-dirt: SUCCESS (0.000s)
[610.765288] [115/133] (411s left) gem_exec_nop (basic-sequential)
[610.843398] Starting subtest: basic-sequential
[625.650987] Subtest basic-sequential: SUCCESS (14.790s)
[625.869515] [116/133] (396s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[625.976103] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[625.980883] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[626.072371] [117/133] (396s left) vgem_basic (dmabuf-mmap)
[626.123742] Starting subtest: dmabuf-mmap
[626.189547] Subtest dmabuf-mmap: SUCCESS (0.070s)
[626.248128] [118/133] (396s left) kms_psr (fbc-psr2-primary-render)
[626.346853] Starting subtest: fbc-psr2-primary-render
[626.349478] Starting dynamic subtest: eDP-1
[626.354040] Dynamic subtest eDP-1: SKIP (0.000s)
[626.358609] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[626.425697] [119/133] (395s left) kms_atomic (plane-immutable-zpos)
[626.519452] Starting subtest: plane-immutable-zpos
[626.521854] Starting dynamic subtest: pipe-A-eDP-1
[627.159847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.639s)
[627.162718] Subtest plane-immutable-zpos: SUCCESS (0.641s)
[628.022176] [120/133] (394s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[628.124712] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[628.129711] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[628.217879] [121/133] (394s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[628.341336] Starting subtest: basic-flip-after-cursor-varying-size
[629.267654] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[630.148613] [122/133] (392s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[630.246310] Starting subtest: plane-all-transition-nonblocking-fencing
[630.248583] Starting dynamic subtest: pipe-A-eDP-1
[632.739559] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[633.049351] Starting dynamic subtest: pipe-B-eDP-1
[636.283179] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[636.584820] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.338s)
[637.412108] [123/133] (385s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[637.518642] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[637.523595] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[637.611270] [124/133] (384s left) kms_tiled_display (basic-test-pattern)
[637.727353] Subtest basic-test-pattern: SKIP (0.000s)
[637.772168] [125/133] (384s left) kms_plane_lowres (tiling-x)
[637.859559] Starting subtest: tiling-x
[637.862040] Starting dynamic subtest: pipe-A-eDP-1
[637.866861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.167972] Starting dynamic subtest: pipe-B-eDP-1
[638.172846] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.183423] Starting dynamic subtest: pipe-C-eDP-1
[638.188287] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.199493] Starting dynamic subtest: pipe-D-eDP-1
[638.204661] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.209858] Subtest tiling-x: SKIP (0.305s)
[638.970509] [126/133] (383s left) gem_exec_schedule (in-order)
[639.049631] Starting subtest: in-order
[639.052578] Starting dynamic subtest: rcs0
[639.146083] Dynamic subtest rcs0: SUCCESS (0.107s)
[639.159462] Starting dynamic subtest: vcs0
[639.242478] Dynamic subtest vcs0: SUCCESS (0.095s)
[639.255884] Starting dynamic subtest: vcs1
[639.331782] Dynamic subtest vcs1: SUCCESS (0.088s)
[639.348941] Starting dynamic subtest: vecs0
[639.416246] Dynamic subtest vecs0: SUCCESS (0.083s)
[639.429234] Starting dynamic subtest: ccs0
[639.498348] Dynamic subtest ccs0: SUCCESS (0.081s)
[639.501395] Subtest in-order: SUCCESS (0.460s)
[641.227007] [127/133] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[641.322773] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[647.967516] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.649s)
[648.093175] [128/133] (374s left) kms_frontbuffer_tracking (psr-slowdraw)
[648.209715] Starting subtest: psr-slowdraw
[673.448543] Subtest psr-slowdraw: SUCCESS (25.248s)
[673.573839] [129/133] (349s left) syncobj_wait (wait-any-interrupted)
[673.632705] Starting subtest: wait-any-interrupted
[673.735776] Subtest wait-any-interrupted: SUCCESS (0.105s)
[673.814228] [130/133] (349s left) gem_ctx_persistence (engines-queued)
[673.873560] Starting subtest: engines-queued
[673.875770] Starting dynamic subtest: rcs0
[673.916116] Dynamic subtest rcs0: SUCCESS (0.045s)
[673.930872] Starting dynamic subtest: bcs0
[673.957562] Dynamic subtest bcs0: SUCCESS (0.041s)
[673.969354] Starting dynamic subtest: vcs0
[675.066844] Dynamic subtest vcs0: SUCCESS (1.107s)
[675.081491] Starting dynamic subtest: vcs1
[677.114630] Dynamic subtest vcs1: SUCCESS (2.045s)
[677.129034] Starting dynamic subtest: vecs0
[679.098618] Dynamic subtest vecs0: SUCCESS (1.981s)
[679.113121] Starting dynamic subtest: ccs0
[679.270207] Dynamic subtest ccs0: SUCCESS (0.169s)
[679.273140] Subtest engines-queued: SUCCESS (5.401s)
[679.397662] [131/133] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[679.500529] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[679.505612] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[679.598868] [132/133] (343s left) gem_mmap_gtt (medium-copy)
[679.657604] Subtest medium-copy: SKIP (0.000s)
[679.724050] [133/133] (343s left) i915_pm_rps (waitboost)
[679.794300] Starting subtest: waitboost
[685.906845] Subtest waitboost: SUCCESS (6.114s)
[686.032945] Closing watchdogs
results: parsing output: 0/ for test: kms_dsc
results: parsing output: 1/ for test: gem_eio
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_alignment
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_dp_link_training
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_vblank
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: i915_drm_fdinfo
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: prime_mmap
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: gem_readwrite
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_tiled_blits
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_chamelium_color
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: gem_ctx_param
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_fbcon_fbt
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: api_intel_bb
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: kms_chamelium_edid
results: parsing output: 62/ for test: sysfs_preempt_timeout
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_flush
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_pipe_crc_basic
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: gem_mmap_wc
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: kms_invalid_mode
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: gem_spin_batch
results: parsing output: 89/ for test: gem_ctx_exec
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_color
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: prime_mmap_coherency
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_pm_rpm
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: gem_pwrite
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: gem_exec_params
results: parsing output: 114/ for test: gem_exec_nop
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: vgem_basic
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_atomic
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_atomic_transition
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_tiled_display
results: parsing output: 124/ for test: kms_plane_lowres
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: i915_pm_rps
Done.