[73.428517] Initializing watchdogs
[73.428566]   /dev/watchdog0
[73.442382] [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]
[73.446678] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.448838] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.452202] [001/133] (960s left) kms_dsc (dsc-with-bpc-formats)
[73.571077] Starting subtest: dsc-with-bpc-formats
[73.683271] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[73.718867] [002/133] (960s left) gem_eio (in-flight-contexts-1us)
[73.857587] Starting subtest: in-flight-contexts-1us
[84.294135] Subtest in-flight-contexts-1us: SUCCESS (10.436s)
[84.463712] [003/133] (949s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[84.558718] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[84.560853] Starting dynamic subtest: pipe-A-eDP-1
[84.583048] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[84.591761] Starting dynamic subtest: pipe-B-eDP-1
[84.612890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[84.620759] Starting dynamic subtest: pipe-C-eDP-1
[84.641656] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[84.649727] Starting dynamic subtest: pipe-D-eDP-1
[84.671649] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[84.675660] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[86.867311] [004/133] (947s left) gem_exec_alignment (pi-isolated)
[86.930893] Starting subtest: pi-isolated
[137.200931] Subtest pi-isolated: SUCCESS (50.248s)
[138.081695] [005/133] (896s left) kms_flip (plain-flip-fb-recreate-interruptible)
[138.218335] Starting subtest: plain-flip-fb-recreate-interruptible
[138.220646] Starting dynamic subtest: A-eDP1
[147.069345] Dynamic subtest A-eDP1: SUCCESS (8.850s)
[147.079784] Starting dynamic subtest: B-eDP1
[155.893326] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[155.905644] Starting dynamic subtest: C-eDP1
[164.713463] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[164.724616] Starting dynamic subtest: D-eDP1
[173.549492] Dynamic subtest D-eDP1: SUCCESS (8.835s)
[173.553660] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.335s)
[174.737097] [006/133] (859s left) kms_pm_rpm (modeset-lpsp)
[176.477595] Starting subtest: modeset-lpsp
[177.951637] Subtest modeset-lpsp: SUCCESS (1.476s)
[178.081524] [007/133] (856s left) syncobj_timeline (invalid-signal-illegal-point)
[178.141350] Starting subtest: invalid-signal-illegal-point
[178.143852] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[178.236428] [008/133] (855s left) kms_dp_link_training (uhbr-mst)
[178.328461] Starting subtest: uhbr-mst
[178.337136] Subtest uhbr-mst: SKIP (0.000s)
[178.395290] [009/133] (855s left) syncobj_timeline (single-wait-available-signaled)
[178.442058] Starting subtest: single-wait-available-signaled
[178.444062] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[178.523079] [010/133] (855s left) kms_vblank (wait-busy-hang)
[178.615931] Starting subtest: wait-busy-hang
[178.618330] Starting dynamic subtest: pipe-A-eDP-1
[205.057572] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.440s)
[205.071052] Starting dynamic subtest: pipe-D-eDP-1
[230.067310] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.008s)
[230.069687] Subtest wait-busy-hang: SUCCESS (51.451s)
[230.862759] [011/133] (803s left) kms_flip (2x-flip-vs-rmfb)
[230.949648] Starting subtest: 2x-flip-vs-rmfb
[230.959093] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[231.034224] [012/133] (803s left) syncobj_timeline (32bits-limit)
[231.092719] Starting subtest: 32bits-limit
[231.095096] Subtest 32bits-limit: SUCCESS (0.001s)
[231.185085] [013/133] (803s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[231.236681] Starting subtest: invalid-bsd2-flag-on-vebox
[231.239079] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[231.330610] [014/133] (803s left) kms_plane_scaling (2x-scaler-multi-pipe)
[231.431457] Starting subtest: 2x-scaler-multi-pipe
[231.435493] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[231.550819] [015/133] (802s left) kms_frontbuffer_tracking (fbc-1p-rte)
[231.649800] Starting subtest: fbc-1p-rte
[237.154308] Subtest fbc-1p-rte: SUCCESS (5.508s)
[238.282015] [016/133] (796s left) i915_drm_fdinfo (virtual-idle)
[238.325409] Starting subtest: virtual-idle
[241.386209] Subtest virtual-idle: SUCCESS (3.057s)
[241.473421] [017/133] (793s left) gem_lmem_swapping (heavy-random)
[241.515502] Subtest heavy-random: SKIP (0.000s)
[241.551523] [018/133] (793s left) kms_plane (pixel-format-linear-modifier)
[241.646335] Starting subtest: pixel-format-linear-modifier
[241.675826] Starting dynamic subtest: pipe-A-plane-0
[245.342374] Dynamic subtest pipe-A-plane-0: SUCCESS (3.667s)
[245.350905] Starting dynamic subtest: pipe-A-plane-3
[247.119964] Dynamic subtest pipe-A-plane-3: SUCCESS (1.777s)
[247.130169] Starting dynamic subtest: pipe-A-plane-5
[247.331267] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[248.459063] Starting dynamic subtest: pipe-B-plane-0
[252.152053] Dynamic subtest pipe-B-plane-0: SUCCESS (3.700s)
[252.161322] Starting dynamic subtest: pipe-B-plane-3
[253.908481] Dynamic subtest pipe-B-plane-3: SUCCESS (1.755s)
[253.916751] Starting dynamic subtest: pipe-B-plane-5
[254.118752] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[254.434596] Subtest pixel-format-linear-modifier: SUCCESS (12.784s)
[255.229340] [019/133] (779s left) sw_sync (sync_merge)
[255.265969] Starting subtest: sync_merge
[255.267823] Subtest sync_merge: SUCCESS (0.000s)
[255.314586] [020/133] (779s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[255.410306] Starting subtest: fbc-farfromfence-mmap-gtt
[255.414501] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[255.494320] [021/133] (779s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[255.548601] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[255.552706] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[255.741285] [022/133] (779s left) drm_read (short-buffer-wakeup)
[255.885940] Starting subtest: short-buffer-wakeup
[288.102804] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[288.256772] [023/133] (746s left) gem_exec_schedule (u-semaphore-noskip)
[288.324621] Starting subtest: u-semaphore-noskip
[288.735856] Subtest u-semaphore-noskip: SUCCESS (0.418s)
[289.080755] [024/133] (745s left) i915_pm_rpm (system-suspend-execbuf)
[290.593099] Starting subtest: system-suspend-execbuf
[348.111244] Subtest system-suspend-execbuf: SUCCESS (42.926s)
[348.487483] [025/133] (686s left) gem_exec_fence (submit67)
[348.669180] Starting subtest: submit67
[348.673718] Subtest submit67: SKIP (0.000s)
[350.936811] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[350.940288] [026/133] (683s left) gem_ccs (ctrl-surf-copy-new-ctx)
[351.000356] Starting subtest: ctrl-surf-copy-new-ctx
[351.004682] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[351.105149] [027/133] (683s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[351.204390] Starting subtest: x-tiled-8bpp-rotate-270
[351.228515] Subtest x-tiled-8bpp-rotate-270: SKIP (0.024s)
[351.340893] [028/133] (683s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[351.431361] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[351.433680] Starting dynamic subtest: pipe-A-eDP-1
[351.456312] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.466750] Starting dynamic subtest: pipe-B-eDP-1
[351.487689] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.496917] Starting dynamic subtest: pipe-C-eDP-1
[351.517613] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[351.526500] Starting dynamic subtest: pipe-D-eDP-1
[351.547457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.551555] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[353.745120] [029/133] (681s left) prime_mmap (test_correct_cpu_write)
[353.802727] Starting subtest: test_correct_cpu_write
[353.804800] Starting dynamic subtest: test_correct_cpu_write-smem
[353.806758] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[353.808798] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[353.925251] [030/133] (681s left) kms_big_fb (linear-32bpp-rotate-0)
[354.024577] Starting subtest: linear-32bpp-rotate-0
[355.449319] Subtest linear-32bpp-rotate-0: SUCCESS (1.426s)
[355.590246] [031/133] (679s left) gem_readwrite (read-bad-handle)
[355.637165] Subtest read-bad-handle: SKIP (0.000s)
[355.697460] [032/133] (679s left) kms_flip (bo-too-big-interruptible)
[355.791649] Starting subtest: bo-too-big-interruptible
[355.793605] Starting dynamic subtest: A-eDP1
[357.113119] Dynamic subtest A-eDP1: SUCCESS (1.319s)
[357.125889] Starting dynamic subtest: B-eDP1
[358.372041] Dynamic subtest B-eDP1: SUCCESS (1.258s)
[358.383097] Starting dynamic subtest: C-eDP1
[359.693230] Dynamic subtest C-eDP1: SUCCESS (1.319s)
[359.703526] Starting dynamic subtest: D-eDP1
[360.921035] Dynamic subtest D-eDP1: SUCCESS (1.227s)
[360.923478] Subtest bo-too-big-interruptible: SUCCESS (5.131s)
[362.137038] [033/133] (673s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[362.238590] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[362.240739] Starting dynamic subtest: pipe-A-eDP-1
[362.298098] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[362.309564] Starting dynamic subtest: pipe-B-eDP-1
[362.367732] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[362.379072] Starting dynamic subtest: pipe-C-eDP-1
[362.436381] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[362.447515] Starting dynamic subtest: pipe-D-eDP-1
[362.505609] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[362.509767] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[364.481025] [034/133] (670s left) gem_mmap_offset (basic-uaf)
[364.530038] Starting subtest: basic-uaf
[364.532493] Subtest basic-uaf: SUCCESS (0.001s)
[364.629209] [035/133] (670s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[364.728213] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[364.732731] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[364.823853] [036/133] (670s left) gem_tiled_blits (basic)
[364.894021] Subtest basic: SKIP (0.000s)
[364.964342] [037/133] (670s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[365.062479] Starting subtest: pr-cursor-plane-update-sf
[365.066778] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[365.130287] [038/133] (670s left) kms_chamelium_color (ctm-0-50)
[365.222754] Subtest ctm-0-50: SKIP (0.000s)
[365.269987] [039/133] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[365.362040] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[369.808876] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.450s)
[370.977760] [040/133] (664s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[371.061445] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[371.063624] Starting dynamic subtest: pipe-A-eDP-1
[371.086356] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.099047] Starting dynamic subtest: pipe-B-eDP-1
[371.120585] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.130266] Starting dynamic subtest: pipe-C-eDP-1
[371.151622] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.161195] Starting dynamic subtest: pipe-D-eDP-1
[371.183251] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.187398] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[373.255240] [041/133] (662s left) vgem_basic (sysfs)
[373.301518] Starting subtest: sysfs
[373.303429] Subtest sysfs: SUCCESS (0.000s)
[373.354725] [042/133] (662s left) perf_pmu (busy-double-start)
[373.402593] Starting subtest: busy-double-start
[373.404779] Starting dynamic subtest: rcs0
[377.050910] Dynamic subtest rcs0: FAIL (3.590s)
[377.063103] Starting dynamic subtest: bcs0
[380.561517] Dynamic subtest bcs0: SUCCESS (3.568s)
[380.573044] Starting dynamic subtest: vcs0
[384.356311] Dynamic subtest vcs0: SUCCESS (3.792s)
[384.371110] Starting dynamic subtest: vcs1
[388.419499] Dynamic subtest vcs1: SUCCESS (4.060s)
[388.432712] Starting dynamic subtest: vecs0
[392.382172] Dynamic subtest vecs0: SUCCESS (3.960s)
[392.395312] Starting dynamic subtest: ccs0
[396.021601] Dynamic subtest ccs0: FAIL (3.566s)
[396.023639] Subtest busy-double-start: FAIL (22.545s)
[396.068269] [043/133] (639s left) gem_mmap_gtt (cpuset-basic-small-copy)
[396.122426] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[396.177210] [044/133] (639s left) perf_pmu (init-wait)
[396.213949] Starting subtest: init-wait
[396.216340] Starting dynamic subtest: rcs0
[396.218676] Dynamic subtest rcs0: SUCCESS (0.002s)
[396.230387] Starting dynamic subtest: bcs0
[396.232540] Dynamic subtest bcs0: SUCCESS (0.000s)
[396.242691] Starting dynamic subtest: vcs0
[396.244496] Dynamic subtest vcs0: SUCCESS (0.001s)
[396.259951] Starting dynamic subtest: vcs1
[396.261863] Dynamic subtest vcs1: SUCCESS (0.001s)
[396.274360] Starting dynamic subtest: vecs0
[396.276777] Dynamic subtest vecs0: SUCCESS (0.001s)
[396.286504] Starting dynamic subtest: ccs0
[396.288451] Dynamic subtest ccs0: SUCCESS (0.000s)
[396.290497] Subtest init-wait: SUCCESS (0.008s)
[396.343503] [045/133] (639s left) kms_cursor_crc (cursor-tearing-position-change)
[396.453430] Starting subtest: cursor-tearing-position-change
[396.456194] Starting dynamic subtest: pipe-A-eDP-1
[397.023273] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.566s)
[397.034082] Starting dynamic subtest: pipe-D-eDP-1
[398.302584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.281s)
[398.304952] Subtest cursor-tearing-position-change: SUCCESS (1.849s)
[399.131687] [046/133] (636s left) kms_flip (2x-plain-flip-interruptible)
[399.218825] Starting subtest: 2x-plain-flip-interruptible
[399.229693] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[399.310665] [047/133] (636s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[399.686611] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[400.540726] [048/133] (635s left) gem_ctx_param (non-root-set)
[400.595217] Starting subtest: non-root-set
[400.610366] Subtest non-root-set: SUCCESS (0.018s)
[400.711151] [049/133] (635s left) gem_mmap_wc (copy)
[400.761611] Subtest copy: SKIP (0.000s)
[400.819561] [050/133] (635s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[400.918628] Starting subtest: yf-tiled-64bpp-rotate-270
[400.923042] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[401.012607] [051/133] (634s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[401.133526] Starting subtest: basic-flip-before-cursor-varying-size
[402.059008] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[402.888145] [052/133] (633s left) gem_exec_balancer (parallel-keep-in-fence)
[403.161793] Starting subtest: parallel-keep-in-fence
[404.278847] Subtest parallel-keep-in-fence: SUCCESS (1.118s)
[404.390497] [053/133] (631s left) kms_psr (pr-no-drrs)
[404.487032] Starting subtest: pr-no-drrs
[404.491500] Subtest pr-no-drrs: SKIP (0.000s)
[404.570859] [054/133] (631s left) kms_fbcon_fbt (fbc)
[404.631093] Starting subtest: fbc
[410.931931] Subtest fbc: SUCCESS (6.302s)
[412.012950] [055/133] (624s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[412.109359] Starting subtest: psr-rgb565-draw-blt
[419.178729] Subtest psr-rgb565-draw-blt: SUCCESS (7.074s)
[419.292821] [056/133] (616s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[419.345724] Starting subtest: invalid-multi-wait-all-unsubmitted
[419.347687] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[419.439162] [057/133] (616s left) gem_exec_balancer (invalid-bonds)
[419.507681] Starting subtest: invalid-bonds
[419.511621] Subtest invalid-bonds: SKIP (0.000s)
[419.829711] [058/133] (616s left) gem_exec_schedule (fairslice)
[419.902984] Starting subtest: fairslice
[419.905317] Starting dynamic subtest: rcs0
[421.921368] Dynamic subtest rcs0: SUCCESS (2.025s)
[421.933368] Starting dynamic subtest: bcs0
[423.947271] Dynamic subtest bcs0: SUCCESS (2.024s)
[423.960272] Starting dynamic subtest: vcs0
[425.970239] Dynamic subtest vcs0: SUCCESS (2.021s)
[425.980289] Starting dynamic subtest: vcs1
[427.987882] Dynamic subtest vcs1: SUCCESS (2.020s)
[427.999310] Starting dynamic subtest: vecs0
[430.007783] Dynamic subtest vecs0: SUCCESS (2.018s)
[430.021650] Starting dynamic subtest: ccs0
[432.027572] Dynamic subtest ccs0: SUCCESS (2.019s)
[432.029588] Subtest fairslice: SUCCESS (12.131s)
[432.324256] [059/133] (603s left) api_intel_bb (blit-noreloc-purge-cache)
[432.377201] Starting subtest: blit-noreloc-purge-cache
[432.390846] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[432.518972] [060/133] (603s left) syncobj_wait (wait-all-complex)
[432.575547] Starting subtest: wait-all-complex
[432.791432] Subtest wait-all-complex: SUCCESS (0.215s)
[432.870051] [061/133] (603s left) kms_lease (lease-unleased-crtc)
[432.969552] Starting subtest: lease-unleased-crtc
[432.971797] Starting dynamic subtest: pipe-A-eDP-1
[433.261462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[433.274986] Starting dynamic subtest: pipe-B-eDP-1
[434.014625] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[434.026361] Starting dynamic subtest: pipe-C-eDP-1
[434.029028] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[434.039323] Starting dynamic subtest: pipe-D-eDP-1
[434.041464] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[434.043473] Subtest lease-unleased-crtc: SUCCESS (1.064s)
[434.411506] [062/133] (601s left) kms_chamelium_edid (dp-edid-read)
[434.813510] Subtest dp-edid-read: SKIP (0.000s)
[435.620098] [063/133] (600s left) sysfs_preempt_timeout (idempotent)
[435.679264] Starting subtest: idempotent
[435.681811] Starting dynamic subtest: vecs0
[435.684172] Dynamic subtest vecs0: SUCCESS (0.000s)
[435.696449] Starting dynamic subtest: ccs0
[435.698645] Dynamic subtest ccs0: SUCCESS (0.000s)
[435.709277] Starting dynamic subtest: vcs0
[435.711461] Dynamic subtest vcs0: SUCCESS (0.000s)
[435.721213] Starting dynamic subtest: bcs0
[435.723455] Dynamic subtest bcs0: SUCCESS (0.000s)
[435.733254] Starting dynamic subtest: rcs0
[435.735510] Dynamic subtest rcs0: SUCCESS (0.000s)
[435.746369] Starting dynamic subtest: vcs1
[435.748252] Dynamic subtest vcs1: SUCCESS (0.000s)
[435.750121] Subtest idempotent: SUCCESS (0.006s)
[435.808718] [064/133] (600s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[435.901848] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[435.906276] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[436.002015] [065/133] (600s left) gem_exec_flush (basic-uc-set-default)
[436.065016] Starting subtest: basic-uc-set-default
[441.516241] Subtest basic-uc-set-default: SUCCESS (5.450s)
[441.700304] [066/133] (594s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[441.812877] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[441.817479] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[441.929847] [067/133] (594s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[442.021446] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[442.023751] Starting dynamic subtest: pipe-A-default-mode
[443.194217] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[443.198503] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.171s)
[443.351595] [068/133] (593s left) perf_pmu (semaphore-wait-idle)
[443.394050] Starting subtest: semaphore-wait-idle
[443.395907] Starting dynamic subtest: rcs0
[443.907754] Dynamic subtest rcs0: SUCCESS (0.512s)
[443.919554] Starting dynamic subtest: bcs0
[444.421121] Dynamic subtest bcs0: SUCCESS (0.511s)
[444.433253] Starting dynamic subtest: vcs0
[444.934072] Dynamic subtest vcs0: SUCCESS (0.510s)
[444.947392] Starting dynamic subtest: vcs1
[445.447428] Dynamic subtest vcs1: SUCCESS (0.510s)
[445.459862] Starting dynamic subtest: vecs0
[445.960708] Dynamic subtest vecs0: SUCCESS (0.510s)
[445.974744] Starting dynamic subtest: ccs0
[446.493641] Dynamic subtest ccs0: SUCCESS (0.512s)
[446.498224] Subtest semaphore-wait-idle: SUCCESS (3.083s)
[447.871634] [069/133] (588s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[447.972761] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[447.977140] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[448.089948] [070/133] (588s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[448.196794] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[448.809855] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s)
[448.982424] [071/133] (587s left) kms_addfb_basic (bad-pitch-63)
[449.050942] Starting subtest: bad-pitch-63
[449.052824] Subtest bad-pitch-63: SUCCESS (0.000s)
[449.187887] [072/133] (587s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[449.305138] Starting subtest: 2x-flip-vs-cursor-legacy
[449.309577] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[449.462730] [073/133] (587s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[449.524976] Starting subtest: saturated-hostile-nopreempt
[449.527286] Starting dynamic subtest: rcs0
[449.584693] Dynamic subtest rcs0: SKIP (0.057s)
[449.597750] Starting dynamic subtest: bcs0
[449.601770] Dynamic subtest bcs0: SKIP (0.011s)
[449.614625] Starting dynamic subtest: vcs0
[449.619023] Dynamic subtest vcs0: SKIP (0.010s)
[449.631271] Starting dynamic subtest: vcs1
[449.635451] Dynamic subtest vcs1: SKIP (0.018s)
[449.645050] Starting dynamic subtest: vecs0
[449.658076] Dynamic subtest vecs0: SKIP (0.030s)
[449.668101] Starting dynamic subtest: ccs0
[449.676920] Dynamic subtest ccs0: SKIP (0.018s)
[449.681471] Subtest saturated-hostile-nopreempt: SKIP (0.150s)
[449.751101] [074/133] (587s left) kms_pipe_crc_basic (hang-read-crc)
[449.848942] Starting subtest: hang-read-crc
[449.850934] Starting dynamic subtest: pipe-A-eDP-1
[451.945151] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.093s)
[451.955944] Starting dynamic subtest: pipe-B-eDP-1
[454.718076] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[454.730112] Starting dynamic subtest: pipe-C-eDP-1
[457.350775] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[457.365231] Starting dynamic subtest: pipe-D-eDP-1
[460.026751] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.675s)
[460.029143] Subtest hang-read-crc: SUCCESS (10.177s)
[460.842353] [075/133] (576s left) gem_exec_reloc (basic-write-wc-active)
[460.903615] Subtest basic-write-wc-active: SKIP (0.000s)
[460.979163] [076/133] (576s left) kms_psr (psr2-sprite-blt)
[461.074179] Starting subtest: psr2-sprite-blt
[461.076541] Starting dynamic subtest: eDP-1
[462.822079] Dynamic subtest eDP-1: SUCCESS (1.749s)
[462.824600] Subtest psr2-sprite-blt: SUCCESS (1.750s)
[463.696054] [077/133] (573s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[463.785917] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[463.788331] Starting dynamic subtest: pipe-A
[464.947223] Dynamic subtest pipe-A: SUCCESS (1.162s)
[464.961051] Starting dynamic subtest: pipe-B
[467.176566] Dynamic subtest pipe-B: SUCCESS (2.229s)
[467.187056] Starting dynamic subtest: pipe-C
[468.396670] Dynamic subtest pipe-C: SUCCESS (1.219s)
[468.408197] Starting dynamic subtest: pipe-D
[469.622842] Dynamic subtest pipe-D: SUCCESS (1.225s)
[469.625258] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.839s)
[471.030253] [078/133] (566s left) gem_mmap_wc (read-write-distinct)
[471.091425] Subtest read-write-distinct: SKIP (0.000s)
[471.157470] [079/133] (565s left) kms_psr (fbc-psr-primary-mmap-gtt)
[471.250418] Starting subtest: fbc-psr-primary-mmap-gtt
[471.252670] Starting dynamic subtest: eDP-1
[471.256652] Dynamic subtest eDP-1: SKIP (0.000s)
[471.260663] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[471.326808] [080/133] (565s left) kms_cursor_crc (cursor-offscreen-64x21)
[471.519869] Starting subtest: cursor-offscreen-64x21
[471.567186] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[471.807822] [081/133] (565s left) kms_psr (fbc-pr-cursor-render)
[471.897452] Starting subtest: fbc-pr-cursor-render
[471.901918] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[471.972019] [082/133] (565s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[472.054887] Starting subtest: plane-upscale-20x20-with-pixel-format
[472.056779] Starting dynamic subtest: pipe-A
[473.114251] Dynamic subtest pipe-A: SUCCESS (1.061s)
[473.130392] Starting dynamic subtest: pipe-B
[475.228848] Dynamic subtest pipe-B: SUCCESS (2.114s)
[475.238832] Starting dynamic subtest: pipe-C
[476.432345] Dynamic subtest pipe-C: SUCCESS (1.200s)
[476.443813] Starting dynamic subtest: pipe-D
[477.661759] Dynamic subtest pipe-D: SUCCESS (1.230s)
[477.664062] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.608s)
[478.861038] [083/133] (558s left) kms_invalid_mode (uint-max-clock)
[478.952687] Starting subtest: uint-max-clock
[478.955329] Starting dynamic subtest: pipe-A-eDP-1
[479.244129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[479.255966] Starting dynamic subtest: pipe-B-eDP-1
[479.258240] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[479.269089] Starting dynamic subtest: pipe-C-eDP-1
[479.271310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[479.282054] Starting dynamic subtest: pipe-D-eDP-1
[479.284488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[479.286840] Subtest uint-max-clock: SUCCESS (0.298s)
[480.091119] [084/133] (557s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[480.218116] Starting subtest: verify-pxp-key-change-after-suspend-resume
[488.096076] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.882s)
[488.232133] [085/133] (549s left) gem_exec_suspend (basic-s0)
[488.301174] Starting subtest: basic-S0
[488.303553] Starting dynamic subtest: smem
[508.469093] Dynamic subtest smem: SUCCESS (6.579s)
[508.471816] Subtest basic-S0: SUCCESS (6.583s)
[508.654479] [086/133] (528s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[508.903106] Starting subtest: cursor-rapid-movement-128x42
[508.952501] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[509.154552] [087/133] (528s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[509.250707] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[509.255192] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[509.326987] [088/133] (528s left) gen9_exec_parse (bb-chained)
[509.397750] Subtest bb-chained: SKIP (0.000s)
[509.473053] [089/133] (528s left) gem_spin_batch (engines)
[509.530928] Starting subtest: engines
[509.533276] Starting dynamic subtest: rcs0
[512.772809] Dynamic subtest rcs0: SUCCESS (3.233s)
[512.786941] Starting dynamic subtest: bcs0
[516.010545] Dynamic subtest bcs0: SUCCESS (3.231s)
[516.024182] Starting dynamic subtest: vcs0
[519.248629] Dynamic subtest vcs0: SUCCESS (3.232s)
[519.261528] Starting dynamic subtest: vcs1
[522.486063] Dynamic subtest vcs1: SUCCESS (3.233s)
[522.499021] Starting dynamic subtest: vecs0
[525.720349] Dynamic subtest vecs0: SUCCESS (3.229s)
[525.732039] Starting dynamic subtest: ccs0
[528.956699] Dynamic subtest ccs0: SUCCESS (3.231s)
[528.958979] Subtest engines: SUCCESS (19.408s)
[529.185019] [090/133] (508s left) gem_ctx_exec (basic-close-race)
[529.242152] Starting subtest: basic-close-race
[535.274903] Subtest basic-close-race: SUCCESS (6.029s)
[535.417217] [091/133] (502s left) kms_content_protection (atomic-dpms-hdcp14)
[535.563826] Starting subtest: atomic-dpms-hdcp14
[535.568879] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[535.718408] [092/133] (501s left) kms_color (ctm-0-50)
[535.822286] Starting subtest: ctm-0-50
[535.824229] Starting dynamic subtest: pipe-A-eDP-1
[539.360595] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.540s)
[539.373360] Starting dynamic subtest: pipe-B-eDP-1
[543.560718] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.197s)
[543.571788] Starting dynamic subtest: pipe-C-eDP-1
[547.533881] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.972s)
[547.545920] Starting dynamic subtest: pipe-D-eDP-1
[551.511821] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.977s)
[551.514280] Subtest ctm-0-50: SUCCESS (15.689s)
[552.344170] [093/133] (485s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[552.442314] Starting subtest: extended-modeset-hang-oldfb-with-reset
[552.444564] Starting dynamic subtest: pipe-A
[564.034608] Dynamic subtest pipe-A: SUCCESS (11.589s)
[564.046585] Starting dynamic subtest: pipe-D
[576.301187] Dynamic subtest pipe-D: SUCCESS (12.259s)
[576.303488] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.852s)
[577.115387] [094/133] (460s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[577.241216] Starting subtest: 2x-long-cursor-vs-flip-atomic
[577.245817] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[577.396700] [095/133] (460s left) prime_mmap_coherency (read)
[577.461803] Starting subtest: read
[582.838450] Subtest read: SUCCESS (5.376s)
[582.954874] [096/133] (454s left) i915_drm_fdinfo (busy-hang)
[582.995867] Starting subtest: busy-hang
[582.998182] Starting dynamic subtest: rcs0
[583.024463] Dynamic subtest rcs0: SKIP (0.027s)
[583.036751] Starting dynamic subtest: bcs0
[583.040809] Dynamic subtest bcs0: SKIP (0.001s)
[583.051085] Starting dynamic subtest: vcs0
[583.055414] Dynamic subtest vcs0: SKIP (0.001s)
[583.065874] Starting dynamic subtest: vcs1
[583.069917] Dynamic subtest vcs1: SKIP (0.002s)
[583.079798] Starting dynamic subtest: vecs0
[583.083890] Dynamic subtest vecs0: SKIP (0.001s)
[583.093810] Starting dynamic subtest: ccs0
[583.097881] Dynamic subtest ccs0: SKIP (0.001s)
[583.101908] Subtest busy-hang: SKIP (0.037s)
[583.140586] [097/133] (454s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[583.243377] Starting subtest: fbcpsr-stridechange
[589.474252] Subtest fbcpsr-stridechange: SUCCESS (6.232s)
[589.599340] [098/133] (448s left) kms_cursor_crc (cursor-size-change)
[589.703554] Starting subtest: cursor-size-change
[589.705351] Starting dynamic subtest: pipe-A-eDP-1
[590.496110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.790s)
[590.507967] Starting dynamic subtest: pipe-D-eDP-1
[592.041823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[592.044102] Subtest cursor-size-change: SUCCESS (2.338s)
[592.923130] [099/133] (445s left) kms_big_fb (4-tiled-addfb-size-overflow)
[593.017437] Starting subtest: 4-tiled-addfb-size-overflow
[593.019794] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[593.127915] [100/133] (444s left) kms_pm_rpm (cursor)
[594.661000] Starting subtest: cursor
[594.666576] Subtest cursor: SKIP (0.000s)
[595.364868] [101/133] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[595.458444] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[602.039450] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.581s)
[602.165622] [102/133] (435s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[602.256441] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[609.006097] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.754s)
[609.149192] [103/133] (429s left) api_intel_bb (destroy-bb)
[609.204224] Starting subtest: destroy-bb
[609.209830] Subtest destroy-bb: SUCCESS (0.008s)
[609.343310] [104/133] (428s left) gem_userptr_blits (probe)
[609.417240] Starting subtest: probe
[609.489397] Subtest probe: SUCCESS (0.075s)
[609.596119] [105/133] (428s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[609.700194] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[609.704434] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[609.783627] [106/133] (428s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[609.880152] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[616.780640] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.905s)
[616.886257] [107/133] (421s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[616.976051] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[616.980605] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[617.073526] [108/133] (421s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[617.176160] Starting subtest: primary-4-tiled-reflect-x-0
[624.306413] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.132s)
[625.473556] [109/133] (412s left) gem_pwrite (basic-self)
[625.531565] Subtest basic-self: SKIP (0.000s)
[625.595978] [110/133] (412s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[625.710234] Starting subtest: cursorA-vs-flipA-atomic
[636.841966] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.129s)
[637.701477] [111/133] (400s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[637.748610] Starting subtest: multi-wait-for-submit-available-submitted
[637.750816] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[637.839820] [112/133] (400s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[637.925117] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[638.033910] [113/133] (400s left) gem_softpin (evict-snoop)
[638.089498] Starting subtest: evict-snoop
[638.093482] Subtest evict-snoop: SKIP (0.000s)
[638.213241] [114/133] (400s left) gem_exec_params (dr1-dirt)
[638.260580] Starting subtest: DR1-dirt
[638.262840] Subtest DR1-dirt: SUCCESS (0.000s)
[638.360145] [115/133] (400s left) gem_exec_nop (basic-sequential)
[638.432783] Starting subtest: basic-sequential
[652.922479] Subtest basic-sequential: SUCCESS (14.497s)
[653.166461] [116/133] (385s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[653.271329] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[653.275469] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[653.364893] [117/133] (385s left) vgem_basic (dmabuf-mmap)
[653.404977] Starting subtest: dmabuf-mmap
[653.436525] Subtest dmabuf-mmap: SUCCESS (0.035s)
[653.513100] [118/133] (385s left) kms_psr (fbc-psr2-primary-render)
[653.598923] Starting subtest: fbc-psr2-primary-render
[653.600787] Starting dynamic subtest: eDP-1
[653.604826] Dynamic subtest eDP-1: SKIP (0.000s)
[653.608907] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[653.671819] [119/133] (385s left) kms_atomic (plane-immutable-zpos)
[653.762111] Starting subtest: plane-immutable-zpos
[653.764216] Starting dynamic subtest: pipe-A-eDP-1
[654.393469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[654.396021] Subtest plane-immutable-zpos: SUCCESS (0.634s)
[655.245236] [120/133] (383s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[655.334656] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[655.338885] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[655.426148] [121/133] (383s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[655.546859] Starting subtest: basic-flip-after-cursor-varying-size
[656.469501] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.924s)
[657.275021] [122/133] (381s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[657.361906] Starting subtest: plane-all-transition-nonblocking-fencing
[657.364242] Starting dynamic subtest: pipe-A-eDP-1
[659.858802] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[660.166685] Starting dynamic subtest: pipe-B-eDP-1
[663.403307] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.245s)
[663.702495] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.339s)
[664.544929] [123/133] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[664.659217] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[664.663894] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[664.758204] [124/133] (374s left) kms_tiled_display (basic-test-pattern)
[664.865896] Subtest basic-test-pattern: SKIP (0.000s)
[664.910506] [125/133] (374s left) kms_plane_lowres (tiling-x)
[664.999664] Starting subtest: tiling-x
[665.001890] Starting dynamic subtest: pipe-A-eDP-1
[665.006359] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[665.295892] Starting dynamic subtest: pipe-B-eDP-1
[665.300564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[665.311337] Starting dynamic subtest: pipe-C-eDP-1
[665.316084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[665.326509] Starting dynamic subtest: pipe-D-eDP-1
[665.330736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[665.334970] Subtest tiling-x: SKIP (0.295s)
[666.166827] [126/133] (372s left) gem_exec_schedule (in-order)
[666.225559] Starting subtest: in-order
[666.227850] Starting dynamic subtest: rcs0
[666.323227] Dynamic subtest rcs0: SUCCESS (0.104s)
[666.338623] Starting dynamic subtest: vcs0
[666.415519] Dynamic subtest vcs0: SUCCESS (0.091s)
[666.430256] Starting dynamic subtest: vcs1
[666.496199] Dynamic subtest vcs1: SUCCESS (0.080s)
[666.510420] Starting dynamic subtest: vecs0
[666.580898] Dynamic subtest vecs0: SUCCESS (0.084s)
[666.594512] Starting dynamic subtest: ccs0
[666.676798] Dynamic subtest ccs0: SUCCESS (0.093s)
[666.679581] Subtest in-order: SUCCESS (0.457s)
[667.536090] [127/133] (371s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[667.634137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[674.260117] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.627s)
[674.381140] [128/133] (364s left) kms_frontbuffer_tracking (psr-slowdraw)
[674.472379] Starting subtest: psr-slowdraw
[699.707858] Subtest psr-slowdraw: SUCCESS (25.234s)
[699.821458] [129/133] (339s left) syncobj_wait (wait-any-interrupted)
[699.883974] Starting subtest: wait-any-interrupted
[699.992697] Subtest wait-any-interrupted: SUCCESS (0.108s)
[700.070485] [130/133] (339s left) gem_ctx_persistence (engines-queued)
[700.131425] Starting subtest: engines-queued
[700.133853] Starting dynamic subtest: rcs0
[700.229830] Dynamic subtest rcs0: SUCCESS (0.098s)
[700.243455] Starting dynamic subtest: bcs0
[700.285388] Dynamic subtest bcs0: SUCCESS (0.053s)
[700.297933] Starting dynamic subtest: vcs0
[701.393545] Dynamic subtest vcs0: SUCCESS (1.104s)
[701.404750] Starting dynamic subtest: vcs1
[703.378127] Dynamic subtest vcs1: SUCCESS (1.983s)
[703.396573] Starting dynamic subtest: vecs0
[705.426238] Dynamic subtest vecs0: SUCCESS (2.043s)
[705.439975] Starting dynamic subtest: ccs0
[705.608230] Dynamic subtest ccs0: SUCCESS (0.179s)
[705.610967] Subtest engines-queued: SUCCESS (5.476s)
[705.734559] [131/133] (333s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[705.841378] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[705.846109] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[705.953519] [132/133] (333s left) gem_mmap_gtt (medium-copy)
[706.001924] Subtest medium-copy: SKIP (0.000s)
[706.057578] [133/133] (333s left) i915_pm_rps (waitboost)
[706.125397] Starting subtest: waitboost
[712.489965] Subtest waitboost: SUCCESS (6.363s)
[712.564178] 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.