[55.886424] Initializing watchdogs
[55.886469]   /dev/watchdog0
[55.901506] [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]
[55.906524] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.909084] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.912501] [001/133] (960s left) kms_dsc (dsc-with-bpc-formats)
[56.020980] Starting subtest: dsc-with-bpc-formats
[56.129391] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[56.164431] [002/133] (960s left) gem_eio (in-flight-contexts-1us)
[56.316128] Starting subtest: in-flight-contexts-1us
[68.325034] Subtest in-flight-contexts-1us: SUCCESS (11.877s)
[68.502556] [003/133] (947s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[68.604312] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[68.606713] Starting dynamic subtest: pipe-A-eDP-1
[68.630462] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.641651] Starting dynamic subtest: pipe-B-eDP-1
[68.663425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.671451] Starting dynamic subtest: pipe-C-eDP-1
[68.693267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[68.700703] Starting dynamic subtest: pipe-D-eDP-1
[68.722638] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[68.727092] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[70.890337] [004/133] (945s left) gem_exec_alignment (pi-isolated)
[70.961717] Starting subtest: pi-isolated
[122.814108] Subtest pi-isolated: SUCCESS (51.811s)
[124.031110] [005/133] (892s left) kms_flip (plain-flip-fb-recreate-interruptible)
[124.184946] Starting subtest: plain-flip-fb-recreate-interruptible
[124.187204] Starting dynamic subtest: A-eDP1
[133.120068] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[133.139425] Starting dynamic subtest: B-eDP1
[141.942614] Dynamic subtest B-eDP1: SUCCESS (8.820s)
[141.953141] Starting dynamic subtest: C-eDP1
[150.761117] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[150.770916] Starting dynamic subtest: D-eDP1
[159.598315] Dynamic subtest D-eDP1: SUCCESS (8.836s)
[159.602553] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.415s)
[160.772446] [006/133] (855s left) kms_pm_rpm (modeset-lpsp)
[162.516752] Starting subtest: modeset-lpsp
[163.988089] Subtest modeset-lpsp: SUCCESS (1.474s)
[164.119420] [007/133] (852s left) syncobj_timeline (invalid-signal-illegal-point)
[164.170817] Starting subtest: invalid-signal-illegal-point
[164.173351] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[164.285200] [008/133] (852s left) kms_dp_link_training (uhbr-mst)
[164.387511] Starting subtest: uhbr-mst
[164.396225] Subtest uhbr-mst: SKIP (0.000s)
[164.455749] [009/133] (852s left) syncobj_timeline (single-wait-available-signaled)
[164.517970] Starting subtest: single-wait-available-signaled
[164.520623] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[164.611425] [010/133] (852s left) kms_vblank (wait-busy-hang)
[164.699273] Starting subtest: wait-busy-hang
[164.701472] Starting dynamic subtest: pipe-A-eDP-1
[192.081970] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.379s)
[192.099230] Starting dynamic subtest: pipe-D-eDP-1
[207.116818] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.032s)
[207.119176] Subtest wait-busy-hang: SUCCESS (42.415s)
[207.913731] [011/133] (808s left) kms_flip (2x-flip-vs-rmfb)
[208.015379] Starting subtest: 2x-flip-vs-rmfb
[208.024893] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[208.112735] [012/133] (808s left) syncobj_timeline (32bits-limit)
[208.169805] Starting subtest: 32bits-limit
[208.172166] Subtest 32bits-limit: SUCCESS (0.001s)
[208.270703] [013/133] (808s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[208.327397] Starting subtest: invalid-bsd2-flag-on-vebox
[208.329775] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[208.427652] [014/133] (808s left) kms_plane_scaling (2x-scaler-multi-pipe)
[208.520921] Starting subtest: 2x-scaler-multi-pipe
[208.525507] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[208.623189] [015/133] (808s left) kms_frontbuffer_tracking (fbc-1p-rte)
[208.722433] Starting subtest: fbc-1p-rte
[214.200587] Subtest fbc-1p-rte: SUCCESS (5.483s)
[215.343506] [016/133] (801s left) i915_drm_fdinfo (virtual-idle)
[215.390794] Starting subtest: virtual-idle
[218.446809] Subtest virtual-idle: SUCCESS (3.056s)
[218.522150] [017/133] (798s left) gem_lmem_swapping (heavy-random)
[218.566970] Subtest heavy-random: SKIP (0.000s)
[218.606813] [018/133] (798s left) kms_plane (pixel-format-linear-modifier)
[218.699249] Starting subtest: pixel-format-linear-modifier
[218.726505] Starting dynamic subtest: pipe-A-plane-0
[222.337622] Dynamic subtest pipe-A-plane-0: SUCCESS (3.611s)
[222.348317] Starting dynamic subtest: pipe-A-plane-3
[224.093238] Dynamic subtest pipe-A-plane-3: SUCCESS (1.755s)
[224.103303] Starting dynamic subtest: pipe-A-plane-5
[224.304323] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[225.416993] Starting dynamic subtest: pipe-B-plane-0
[229.119967] Dynamic subtest pipe-B-plane-0: SUCCESS (3.711s)
[229.129602] Starting dynamic subtest: pipe-B-plane-3
[230.820632] Dynamic subtest pipe-B-plane-3: SUCCESS (1.699s)
[230.832123] Starting dynamic subtest: pipe-B-plane-5
[231.031533] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[231.342503] Subtest pixel-format-linear-modifier: SUCCESS (12.643s)
[232.186013] [019/133] (784s left) sw_sync (sync_merge)
[232.224496] Starting subtest: sync_merge
[232.226386] Subtest sync_merge: SUCCESS (0.000s)
[232.276440] [020/133] (784s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[232.378480] Starting subtest: fbc-farfromfence-mmap-gtt
[232.382625] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[232.465996] [021/133] (784s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[232.520087] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[232.524578] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[232.700761] [022/133] (784s left) drm_read (short-buffer-wakeup)
[232.847422] Starting subtest: short-buffer-wakeup
[265.066719] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[265.199239] [023/133] (752s left) gem_exec_schedule (u-semaphore-noskip)
[265.281074] Starting subtest: u-semaphore-noskip
[265.689345] Subtest u-semaphore-noskip: SUCCESS (0.410s)
[266.020385] [024/133] (751s left) i915_pm_rpm (system-suspend-execbuf)
[267.545541] Starting subtest: system-suspend-execbuf
[324.908352] Subtest system-suspend-execbuf: SUCCESS (42.607s)
[325.292164] [025/133] (692s left) gem_exec_fence (submit67)
[325.467481] Starting subtest: submit67
[325.471973] Subtest submit67: SKIP (0.000s)
[327.762800] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[327.766546] [026/133] (689s left) gem_ccs (ctrl-surf-copy-new-ctx)
[327.829433] Starting subtest: ctrl-surf-copy-new-ctx
[327.833898] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[327.936364] [027/133] (689s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[328.047815] Starting subtest: x-tiled-8bpp-rotate-270
[328.070811] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[328.187202] [028/133] (689s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[328.283606] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[328.285913] Starting dynamic subtest: pipe-A-eDP-1
[328.308519] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.319468] Starting dynamic subtest: pipe-B-eDP-1
[328.340781] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.350123] Starting dynamic subtest: pipe-C-eDP-1
[328.371402] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.380542] Starting dynamic subtest: pipe-D-eDP-1
[328.402352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.406760] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[330.446139] [029/133] (687s left) prime_mmap (test_correct_cpu_write)
[330.513569] Starting subtest: test_correct_cpu_write
[330.515851] Starting dynamic subtest: test_correct_cpu_write-smem
[330.518151] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[330.520315] Subtest test_correct_cpu_write: SUCCESS (0.002s)
[330.644182] [030/133] (686s left) kms_big_fb (linear-32bpp-rotate-0)
[330.747971] Starting subtest: linear-32bpp-rotate-0
[332.283132] Subtest linear-32bpp-rotate-0: SUCCESS (1.535s)
[332.403986] [031/133] (685s left) gem_readwrite (read-bad-handle)
[332.459626] Subtest read-bad-handle: SKIP (0.000s)
[332.517658] [032/133] (685s left) kms_flip (bo-too-big-interruptible)
[332.600452] Starting subtest: bo-too-big-interruptible
[332.602259] Starting dynamic subtest: A-eDP1
[333.921815] Dynamic subtest A-eDP1: SUCCESS (1.318s)
[333.931776] Starting dynamic subtest: B-eDP1
[335.264112] Dynamic subtest B-eDP1: SUCCESS (1.341s)
[335.276365] Starting dynamic subtest: C-eDP1
[336.588614] Dynamic subtest C-eDP1: SUCCESS (1.321s)
[336.600030] Starting dynamic subtest: D-eDP1
[337.820155] Dynamic subtest D-eDP1: SUCCESS (1.231s)
[337.825095] Subtest bo-too-big-interruptible: SUCCESS (5.222s)
[339.015708] [033/133] (678s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[339.107922] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[339.110207] Starting dynamic subtest: pipe-A-eDP-1
[339.169705] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[339.181277] Starting dynamic subtest: pipe-B-eDP-1
[339.240718] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[339.251434] Starting dynamic subtest: pipe-C-eDP-1
[339.308804] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[339.318374] Starting dynamic subtest: pipe-D-eDP-1
[339.376320] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[339.380739] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[341.304573] [034/133] (676s left) gem_mmap_offset (basic-uaf)
[341.368803] Starting subtest: basic-uaf
[341.371281] Subtest basic-uaf: SUCCESS (0.001s)
[341.471421] [035/133] (676s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[341.577252] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[341.581315] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[341.683542] [036/133] (676s left) gem_tiled_blits (basic)
[341.744764] Subtest basic: SKIP (0.000s)
[341.819200] [037/133] (676s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[341.916678] Starting subtest: pr-cursor-plane-update-sf
[341.920699] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[341.984878] [038/133] (675s left) kms_chamelium_color (ctm-0-50)
[342.073035] Subtest ctm-0-50: SKIP (0.000s)
[342.118312] [039/133] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[342.224101] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[346.679459] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.456s)
[347.818278] [040/133] (670s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[347.911772] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[347.914086] Starting dynamic subtest: pipe-A-eDP-1
[347.938189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.950515] Starting dynamic subtest: pipe-B-eDP-1
[347.971324] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.981075] Starting dynamic subtest: pipe-C-eDP-1
[348.001543] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[348.010492] Starting dynamic subtest: pipe-D-eDP-1
[348.031038] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[348.035137] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[350.080142] [041/133] (667s left) vgem_basic (sysfs)
[350.135988] Starting subtest: sysfs
[350.137890] Subtest sysfs: SUCCESS (0.000s)
[350.206771] [042/133] (667s left) perf_pmu (busy-double-start)
[350.253362] Starting subtest: busy-double-start
[350.255264] Starting dynamic subtest: rcs0
[353.900237] Dynamic subtest rcs0: FAIL (3.591s)
[353.911505] Starting dynamic subtest: bcs0
[357.434543] Dynamic subtest bcs0: SUCCESS (3.587s)
[357.447554] Starting dynamic subtest: vcs0
[361.247583] Dynamic subtest vcs0: SUCCESS (3.809s)
[361.259260] Starting dynamic subtest: vcs1
[365.216503] Dynamic subtest vcs1: SUCCESS (3.965s)
[365.227859] Starting dynamic subtest: vecs0
[369.247452] Dynamic subtest vecs0: SUCCESS (4.027s)
[369.259508] Starting dynamic subtest: ccs0
[372.890094] Dynamic subtest ccs0: FAIL (3.566s)
[372.892493] Subtest busy-double-start: FAIL (22.555s)
[372.937591] [043/133] (645s left) gem_mmap_gtt (cpuset-basic-small-copy)
[373.004807] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[373.064692] [044/133] (645s left) perf_pmu (init-wait)
[373.110567] Starting subtest: init-wait
[373.112886] Starting dynamic subtest: rcs0
[373.115044] Dynamic subtest rcs0: SUCCESS (0.001s)
[373.125354] Starting dynamic subtest: bcs0
[373.127564] Dynamic subtest bcs0: SUCCESS (0.001s)
[373.137820] Starting dynamic subtest: vcs0
[373.140106] Dynamic subtest vcs0: SUCCESS (0.001s)
[373.151169] Starting dynamic subtest: vcs1
[373.153098] Dynamic subtest vcs1: SUCCESS (0.001s)
[373.167608] Starting dynamic subtest: vecs0
[373.169787] Dynamic subtest vecs0: SUCCESS (0.001s)
[373.179295] Starting dynamic subtest: ccs0
[373.181203] Dynamic subtest ccs0: SUCCESS (0.000s)
[373.183063] Subtest init-wait: SUCCESS (0.007s)
[373.225373] [045/133] (644s left) kms_cursor_crc (cursor-tearing-position-change)
[373.354701] Starting subtest: cursor-tearing-position-change
[373.356968] Starting dynamic subtest: pipe-A-eDP-1
[373.930591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[373.941534] Starting dynamic subtest: pipe-D-eDP-1
[375.140245] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[375.142426] Subtest cursor-tearing-position-change: SUCCESS (1.788s)
[375.958604] [046/133] (642s left) kms_flip (2x-plain-flip-interruptible)
[376.059514] Starting subtest: 2x-plain-flip-interruptible
[376.079864] Subtest 2x-plain-flip-interruptible: SKIP (0.019s)
[376.168742] [047/133] (642s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[376.558498] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[377.369069] [048/133] (640s left) gem_ctx_param (non-root-set)
[377.420606] Starting subtest: non-root-set
[377.435439] Subtest non-root-set: SUCCESS (0.015s)
[377.512787] [049/133] (640s left) gem_mmap_wc (copy)
[377.569060] Subtest copy: SKIP (0.000s)
[377.631630] [050/133] (640s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[377.730138] Starting subtest: yf-tiled-64bpp-rotate-270
[377.734303] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[377.835408] [051/133] (640s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[377.957987] Starting subtest: basic-flip-before-cursor-varying-size
[378.887325] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.927s)
[379.731931] [052/133] (638s left) gem_exec_balancer (parallel-keep-in-fence)
[379.993284] Starting subtest: parallel-keep-in-fence
[381.173414] Subtest parallel-keep-in-fence: SUCCESS (1.180s)
[381.273682] [053/133] (637s left) kms_psr (pr-no-drrs)
[381.381884] Starting subtest: pr-no-drrs
[381.386251] Subtest pr-no-drrs: SKIP (0.000s)
[381.455526] [054/133] (637s left) kms_fbcon_fbt (fbc)
[381.518407] Starting subtest: fbc
[387.851296] Subtest fbc: SUCCESS (6.333s)
[388.936942] [055/133] (629s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[389.038572] Starting subtest: psr-rgb565-draw-blt
[396.171581] Subtest psr-rgb565-draw-blt: SUCCESS (7.138s)
[396.287611] [056/133] (622s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[396.337938] Starting subtest: invalid-multi-wait-all-unsubmitted
[396.339860] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[396.435176] [057/133] (622s left) gem_exec_balancer (invalid-bonds)
[396.494537] Starting subtest: invalid-bonds
[396.498925] Subtest invalid-bonds: SKIP (0.000s)
[396.798532] [058/133] (621s left) gem_exec_schedule (fairslice)
[396.860365] Starting subtest: fairslice
[396.862282] Starting dynamic subtest: rcs0
[398.876688] Dynamic subtest rcs0: SUCCESS (2.021s)
[398.887582] Starting dynamic subtest: bcs0
[400.899069] Dynamic subtest bcs0: SUCCESS (2.024s)
[400.910269] Starting dynamic subtest: vcs0
[402.923036] Dynamic subtest vcs0: SUCCESS (2.021s)
[402.933766] Starting dynamic subtest: vcs1
[404.941413] Dynamic subtest vcs1: SUCCESS (2.017s)
[404.952338] Starting dynamic subtest: vecs0
[406.960653] Dynamic subtest vecs0: SUCCESS (2.019s)
[406.971389] Starting dynamic subtest: ccs0
[408.984281] Dynamic subtest ccs0: SUCCESS (2.023s)
[408.986219] Subtest fairslice: SUCCESS (12.130s)
[409.282010] [059/133] (609s left) api_intel_bb (blit-noreloc-purge-cache)
[409.347105] Starting subtest: blit-noreloc-purge-cache
[409.361282] Subtest blit-noreloc-purge-cache: SUCCESS (0.017s)
[409.486842] [060/133] (609s left) syncobj_wait (wait-all-complex)
[409.539381] Starting subtest: wait-all-complex
[409.756029] Subtest wait-all-complex: SUCCESS (0.216s)
[409.833922] [061/133] (609s left) kms_lease (lease-unleased-crtc)
[409.926055] Starting subtest: lease-unleased-crtc
[409.928273] Starting dynamic subtest: pipe-A-eDP-1
[410.236130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.308s)
[410.246657] Starting dynamic subtest: pipe-B-eDP-1
[411.021523] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.784s)
[411.033785] Starting dynamic subtest: pipe-C-eDP-1
[411.036009] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s)
[411.045355] Starting dynamic subtest: pipe-D-eDP-1
[411.047183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[411.049030] Subtest lease-unleased-crtc: SUCCESS (1.106s)
[411.401868] [062/133] (607s left) kms_chamelium_edid (dp-edid-read)
[411.784538] Subtest dp-edid-read: SKIP (0.000s)
[412.618894] [063/133] (606s left) sysfs_preempt_timeout (idempotent)
[412.683373] Starting subtest: idempotent
[412.685664] Starting dynamic subtest: vecs0
[412.687869] Dynamic subtest vecs0: SUCCESS (0.001s)
[412.699036] Starting dynamic subtest: ccs0
[412.701227] Dynamic subtest ccs0: SUCCESS (0.000s)
[412.711322] Starting dynamic subtest: vcs0
[412.713453] Dynamic subtest vcs0: SUCCESS (0.000s)
[412.723804] Starting dynamic subtest: bcs0
[412.725622] Dynamic subtest bcs0: SUCCESS (0.000s)
[412.736053] Starting dynamic subtest: rcs0
[412.738294] Dynamic subtest rcs0: SUCCESS (0.000s)
[412.748417] Starting dynamic subtest: vcs1
[412.750550] Dynamic subtest vcs1: SUCCESS (0.000s)
[412.752724] Subtest idempotent: SUCCESS (0.009s)
[412.791224] [064/133] (606s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[412.884086] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[412.888118] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[412.968791] [065/133] (606s left) gem_exec_flush (basic-uc-set-default)
[413.030131] Starting subtest: basic-uc-set-default
[418.486945] Subtest basic-uc-set-default: SUCCESS (5.456s)
[418.688791] [066/133] (600s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[418.809765] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[418.814278] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[418.906725] [067/133] (600s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[418.999085] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[419.001388] Starting dynamic subtest: pipe-A-default-mode
[420.208110] Dynamic subtest pipe-A-default-mode: SKIP (1.206s)
[420.212363] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.207s)
[420.383768] [068/133] (598s left) perf_pmu (semaphore-wait-idle)
[420.441061] Starting subtest: semaphore-wait-idle
[420.442908] Starting dynamic subtest: rcs0
[420.955411] Dynamic subtest rcs0: SUCCESS (0.513s)
[420.968781] Starting dynamic subtest: bcs0
[421.469157] Dynamic subtest bcs0: SUCCESS (0.510s)
[421.481191] Starting dynamic subtest: vcs0
[421.982355] Dynamic subtest vcs0: SUCCESS (0.510s)
[421.995620] Starting dynamic subtest: vcs1
[422.495768] Dynamic subtest vcs1: SUCCESS (0.510s)
[422.508901] Starting dynamic subtest: vecs0
[423.010075] Dynamic subtest vecs0: SUCCESS (0.511s)
[423.023340] Starting dynamic subtest: ccs0
[423.525166] Dynamic subtest ccs0: SUCCESS (0.512s)
[423.529291] Subtest semaphore-wait-idle: SUCCESS (3.085s)
[424.817425] [069/133] (594s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[424.927183] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[424.931305] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[425.027203] [070/133] (594s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[425.133217] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[425.746322] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s)
[425.910217] [071/133] (593s left) kms_addfb_basic (bad-pitch-63)
[425.967133] Starting subtest: bad-pitch-63
[425.969449] Subtest bad-pitch-63: SUCCESS (0.000s)
[426.111885] [072/133] (593s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[426.237638] Starting subtest: 2x-flip-vs-cursor-legacy
[426.242391] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[426.397580] [073/133] (593s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[426.461536] Starting subtest: saturated-hostile-nopreempt
[426.463847] Starting dynamic subtest: rcs0
[426.509124] Dynamic subtest rcs0: SKIP (0.044s)
[426.520662] Starting dynamic subtest: bcs0
[426.568461] Dynamic subtest bcs0: SKIP (0.058s)
[426.579262] Starting dynamic subtest: vcs0
[426.593311] Dynamic subtest vcs0: SKIP (0.023s)
[426.604352] Starting dynamic subtest: vcs1
[426.612361] Dynamic subtest vcs1: SKIP (0.017s)
[426.623085] Starting dynamic subtest: vecs0
[426.627705] Dynamic subtest vecs0: SKIP (0.013s)
[426.640025] Starting dynamic subtest: ccs0
[426.644418] Dynamic subtest ccs0: SKIP (0.013s)
[426.648671] Subtest saturated-hostile-nopreempt: SKIP (0.177s)
[426.716808] [074/133] (592s left) kms_pipe_crc_basic (hang-read-crc)
[426.804284] Starting subtest: hang-read-crc
[426.805918] Starting dynamic subtest: pipe-A-eDP-1
[428.865554] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s)
[428.876868] Starting dynamic subtest: pipe-B-eDP-1
[431.646779] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.779s)
[431.657964] Starting dynamic subtest: pipe-C-eDP-1
[434.289674] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.643s)
[434.301451] Starting dynamic subtest: pipe-D-eDP-1
[436.950962] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[436.953388] Subtest hang-read-crc: SUCCESS (10.147s)
[437.784696] [075/133] (581s left) gem_exec_reloc (basic-write-wc-active)
[437.857771] Subtest basic-write-wc-active: SKIP (0.000s)
[437.931439] [076/133] (581s left) kms_psr (psr2-sprite-blt)
[438.034058] Starting subtest: psr2-sprite-blt
[438.036417] Starting dynamic subtest: eDP-1
[439.779003] Dynamic subtest eDP-1: SUCCESS (1.745s)
[439.781358] Subtest psr2-sprite-blt: SUCCESS (1.747s)
[440.660184] [077/133] (578s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[440.757144] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[440.759416] Starting dynamic subtest: pipe-A
[441.905893] Dynamic subtest pipe-A: SUCCESS (1.151s)
[441.918725] Starting dynamic subtest: pipe-B
[444.142189] Dynamic subtest pipe-B: SUCCESS (2.230s)
[444.153322] Starting dynamic subtest: pipe-C
[445.358035] Dynamic subtest pipe-C: SUCCESS (1.217s)
[445.372229] Starting dynamic subtest: pipe-D
[446.577046] Dynamic subtest pipe-D: SUCCESS (1.216s)
[446.579398] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.821s)
[447.759808] [078/133] (571s left) gem_mmap_wc (read-write-distinct)
[447.839046] Subtest read-write-distinct: SKIP (0.000s)
[447.903972] [079/133] (571s left) kms_psr (fbc-psr-primary-mmap-gtt)
[447.990998] Starting subtest: fbc-psr-primary-mmap-gtt
[447.992902] Starting dynamic subtest: eDP-1
[447.996941] Dynamic subtest eDP-1: SKIP (0.000s)
[448.001002] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[448.070109] [080/133] (571s left) kms_cursor_crc (cursor-offscreen-64x21)
[448.275444] Starting subtest: cursor-offscreen-64x21
[448.320527] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[448.575282] [081/133] (571s left) kms_psr (fbc-pr-cursor-render)
[448.663994] Starting subtest: fbc-pr-cursor-render
[448.668352] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[448.736306] [082/133] (571s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[448.828048] Starting subtest: plane-upscale-20x20-with-pixel-format
[448.829832] Starting dynamic subtest: pipe-A
[449.876385] Dynamic subtest pipe-A: SUCCESS (1.050s)
[449.887168] Starting dynamic subtest: pipe-B
[451.966379] Dynamic subtest pipe-B: SUCCESS (2.088s)
[451.976642] Starting dynamic subtest: pipe-C
[453.164205] Dynamic subtest pipe-C: SUCCESS (1.196s)
[453.176297] Starting dynamic subtest: pipe-D
[454.322983] Dynamic subtest pipe-D: SUCCESS (1.156s)
[454.325272] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.496s)
[455.519143] [083/133] (564s left) kms_invalid_mode (uint-max-clock)
[455.622272] Starting subtest: uint-max-clock
[455.624456] Starting dynamic subtest: pipe-A-eDP-1
[455.920867] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.301s)
[455.931429] Starting dynamic subtest: pipe-B-eDP-1
[455.933404] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[455.943008] Starting dynamic subtest: pipe-C-eDP-1
[455.945367] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[455.955279] Starting dynamic subtest: pipe-D-eDP-1
[455.957665] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[455.960004] Subtest uint-max-clock: SUCCESS (0.307s)
[456.778655] [084/133] (563s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[456.903051] Starting subtest: verify-pxp-key-change-after-suspend-resume
[464.890190] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.986s)
[465.029134] [085/133] (554s left) gem_exec_suspend (basic-s0)
[465.089097] Starting subtest: basic-S0
[465.091423] Starting dynamic subtest: smem
[485.037257] Dynamic subtest smem: SUCCESS (6.479s)
[485.040627] Subtest basic-S0: SUCCESS (6.481s)
[485.235338] [086/133] (534s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[485.463748] Starting subtest: cursor-rapid-movement-128x42
[485.513398] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[485.731970] [087/133] (534s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[485.824555] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[485.828951] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[485.903507] [088/133] (534s left) gen9_exec_parse (bb-chained)
[485.958905] Subtest bb-chained: SKIP (0.000s)
[486.029904] [089/133] (534s left) gem_spin_batch (engines)
[486.099076] Starting subtest: engines
[486.101079] Starting dynamic subtest: rcs0
[489.494724] Dynamic subtest rcs0: SUCCESS (3.303s)
[489.507528] Starting dynamic subtest: bcs0
[492.871627] Dynamic subtest bcs0: SUCCESS (3.317s)
[492.884160] Starting dynamic subtest: vcs0
[496.238050] Dynamic subtest vcs0: SUCCESS (3.327s)
[496.250906] Starting dynamic subtest: vcs1
[499.590651] Dynamic subtest vcs1: SUCCESS (3.325s)
[499.603506] Starting dynamic subtest: vecs0
[502.836635] Dynamic subtest vecs0: SUCCESS (3.227s)
[502.848847] Starting dynamic subtest: ccs0
[506.081243] Dynamic subtest ccs0: SUCCESS (3.231s)
[506.083386] Subtest engines: SUCCESS (19.745s)
[506.315279] [090/133] (513s left) gem_ctx_exec (basic-close-race)
[506.369495] Starting subtest: basic-close-race
[511.938016] Subtest basic-close-race: SUCCESS (5.558s)
[512.102700] [091/133] (508s left) kms_content_protection (atomic-dpms-hdcp14)
[512.249648] Starting subtest: atomic-dpms-hdcp14
[512.254350] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[512.394461] [092/133] (507s left) kms_color (ctm-0-50)
[512.494248] Starting subtest: ctm-0-50
[512.496213] Starting dynamic subtest: pipe-A-eDP-1
[515.994167] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s)
[516.006073] Starting dynamic subtest: pipe-B-eDP-1
[520.210945] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.211s)
[520.221516] Starting dynamic subtest: pipe-C-eDP-1
[524.244419] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.032s)
[524.257613] Starting dynamic subtest: pipe-D-eDP-1
[528.257531] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.007s)
[528.259957] Subtest ctm-0-50: SUCCESS (15.752s)
[529.075251] [093/133] (491s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[529.191730] Starting subtest: extended-modeset-hang-oldfb-with-reset
[529.194132] Starting dynamic subtest: pipe-A
[541.151950] Dynamic subtest pipe-A: SUCCESS (11.951s)
[541.162847] Starting dynamic subtest: pipe-D
[553.435535] Dynamic subtest pipe-D: SUCCESS (12.276s)
[553.437641] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.231s)
[554.314397] [094/133] (466s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[554.423229] Starting subtest: 2x-long-cursor-vs-flip-atomic
[554.427969] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[554.571502] [095/133] (465s left) prime_mmap_coherency (read)
[554.630900] Starting subtest: read
[560.014653] Subtest read: SUCCESS (5.379s)
[560.125119] [096/133] (460s left) i915_drm_fdinfo (busy-hang)
[560.175879] Starting subtest: busy-hang
[560.178321] Starting dynamic subtest: rcs0
[560.231652] Dynamic subtest rcs0: SKIP (0.053s)
[560.245190] Starting dynamic subtest: bcs0
[560.249808] Dynamic subtest bcs0: SKIP (0.001s)
[560.260510] Starting dynamic subtest: vcs0
[560.264786] Dynamic subtest vcs0: SKIP (0.001s)
[560.275353] Starting dynamic subtest: vcs1
[560.279763] Dynamic subtest vcs1: SKIP (0.001s)
[560.289932] Starting dynamic subtest: vecs0
[560.294304] Dynamic subtest vecs0: SKIP (0.001s)
[560.304360] Starting dynamic subtest: ccs0
[560.308739] Dynamic subtest ccs0: SKIP (0.001s)
[560.313182] Subtest busy-hang: SKIP (0.064s)
[560.353258] [097/133] (460s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[560.457239] Starting subtest: fbcpsr-stridechange
[566.626462] Subtest fbcpsr-stridechange: SUCCESS (6.168s)
[566.768537] [098/133] (453s left) kms_cursor_crc (cursor-size-change)
[566.869052] Starting subtest: cursor-size-change
[566.871322] Starting dynamic subtest: pipe-A-eDP-1
[567.722431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s)
[567.733795] Starting dynamic subtest: pipe-D-eDP-1
[569.190884] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.466s)
[569.193121] Subtest cursor-size-change: SUCCESS (2.321s)
[569.996345] [099/133] (450s left) kms_big_fb (4-tiled-addfb-size-overflow)
[570.094024] Starting subtest: 4-tiled-addfb-size-overflow
[570.096295] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[570.206577] [100/133] (450s left) kms_pm_rpm (cursor)
[572.341422] Starting subtest: cursor
[572.346137] Subtest cursor: SKIP (0.000s)
[572.754149] [101/133] (447s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[572.847504] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[579.452702] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.605s)
[579.579161] [102/133] (441s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[579.686875] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[586.431696] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.750s)
[586.540372] [103/133] (434s left) api_intel_bb (destroy-bb)
[586.597027] Starting subtest: destroy-bb
[586.604996] Subtest destroy-bb: SUCCESS (0.007s)
[586.743302] [104/133] (434s left) gem_userptr_blits (probe)
[586.822461] Starting subtest: probe
[586.900036] Subtest probe: SUCCESS (0.077s)
[587.007384] [105/133] (433s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[587.106591] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[587.111084] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[587.202260] [106/133] (433s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[587.302055] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[594.165391] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.867s)
[594.307790] [107/133] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[594.415253] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[594.419648] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[594.516788] [108/133] (426s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[594.612492] Starting subtest: primary-4-tiled-reflect-x-0
[601.713442] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.103s)
[602.908924] [109/133] (418s left) gem_pwrite (basic-self)
[602.973823] Subtest basic-self: SKIP (0.000s)
[603.044873] [110/133] (418s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[603.162466] Starting subtest: cursorA-vs-flipA-atomic
[614.297350] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.135s)
[615.129227] [111/133] (406s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[615.178173] Starting subtest: multi-wait-for-submit-available-submitted
[615.180573] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[615.269197] [112/133] (405s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[615.363526] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[615.451086] [113/133] (405s left) gem_softpin (evict-snoop)
[615.521187] Starting subtest: evict-snoop
[615.525279] Subtest evict-snoop: SKIP (0.000s)
[615.642647] [114/133] (405s left) gem_exec_params (dr1-dirt)
[615.709994] Starting subtest: DR1-dirt
[615.712383] Subtest DR1-dirt: SUCCESS (0.000s)
[615.804890] [115/133] (405s left) gem_exec_nop (basic-sequential)
[615.879606] Starting subtest: basic-sequential
[630.641242] Subtest basic-sequential: SUCCESS (14.767s)
[630.892035] [116/133] (390s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[631.002279] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[631.007181] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[631.112547] [117/133] (390s left) vgem_basic (dmabuf-mmap)
[631.178340] Starting subtest: dmabuf-mmap
[631.202267] Subtest dmabuf-mmap: SUCCESS (0.029s)
[631.268645] [118/133] (390s left) kms_psr (fbc-psr2-primary-render)
[631.366934] Starting subtest: fbc-psr2-primary-render
[631.369180] Starting dynamic subtest: eDP-1
[631.373306] Dynamic subtest eDP-1: SKIP (0.000s)
[631.377475] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[631.440984] [119/133] (390s left) kms_atomic (plane-immutable-zpos)
[631.538633] Starting subtest: plane-immutable-zpos
[631.540919] Starting dynamic subtest: pipe-A-eDP-1
[632.174739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.634s)
[632.176690] Subtest plane-immutable-zpos: SUCCESS (0.636s)
[633.064508] [120/133] (388s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[633.169546] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[633.174100] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[633.277109] [121/133] (388s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[633.389131] Starting subtest: basic-flip-after-cursor-varying-size
[634.316552] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.925s)
[635.183446] [122/133] (386s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[635.293941] Starting subtest: plane-all-transition-nonblocking-fencing
[635.296193] Starting dynamic subtest: pipe-A-eDP-1
[637.789683] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[638.108567] Starting dynamic subtest: pipe-B-eDP-1
[641.329424] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.231s)
[641.635520] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.340s)
[642.469097] [123/133] (379s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[642.566480] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[642.570708] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[642.673554] [124/133] (379s left) kms_tiled_display (basic-test-pattern)
[642.801097] Subtest basic-test-pattern: SKIP (0.000s)
[642.846210] [125/133] (378s left) kms_plane_lowres (tiling-x)
[642.929572] Starting subtest: tiling-x
[642.931785] Starting dynamic subtest: pipe-A-eDP-1
[642.936321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.227136] Starting dynamic subtest: pipe-B-eDP-1
[643.231846] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.242244] Starting dynamic subtest: pipe-C-eDP-1
[643.247030] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.257697] Starting dynamic subtest: pipe-D-eDP-1
[643.261779] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.265799] Subtest tiling-x: SKIP (0.298s)
[644.093963] [126/133] (377s left) gem_exec_schedule (in-order)
[644.157112] Starting subtest: in-order
[644.159007] Starting dynamic subtest: rcs0
[644.257729] Dynamic subtest rcs0: SUCCESS (0.109s)
[644.275382] Starting dynamic subtest: vcs0
[644.340948] Dynamic subtest vcs0: SUCCESS (0.082s)
[644.355068] Starting dynamic subtest: vcs1
[644.431994] Dynamic subtest vcs1: SUCCESS (0.090s)
[644.445531] Starting dynamic subtest: vecs0
[644.524707] Dynamic subtest vecs0: SUCCESS (0.091s)
[644.538063] Starting dynamic subtest: ccs0
[644.624099] Dynamic subtest ccs0: SUCCESS (0.097s)
[644.626480] Subtest in-order: SUCCESS (0.476s)
[646.230286] [127/133] (375s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[646.330731] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[652.897123] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.569s)
[653.035857] [128/133] (368s left) kms_frontbuffer_tracking (psr-slowdraw)
[653.136540] Starting subtest: psr-slowdraw
[678.321697] Subtest psr-slowdraw: SUCCESS (25.180s)
[678.448911] [129/133] (343s left) syncobj_wait (wait-any-interrupted)
[678.510592] Starting subtest: wait-any-interrupted
[678.616876] Subtest wait-any-interrupted: SUCCESS (0.105s)
[678.701371] [130/133] (343s left) gem_ctx_persistence (engines-queued)
[678.762811] Starting subtest: engines-queued
[678.765283] Starting dynamic subtest: rcs0
[678.829494] Dynamic subtest rcs0: SUCCESS (0.066s)
[678.842625] Starting dynamic subtest: bcs0
[678.876455] Dynamic subtest bcs0: SUCCESS (0.046s)
[678.887736] Starting dynamic subtest: vcs0
[680.075417] Dynamic subtest vcs0: SUCCESS (1.195s)
[680.089945] Starting dynamic subtest: vcs1
[682.057761] Dynamic subtest vcs1: SUCCESS (1.979s)
[682.072957] Starting dynamic subtest: vecs0
[684.105535] Dynamic subtest vecs0: SUCCESS (2.044s)
[684.119616] Starting dynamic subtest: ccs0
[684.283271] Dynamic subtest ccs0: SUCCESS (0.176s)
[684.285741] Subtest engines-queued: SUCCESS (5.519s)
[684.425421] [131/133] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[684.526930] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[684.531108] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[684.624765] [132/133] (337s left) gem_mmap_gtt (medium-copy)
[684.687482] Subtest medium-copy: SKIP (0.000s)
[684.751505] [133/133] (337s left) i915_pm_rps (waitboost)
[684.811105] Starting subtest: waitboost
[690.912718] Subtest waitboost: SUCCESS (6.098s)
[691.036257] 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.