[56.762788] Initializing watchdogs
[56.762835]   /dev/watchdog0
[56.777432] [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.781926] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.784241] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.787664] [001/133] (960s left) kms_dsc (dsc-with-bpc-formats)
[56.906773] Starting subtest: dsc-with-bpc-formats
[57.014260] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[57.049757] [002/133] (960s left) gem_eio (in-flight-contexts-1us)
[57.194584] Starting subtest: in-flight-contexts-1us
[71.315845] Subtest in-flight-contexts-1us: SUCCESS (14.268s)
[71.434898] [003/133] (945s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[71.537189] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[71.539730] Starting dynamic subtest: pipe-A-eDP-1
[71.563143] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[71.574339] Starting dynamic subtest: pipe-B-eDP-1
[71.595213] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[71.603345] Starting dynamic subtest: pipe-C-eDP-1
[71.624372] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.631808] Starting dynamic subtest: pipe-D-eDP-1
[71.653550] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.657978] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[73.721344] [004/133] (943s left) gem_exec_alignment (pi-isolated)
[73.780688] Starting subtest: pi-isolated
[125.430252] Subtest pi-isolated: SUCCESS (51.657s)
[126.698197] [005/133] (890s left) kms_flip (plain-flip-fb-recreate-interruptible)
[126.843673] Starting subtest: plain-flip-fb-recreate-interruptible
[126.845955] Starting dynamic subtest: A-eDP1
[135.696589] Dynamic subtest A-eDP1: SUCCESS (8.851s)
[135.708484] Starting dynamic subtest: B-eDP1
[144.522013] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[144.532793] Starting dynamic subtest: C-eDP1
[153.347664] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[153.357617] Starting dynamic subtest: D-eDP1
[162.188423] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[162.193110] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.348s)
[163.385753] [006/133] (854s left) kms_pm_rpm (modeset-lpsp)
[165.434368] Starting subtest: modeset-lpsp
[166.914095] Subtest modeset-lpsp: SUCCESS (1.482s)
[167.034476] [007/133] (850s left) syncobj_timeline (invalid-signal-illegal-point)
[167.096224] Starting subtest: invalid-signal-illegal-point
[167.098509] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[167.192876] [008/133] (850s left) kms_dp_link_training (uhbr-mst)
[167.296671] Starting subtest: uhbr-mst
[167.305308] Subtest uhbr-mst: SKIP (0.000s)
[167.367158] [009/133] (850s left) syncobj_timeline (single-wait-available-signaled)
[167.416368] Starting subtest: single-wait-available-signaled
[167.418736] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[167.505873] [010/133] (850s left) kms_vblank (wait-busy-hang)
[167.598143] Starting subtest: wait-busy-hang
[167.600396] Starting dynamic subtest: pipe-A-eDP-1
[194.058725] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.456s)
[194.074023] Starting dynamic subtest: pipe-D-eDP-1
[219.065203] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.006s)
[219.067656] Subtest wait-busy-hang: SUCCESS (51.466s)
[219.927195] [011/133] (797s left) kms_flip (2x-flip-vs-rmfb)
[220.026307] Starting subtest: 2x-flip-vs-rmfb
[220.038391] Subtest 2x-flip-vs-rmfb: SKIP (0.012s)
[220.126177] [012/133] (797s left) syncobj_timeline (32bits-limit)
[220.184494] Starting subtest: 32bits-limit
[220.186826] Subtest 32bits-limit: SUCCESS (0.001s)
[220.305508] [013/133] (797s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[220.368637] Starting subtest: invalid-bsd2-flag-on-vebox
[220.370606] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[220.475518] [014/133] (797s left) kms_plane_scaling (2x-scaler-multi-pipe)
[220.559534] Starting subtest: 2x-scaler-multi-pipe
[220.564264] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[220.681469] [015/133] (797s left) kms_frontbuffer_tracking (fbc-1p-rte)
[220.802646] Starting subtest: fbc-1p-rte
[226.325648] Subtest fbc-1p-rte: SUCCESS (5.527s)
[227.450343] [016/133] (790s left) i915_drm_fdinfo (virtual-idle)
[227.492672] Starting subtest: virtual-idle
[230.555965] Subtest virtual-idle: SUCCESS (3.061s)
[230.653094] [017/133] (787s left) gem_lmem_swapping (heavy-random)
[230.707864] Subtest heavy-random: SKIP (0.000s)
[230.748792] [018/133] (787s left) kms_plane (pixel-format-linear-modifier)
[230.845881] Starting subtest: pixel-format-linear-modifier
[230.874949] Starting dynamic subtest: pipe-A-plane-0
[234.494176] Dynamic subtest pipe-A-plane-0: SUCCESS (3.622s)
[234.504352] Starting dynamic subtest: pipe-A-plane-3
[236.171923] Dynamic subtest pipe-A-plane-3: SUCCESS (1.677s)
[236.180522] Starting dynamic subtest: pipe-A-plane-5
[236.383199] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[237.530772] Starting dynamic subtest: pipe-B-plane-0
[241.123202] Dynamic subtest pipe-B-plane-0: SUCCESS (3.600s)
[241.134305] Starting dynamic subtest: pipe-B-plane-3
[242.767475] Dynamic subtest pipe-B-plane-3: SUCCESS (1.644s)
[242.778483] Starting dynamic subtest: pipe-B-plane-5
[242.978496] Dynamic subtest pipe-B-plane-5: SUCCESS (0.211s)
[243.287208] Subtest pixel-format-linear-modifier: SUCCESS (12.441s)
[244.097194] [019/133] (773s left) sw_sync (sync_merge)
[244.134997] Starting subtest: sync_merge
[244.137258] Subtest sync_merge: SUCCESS (0.000s)
[244.183619] [020/133] (773s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[244.276080] Starting subtest: fbc-farfromfence-mmap-gtt
[244.280437] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[244.369086] [021/133] (773s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[244.432228] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[244.436151] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[244.611201] [022/133] (773s left) drm_read (short-buffer-wakeup)
[244.770375] Starting subtest: short-buffer-wakeup
[276.983687] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[277.119952] [023/133] (741s left) gem_exec_schedule (u-semaphore-noskip)
[277.192077] Starting subtest: u-semaphore-noskip
[277.589699] Subtest u-semaphore-noskip: SUCCESS (0.404s)
[277.912781] [024/133] (740s left) i915_pm_rpm (system-suspend-execbuf)
[279.447027] Starting subtest: system-suspend-execbuf
[337.450404] Subtest system-suspend-execbuf: SUCCESS (43.332s)
[337.829002] [025/133] (680s left) gem_exec_fence (submit67)
[338.006198] Starting subtest: submit67
[338.010969] Subtest submit67: SKIP (0.000s)
[340.322421] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[340.325896] [026/133] (678s left) gem_ccs (ctrl-surf-copy-new-ctx)
[340.385799] Starting subtest: ctrl-surf-copy-new-ctx
[340.390198] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[340.502429] [027/133] (677s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[340.604343] Starting subtest: x-tiled-8bpp-rotate-270
[340.625816] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[340.727555] [028/133] (677s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[340.820808] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[340.823074] Starting dynamic subtest: pipe-A-eDP-1
[340.845618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[340.856886] Starting dynamic subtest: pipe-B-eDP-1
[340.878767] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[340.888189] Starting dynamic subtest: pipe-C-eDP-1
[340.909984] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[340.919054] Starting dynamic subtest: pipe-D-eDP-1
[340.941182] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[340.945291] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[343.084120] [029/133] (675s left) prime_mmap (test_correct_cpu_write)
[343.149640] Starting subtest: test_correct_cpu_write
[343.151785] Starting dynamic subtest: test_correct_cpu_write-smem
[343.153665] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[343.155574] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[343.278402] [030/133] (675s left) kms_big_fb (linear-32bpp-rotate-0)
[343.378217] Starting subtest: linear-32bpp-rotate-0
[344.811543] Subtest linear-32bpp-rotate-0: SUCCESS (1.434s)
[344.962842] [031/133] (673s left) gem_readwrite (read-bad-handle)
[345.028573] Subtest read-bad-handle: SKIP (0.000s)
[345.093134] [032/133] (673s left) kms_flip (bo-too-big-interruptible)
[345.188031] Starting subtest: bo-too-big-interruptible
[345.189636] Starting dynamic subtest: A-eDP1
[346.540325] Dynamic subtest A-eDP1: SUCCESS (1.350s)
[346.552802] Starting dynamic subtest: B-eDP1
[347.765383] Dynamic subtest B-eDP1: SUCCESS (1.223s)
[347.776410] Starting dynamic subtest: C-eDP1
[349.014974] Dynamic subtest C-eDP1: SUCCESS (1.249s)
[349.026621] Starting dynamic subtest: D-eDP1
[350.361945] Dynamic subtest D-eDP1: SUCCESS (1.346s)
[350.364358] Subtest bo-too-big-interruptible: SUCCESS (5.177s)
[351.562387] [033/133] (667s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[351.670189] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[351.672527] Starting dynamic subtest: pipe-A-eDP-1
[351.728290] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[351.737389] Starting dynamic subtest: pipe-B-eDP-1
[351.791333] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[351.801144] Starting dynamic subtest: pipe-C-eDP-1
[351.854853] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[351.864529] Starting dynamic subtest: pipe-D-eDP-1
[351.919969] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[351.924182] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[353.926694] [034/133] (664s left) gem_mmap_offset (basic-uaf)
[353.976956] Starting subtest: basic-uaf
[353.978802] Subtest basic-uaf: SUCCESS (0.002s)
[354.086468] [035/133] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[354.189145] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[354.193037] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[354.319399] [036/133] (664s left) gem_tiled_blits (basic)
[354.399709] Subtest basic: SKIP (0.000s)
[354.474297] [037/133] (664s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[354.569256] Starting subtest: pr-cursor-plane-update-sf
[354.573547] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[354.650024] [038/133] (664s left) kms_chamelium_color (ctm-0-50)
[354.756256] Subtest ctm-0-50: SKIP (0.000s)
[354.803702] [039/133] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[354.900986] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[359.339593] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.443s)
[360.527453] [040/133] (658s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[360.624345] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[360.626741] Starting dynamic subtest: pipe-A-eDP-1
[360.650594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.662896] Starting dynamic subtest: pipe-B-eDP-1
[360.684397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.693684] Starting dynamic subtest: pipe-C-eDP-1
[360.715268] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.724436] Starting dynamic subtest: pipe-D-eDP-1
[360.746324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.750693] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[362.859746] [041/133] (656s left) vgem_basic (sysfs)
[362.903936] Starting subtest: sysfs
[362.905808] Subtest sysfs: SUCCESS (0.000s)
[362.961749] [042/133] (656s left) perf_pmu (busy-double-start)
[363.012704] Starting subtest: busy-double-start
[363.014906] Starting dynamic subtest: rcs0
[366.658231] Dynamic subtest rcs0: FAIL (3.590s)
[366.670322] Starting dynamic subtest: bcs0
[370.172204] Dynamic subtest bcs0: SUCCESS (3.570s)
[370.184594] Starting dynamic subtest: vcs0
[374.753023] Dynamic subtest vcs0: SUCCESS (4.581s)
[374.764707] Starting dynamic subtest: vcs1
[378.781729] Dynamic subtest vcs1: SUCCESS (4.009s)
[378.795686] Starting dynamic subtest: vecs0
[382.730080] Dynamic subtest vecs0: SUCCESS (3.967s)
[382.742710] Starting dynamic subtest: ccs0
[386.366019] Dynamic subtest ccs0: FAIL (3.565s)
[386.368358] Subtest busy-double-start: FAIL (23.291s)
[386.426636] [043/133] (632s left) gem_mmap_gtt (cpuset-basic-small-copy)
[386.488344] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[386.555496] [044/133] (632s left) perf_pmu (init-wait)
[386.598846] Starting subtest: init-wait
[386.601090] Starting dynamic subtest: rcs0
[386.603453] Dynamic subtest rcs0: SUCCESS (0.002s)
[386.615549] Starting dynamic subtest: bcs0
[386.617455] Dynamic subtest bcs0: SUCCESS (0.000s)
[386.627092] Starting dynamic subtest: vcs0
[386.629048] Dynamic subtest vcs0: SUCCESS (0.001s)
[386.638581] Starting dynamic subtest: vcs1
[386.640493] Dynamic subtest vcs1: SUCCESS (0.001s)
[386.650177] Starting dynamic subtest: vecs0
[386.652051] Dynamic subtest vecs0: SUCCESS (0.001s)
[386.662096] Starting dynamic subtest: ccs0
[386.664340] Dynamic subtest ccs0: SUCCESS (0.000s)
[386.666524] Subtest init-wait: SUCCESS (0.008s)
[386.729061] [045/133] (632s left) kms_cursor_crc (cursor-tearing-position-change)
[386.850359] Starting subtest: cursor-tearing-position-change
[386.852495] Starting dynamic subtest: pipe-A-eDP-1
[387.418996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[387.429814] Starting dynamic subtest: pipe-D-eDP-1
[388.676677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[388.678666] Subtest cursor-tearing-position-change: SUCCESS (1.825s)
[389.532851] [046/133] (629s left) kms_flip (2x-plain-flip-interruptible)
[389.626676] Starting subtest: 2x-plain-flip-interruptible
[389.638806] Subtest 2x-plain-flip-interruptible: SKIP (0.011s)
[389.730184] [047/133] (629s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[390.112792] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[390.931324] [048/133] (628s left) gem_ctx_param (non-root-set)
[390.989260] Starting subtest: non-root-set
[391.008069] Subtest non-root-set: SUCCESS (0.019s)
[391.090109] [049/133] (628s left) gem_mmap_wc (copy)
[391.134945] Subtest copy: SKIP (0.000s)
[391.200595] [050/133] (628s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[391.295361] Starting subtest: yf-tiled-64bpp-rotate-270
[391.299607] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[391.394928] [051/133] (628s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[391.505530] Starting subtest: basic-flip-before-cursor-varying-size
[392.438082] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[393.285444] [052/133] (626s left) gem_exec_balancer (parallel-keep-in-fence)
[393.613710] Starting subtest: parallel-keep-in-fence
[394.774821] Subtest parallel-keep-in-fence: SUCCESS (1.157s)
[394.876961] [053/133] (624s left) kms_psr (pr-no-drrs)
[394.982186] Starting subtest: pr-no-drrs
[394.986273] Subtest pr-no-drrs: SKIP (0.000s)
[395.098628] [054/133] (624s left) kms_fbcon_fbt (fbc)
[395.159808] Starting subtest: fbc
[401.550812] Subtest fbc: SUCCESS (6.385s)
[402.632825] [055/133] (617s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[402.734920] Starting subtest: psr-rgb565-draw-blt
[409.962136] Subtest psr-rgb565-draw-blt: SUCCESS (7.229s)
[410.105570] [056/133] (609s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[410.160303] Starting subtest: invalid-multi-wait-all-unsubmitted
[410.162560] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[410.272074] [057/133] (609s left) gem_exec_balancer (invalid-bonds)
[410.348327] Starting subtest: invalid-bonds
[410.352363] Subtest invalid-bonds: SKIP (0.000s)
[410.644524] [058/133] (609s left) gem_exec_schedule (fairslice)
[410.714522] Starting subtest: fairslice
[410.717159] Starting dynamic subtest: rcs0
[412.729837] Dynamic subtest rcs0: SUCCESS (2.022s)
[412.741761] Starting dynamic subtest: bcs0
[414.803554] Dynamic subtest bcs0: SUCCESS (2.024s)
[414.814862] Starting dynamic subtest: vcs0
[416.774570] Dynamic subtest vcs0: SUCCESS (2.019s)
[416.786117] Starting dynamic subtest: vcs1
[418.843698] Dynamic subtest vcs1: SUCCESS (2.019s)
[418.856683] Starting dynamic subtest: vecs0
[420.813287] Dynamic subtest vecs0: SUCCESS (2.018s)
[420.823997] Starting dynamic subtest: ccs0
[422.886787] Dynamic subtest ccs0: SUCCESS (2.023s)
[422.888844] Subtest fairslice: SUCCESS (12.129s)
[423.133718] [059/133] (596s left) api_intel_bb (blit-noreloc-purge-cache)
[423.193797] Starting subtest: blit-noreloc-purge-cache
[423.207344] Subtest blit-noreloc-purge-cache: SUCCESS (0.016s)
[423.347225] [060/133] (596s left) syncobj_wait (wait-all-complex)
[423.392106] Starting subtest: wait-all-complex
[423.606697] Subtest wait-all-complex: SUCCESS (0.214s)
[423.689857] [061/133] (596s left) kms_lease (lease-unleased-crtc)
[423.784169] Starting subtest: lease-unleased-crtc
[423.786519] Starting dynamic subtest: pipe-A-eDP-1
[424.084491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[424.095343] Starting dynamic subtest: pipe-B-eDP-1
[424.836671] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[424.850440] Starting dynamic subtest: pipe-C-eDP-1
[424.852890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[424.862899] Starting dynamic subtest: pipe-D-eDP-1
[424.865005] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[424.867064] Subtest lease-unleased-crtc: SUCCESS (1.067s)
[425.219535] [062/133] (594s left) kms_chamelium_edid (dp-edid-read)
[425.612396] Subtest dp-edid-read: SKIP (0.000s)
[426.427939] [063/133] (593s left) sysfs_preempt_timeout (idempotent)
[426.485203] Starting subtest: idempotent
[426.487483] Starting dynamic subtest: vecs0
[426.489884] Dynamic subtest vecs0: SUCCESS (0.000s)
[426.501592] Starting dynamic subtest: ccs0
[426.503958] Dynamic subtest ccs0: SUCCESS (0.002s)
[426.513990] Starting dynamic subtest: vcs0
[426.515947] Dynamic subtest vcs0: SUCCESS (0.001s)
[426.525462] Starting dynamic subtest: bcs0
[426.527369] Dynamic subtest bcs0: SUCCESS (0.001s)
[426.536729] Starting dynamic subtest: rcs0
[426.538649] Dynamic subtest rcs0: SUCCESS (0.001s)
[426.548460] Starting dynamic subtest: vcs1
[426.550817] Dynamic subtest vcs1: SUCCESS (0.001s)
[426.553009] Subtest idempotent: SUCCESS (0.019s)
[426.618723] [064/133] (593s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[426.728560] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[426.732926] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[426.815052] [065/133] (593s left) gem_exec_flush (basic-uc-set-default)
[426.876976] Starting subtest: basic-uc-set-default
[432.365467] Subtest basic-uc-set-default: SUCCESS (5.475s)
[432.561522] [066/133] (587s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[432.674846] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[432.679226] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[432.763544] [067/133] (587s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[432.855993] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[432.858304] Starting dynamic subtest: pipe-A-default-mode
[434.016005] Dynamic subtest pipe-A-default-mode: SKIP (1.156s)
[434.020389] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.158s)
[434.174029] [068/133] (586s left) perf_pmu (semaphore-wait-idle)
[434.227353] Starting subtest: semaphore-wait-idle
[434.229365] Starting dynamic subtest: rcs0
[434.740432] Dynamic subtest rcs0: SUCCESS (0.512s)
[434.753892] Starting dynamic subtest: bcs0
[435.253165] Dynamic subtest bcs0: SUCCESS (0.510s)
[435.267110] Starting dynamic subtest: vcs0
[435.764581] Dynamic subtest vcs0: SUCCESS (0.509s)
[435.777419] Starting dynamic subtest: vcs1
[436.277359] Dynamic subtest vcs1: SUCCESS (0.510s)
[436.290557] Starting dynamic subtest: vecs0
[436.789779] Dynamic subtest vecs0: SUCCESS (0.510s)
[436.803662] Starting dynamic subtest: ccs0
[437.305494] Dynamic subtest ccs0: SUCCESS (0.512s)
[437.308435] Subtest semaphore-wait-idle: SUCCESS (3.080s)
[437.423984] [069/133] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[437.540785] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[437.545107] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[437.633418] [070/133] (582s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[437.746006] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[438.370741] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[438.547886] [071/133] (581s left) kms_addfb_basic (bad-pitch-63)
[438.602977] Starting subtest: bad-pitch-63
[438.605066] Subtest bad-pitch-63: SUCCESS (0.000s)
[438.744423] [072/133] (581s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[438.858298] Starting subtest: 2x-flip-vs-cursor-legacy
[438.862598] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[439.007253] [073/133] (581s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[439.059439] Starting subtest: saturated-hostile-nopreempt
[439.061798] Starting dynamic subtest: rcs0
[439.114227] Dynamic subtest rcs0: SKIP (0.052s)
[439.125565] Starting dynamic subtest: bcs0
[439.138016] Dynamic subtest bcs0: SKIP (0.022s)
[439.147780] Starting dynamic subtest: vcs0
[439.154883] Dynamic subtest vcs0: SKIP (0.016s)
[439.167826] Starting dynamic subtest: vcs1
[439.171881] Dynamic subtest vcs1: SKIP (0.012s)
[439.183841] Starting dynamic subtest: vecs0
[439.190877] Dynamic subtest vecs0: SKIP (0.022s)
[439.200737] Starting dynamic subtest: ccs0
[439.212789] Dynamic subtest ccs0: SKIP (0.021s)
[439.217406] Subtest saturated-hostile-nopreempt: SKIP (0.152s)
[439.291812] [074/133] (581s left) kms_pipe_crc_basic (hang-read-crc)
[439.376695] Starting subtest: hang-read-crc
[439.378672] Starting dynamic subtest: pipe-A-eDP-1
[441.468084] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[441.480015] Starting dynamic subtest: pipe-B-eDP-1
[444.243668] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.774s)
[444.255048] Starting dynamic subtest: pipe-C-eDP-1
[446.870465] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.627s)
[446.881964] Starting dynamic subtest: pipe-D-eDP-1
[449.546570] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.675s)
[449.548957] Subtest hang-read-crc: SUCCESS (10.172s)
[450.377918] [075/133] (570s left) gem_exec_reloc (basic-write-wc-active)
[450.448166] Subtest basic-write-wc-active: SKIP (0.000s)
[450.539676] [076/133] (569s left) kms_psr (psr2-sprite-blt)
[450.636163] Starting subtest: psr2-sprite-blt
[450.638447] Starting dynamic subtest: eDP-1
[452.369229] Dynamic subtest eDP-1: SUCCESS (1.734s)
[452.371528] Subtest psr2-sprite-blt: SUCCESS (1.736s)
[453.242566] [077/133] (567s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[453.332955] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[453.335287] Starting dynamic subtest: pipe-A
[454.448965] Dynamic subtest pipe-A: SUCCESS (1.118s)
[454.462407] Starting dynamic subtest: pipe-B
[456.804427] Dynamic subtest pipe-B: SUCCESS (2.354s)
[456.814518] Starting dynamic subtest: pipe-C
[457.950047] Dynamic subtest pipe-C: SUCCESS (1.144s)
[457.961397] Starting dynamic subtest: pipe-D
[459.177446] Dynamic subtest pipe-D: SUCCESS (1.227s)
[459.179766] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.848s)
[460.375304] [078/133] (560s left) gem_mmap_wc (read-write-distinct)
[460.441695] Subtest read-write-distinct: SKIP (0.000s)
[460.510702] [079/133] (560s left) kms_psr (fbc-psr-primary-mmap-gtt)
[460.605939] Starting subtest: fbc-psr-primary-mmap-gtt
[460.608292] Starting dynamic subtest: eDP-1
[460.612420] Dynamic subtest eDP-1: SKIP (0.000s)
[460.616626] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[460.682801] [080/133] (560s left) kms_cursor_crc (cursor-offscreen-64x21)
[460.888762] Starting subtest: cursor-offscreen-64x21
[460.936259] Subtest cursor-offscreen-64x21: SKIP (0.043s)
[461.164216] [081/133] (559s left) kms_psr (fbc-pr-cursor-render)
[461.265198] Starting subtest: fbc-pr-cursor-render
[461.269453] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[461.350851] [082/133] (559s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[461.432142] Starting subtest: plane-upscale-20x20-with-pixel-format
[461.433944] Starting dynamic subtest: pipe-A
[462.480193] Dynamic subtest pipe-A: SUCCESS (1.049s)
[462.490806] Starting dynamic subtest: pipe-B
[464.584530] Dynamic subtest pipe-B: SUCCESS (2.104s)
[464.596269] Starting dynamic subtest: pipe-C
[465.769382] Dynamic subtest pipe-C: SUCCESS (1.183s)
[465.779983] Starting dynamic subtest: pipe-D
[466.914933] Dynamic subtest pipe-D: SUCCESS (1.145s)
[466.917319] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.485s)
[468.113453] [083/133] (552s left) kms_invalid_mode (uint-max-clock)
[468.210226] Starting subtest: uint-max-clock
[468.212541] Starting dynamic subtest: pipe-A-eDP-1
[468.493796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[468.507860] Starting dynamic subtest: pipe-B-eDP-1
[468.509911] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[468.519960] Starting dynamic subtest: pipe-C-eDP-1
[468.522178] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[468.532190] Starting dynamic subtest: pipe-D-eDP-1
[468.534545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[468.536836] Subtest uint-max-clock: SUCCESS (0.290s)
[469.342491] [084/133] (551s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[469.471503] Starting subtest: verify-pxp-key-change-after-suspend-resume
[476.664163] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.198s)
[476.783668] [085/133] (544s left) gem_exec_suspend (basic-s0)
[476.866013] Starting subtest: basic-S0
[476.868385] Starting dynamic subtest: smem
[499.490347] Dynamic subtest smem: SUCCESS (8.329s)
[499.493470] Subtest basic-S0: SUCCESS (8.331s)
[506.699405] [086/133] (521s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[506.957522] Starting subtest: cursor-rapid-movement-128x42
[507.004410] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[507.198499] [087/133] (520s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[507.289611] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[507.294543] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[507.361521] [088/133] (520s left) gen9_exec_parse (bb-chained)
[507.412613] Subtest bb-chained: SKIP (0.000s)
[507.478810] [089/133] (520s left) gem_spin_batch (engines)
[507.538574] Starting subtest: engines
[507.541200] Starting dynamic subtest: rcs0
[510.775909] Dynamic subtest rcs0: SUCCESS (3.313s)
[510.787629] Starting dynamic subtest: bcs0
[514.056583] Dynamic subtest bcs0: SUCCESS (3.279s)
[514.069880] Starting dynamic subtest: vcs0
[517.288636] Dynamic subtest vcs0: SUCCESS (3.263s)
[517.301674] Starting dynamic subtest: vcs1
[520.517983] Dynamic subtest vcs1: SUCCESS (3.249s)
[520.531722] Starting dynamic subtest: vecs0
[523.748769] Dynamic subtest vecs0: SUCCESS (3.242s)
[523.762414] Starting dynamic subtest: ccs0
[526.981217] Dynamic subtest ccs0: SUCCESS (3.241s)
[526.984408] Subtest engines: SUCCESS (19.604s)
[527.162926] [090/133] (500s left) gem_ctx_exec (basic-close-race)
[527.222996] Starting subtest: basic-close-race
[532.902597] Subtest basic-close-race: SUCCESS (5.641s)
[532.995180] [091/133] (495s left) kms_content_protection (atomic-dpms-hdcp14)
[533.145544] Starting subtest: atomic-dpms-hdcp14
[533.151120] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[533.285845] [092/133] (494s left) kms_color (ctm-0-50)
[533.377729] Starting subtest: ctm-0-50
[533.380089] Starting dynamic subtest: pipe-A-eDP-1
[536.902569] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s)
[536.913675] Starting dynamic subtest: pipe-B-eDP-1
[541.070853] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.169s)
[541.082522] Starting dynamic subtest: pipe-C-eDP-1
[545.129978] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.053s)
[545.143769] Starting dynamic subtest: pipe-D-eDP-1
[549.129654] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[549.132672] Subtest ctm-0-50: SUCCESS (15.756s)
[549.962624] [093/133] (478s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[550.078330] Starting subtest: extended-modeset-hang-oldfb-with-reset
[550.080818] Starting dynamic subtest: pipe-A
[562.028883] Dynamic subtest pipe-A: SUCCESS (11.949s)
[562.041188] Starting dynamic subtest: pipe-D
[574.308764] Dynamic subtest pipe-D: SUCCESS (12.279s)
[574.310856] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.232s)
[575.102192] [094/133] (453s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[575.230371] Starting subtest: 2x-long-cursor-vs-flip-atomic
[575.235520] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[575.389213] [095/133] (453s left) prime_mmap_coherency (read)
[575.452168] Starting subtest: read
[580.884581] Subtest read: SUCCESS (5.380s)
[580.960936] [096/133] (447s left) i915_drm_fdinfo (busy-hang)
[581.007105] Starting subtest: busy-hang
[581.009611] Starting dynamic subtest: rcs0
[581.028668] Dynamic subtest rcs0: SKIP (0.021s)
[581.039844] Starting dynamic subtest: bcs0
[581.044831] Dynamic subtest bcs0: SKIP (0.001s)
[581.055650] Starting dynamic subtest: vcs0
[581.060842] Dynamic subtest vcs0: SKIP (0.001s)
[581.071321] Starting dynamic subtest: vcs1
[581.076678] Dynamic subtest vcs1: SKIP (0.001s)
[581.089472] Starting dynamic subtest: vecs0
[581.094383] Dynamic subtest vecs0: SKIP (0.001s)
[581.104551] Starting dynamic subtest: ccs0
[581.109640] Dynamic subtest ccs0: SKIP (0.001s)
[581.114646] Subtest busy-hang: SKIP (0.030s)
[581.155950] [097/133] (447s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[581.257751] Starting subtest: fbcpsr-stridechange
[587.442757] Subtest fbcpsr-stridechange: SUCCESS (6.191s)
[587.557928] [098/133] (440s left) kms_cursor_crc (cursor-size-change)
[587.659250] Starting subtest: cursor-size-change
[587.661819] Starting dynamic subtest: pipe-A-eDP-1
[588.480579] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[588.492452] Starting dynamic subtest: pipe-D-eDP-1
[589.895717] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.415s)
[589.898648] Subtest cursor-size-change: SUCCESS (2.239s)
[590.721681] [099/133] (437s left) kms_big_fb (4-tiled-addfb-size-overflow)
[590.822001] Starting subtest: 4-tiled-addfb-size-overflow
[590.824540] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[590.916642] [100/133] (437s left) kms_pm_rpm (cursor)
[592.650334] Starting subtest: cursor
[592.656142] Subtest cursor: SKIP (0.000s)
[593.164515] [101/133] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[593.260448] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[599.886192] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.631s)
[600.014266] [102/133] (428s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[600.116351] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[606.807597] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.694s)
[606.924931] [103/133] (421s left) api_intel_bb (destroy-bb)
[606.986543] Starting subtest: destroy-bb
[606.994740] Subtest destroy-bb: SUCCESS (0.008s)
[607.107875] [104/133] (421s left) gem_userptr_blits (probe)
[607.185239] Starting subtest: probe
[607.262840] Subtest probe: SUCCESS (0.078s)
[607.388949] [105/133] (421s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[607.492372] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[607.497762] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[607.569634] [106/133] (421s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[607.664773] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[614.477061] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.813s)
[614.607353] [107/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[614.703024] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[614.708736] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[614.804286] [108/133] (414s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[614.895413] Starting subtest: primary-4-tiled-reflect-x-0
[622.125622] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.229s)
[623.308844] [109/133] (405s left) gem_pwrite (basic-self)
[623.379862] Subtest basic-self: SKIP (0.000s)
[623.441935] [110/133] (405s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[623.564531] Starting subtest: cursorA-vs-flipA-atomic
[634.694710] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.128s)
[635.545653] [111/133] (393s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[635.600873] Starting subtest: multi-wait-for-submit-available-submitted
[635.603392] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[635.711771] [112/133] (393s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[635.808102] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[635.908989] [113/133] (393s left) gem_softpin (evict-snoop)
[635.967720] Starting subtest: evict-snoop
[635.973554] Subtest evict-snoop: SKIP (0.000s)
[636.086227] [114/133] (393s left) gem_exec_params (dr1-dirt)
[636.142747] Starting subtest: DR1-dirt
[636.145774] Subtest DR1-dirt: SUCCESS (0.000s)
[636.243458] [115/133] (393s left) gem_exec_nop (basic-sequential)
[636.320642] Starting subtest: basic-sequential
[650.980771] Subtest basic-sequential: SUCCESS (14.645s)
[651.193154] [116/133] (378s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[651.290666] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[651.296064] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[651.386619] [117/133] (377s left) vgem_basic (dmabuf-mmap)
[651.429666] Starting subtest: dmabuf-mmap
[651.473517] Subtest dmabuf-mmap: SUCCESS (0.045s)
[651.536629] [118/133] (377s left) kms_psr (fbc-psr2-primary-render)
[651.628004] Starting subtest: fbc-psr2-primary-render
[651.630345] Starting dynamic subtest: eDP-1
[651.635299] Dynamic subtest eDP-1: SKIP (0.000s)
[651.640312] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[651.702551] [119/133] (377s left) kms_atomic (plane-immutable-zpos)
[651.802255] Starting subtest: plane-immutable-zpos
[651.804858] Starting dynamic subtest: pipe-A-eDP-1
[652.439743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.638s)
[652.442776] Subtest plane-immutable-zpos: SUCCESS (0.640s)
[653.274349] [120/133] (376s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[653.377755] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[653.382674] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[653.475557] [121/133] (376s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[653.592840] Starting subtest: basic-flip-after-cursor-varying-size
[654.513547] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.923s)
[655.315236] [122/133] (374s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[655.399479] Starting subtest: plane-all-transition-nonblocking-fencing
[655.401973] Starting dynamic subtest: pipe-A-eDP-1
[657.893606] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[658.202065] Starting dynamic subtest: pipe-B-eDP-1
[661.436087] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.243s)
[661.745034] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.348s)
[662.576037] [123/133] (367s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[662.674473] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[662.679576] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[662.772661] [124/133] (366s left) kms_tiled_display (basic-test-pattern)
[662.881161] Subtest basic-test-pattern: SKIP (0.000s)
[662.933128] [125/133] (366s left) kms_plane_lowres (tiling-x)
[663.014969] Starting subtest: tiling-x
[663.017315] Starting dynamic subtest: pipe-A-eDP-1
[663.021926] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[663.313410] Starting dynamic subtest: pipe-B-eDP-1
[663.318430] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[663.329144] Starting dynamic subtest: pipe-C-eDP-1
[663.334584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[663.345727] Starting dynamic subtest: pipe-D-eDP-1
[663.350423] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[663.354810] Subtest tiling-x: SKIP (0.296s)
[664.101229] [126/133] (365s left) gem_exec_schedule (in-order)
[664.178700] Starting subtest: in-order
[664.181522] Starting dynamic subtest: rcs0
[664.387294] Dynamic subtest rcs0: SUCCESS (0.208s)
[664.401115] Starting dynamic subtest: vcs0
[664.483397] Dynamic subtest vcs0: SUCCESS (0.093s)
[664.496296] Starting dynamic subtest: vcs1
[664.567702] Dynamic subtest vcs1: SUCCESS (0.083s)
[664.580882] Starting dynamic subtest: vecs0
[664.650472] Dynamic subtest vecs0: SUCCESS (0.082s)
[664.663549] Starting dynamic subtest: ccs0
[664.741896] Dynamic subtest ccs0: SUCCESS (0.091s)
[664.744638] Subtest in-order: SUCCESS (0.565s)
[665.604253] [127/133] (364s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[665.699835] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[672.294728] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.598s)
[672.431344] [128/133] (357s left) kms_frontbuffer_tracking (psr-slowdraw)
[672.538636] Starting subtest: psr-slowdraw
[697.790446] Subtest psr-slowdraw: SUCCESS (25.258s)
[697.915539] [129/133] (331s left) syncobj_wait (wait-any-interrupted)
[697.990373] Starting subtest: wait-any-interrupted
[698.092373] Subtest wait-any-interrupted: SUCCESS (0.103s)
[698.188261] [130/133] (331s left) gem_ctx_persistence (engines-queued)
[698.257976] Starting subtest: engines-queued
[698.260878] Starting dynamic subtest: rcs0
[698.311189] Dynamic subtest rcs0: SUCCESS (0.054s)
[698.322814] Starting dynamic subtest: bcs0
[698.356525] Dynamic subtest bcs0: SUCCESS (0.044s)
[698.367237] Starting dynamic subtest: vcs0
[699.459158] Dynamic subtest vcs0: SUCCESS (1.097s)
[699.473847] Starting dynamic subtest: vcs1
[701.503514] Dynamic subtest vcs1: SUCCESS (2.045s)
[701.517243] Starting dynamic subtest: vecs0
[703.487408] Dynamic subtest vecs0: SUCCESS (1.981s)
[703.501559] Starting dynamic subtest: ccs0
[703.685948] Dynamic subtest ccs0: SUCCESS (0.197s)
[703.689035] Subtest engines-queued: SUCCESS (5.430s)
[703.767968] [131/133] (326s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[703.874639] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[703.879821] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[703.979203] [132/133] (326s left) gem_mmap_gtt (medium-copy)
[704.037583] Subtest medium-copy: SKIP (0.000s)
[704.101433] [133/133] (325s left) i915_pm_rps (waitboost)
[704.163846] Starting subtest: waitboost
[710.255459] Subtest waitboost: SUCCESS (6.096s)
[710.382101] 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.