[60.183239] Initializing watchdogs
[60.183300]   /dev/watchdog0
[60.200927] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.210402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.213765] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.216779] [001/129] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[60.512541] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[60.514291] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[60.648737] [002/129] (960s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[60.859401] Starting subtest: y-tiled-16bpp-rotate-90
[60.861196] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[60.973044] [003/129] (959s left) kms_cursor_crc (cursor-onscreen-512x170)
[61.398991] Starting subtest: cursor-onscreen-512x170
[61.401744] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[61.646323] [004/129] (959s left) kms_addfb_basic (basic-y-tiled-legacy)
[61.717995] Starting subtest: basic-y-tiled-legacy
[61.719804] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[61.979933] [005/129] (958s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[62.181682] Starting subtest: 2x-flip-vs-cursor-atomic
[62.184407] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[62.279308] [006/129] (958s left) gem_softpin (evict-snoop-interruptible)
[62.367337] Starting subtest: evict-snoop-interruptible
[62.369189] Subtest evict-snoop-interruptible: SKIP (0.000s)
[62.479058] [007/129] (958s left) template (a)
[62.549945] Starting subtest: A
[62.550893] Subtest A: SUCCESS (0.000s)
[62.667379] [008/129] (958s left) kms_flip (modeset-vs-vblank-race)
[62.868834] Starting subtest: modeset-vs-vblank-race
[62.873309] Starting dynamic subtest: A-DP4
[66.186402] Dynamic subtest A-DP4: SUCCESS (3.312s)
[66.221100] Starting dynamic subtest: B-DP4
[69.389288] Dynamic subtest B-DP4: SUCCESS (3.201s)
[69.422049] Starting dynamic subtest: C-DP4
[72.602050] Dynamic subtest C-DP4: SUCCESS (3.211s)
[72.635623] Starting dynamic subtest: D-DP4
[75.782961] Dynamic subtest D-DP4: SUCCESS (3.178s)
[75.788585] Subtest modeset-vs-vblank-race: SUCCESS (12.917s)
[76.169544] [009/129] (945s left) gem_fenced_exec_thrash (2-spare-fences)
[76.259092] Subtest 2-spare-fences: SKIP (0.000s)
[76.323963] [010/129] (944s left) kms_cursor_crc (cursor-alpha-transparent)
[76.522180] Starting subtest: cursor-alpha-transparent
[76.523165] Starting dynamic subtest: pipe-A-DP-4
[77.112692] Dynamic subtest pipe-A-DP-4: SUCCESS (0.589s)
[77.125130] Starting dynamic subtest: pipe-D-DP-4
[77.612362] Dynamic subtest pipe-D-DP-4: SUCCESS (0.497s)
[77.613463] Subtest cursor-alpha-transparent: SUCCESS (1.091s)
[78.189857] [011/129] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[78.398735] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[78.400453] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.508718] [012/129] (942s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[78.729817] Starting subtest: yf-tiled-32bpp-rotate-270
[78.731580] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[78.847761] [013/129] (942s left) gem_readwrite (read-write)
[78.919380] Subtest read-write: SKIP (0.000s)
[79.010591] [014/129] (942s left) gem_mmap_gtt (fault-concurrent-x)
[79.084400] Subtest fault-concurrent-X: SKIP (0.000s)
[79.140790] [015/129] (942s left) gem_softpin (allocator-nopin)
[79.215796] Starting subtest: allocator-nopin
[79.426616] Subtest allocator-nopin: SUCCESS (0.200s)
[79.557890] [016/129] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[79.762811] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[79.764486] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[79.910942] [017/129] (941s left) kms_atomic_transition (plane-all-transition-nonblocking)
[80.112369] Starting subtest: plane-all-transition-nonblocking
[80.114431] Starting dynamic subtest: pipe-A-DP-4
[83.824144] Dynamic subtest pipe-A-DP-4: SUCCESS (3.709s)
[83.909995] Starting dynamic subtest: pipe-B-DP-4
[87.676665] Dynamic subtest pipe-B-DP-4: SUCCESS (3.776s)
[87.730070] Subtest plane-all-transition-nonblocking: SUCCESS (7.616s)
[87.981347] [018/129] (933s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[88.185182] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[99.123563] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.938s)
[99.368941] [019/129] (922s left) gem_ctx_persistence (legacy-engines-persistence)
[99.448442] Starting subtest: legacy-engines-persistence
[99.449446] Starting dynamic subtest: render
[100.270657] Dynamic subtest render: SUCCESS (0.821s)
[100.281262] Starting dynamic subtest: bsd1
[101.024410] Dynamic subtest bsd1: SUCCESS (0.752s)
[101.036056] Starting dynamic subtest: bsd2
[101.800560] Dynamic subtest bsd2: SUCCESS (0.774s)
[101.811572] Starting dynamic subtest: blt
[102.567648] Dynamic subtest blt: SUCCESS (0.763s)
[102.578543] Starting dynamic subtest: vebox
[103.344626] Dynamic subtest vebox: SUCCESS (0.773s)
[103.346767] Subtest legacy-engines-persistence: SUCCESS (3.897s)
[103.495391] [020/129] (918s left) gem_mmap_wc (bad-object)
[103.570142] Subtest bad-object: SKIP (0.000s)
[103.638507] [021/129] (918s left) i915_module_load (reload)
[103.686073] Starting subtest: reload
[106.460611] Subtest reload: SUCCESS (2.776s)
[106.500790] [022/129] (915s left) kms_flip (2x-nonexisting-fb)
[106.776245] Starting subtest: 2x-nonexisting-fb
[106.789439] Subtest 2x-nonexisting-fb: SKIP (0.013s)
[106.894136] [023/129] (915s left) gem_spin_batch (engines)
[106.978794] Starting subtest: engines
[106.979814] Starting dynamic subtest: rcs0
[110.235031] Dynamic subtest rcs0: SUCCESS (3.253s)
[110.243382] Starting dynamic subtest: bcs0
[113.470030] Dynamic subtest bcs0: SUCCESS (3.233s)
[113.481769] Starting dynamic subtest: vcs0
[116.710192] Dynamic subtest vcs0: SUCCESS (3.237s)
[116.722373] Starting dynamic subtest: vcs1
[119.951757] Dynamic subtest vcs1: SUCCESS (3.238s)
[119.960151] Starting dynamic subtest: vecs0
[123.188604] Dynamic subtest vecs0: SUCCESS (3.234s)
[123.200537] Starting dynamic subtest: vecs1
[126.429422] Dynamic subtest vecs1: SUCCESS (3.238s)
[126.438149] Starting dynamic subtest: ccs0
[129.669237] Dynamic subtest ccs0: SUCCESS (3.236s)
[129.671297] Subtest engines: SUCCESS (22.689s)
[129.928286] [024/129] (892s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[130.123266] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[130.124187] Starting dynamic subtest: pipe-A-DP-4
[130.133056] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[130.140612] Starting dynamic subtest: pipe-B-DP-4
[130.149393] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[130.157679] Starting dynamic subtest: pipe-C-DP-4
[130.166160] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[130.173312] Starting dynamic subtest: pipe-D-DP-4
[130.182161] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[130.184171] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[130.567734] [025/129] (891s left) core_getversion (all-cards)
[130.626036] Starting subtest: all-cards
[133.134382] Subtest all-cards: SUCCESS (2.510s)
[133.192454] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.amdgpu: true
[133.193511] [FACT core_getversion (all-cards)] new: kernel.kmod_is_loaded.xe: true
[133.195578] [026/129] (888s left) kms_writeback (writeback-pixel-formats)
[133.395840] Subtest writeback-pixel-formats: SKIP (0.000s)
[133.451819] [027/129] (888s left) api_intel_bb (intel-bb-blit-none)
[133.523227] Starting subtest: intel-bb-blit-none
[134.202575] Subtest intel-bb-blit-none: SUCCESS (0.679s)
[134.337894] [028/129] (887s left) gem_exec_balancer (smoke)
[134.420907] Starting subtest: smoke
[157.359131] Subtest smoke: SUCCESS (22.937s)
[158.398744] [029/129] (863s left) kms_rotation_crc (multiplane-rotation)
[158.598144] Starting subtest: multiplane-rotation
[169.951720] Subtest multiplane-rotation: SUCCESS (11.354s)
[170.095433] [030/129] (852s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[170.169957] Starting subtest: wait-all-for-submit-delayed-submit
[170.273577] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[170.368621] [031/129] (852s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[170.569470] Starting subtest: compare-crc-sanitycheck-xr24
[170.570407] Starting dynamic subtest: pipe-A-DP-4
[171.112174] Dynamic subtest pipe-A-DP-4: SUCCESS (0.541s)
[171.128210] Starting dynamic subtest: pipe-B-DP-4
[171.579068] Dynamic subtest pipe-B-DP-4: SUCCESS (0.465s)
[171.595942] Starting dynamic subtest: pipe-C-DP-4
[172.045870] Dynamic subtest pipe-C-DP-4: SUCCESS (0.464s)
[172.058924] Starting dynamic subtest: pipe-D-DP-4
[172.497870] Dynamic subtest pipe-D-DP-4: SUCCESS (0.448s)
[172.499022] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.928s)
[172.782412] [032/129] (849s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[173.065525] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[173.211224] [033/129] (849s left) kms_pm_rpm (cursor)
[175.159759] Starting subtest: cursor
[175.161863] Subtest cursor: SKIP (0.000s)
[175.500950] [034/129] (847s left) syncobj_wait (single-wait-all-signaled)
[175.570754] Starting subtest: single-wait-all-signaled
[175.571641] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[175.741906] [035/129] (846s left) gem_mmap_wc (copy)
[175.819570] Subtest copy: SKIP (0.000s)
[175.889622] [036/129] (846s left) gem_partial_pwrite_pread (write-display)
[175.967510] Subtest write-display: SKIP (0.000s)
[176.049906] [037/129] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[176.253201] Starting subtest: fbcpsr-2p-rte
[176.255072] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[176.393967] [038/129] (846s left) gem_exec_params (cliprects-invalid)
[176.493844] Starting subtest: cliprects-invalid
[176.495136] Subtest cliprects-invalid: SUCCESS (0.000s)
[176.655439] [039/129] (846s left) i915_query (test-query-geometry-subslices)
[176.725455] Starting subtest: test-query-geometry-subslices
[176.726438] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[176.869249] [040/129] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[177.077025] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[177.078834] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[177.204525] [041/129] (845s left) gem_flink_basic (flink-lifetime)
[177.278425] Starting subtest: flink-lifetime
[177.300377] Subtest flink-lifetime: SUCCESS (0.022s)
[177.421971] [042/129] (845s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[177.629388] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[177.679745] [043/129] (845s left) kms_cdclk (mode-transition)
[177.881403] Starting subtest: mode-transition
[177.882328] Starting dynamic subtest: pipe-A-DP-4
[177.952242] Dynamic subtest pipe-A-DP-4: SKIP (0.070s)
[177.960566] Starting dynamic subtest: pipe-B-DP-4
[177.962348] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[177.970339] Starting dynamic subtest: pipe-C-DP-4
[177.972051] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[177.979981] Starting dynamic subtest: pipe-D-DP-4
[177.981917] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[177.983686] Subtest mode-transition: SKIP (0.081s)
[178.175961] [044/129] (845s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[178.390230] Starting subtest: psr-rgb565-draw-pwrite
[178.391966] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[178.513077] [045/129] (844s left) syncobj_wait (reset-during-wait-for-submit)
[178.582070] Starting subtest: reset-during-wait-for-submit
[178.683602] Subtest reset-during-wait-for-submit: SUCCESS (0.101s)
[178.837946] [046/129] (844s left) fbdev (unaligned-write)
[178.902641] Starting subtest: unaligned-write
[179.268050] Subtest unaligned-write: SUCCESS (0.365s)
[179.341761] [047/129] (844s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[179.550269] Starting subtest: yf-tiled-16bpp-rotate-0
[179.551945] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[179.687057] [048/129] (843s left) kms_feature_discovery (psr2)
[179.886660] Starting subtest: psr2
[179.888431] Subtest psr2: SKIP (0.000s)
[179.980390] [049/129] (843s left) fbdev (eof)
[180.035436] Starting subtest: eof
[180.036440] Subtest eof: SUCCESS (0.000s)
[180.107281] [050/129] (843s left) gem_exec_balancer (parallel-contexts)
[180.424373] Starting subtest: parallel-contexts
[185.930538] Subtest parallel-contexts: SUCCESS (5.506s)
[186.141162] [051/129] (837s left) kms_psr (psr2-sprite-mmap-gtt)
[186.341046] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[186.388935] [052/129] (837s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[186.595595] Starting subtest: crc-primary-basic-y-tiled-ccs
[186.596510] Starting dynamic subtest: pipe-A-DP-4
[186.605251] Dynamic subtest pipe-A-DP-4: SKIP (0.001s)
[186.613813] Starting dynamic subtest: pipe-B-DP-4
[186.622425] Dynamic subtest pipe-B-DP-4: SKIP (0.001s)
[186.630776] Starting dynamic subtest: pipe-C-DP-4
[186.639190] Dynamic subtest pipe-C-DP-4: SKIP (0.001s)
[186.647354] Starting dynamic subtest: pipe-D-DP-4
[186.656201] Dynamic subtest pipe-D-DP-4: SKIP (0.001s)
[186.658290] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s)
[187.037878] [053/129] (836s left) perf_pmu (busy-double-start)
[187.101213] Starting subtest: busy-double-start
[187.102236] Starting dynamic subtest: rcs0
[190.716714] Dynamic subtest rcs0: SUCCESS (3.614s)
[190.729381] Starting dynamic subtest: bcs0
[194.318600] Dynamic subtest bcs0: SUCCESS (3.597s)
[194.331470] Starting dynamic subtest: vcs0
[197.926800] Dynamic subtest vcs0: FAIL (3.583s)
[197.937443] Starting dynamic subtest: vcs1
[201.499333] Dynamic subtest vcs1: FAIL (3.565s)
[201.510882] Starting dynamic subtest: vecs0
[205.063297] Dynamic subtest vecs0: FAIL (3.563s)
[205.074616] Starting dynamic subtest: vecs1
[208.648228] Dynamic subtest vecs1: FAIL (3.580s)
[208.660566] Starting dynamic subtest: ccs0
[212.228541] Dynamic subtest ccs0: SUCCESS (3.604s)
[212.233203] Subtest busy-double-start: FAIL (25.129s)
[212.370887] [054/129] (811s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[214.972494] Starting subtest: protected-encrypted-src-copy-not-readible
[214.974555] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[215.057083] [055/129] (808s left) syncobj_wait (single-wait-all-for-submit-signaled)
[215.128991] Starting subtest: single-wait-all-for-submit-signaled
[215.129935] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[215.243316] [056/129] (808s left) kms_atomic_interruptible (universal-setplane-cursor)
[215.444324] Starting subtest: universal-setplane-cursor
[215.446584] Starting dynamic subtest: pipe-A-DP-4
[221.743286] Dynamic subtest pipe-A-DP-4: SUCCESS (6.297s)
[221.744325] Subtest universal-setplane-cursor: SUCCESS (6.300s)
[222.008584] [057/129] (802s left) syncobj_wait (invalid-reset-one-illegal-handle)
[222.080985] Starting subtest: invalid-reset-one-illegal-handle
[222.081900] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[222.239624] [058/129] (801s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[222.440551] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[222.441463] Starting dynamic subtest: pipe-A-valid-mode
[222.514238] Dynamic subtest pipe-A-valid-mode: SKIP (0.072s)
[222.516031] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.074s)
[222.726777] [059/129] (801s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[222.926347] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[222.927250] Starting dynamic subtest: pipe-A-valid-mode
[223.014410] Dynamic subtest pipe-A-valid-mode: SKIP (0.085s)
[223.016310] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.086s)
[223.220873] [060/129] (801s left) prime_vgem (basic-read)
[223.371725] Starting subtest: basic-read
[223.378583] Subtest basic-read: SKIP (0.006s)
[223.531245] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[223.533631] [061/129] (800s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[223.747831] Starting subtest: fbcpsr-tiling-y
[223.749565] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[223.892456] [062/129] (800s left) kms_pwrite_crc
[225.030023] [063/129] (799s left) i915_pm_rpm (system-suspend-devices)
[227.075139] Starting subtest: system-suspend-devices
[234.952677] Subtest system-suspend-devices: SUCCESS (7.878s)
[239.300110] [064/129] (789s left) kms_psr (pr-primary-blt)
[239.517286] Subtest pr-primary-blt: SKIP (0.000s)
[239.570157] [065/129] (789s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[239.776644] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[239.777558] Starting dynamic subtest: pipe-A-DP-4
[239.781068] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[239.791513] Starting dynamic subtest: pipe-B-DP-4
[239.795057] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[239.805371] Starting dynamic subtest: pipe-C-DP-4
[239.809028] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[239.819060] Starting dynamic subtest: pipe-D-DP-4
[239.822470] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[239.824223] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[240.227213] [066/129] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[240.440439] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[240.442255] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[240.594843] [067/129] (788s left) syncobj_timeline (invalid-signal-bad-pad)
[240.673103] Starting subtest: invalid-signal-bad-pad
[240.674111] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[240.816620] [068/129] (788s left) gem_exec_schedule (semaphore-resolve)
[240.908896] Starting subtest: semaphore-resolve
[240.978907] Subtest semaphore-resolve: SUCCESS (0.070s)
[241.372952] [069/129] (787s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[241.587878] Starting subtest: psr-dirtyfb-ioctl
[241.593060] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[241.713553] [070/129] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[241.930277] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[241.932156] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[242.045544] [071/129] (786s left) gem_lmem_swapping (heavy-multi)
[244.725958] Starting subtest: heavy-multi
[244.726892] Starting dynamic subtest: lmem0
[249.002667] Dynamic subtest lmem0: SUCCESS (4.278s)
[249.003549] Subtest heavy-multi: SUCCESS (4.281s)
[250.337476] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[250.339047] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true
[250.341154] [072/129] (778s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[251.883965] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[251.885782] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[252.008182] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[252.012882] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)] new: kernel.kmod_is_loaded.i915: true
[252.016356] [073/129] (777s left) drm_fdinfo (memory-info-active)
[252.092637] Starting subtest: memory-info-active
[252.093572] Starting dynamic subtest: lmem0
[255.702534] Dynamic subtest lmem0: SUCCESS (3.608s)
[255.721382] Starting dynamic subtest: smem0
[259.814380] Dynamic subtest smem0: SUCCESS (4.108s)
[259.815384] Subtest memory-info-active: SUCCESS (7.722s)
[259.910232] [074/129] (769s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[260.130948] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[260.798267] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.667s)
[261.016093] [075/129] (768s left) gem_exec_capture (userptr)
[261.106489] Starting subtest: userptr
[262.077494] Subtest userptr: SUCCESS (0.972s)
[262.220296] [076/129] (767s left) kms_plane_scaling (invalid-parameters)
[262.446265] Starting subtest: invalid-parameters
[262.447218] Starting dynamic subtest: less-than-1-height-src
[262.458623] Dynamic subtest less-than-1-height-src: SUCCESS (0.012s)
[262.468705] Starting dynamic subtest: less-than-1-width-src
[262.471505] Dynamic subtest less-than-1-width-src: SUCCESS (0.012s)
[262.472415] Subtest invalid-parameters: SUCCESS (0.027s)
[262.592391] [077/129] (766s left) syncobj_wait (wait-for-submit-snapshot)
[262.679222] Starting subtest: wait-for-submit-snapshot
[262.762347] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[262.898102] [078/129] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[263.113578] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[263.115364] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[263.282226] [079/129] (766s left) gem_wait (write-wait)
[263.377378] Starting subtest: write-wait
[263.378345] Starting dynamic subtest: all-engines
[264.509433] Dynamic subtest all-engines: SUCCESS (1.131s)
[264.524900] Starting dynamic subtest: rcs0
[265.572865] Dynamic subtest rcs0: SUCCESS (1.062s)
[265.588544] Starting dynamic subtest: bcs0
[266.634083] Dynamic subtest bcs0: SUCCESS (1.058s)
[266.654323] Starting dynamic subtest: vcs0
[267.699125] Dynamic subtest vcs0: SUCCESS (1.060s)
[267.719373] Starting dynamic subtest: vcs1
[268.765136] Dynamic subtest vcs1: SUCCESS (1.061s)
[268.785667] Starting dynamic subtest: vecs0
[269.830139] Dynamic subtest vecs0: SUCCESS (1.060s)
[269.876058] Starting dynamic subtest: vecs1
[270.903134] Dynamic subtest vecs1: SUCCESS (1.068s)
[270.918347] Starting dynamic subtest: ccs0
[271.962938] Dynamic subtest ccs0: SUCCESS (1.055s)
[271.969544] Subtest write-wait: SUCCESS (8.587s)
[272.266140] [080/129] (757s left) gem_exec_fence (syncobj-wait)
[272.772430] Starting subtest: syncobj-wait
[272.916536] Subtest syncobj-wait: SUCCESS (0.144s)
[273.389965] [081/129] (756s left) gem_ctx_persistence (hostile)
[273.477221] Starting subtest: hostile
[283.623341] Subtest hostile: SUCCESS (10.140s)
[283.785801] [082/129] (745s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[284.001078] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[284.002887] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[284.133174] [083/129] (745s left) gem_create (create-ext-placement-each)
[284.329286] Starting subtest: create-ext-placement-each
[284.330325] Subtest create-ext-placement-each: SUCCESS (0.000s)
[284.506435] [084/129] (745s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[284.719194] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[284.772736] [085/129] (745s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[284.852949] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[284.961527] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[285.114726] [086/129] (744s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[285.323556] Starting subtest: primary-yf-tiled-reflect-x-0
[285.416609] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.093s)
[285.583637] [087/129] (744s left) gem_softpin (evict-active-interruptible)
[285.677396] Starting subtest: evict-active-interruptible
[285.691573] Subtest evict-active-interruptible: SUCCESS (0.014s)
[285.890423] [088/129] (744s left) kms_psr (psr-cursor-mmap-cpu)
[286.105277] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[286.156805] [089/129] (744s left) gem_tiled_wb
[286.307059] [090/129] (743s left) kms_flip (wf_vblank-ts-check-interruptible)
[286.520944] Starting subtest: wf_vblank-ts-check-interruptible
[286.526546] Starting dynamic subtest: A-DP4
[294.627594] Dynamic subtest A-DP4: SUCCESS (8.101s)
[294.642348] Starting dynamic subtest: B-DP4
[302.664431] Dynamic subtest B-DP4: SUCCESS (8.035s)
[302.677548] Starting dynamic subtest: C-DP4
[310.677426] Dynamic subtest C-DP4: SUCCESS (8.011s)
[310.689863] Starting dynamic subtest: D-DP4
[318.690491] Dynamic subtest D-DP4: SUCCESS (8.011s)
[318.691492] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.170s)
[319.021773] [091/129] (711s left) kms_pm_dc (dc5-dpms-negative)
[320.235681] Starting subtest: dc5-dpms-negative
[324.472562] Subtest dc5-dpms-negative: SUCCESS (4.235s)
[324.592707] [092/129] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[324.801736] Starting subtest: flip-vs-cursor-legacy
[334.345013] Subtest flip-vs-cursor-legacy: SUCCESS (9.543s)
[334.594335] [093/129] (695s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[334.880765] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[335.029931] [094/129] (695s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[335.245301] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[335.299478] [095/129] (695s left) gem_wait (invalid-buf)
[335.383910] Starting subtest: invalid-buf
[335.384914] Subtest invalid-buf: SUCCESS (0.000s)
[335.645571] [096/129] (694s left) gem_exec_schedule (out-order)
[335.742958] Starting subtest: out-order
[335.744013] Starting dynamic subtest: rcs0
[336.031459] Dynamic subtest rcs0: SUCCESS (0.288s)
[336.042300] Starting dynamic subtest: bcs0
[336.232808] Dynamic subtest bcs0: SUCCESS (0.200s)
[336.243575] Starting dynamic subtest: vcs0
[336.445235] Dynamic subtest vcs0: SUCCESS (0.211s)
[336.456065] Starting dynamic subtest: vcs1
[336.660618] Dynamic subtest vcs1: SUCCESS (0.214s)
[336.671421] Starting dynamic subtest: vecs0
[336.872442] Dynamic subtest vecs0: SUCCESS (0.211s)
[336.883181] Starting dynamic subtest: vecs1
[337.093897] Dynamic subtest vecs1: SUCCESS (0.220s)
[337.104621] Starting dynamic subtest: ccs0
[337.296453] Dynamic subtest ccs0: SUCCESS (0.202s)
[337.297376] Subtest out-order: SUCCESS (1.554s)
[337.710756] [097/129] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[337.922547] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[340.526185] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.604s)
[340.736701] [098/129] (689s left) gem_ctx_param (basic-default)
[340.819864] Starting subtest: basic-default
[340.820851] Subtest basic-default: SUCCESS (0.000s)
[340.914573] [099/129] (689s left) kms_setmode (basic)
[340.998437] Starting subtest: basic
[341.146511] Starting dynamic subtest: pipe-A-DP-4
[343.308404] Dynamic subtest pipe-A-DP-4: SUCCESS (2.159s)
[343.438826] Starting dynamic subtest: pipe-B-DP-4
[345.587772] Dynamic subtest pipe-B-DP-4: SUCCESS (2.156s)
[345.660522] Subtest basic: SUCCESS (4.660s)
[345.929037] [100/129] (684s left) kms_addfb_basic (unused-modifier)
[346.009494] Starting subtest: unused-modifier
[346.010466] Subtest unused-modifier: SUCCESS (0.000s)
[346.287787] [101/129] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[346.498436] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[346.500183] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[346.663102] [102/129] (684s left) kms_invalid_mode (bad-hsync-end)
[346.870237] Starting subtest: bad-hsync-end
[346.871192] Starting dynamic subtest: pipe-A-DP-4
[346.954554] Dynamic subtest pipe-A-DP-4: SUCCESS (0.084s)
[346.969318] Starting dynamic subtest: pipe-B-DP-4
[346.970407] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[346.983147] Starting dynamic subtest: pipe-C-DP-4
[346.984167] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[346.996614] Starting dynamic subtest: pipe-D-DP-4
[346.997576] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[346.998528] Subtest bad-hsync-end: SUCCESS (0.094s)
[347.190788] [103/129] (683s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[347.409080] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[348.650158] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.226s)
[348.845099] [104/129] (682s left) sysfs_heartbeat_interval (mixed)
[348.928257] Starting subtest: mixed
[348.930993] Starting dynamic subtest: vecs0
[354.224079] Dynamic subtest vecs0: SUCCESS (5.295s)
[354.237834] Starting dynamic subtest: ccs0
[359.494429] Dynamic subtest ccs0: SUCCESS (5.268s)
[359.511216] Starting dynamic subtest: vcs0
[364.730467] Dynamic subtest vcs0: SUCCESS (5.233s)
[364.745240] Starting dynamic subtest: bcs0
[369.981790] Dynamic subtest bcs0: SUCCESS (5.247s)
[369.995567] Starting dynamic subtest: vecs1
[375.261943] Dynamic subtest vecs1: SUCCESS (5.276s)
[375.304895] Starting dynamic subtest: rcs0
[380.574299] Dynamic subtest rcs0: SUCCESS (5.307s)
[380.587933] Starting dynamic subtest: vcs1
[385.821550] Dynamic subtest vcs1: SUCCESS (5.244s)
[385.823542] Subtest mixed: SUCCESS (36.894s)
[385.989444] [105/129] (645s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[386.199417] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[386.200307] Starting dynamic subtest: pipe-A-DP-4
[386.209131] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[386.219853] Starting dynamic subtest: pipe-B-DP-4
[386.228608] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[386.239095] Starting dynamic subtest: pipe-C-DP-4
[386.247622] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[386.258299] Starting dynamic subtest: pipe-D-DP-4
[386.267747] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[386.269440] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[386.649714] [106/129] (644s left) gem_sync (basic-all)
[386.740791] Starting subtest: basic-all
[389.081811] Subtest basic-all: SUCCESS (2.340s)
[389.289861] [107/129] (642s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[389.381064] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[389.382036] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[389.528231] [108/129] (641s left) gem_exec_reloc (basic-cpu-gtt-active)
[389.613452] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[389.682951] [109/129] (641s left) kms_plane_lowres (tiling-4)
[389.890819] Starting subtest: tiling-4
[389.891718] Starting dynamic subtest: pipe-A-DP-4
[400.290620] Dynamic subtest pipe-A-DP-4: SUCCESS (10.399s)
[400.406391] Starting dynamic subtest: pipe-B-DP-4
[410.743738] Dynamic subtest pipe-B-DP-4: SUCCESS (10.346s)
[410.859472] Starting dynamic subtest: pipe-C-DP-4
[421.324865] Dynamic subtest pipe-C-DP-4: SUCCESS (10.475s)
[421.426685] Starting dynamic subtest: pipe-D-DP-4
[431.933745] Dynamic subtest pipe-D-DP-4: SUCCESS (10.517s)
[432.039031] Subtest tiling-4: SUCCESS (42.147s)
[432.293926] [110/129] (599s left) kms_universal_plane (cursor-fb-leak)
[432.515418] Starting subtest: cursor-fb-leak
[432.516300] Starting dynamic subtest: pipe-A-DP-4
[432.980163] Dynamic subtest pipe-A-DP-4: SUCCESS (0.464s)
[433.004942] Starting dynamic subtest: pipe-B-DP-4
[433.569544] Dynamic subtest pipe-B-DP-4: SUCCESS (0.585s)
[433.602934] Starting dynamic subtest: pipe-C-DP-4
[434.177607] Dynamic subtest pipe-C-DP-4: SUCCESS (0.597s)
[434.190507] Starting dynamic subtest: pipe-D-DP-4
[434.746562] Dynamic subtest pipe-D-DP-4: SUCCESS (0.566s)
[434.752956] Subtest cursor-fb-leak: SUCCESS (2.234s)
[435.111171] [111/129] (596s left) syncobj_eventfd (invalid-illegal-eventfd)
[435.190922] Starting subtest: invalid-illegal-eventfd
[435.191881] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[435.364617] [112/129] (596s left) sysfs_defaults (readonly)
[435.454029] Starting subtest: readonly
[435.454967] Starting dynamic subtest: vecs0
[435.455915] Dynamic subtest vecs0: SUCCESS (0.000s)
[435.466919] Starting dynamic subtest: ccs0
[435.468024] Dynamic subtest ccs0: SUCCESS (0.000s)
[435.478436] Starting dynamic subtest: vcs0
[435.479448] Dynamic subtest vcs0: SUCCESS (0.000s)
[435.489910] Starting dynamic subtest: bcs0
[435.491025] Dynamic subtest bcs0: SUCCESS (0.000s)
[435.501791] Starting dynamic subtest: vecs1
[435.502912] Dynamic subtest vecs1: SUCCESS (0.000s)
[435.513599] Starting dynamic subtest: rcs0
[435.514784] Dynamic subtest rcs0: SUCCESS (0.000s)
[435.525540] Starting dynamic subtest: vcs1
[435.526788] Dynamic subtest vcs1: SUCCESS (0.000s)
[435.527684] Subtest readonly: SUCCESS (0.010s)
[435.573656] [113/129] (596s left) kms_chamelium_frames (dp-crc-fast)
[435.853245] Subtest dp-crc-fast: SKIP (0.000s)
[436.000868] [114/129] (595s left) kms_flip (2x-blocking-absolute-wf_vblank)
[436.210180] Starting subtest: 2x-blocking-absolute-wf_vblank
[436.224168] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[436.336738] [115/129] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[436.554851] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[436.556592] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[436.675999] [116/129] (595s left) kms_cursor_edge_walk (64x64-right-edge)
[436.884910] Starting subtest: 64x64-right-edge
[436.885897] Starting dynamic subtest: pipe-A-DP-4
[440.338923] Dynamic subtest pipe-A-DP-4: SUCCESS (3.453s)
[440.357597] Starting dynamic subtest: pipe-D-DP-4
[443.656514] Dynamic subtest pipe-D-DP-4: SUCCESS (3.314s)
[443.657582] Subtest 64x64-right-edge: SUCCESS (6.772s)
[443.918744] [117/129] (588s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[444.127282] Starting subtest: plane-downscale-factor-0-75-with-rotation
[444.128083] Starting dynamic subtest: pipe-A
[444.514468] Dynamic subtest pipe-A: SUCCESS (0.387s)
[444.541355] Starting dynamic subtest: pipe-B
[444.999454] Dynamic subtest pipe-B: SUCCESS (0.483s)
[445.028914] Starting dynamic subtest: pipe-C
[445.485195] Dynamic subtest pipe-C: SUCCESS (0.483s)
[445.508483] Starting dynamic subtest: pipe-D
[445.970472] Dynamic subtest pipe-D: SUCCESS (0.483s)
[445.971816] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (1.845s)
[446.308324] [118/129] (585s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[446.711429] Starting subtest: cursor-rapid-movement-256x85
[446.716749] Starting dynamic subtest: pipe-A-DP-4
[447.150753] Dynamic subtest pipe-A-DP-4: SUCCESS (0.434s)
[447.198825] Starting dynamic subtest: pipe-D-DP-4
[447.579045] Dynamic subtest pipe-D-DP-4: SUCCESS (0.391s)
[447.580103] Subtest cursor-rapid-movement-256x85: SUCCESS (0.868s)
[447.970524] [119/129] (584s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[448.051995] Starting subtest: multi-wait-available-unsubmitted-signaled
[448.052970] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[448.228415] [120/129] (584s left) gem_exec_whisper (basic-fds-all)
[448.321168] Starting subtest: basic-fds-all
[470.444528] Subtest basic-fds-all: SUCCESS (22.122s)
[470.706607] [121/129] (561s left) gem_exec_params (readonly)
[470.804062] Starting subtest: readonly
[470.806570] Subtest readonly: SUCCESS (0.003s)
[471.007125] [122/129] (561s left) gem_mmap_gtt (medium-copy-xy)
[471.087308] Subtest medium-copy-XY: SKIP (0.000s)
[471.155679] [123/129] (561s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[471.374691] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[471.376462] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[471.514258] [124/129] (561s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[471.614476] Starting subtest: x-tiled-to-vebox-y-tiled
[471.616441] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[471.830140] [125/129] (560s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[472.043273] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[474.862781] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.819s)
[475.070148] [126/129] (557s left) perf_pmu (idle)
[475.142902] Starting subtest: idle
[475.143894] Starting dynamic subtest: rcs0
[475.710090] Dynamic subtest rcs0: SUCCESS (0.565s)
[475.723158] Starting dynamic subtest: bcs0
[476.226544] Dynamic subtest bcs0: SUCCESS (0.513s)
[476.240945] Starting dynamic subtest: vcs0
[476.743491] Dynamic subtest vcs0: SUCCESS (0.512s)
[476.756953] Starting dynamic subtest: vcs1
[477.262664] Dynamic subtest vcs1: SUCCESS (0.516s)
[477.276129] Starting dynamic subtest: vecs0
[477.782464] Dynamic subtest vecs0: SUCCESS (0.513s)
[477.793850] Starting dynamic subtest: vecs1
[478.300474] Dynamic subtest vecs1: SUCCESS (0.517s)
[478.314845] Starting dynamic subtest: ccs0
[478.820690] Dynamic subtest ccs0: SUCCESS (0.513s)
[478.821612] Subtest idle: SUCCESS (3.676s)
[478.961310] [127/129] (553s left) i915_hangman (engine-engine-error)
[479.055942] Starting subtest: engine-engine-error
[479.056922] Starting dynamic subtest: rcs0
[479.867763] Dynamic subtest rcs0: SUCCESS (0.812s)
[479.881933] Starting dynamic subtest: bcs0
[480.601478] Dynamic subtest bcs0: SUCCESS (0.732s)
[480.615193] Starting dynamic subtest: vcs0
[481.361888] Dynamic subtest vcs0: SUCCESS (0.759s)
[481.378402] Starting dynamic subtest: vcs1
[482.124962] Dynamic subtest vcs1: SUCCESS (0.761s)
[482.142789] Starting dynamic subtest: vecs0
[482.853324] Dynamic subtest vecs0: SUCCESS (0.726s)
[482.864831] Starting dynamic subtest: vecs1
[483.598502] Dynamic subtest vecs1: SUCCESS (0.744s)
[483.614010] Starting dynamic subtest: ccs0
[484.351049] Dynamic subtest ccs0: SUCCESS (0.751s)
[484.352057] Subtest engine-engine-error: SUCCESS (5.296s)
[484.516966] [128/129] (548s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[484.730257] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[484.787514] [129/129] (548s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[484.999589] Starting subtest: plane-primary-overlay-mutable-zpos
[486.928029] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.927s)
[487.272638] Closing watchdogs
Done.