[53.546109] Initializing watchdogs
[53.546347]   /dev/watchdog0
[53.563551] [001/142] (960s left) kms_chamelium_edid (dp-edid-resolution-list)
[53.992287] Subtest dp-edid-resolution-list: SKIP (0.000s)
[54.290142] [002/142] (959s left) kms_psr (dpms)
[54.521417] Subtest dpms: SKIP (0.000s)
[54.566031] [003/142] (959s left) gem_softpin (evict-single-offset)
[54.791899] Starting subtest: evict-single-offset
[91.231862] Subtest evict-single-offset: SUCCESS (36.439s)
[91.318755] [004/142] (922s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[92.025658] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[92.032219] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[92.412784] [005/142] (921s left) prime_mmap (test_correct_cpu_write)
[92.627035] Starting subtest: test_correct_cpu_write
[92.629390] Starting dynamic subtest: test_correct_cpu_write-smem
[92.631633] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.001s)
[92.633852] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[92.728668] [006/142] (921s left) gem_pxp (reject-modify-context-protection-on)
[95.456151] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[95.544358] [007/142] (918s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[95.853468] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[97.163769] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.313s)
[97.500752] [008/142] (916s left) drm_fdinfo (idle)
[97.714626] Starting subtest: idle
[97.717150] Starting dynamic subtest: rcs0
[98.221372] Dynamic subtest rcs0: SUCCESS (0.506s)
[98.237869] Starting dynamic subtest: bcs0
[98.726400] Dynamic subtest bcs0: SUCCESS (0.504s)
[98.741957] Starting dynamic subtest: vcs0
[99.231184] Dynamic subtest vcs0: SUCCESS (0.505s)
[99.247681] Starting dynamic subtest: vecs0
[99.736086] Dynamic subtest vecs0: SUCCESS (0.504s)
[99.738408] Subtest idle: SUCCESS (2.021s)
[99.815185] [009/142] (914s left) gem_exec_fair (basic-flow)
[100.065945] Starting subtest: basic-flow
[100.068380] Starting dynamic subtest: rcs0
[105.077407] Dynamic subtest rcs0: SUCCESS (5.011s)
[105.079666] Subtest basic-flow: SUCCESS (5.012s)
[105.282690] [010/142] (909s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[105.507757] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[105.512071] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[105.699345] [011/142] (908s left) kms_lease (cursor_implicit_plane)
[106.001622] Starting subtest: cursor_implicit_plane
[106.004278] Starting dynamic subtest: pipe-A-DP-1
[106.258701] Dynamic subtest pipe-A-DP-1: SUCCESS (0.256s)
[106.275239] Starting dynamic subtest: pipe-B-DP-1
[106.836956] Dynamic subtest pipe-B-DP-1: SUCCESS (0.575s)
[106.853318] Starting dynamic subtest: pipe-C-DP-1
[107.560403] Dynamic subtest pipe-C-DP-1: SUCCESS (0.720s)
[107.562690] Subtest cursor_implicit_plane: SUCCESS (1.557s)
[107.875358] [012/142] (906s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[108.083063] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[108.085341] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[108.174845] [013/142] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[108.494705] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[108.498894] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[108.592850] [014/142] (905s left) kms_plane_scaling (planes-downscale-factor-0-5)
[108.903196] Starting subtest: planes-downscale-factor-0-5
[108.906278] Starting dynamic subtest: pipe-A-DP-1
[109.246328] Dynamic subtest pipe-A-DP-1: SUCCESS (0.345s)
[109.265310] Starting dynamic subtest: pipe-B-DP-1
[109.651367] Dynamic subtest pipe-B-DP-1: SUCCESS (0.402s)
[109.670170] Starting dynamic subtest: pipe-C-DP-1
[109.747459] Dynamic subtest pipe-C-DP-1: SKIP (0.091s)
[109.749751] Subtest planes-downscale-factor-0-5: SUCCESS (0.846s)
[110.140941] [015/142] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[110.453624] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[110.457861] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[110.542750] [016/142] (904s left) kms_vblank (pipe-a-query-forked-hang)
[110.846608] Starting subtest: pipe-A-query-forked-hang
[117.999974] Subtest pipe-A-query-forked-hang: SUCCESS (7.156s)
[118.332118] [017/142] (896s left) kms_plane_alpha_blend (alpha-transparent-fb)
[118.633368] Starting subtest: alpha-transparent-fb
[118.938946] Starting dynamic subtest: pipe-A-DP-1
[119.723261] Dynamic subtest pipe-A-DP-1: FAIL (0.630s)
[119.740986] Starting dynamic subtest: pipe-C-DP-1
[120.628369] Dynamic subtest pipe-C-DP-1: FAIL (0.898s)
[120.630775] Subtest alpha-transparent-fb: FAIL (1.839s)
[120.965205] [018/142] (893s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[121.279161] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[121.371404] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[121.512635] [019/142] (893s left) gem_exec_schedule (u-lateslice)
[121.962101] Starting subtest: u-lateslice
[121.964250] Starting dynamic subtest: rcs0
[121.966430] Dynamic subtest rcs0: SUCCESS (0.042s)
[121.982913] Starting dynamic subtest: bcs0
[121.985179] Dynamic subtest bcs0: SUCCESS (0.037s)
[122.001938] Starting dynamic subtest: vcs0
[122.004238] Dynamic subtest vcs0: SUCCESS (0.029s)
[122.020988] Starting dynamic subtest: vecs0
[122.023236] Dynamic subtest vecs0: SUCCESS (0.030s)
[122.025432] Subtest u-lateslice: SUCCESS (0.141s)
[122.313840] [020/142] (892s left) gem_workarounds (reset-fd)
[122.557109] Starting subtest: reset-fd
[122.586581] Subtest reset-fd: SUCCESS (0.029s)
[122.697873] [021/142] (892s left) kms_psr (psr2_primary_mmap_gtt)
[122.906786] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[122.962091] [022/142] (892s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[123.627198] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[123.944384] [023/142] (891s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[124.480989] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[124.486568] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[124.925378] [024/142] (890s left) kms_prop_blob (invalid-set-prop-any)
[125.128756] Starting subtest: invalid-set-prop-any
[125.131035] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[125.208395] [025/142] (889s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[125.472475] Subtest get-values-valid-perfmon: SKIP (0.000s)
[125.541790] [026/142] (889s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[125.842776] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[125.849586] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.003s)
[125.942689] [027/142] (889s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[126.257289] Starting subtest: fbcpsr-tiling-4
[126.262100] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[126.342914] [028/142] (888s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs)
[127.008933] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[127.324631] [029/142] (887s left) api_intel_bb (intel-bb-blit-none)
[127.530343] Starting subtest: intel-bb-blit-none
[131.181894] Subtest intel-bb-blit-none: SUCCESS (3.652s)
[131.288932] [030/142] (883s left) gem_exec_balancer (bonded-semaphore)
[131.520327] Starting subtest: bonded-semaphore
[135.133081] Subtest bonded-semaphore: SUCCESS (3.612s)
[139.024142] [031/142] (876s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[139.345886] Starting subtest: yf-tiled-8bpp-rotate-90
[139.350163] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[139.441441] [032/142] (875s left) syncobj_timeline (invalid-wait-bad-flags)
[139.647284] Starting subtest: invalid-wait-bad-flags
[139.649668] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[139.724235] [033/142] (875s left) prime_udl
[139.973899] [034/142] (875s left) gem_mmap_offset (bad-extensions)
[140.179088] Starting subtest: bad-extensions
[140.181339] Subtest bad-extensions: SUCCESS (0.000s)
[140.290122] [035/142] (875s left) i915_suspend (basic-s2idle-without-i915)
[140.490238] Starting subtest: basic-s2idle-without-i915
[160.428763] Subtest basic-s2idle-without-i915: SUCCESS (19.938s)
[165.609948] [036/142] (854s left) gem_close_race (basic-process)
[165.885561] Starting subtest: basic-process
[165.981913] Subtest basic-process: SUCCESS (0.096s)
[166.178414] [037/142] (854s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs)
[166.874457] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs
[166.881093] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[167.225663] [038/142] (853s left) kms_vblank (pipe-d-wait-busy)
[167.527728] Subtest pipe-D-wait-busy: SKIP (0.000s)
[167.609063] [039/142] (853s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[168.128512] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[168.133469] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[168.601167] [040/142] (852s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[168.927380] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[168.931532] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.001s)
[169.035430] [041/142] (851s left) prime_self_import (basic-llseek-bad)
[169.235927] Starting subtest: basic-llseek-bad
[169.241083] Subtest basic-llseek-bad: SUCCESS (0.005s)
[169.334294] [042/142] (851s left) kms_flip (2x-nonexisting-fb-interruptible)
[169.639749] Starting subtest: 2x-nonexisting-fb-interruptible
[169.644046] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.003s)
[169.734599] [043/142] (851s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[170.040699] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[170.043281] Starting dynamic subtest: pipe-A-DP-1
[171.243068] Dynamic subtest pipe-A-DP-1: SUCCESS (1.204s)
[171.265424] Starting dynamic subtest: pipe-B-DP-1
[172.723645] Dynamic subtest pipe-B-DP-1: SUCCESS (1.477s)
[172.746465] Starting dynamic subtest: pipe-C-DP-1
[173.797766] Dynamic subtest pipe-C-DP-1: SUCCESS (1.071s)
[173.800092] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.763s)
[174.262488] [044/142] (846s left) syncobj_timeline (single-wait-available-signaled)
[174.493153] Starting subtest: single-wait-available-signaled
[174.496955] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[174.600278] [045/142] (846s left) api_intel_bb (purge-bb)
[174.826988] Starting subtest: purge-bb
[174.833997] Subtest purge-bb: SUCCESS (0.007s)
[174.947205] [046/142] (846s left) i915_pm_rpm (cursor-dpms)
[176.886464] Starting subtest: cursor-dpms
[179.661029] Subtest cursor-dpms: SUCCESS (2.772s)
[180.092854] [047/142] (840s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[180.405333] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[180.409452] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[180.507437] [048/142] (840s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[180.836119] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[180.870454] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.031s)
[180.990230] [049/142] (840s left) perf (gen12-unprivileged-single-ctx-counters)
[181.338628] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[181.388952] [050/142] (839s left) gem_mmap_gtt (cpuset-basic-small-copy)
[181.591139] Starting subtest: cpuset-basic-small-copy
[187.420283] Subtest cpuset-basic-small-copy: SUCCESS (5.829s)
[187.524219] [051/142] (833s left) sw_sync (sync_multi_producer_single_consumer)
[187.854353] Starting subtest: sync_multi_producer_single_consumer
[188.934441] Subtest sync_multi_producer_single_consumer: SUCCESS (1.079s)
[189.007436] [052/142] (832s left) gem_bad_reloc (negative-reloc-lut)
[189.224149] Starting subtest: negative-reloc-lut
[189.231221] Subtest negative-reloc-lut: SUCCESS (0.002s)
[189.339356] [053/142] (831s left) kms_lease (lessee_list)
[189.655124] Starting subtest: lessee_list
[189.658654] Starting dynamic subtest: pipe-A-DP-1
[189.662366] Dynamic subtest pipe-A-DP-1: SUCCESS (0.002s)
[189.683674] Starting dynamic subtest: pipe-B-DP-1
[189.685825] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s)
[189.707866] Starting dynamic subtest: pipe-C-DP-1
[189.709899] Dynamic subtest pipe-C-DP-1: SUCCESS (0.001s)
[189.711892] Subtest lessee_list: SUCCESS (0.013s)
[189.757793] [054/142] (831s left) perf (whitelisted-registers-userspace-config)
[190.087089] Starting subtest: whitelisted-registers-userspace-config
[190.089622] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[190.137936] [055/142] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[190.464677] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[192.514716] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.057s)
[192.656371] [056/142] (828s left) kms_chamelium_frames (dp-crc-fast)
[193.068209] Subtest dp-crc-fast: SKIP (0.000s)
[193.362060] [057/142] (828s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[194.032498] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[194.338650] [058/142] (827s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[194.654056] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[194.658065] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[194.755870] [059/142] (826s left) gem_close_race (multigpu-basic-process)
[194.991311] Starting subtest: multigpu-basic-process
[194.995686] Subtest multigpu-basic-process: SKIP (0.000s)
[195.223384] [060/142] (826s left) gem_userptr_blits (nohangcheck)
[195.497138] Starting subtest: nohangcheck
[195.828961] Subtest nohangcheck: SUCCESS (0.332s)
[195.939720] [061/142] (825s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[196.241669] Starting subtest: cursor-vs-flip-atomic-transitions
[234.799623] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (38.562s)
[235.147280] [062/142] (786s left) kms_concurrent (pipe-d)
[235.451418] Subtest pipe-D: SKIP (0.000s)
[235.544063] [063/142] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[235.865444] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[235.869817] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[235.960445] [064/142] (785s left) gem_exec_suspend (basic)
[236.186932] Starting subtest: basic
[236.189890] Starting dynamic subtest: smem
[237.534461] Dynamic subtest smem: SUCCESS (1.346s)
[237.536819] Subtest basic: SUCCESS (1.349s)
[237.743751] [065/142] (783s left) sw_sync (sync_random_merge)
[237.946194] Starting subtest: sync_random_merge
[238.095267] Subtest sync_random_merge: SUCCESS (0.149s)
[238.176340] [066/142] (783s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[238.382568] Starting subtest: single-wait-for-submit-unsubmitted
[238.486135] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[238.575776] [067/142] (783s left) gem_wait (invalid-buf)
[238.786827] Starting subtest: invalid-buf
[238.789142] Subtest invalid-buf: SUCCESS (0.000s)
[239.059950] [068/142] (782s left) kms_addfb_basic (addfb25-bad-modifier)
[239.265672] Starting subtest: addfb25-bad-modifier
[239.268061] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[239.478497] [069/142] (782s left) gem_exec_fence (syncobj-timeline-wait)
[240.354130] Starting subtest: syncobj-timeline-wait
[240.390346] Subtest syncobj-timeline-wait: SUCCESS (0.037s)
[240.626994] [070/142] (781s left) syncobj_timeline (multi-wait-signaled)
[240.834408] Starting subtest: multi-wait-signaled
[240.836674] Subtest multi-wait-signaled: SUCCESS (0.002s)
[240.925914] [071/142] (781s left) gem_ctx_isolation (preservation)
[241.152153] Starting subtest: preservation
[241.154571] Starting dynamic subtest: rcs0
[242.298372] Dynamic subtest rcs0: SUCCESS (1.144s)
[242.319978] Starting dynamic subtest: bcs0
[243.786989] Dynamic subtest bcs0: SUCCESS (1.488s)
[243.809326] Starting dynamic subtest: vcs0
[244.867777] Dynamic subtest vcs0: SUCCESS (1.079s)
[244.889908] Starting dynamic subtest: vecs0
[245.952804] Dynamic subtest vecs0: SUCCESS (1.084s)
[245.955359] Subtest preservation: SUCCESS (4.801s)
[246.194681] [072/142] (775s left) gem_userptr_blits (create-destroy-sync)
[246.437546] Starting subtest: create-destroy-sync
[251.477432] Subtest create-destroy-sync: SUCCESS (5.039s)
[251.626883] [073/142] (770s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs)
[252.078888] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs
[252.081415] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.001s)
[252.614764] [074/142] (769s left) gen9_exec_parse (cmd-crossing-page)
[252.844172] Starting subtest: cmd-crossing-page
[252.852668] Subtest cmd-crossing-page: SUCCESS (0.008s)
[253.064825] [075/142] (769s left) gem_exec_balancer (noheartbeat)
[257.086461] Starting subtest: noheartbeat
[260.770400] Subtest noheartbeat: SUCCESS (3.684s)
[260.863876] [076/142] (761s left) kms_async_flips (test-cursor)
[261.165961] Starting subtest: test-cursor
[261.613820] Starting dynamic subtest: pipe-A-DP-1
[262.494369] Dynamic subtest pipe-A-DP-1: SUCCESS (0.881s)
[263.031127] Starting dynamic subtest: pipe-B-DP-1
[263.258628] Dynamic subtest pipe-B-DP-1: SUCCESS (0.263s)
[263.696332] Starting dynamic subtest: pipe-C-DP-1
[263.939942] Dynamic subtest pipe-C-DP-1: SUCCESS (0.268s)
[263.943225] Subtest test-cursor: SUCCESS (2.779s)
[264.589934] [077/142] (757s left) gen7_exec_parse (load-register-reg)
[264.806577] Subtest load-register-reg: SKIP (0.000s)
[264.870891] [078/142] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[265.181601] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[265.185779] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[265.289667] [079/142] (757s left) kms_vblank (pipe-b-ts-continuation-modeset-rpm)
[265.600361] Starting subtest: pipe-B-ts-continuation-modeset-rpm
[267.800664] Subtest pipe-B-ts-continuation-modeset-rpm: SUCCESS (2.203s)
[268.269929] [080/142] (754s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[268.589414] Starting subtest: fbc-1p-pri-indfb-multidraw
[283.741973] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (15.157s)
[283.885451] [081/142] (738s left) kms_flip (nonexisting-fb)
[284.182230] Starting subtest: nonexisting-fb
[284.184539] Starting dynamic subtest: A-DP1
[284.726308] Dynamic subtest A-DP1: SUCCESS (0.545s)
[284.748540] Starting dynamic subtest: B-DP1
[285.207995] Dynamic subtest B-DP1: SUCCESS (0.480s)
[285.230514] Starting dynamic subtest: C-DP1
[285.675407] Dynamic subtest C-DP1: SUCCESS (0.465s)
[285.678064] Subtest nonexisting-fb: SUCCESS (1.501s)
[286.107754] [082/142] (736s left) vgem_basic (unload)
[286.308472] Starting subtest: unload
[315.303805] Subtest unload: SUCCESS (28.994s)
[315.437255] [083/142] (707s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[315.756343] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[315.760401] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[315.872158] [084/142] (706s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_mc_ccs)
[316.448381] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs
[316.453214] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[316.875807] [085/142] (705s left) sw_sync (sync_busy)
[317.080419] Starting subtest: sync_busy
[317.087998] Subtest sync_busy: SUCCESS (0.008s)
[317.158680] [086/142] (705s left) gem_fence_thrash (bo-write-verify-threaded-y)
[317.359823] Starting subtest: bo-write-verify-threaded-y
[320.125402] Subtest bo-write-verify-threaded-y: SUCCESS (2.766s)
[320.226682] [087/142] (702s left) kms_getfb (getfb-handle-zero)
[320.432292] Starting subtest: getfb-handle-zero
[320.434894] Subtest getfb-handle-zero: SUCCESS (0.000s)
[320.541068] [088/142] (702s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[320.867520] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[322.348265] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.480s)
[322.509647] [089/142] (700s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[323.186606] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[323.191086] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.004s)
[323.525576] [090/142] (699s left) i915_pm_backlight (fade)
[323.832060] Subtest fade: SKIP (0.000s)
[323.890571] [091/142] (698s left) v3d/v3d_submit_cl (simple-flush-cache)
[324.149384] Subtest simple-flush-cache: SKIP (0.000s)
[324.224609] [092/142] (698s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[324.557654] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[325.929302] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.372s)
[326.078527] [093/142] (696s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[326.400272] Starting subtest: 4-tiled-8bpp-rotate-0
[326.405209] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[326.508378] [094/142] (696s left) kms_dsc (dsc-with-bpc)
[326.814302] Subtest dsc-with-bpc: SKIP (0.000s)
[326.874304] [095/142] (696s left) gem_ctx_shared (q-in-order)
[327.105840] Starting subtest: Q-in-order
[327.109149] Starting dynamic subtest: rcs0
[327.214926] Dynamic subtest rcs0: SUCCESS (0.107s)
[327.240323] Starting dynamic subtest: bcs0
[327.331631] Dynamic subtest bcs0: SUCCESS (0.116s)
[327.356684] Starting dynamic subtest: vcs0
[327.423213] Dynamic subtest vcs0: SUCCESS (0.089s)
[327.452046] Starting dynamic subtest: vecs0
[327.519742] Dynamic subtest vecs0: SUCCESS (0.094s)
[327.522528] Subtest Q-in-order: SUCCESS (0.415s)
[327.757780] [096/142] (695s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[328.072434] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[330.280955] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (2.215s)
[330.424597] [097/142] (692s left) perf (polling-parameterized)
[330.714466] Starting subtest: polling-parameterized
[350.833787] Subtest polling-parameterized: SUCCESS (20.117s)
[350.892283] [098/142] (672s left) gem_exec_schedule (lateslice)
[351.126210] Starting subtest: lateslice
[351.128863] Starting dynamic subtest: rcs0
[351.155959] Dynamic subtest rcs0: SUCCESS (0.029s)
[351.178537] Starting dynamic subtest: bcs0
[351.191840] Dynamic subtest bcs0: SUCCESS (0.033s)
[351.216245] Starting dynamic subtest: vcs0
[351.226091] Dynamic subtest vcs0: SUCCESS (0.032s)
[351.251545] Starting dynamic subtest: vecs0
[351.259222] Dynamic subtest vecs0: SUCCESS (0.030s)
[351.261417] Subtest lateslice: SUCCESS (0.134s)
[351.626901] [099/142] (671s left) gem_lmem_swapping (parallel-random-verify-ccs)
[351.842647] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[351.910619] [100/142] (671s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs)
[352.394581] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs
[352.400663] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[352.901989] [101/142] (670s left) kms_vblank (pipe-c-query-busy-hang)
[353.208562] Starting subtest: pipe-C-query-busy-hang
[360.995790] Subtest pipe-C-query-busy-hang: SUCCESS (7.791s)
[361.345143] [102/142] (662s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[361.601079] Subtest create-bo-invalid-flags: SKIP (0.000s)
[361.677662] [103/142] (661s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[361.988755] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[361.992326] Starting dynamic subtest: pipe-A-valid-mode
[362.739553] Dynamic subtest pipe-A-valid-mode: SKIP (0.749s)
[362.743967] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.754s)
[363.131580] [104/142] (660s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[363.519205] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[363.523916] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[364.118494] [105/142] (659s left) perf (invalid-create-userspace-config)
[364.410748] Starting subtest: invalid-create-userspace-config
[364.413315] Subtest invalid-create-userspace-config: SUCCESS (0.005s)
[364.466835] [106/142] (659s left) kms_atomic (test-only)
[364.898222] Starting subtest: test-only
[365.840070] Subtest test-only: SUCCESS (0.947s)
[366.189466] [107/142] (657s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted)
[366.398273] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted
[366.400721] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[366.487384] [108/142] (657s left) kms_flip (plain-flip-ts-check)
[366.776680] Starting subtest: plain-flip-ts-check
[366.778817] Starting dynamic subtest: A-DP1
[377.609624] Dynamic subtest A-DP1: SUCCESS (10.834s)
[377.635425] Starting dynamic subtest: B-DP1
[388.372126] Dynamic subtest B-DP1: SUCCESS (10.759s)
[388.397514] Starting dynamic subtest: C-DP1
[399.115081] Dynamic subtest C-DP1: SUCCESS (10.738s)
[399.117407] Subtest plain-flip-ts-check: SUCCESS (32.344s)
[399.551717] [109/142] (624s left) gem_exec_whisper (basic-normal-all)
[399.783560] Starting subtest: basic-normal-all
[408.300703] Subtest basic-normal-all: SUCCESS (8.516s)
[408.517841] [110/142] (615s left) i915_pm_rpm (gem-evict-pwrite)
[410.316670] Starting subtest: gem-evict-pwrite
[411.407863] Subtest gem-evict-pwrite: SUCCESS (1.091s)
[411.933864] [111/142] (611s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[412.275571] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[412.280118] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[412.383521] [112/142] (611s left) kms_color (ctm-0-75)
[412.712652] Starting subtest: ctm-0-75
[412.714862] Starting dynamic subtest: pipe-A
[415.226324] Dynamic subtest pipe-A: SUCCESS (2.506s)
[415.258483] Starting dynamic subtest: pipe-B
[418.061693] Dynamic subtest pipe-B: SUCCESS (2.836s)
[418.091752] Starting dynamic subtest: pipe-C
[420.976317] Dynamic subtest pipe-C: SUCCESS (2.919s)
[420.979194] Subtest ctm-0-75: SUCCESS (8.269s)
[421.312846] [113/142] (602s left) kms_vblank (pipe-b-ts-continuation-suspend)
[421.617792] Starting subtest: pipe-B-ts-continuation-suspend
[439.202643] Subtest pipe-B-ts-continuation-suspend: SUCCESS (2.133s)
[444.544305] [114/142] (599s left) kms_cursor_crc (cursor-random-max-size)
[444.879732] Starting subtest: cursor-random-max-size
[444.886156] Subtest cursor-random-max-size: SKIP (0.000s)
[444.988564] [115/142] (599s left) gem_exec_schedule (fifo)
[445.223775] Starting subtest: fifo
[445.226106] Starting dynamic subtest: rcs0
[445.369423] Dynamic subtest rcs0: SUCCESS (0.143s)
[445.402230] Starting dynamic subtest: bcs0
[445.520045] Dynamic subtest bcs0: SUCCESS (0.146s)
[445.554443] Starting dynamic subtest: vcs0
[445.652033] Dynamic subtest vcs0: SUCCESS (0.128s)
[445.679394] Starting dynamic subtest: vecs0
[445.782567] Dynamic subtest vecs0: SUCCESS (0.129s)
[445.784931] Subtest fifo: SUCCESS (0.558s)
[446.155733] [116/142] (598s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[446.859693] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[447.155963] [117/142] (597s left) vc4/vc4_wait_bo (bad-bo)
[447.424838] Subtest bad-bo: SKIP (0.000s)
[447.505776] [118/142] (597s left) kms_vblank (pipe-d-query-forked)
[447.819750] Subtest pipe-D-query-forked: SKIP (0.000s)
[447.921699] [119/142] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[448.241519] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[448.245760] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[448.354790] [120/142] (596s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[448.661789] Starting subtest: basic-flip-before-cursor-legacy
[449.743756] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.083s)
[450.084100] [121/142] (594s left) kms_selftest (drm_damage)
[450.287437] Starting subtest: drm_damage
[450.296096] Subtest drm_damage: SKIP (0.004s)
[450.382096] [122/142] (594s left) kms_fbcon_fbt (fbc)
[450.599480] Starting subtest: fbc
[454.548037] Subtest fbc: SUCCESS (3.950s)
[454.609763] [123/142] (590s left) core_getversion
[454.914150] [124/142] (589s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[455.219565] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[455.224091] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[455.314545] [125/142] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[455.632115] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[455.636332] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[455.747866] [126/142] (589s left) gem_ctx_persistence (legacy-engines-hang)
[455.963607] Starting subtest: legacy-engines-hang
[455.966238] Starting dynamic subtest: render
[456.007791] Dynamic subtest render: SUCCESS (0.042s)
[456.040572] Starting dynamic subtest: bsd
[456.042757] Dynamic subtest bsd: SUCCESS (0.031s)
[456.070807] Starting dynamic subtest: blt
[456.075453] Dynamic subtest blt: SKIP (0.004s)
[456.101053] Starting dynamic subtest: vebox
[456.111735] Dynamic subtest vebox: SUCCESS (0.059s)
[456.114296] Subtest legacy-engines-hang: SUCCESS (0.150s)
[456.214823] [127/142] (588s left) kms_vblank (pipe-b-ts-continuation-modeset)
[456.516411] Starting subtest: pipe-B-ts-continuation-modeset
[457.535102] Subtest pipe-B-ts-continuation-modeset: SUCCESS (1.020s)
[457.852987] [128/142] (587s left) gem_pread (uncached)
[458.064644] Starting subtest: uncached
[462.604017] Subtest uncached: SUCCESS (4.538s)
[462.718613] [129/142] (582s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[463.038467] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[463.042748] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[463.152983] [130/142] (582s left) prime_mmap (test_forked_cpu_write)
[463.359667] Starting subtest: test_forked_cpu_write
[463.361987] Starting dynamic subtest: test_forked_cpu_write-smem
[463.396879] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.036s)
[463.399145] Subtest test_forked_cpu_write: SUCCESS (0.040s)
[463.503771] [131/142] (581s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[463.972716] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[464.498293] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.526s)
[465.115102] [132/142] (580s left) gem_exec_parallel (contexts)
[465.347164] Starting subtest: contexts
[465.349855] Starting dynamic subtest: rcs0
[469.353900] Dynamic subtest rcs0: SUCCESS (4.004s)
[469.381594] Starting dynamic subtest: bcs0
[473.438230] Dynamic subtest bcs0: SUCCESS (4.081s)
[473.467014] Starting dynamic subtest: vcs0
[477.340620] Dynamic subtest vcs0: SUCCESS (3.899s)
[477.369072] Starting dynamic subtest: vecs0
[481.275754] Dynamic subtest vecs0: SUCCESS (3.931s)
[481.278076] Subtest contexts: SUCCESS (15.927s)
[481.503549] [133/142] (563s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[481.827823] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[481.832379] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[481.931731] [134/142] (563s left) gem_exec_params (cliprects-invalid)
[482.147000] Starting subtest: cliprects-invalid
[482.149700] Subtest cliprects-invalid: SUCCESS (0.001s)
[482.263091] [135/142] (563s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[482.474388] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[482.529044] [136/142] (562s left) vc4/vc4_perfmon (create-perfmon-exceed)
[482.784985] Subtest create-perfmon-exceed: SKIP (0.000s)
[482.863579] [137/142] (562s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[483.171826] Starting subtest: cursorA-vs-flipA-legacy
[494.232304] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.058s)
[494.602601] [138/142] (550s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[495.027458] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[495.032403] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[495.682124] [139/142] (549s left) kms_content_protection (dp-mst-type-1)
[496.098362] Starting subtest: dp-mst-type-1
[496.148241] Subtest dp-mst-type-1: SKIP (0.001s)
[496.276093] [140/142] (549s left) vc4/vc4_perfmon (create-perfmon-0)
[496.653870] Subtest create-perfmon-0: SKIP (0.000s)
[496.714508] [141/142] (549s left) kms_cursor_crc (cursor-onscreen-128x128)
[497.029623] Starting subtest: cursor-onscreen-128x128
[497.039818] Starting dynamic subtest: pipe-A-DP-1
[499.388246] Dynamic subtest pipe-A-DP-1: SUCCESS (2.346s)
[499.476201] Starting dynamic subtest: pipe-C-DP-1
[502.134226] Dynamic subtest pipe-C-DP-1: SUCCESS (2.683s)
[502.136450] Subtest cursor-onscreen-128x128: SUCCESS (5.107s)
[502.502580] [142/142] (543s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[502.833357] Starting subtest: fbc-rgb101010-draw-mmap-wc
[505.482724] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.654s)
[505.609804] Closing watchdogs
Done.