[35.537847] Initializing watchdogs
[35.537901]   /dev/watchdog0
[35.544085] [001/138] (960s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[35.798463] Starting subtest: cursor-rapid-movement-256x256
[35.810827] Starting dynamic subtest: pipe-A-DP-4
[36.321662] Dynamic subtest pipe-A-DP-4: SUCCESS (0.509s)
[36.361743] Starting dynamic subtest: pipe-D-DP-4
[36.729091] Dynamic subtest pipe-D-DP-4: SUCCESS (0.371s)
[36.729957] Subtest cursor-rapid-movement-256x256: SUCCESS (0.930s)
[37.053329] [002/138] (959s left) kms_vrr (flip-suspend)
[37.179250] Starting subtest: flip-suspend
[37.181034] Subtest flip-suspend: SKIP (0.000s)
[37.238561] [003/138] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[37.360241] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[37.361787] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[37.442854] [004/138] (958s left) kms_scaling_modes (scaling-mode-center)
[37.578303] Starting subtest: scaling-mode-center
[37.581036] Subtest scaling-mode-center: SKIP (0.001s)
[37.638147] [005/138] (958s left) i915_query (query-topology-unsupported)
[37.684632] Starting subtest: query-topology-unsupported
[37.686600] Subtest query-topology-unsupported: SKIP (0.000s)
[37.740515] [006/138] (958s left) gem_exec_reloc (basic-cpu-active)
[37.813948] Subtest basic-cpu-active: SKIP (0.000s)
[37.868267] [007/138] (958s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[38.017128] Starting subtest: psr-rgb101010-draw-mmap-wc
[38.018814] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[38.091018] [008/138] (958s left) kms_prop_blob (basic)
[38.164098] Starting subtest: basic
[38.164978] Subtest basic: SUCCESS (0.000s)
[38.228656] [009/138] (957s left) gem_tiled_wc
[38.331687] [010/138] (957s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[38.392402] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[38.497908] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[38.588351] [011/138] (957s left) sw_sync (sync_merge)
[38.644474] Starting subtest: sync_merge
[38.645309] Subtest sync_merge: SUCCESS (0.000s)
[38.688074] [012/138] (957s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[38.923014] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[38.924028] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SUCCESS (0.000s)
[39.114186] [013/138] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[39.271208] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[39.273027] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[39.329886] [014/138] (956s left) kms_addfb_basic (invalid-get-prop)
[39.382726] Starting subtest: invalid-get-prop
[39.383739] Subtest invalid-get-prop: SUCCESS (0.000s)
[39.531737] [015/138] (956s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[39.596663] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[39.623279] [016/138] (956s left) kms_properties (get_properties-sanity-atomic)
[39.748295] Starting subtest: get_properties-sanity-atomic
[39.750764] Subtest get_properties-sanity-atomic: SUCCESS (0.003s)
[39.814652] [017/138] (956s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[39.949805] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[39.951525] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[40.033955] [018/138] (956s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[40.165659] Starting subtest: basic-busy-flip-before-cursor-varying-size
[40.167261] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[40.229683] [019/138] (956s left) kms_chamelium_audio (dp-audio-edid)
[40.442876] Subtest dp-audio-edid: SKIP (0.000s)
[40.554314] [020/138] (955s left) gem_render_copy_redux (flink-interruptible)
[40.625574] Starting subtest: flink-interruptible
[41.965115] Subtest flink-interruptible: SUCCESS (1.340s)
[42.141514] [021/138] (954s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[42.264251] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[42.276495] Starting dynamic subtest: pipe-A-DP-4
[42.360256] Dynamic subtest pipe-A-DP-4: SUCCESS (0.084s)
[42.379254] Starting dynamic subtest: pipe-B-DP-4
[42.583525] Dynamic subtest pipe-B-DP-4: SUCCESS (0.210s)
[42.605232] Starting dynamic subtest: pipe-C-DP-4
[42.805837] Dynamic subtest pipe-C-DP-4: SUCCESS (0.209s)
[42.825814] Starting dynamic subtest: pipe-D-DP-4
[43.029674] Dynamic subtest pipe-D-DP-4: SUCCESS (0.211s)
[43.030683] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.765s)
[43.319545] [022/138] (953s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf-tiled-ccs)
[43.599465] Starting subtest: pipe-C-crc-sprite-planes-basic-yf-tiled-ccs
[43.602110] Subtest pipe-C-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.002s)
[43.776720] [023/138] (952s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[43.934420] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[43.945491] Starting dynamic subtest: pipe-A-DP-4
[43.958741] Dynamic subtest pipe-A-DP-4: SKIP (0.012s)
[43.973539] Starting dynamic subtest: pipe-B-DP-4
[43.994768] Dynamic subtest pipe-B-DP-4: SKIP (0.024s)
[44.009099] Starting dynamic subtest: pipe-C-DP-4
[44.030830] Dynamic subtest pipe-C-DP-4: SKIP (0.024s)
[44.045313] Starting dynamic subtest: pipe-D-DP-4
[44.067498] Dynamic subtest pipe-D-DP-4: SKIP (0.025s)
[44.069209] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.133s)
[44.139212] [024/138] (952s left) gem_ctx_persistence (processes)
[44.188073] Starting subtest: processes
[45.368928] Subtest processes: SUCCESS (1.180s)
[45.426148] [025/138] (951s left) kms_vrr (flip-basic)
[45.538329] Starting subtest: flip-basic
[45.539912] Subtest flip-basic: SKIP (0.000s)
[45.590271] [026/138] (950s left) kms_flip (2x-modeset-vs-vblank-race)
[45.692941] Starting subtest: 2x-modeset-vs-vblank-race
[45.707056] Subtest 2x-modeset-vs-vblank-race: SKIP (0.015s)
[45.776147] [027/138] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[45.915267] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[45.916808] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[45.995861] [028/138] (950s left) api_intel_bb (offset-control)
[46.061425] Starting subtest: offset-control
[46.088363] Subtest offset-control: SUCCESS (0.027s)
[46.192148] [029/138] (950s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[46.346855] Starting subtest: 2x-flip-vs-cursor-atomic
[46.349645] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[46.411211] [030/138] (950s left) gem_userptr_blits (vma-merge)
[46.483996] Starting subtest: vma-merge
[66.573329] Subtest vma-merge: FAIL (20.075s)
[66.674310] [031/138] (929s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[66.724985] Starting subtest: single-wait-all-for-submit-signaled
[66.725879] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[66.794255] [032/138] (929s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[67.049437] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs
[67.051118] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[67.218436] [033/138] (929s left) kms_ccs (pipe-d-bad-rotation-90-y-tiled-ccs)
[67.472378] Starting subtest: pipe-D-bad-rotation-90-y-tiled-ccs
[67.474154] Subtest pipe-D-bad-rotation-90-y-tiled-ccs: SKIP (0.000s)
[67.647710] [034/138] (929s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[67.731489] Starting subtest: multi-wait-all-for-submit-available-signaled
[67.732338] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[67.797451] [035/138] (928s left) kms_flip (plain-flip-fb-recreate-interruptible)
[67.905922] Starting subtest: plain-flip-fb-recreate-interruptible
[67.912068] Starting dynamic subtest: A-DP4
[76.010284] Dynamic subtest A-DP4: SUCCESS (8.098s)
[76.017636] Starting dynamic subtest: B-DP4
[84.032803] Dynamic subtest B-DP4: SUCCESS (8.021s)
[84.038864] Starting dynamic subtest: C-DP4
[92.049216] Dynamic subtest C-DP4: SUCCESS (8.016s)
[92.071645] Starting dynamic subtest: D-DP4
[100.110047] Dynamic subtest D-DP4: SUCCESS (8.060s)
[100.110886] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.205s)
[100.403670] [036/138] (896s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[100.657251] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[100.658921] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[100.896720] [037/138] (895s left) api_intel_allocator (default-alignment)
[100.977436] Starting subtest: default-alignment
[100.980281] Subtest default-alignment: SUCCESS (0.003s)
[101.079496] [038/138] (895s left) kms_psr (cursor_blt)
[101.123803] Subtest cursor_blt: SKIP (0.000s)
[101.141704] [039/138] (895s left) gem_create (create-ext-placement-each)
[101.299930] Starting subtest: create-ext-placement-each
[101.303548] Subtest create-ext-placement-each: SUCCESS (0.000s)
[101.422883] [040/138] (895s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[101.647704] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[101.649429] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[101.884292] [041/138] (894s left) kms_atomic (atomic-invalid-params)
[102.038797] Starting subtest: atomic-invalid-params
[102.039723] Starting dynamic subtest: pipe-A-DP-4
[102.631981] Dynamic subtest pipe-A-DP-4: SUCCESS (0.592s)
[102.632987] Subtest atomic-invalid-params: SUCCESS (0.593s)
[102.842448] [042/138] (894s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[103.004362] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[103.005899] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[103.084234] [043/138] (893s left) perf_pmu (init-busy)
[103.153824] Starting subtest: init-busy
[103.154634] Starting dynamic subtest: rcs0
[103.155434] Dynamic subtest rcs0: SUCCESS (0.001s)
[103.160732] Starting dynamic subtest: bcs0
[103.161515] Dynamic subtest bcs0: SUCCESS (0.000s)
[103.167023] Starting dynamic subtest: vcs0
[103.168085] Dynamic subtest vcs0: SUCCESS (0.000s)
[103.173484] Starting dynamic subtest: vcs1
[103.174651] Dynamic subtest vcs1: SUCCESS (0.000s)
[103.179920] Starting dynamic subtest: vecs0
[103.180816] Dynamic subtest vecs0: SUCCESS (0.000s)
[103.186147] Starting dynamic subtest: vecs1
[103.187225] Dynamic subtest vecs1: SUCCESS (0.000s)
[103.192508] Starting dynamic subtest: ccs0
[103.193645] Dynamic subtest ccs0: SUCCESS (0.000s)
[103.200960] Starting dynamic subtest: ccs1
[103.201861] Dynamic subtest ccs1: SUCCESS (0.000s)
[103.207219] Starting dynamic subtest: ccs2
[103.208395] Dynamic subtest ccs2: SUCCESS (0.000s)
[103.213470] Starting dynamic subtest: ccs3
[103.214583] Dynamic subtest ccs3: SUCCESS (0.000s)
[103.215673] Subtest init-busy: SUCCESS (0.005s)
[103.225771] [044/138] (893s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained)
[103.298727] Subtest mark-unpurgeable-check-retained: SKIP (0.000s)
[103.350722] [045/138] (893s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[103.471445] Starting subtest: fbcpsr-tiling-4
[103.473239] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[103.552152] [046/138] (893s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[103.689287] Starting subtest: 4-tiled-32bpp-rotate-90
[103.732538] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.043s)
[103.866442] [047/138] (893s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[104.112649] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[104.114436] Subtest pipe-B-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[104.325915] [048/138] (892s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[104.418891] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[104.444600] [049/138] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[104.563192] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[104.564773] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[104.637909] [050/138] (892s left) kms_atomic_interruptible (legacy-cursor)
[104.784060] Starting subtest: legacy-cursor
[104.784970] Starting dynamic subtest: pipe-A-DP-4
[111.078196] Dynamic subtest pipe-A-DP-4: SUCCESS (6.294s)
[111.079161] Subtest legacy-cursor: SUCCESS (6.295s)
[111.295702] [051/138] (885s left) drm_fdinfo (virtual-busy-idle-all)
[111.383052] Starting subtest: virtual-busy-idle-all
[111.384861] Subtest virtual-busy-idle-all: SKIP (0.000s)
[111.444866] [052/138] (885s left) gem_exec_schedule (fairslice-all)
[111.503019] Starting subtest: fairslice-all
[113.610183] Subtest fairslice-all: SUCCESS (2.107s)
[113.998531] [053/138] (883s left) i915_hangman (engine-error-state-capture)
[114.068288] Starting subtest: engine-error-state-capture
[114.069179] Starting dynamic subtest: rcs0
[116.047312] Dynamic subtest rcs0: SUCCESS (1.979s)
[116.053307] Starting dynamic subtest: bcs0
[120.043818] Dynamic subtest bcs0: SUCCESS (3.996s)
[120.049476] Starting dynamic subtest: vcs0
[124.028272] Dynamic subtest vcs0: SUCCESS (3.984s)
[124.034215] Starting dynamic subtest: vcs1
[128.055335] Dynamic subtest vcs1: SUCCESS (4.027s)
[128.060854] Starting dynamic subtest: vecs0
[132.009522] Dynamic subtest vecs0: SUCCESS (3.954s)
[132.015206] Starting dynamic subtest: vecs1
[136.063309] Dynamic subtest vecs1: SUCCESS (4.053s)
[136.070406] Starting dynamic subtest: ccs0
[140.045353] Dynamic subtest ccs0: SUCCESS (3.982s)
[140.052184] Starting dynamic subtest: ccs1
[144.072743] Dynamic subtest ccs1: SUCCESS (4.027s)
[144.079357] Starting dynamic subtest: ccs2
[148.036405] Dynamic subtest ccs2: SUCCESS (3.963s)
[148.042416] Starting dynamic subtest: ccs3
[152.073302] Dynamic subtest ccs3: SUCCESS (4.037s)
[152.074266] Subtest engine-error-state-capture: SUCCESS (38.005s)
[152.198610] [054/138] (845s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[152.241194] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[152.242051] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[152.324137] [055/138] (844s left) kms_flip (flip-vs-panning-vs-hang)
[152.460338] Starting subtest: flip-vs-panning-vs-hang
[152.462891] Starting dynamic subtest: A-DP4
[191.991110] Dynamic subtest A-DP4: SUCCESS (39.528s)
[191.997059] Starting dynamic subtest: D-DP4
[241.956444] Dynamic subtest D-DP4: SUCCESS (49.960s)
[241.957366] Subtest flip-vs-panning-vs-hang: SUCCESS (89.492s)
[242.215200] [056/138] (755s left) gem_softpin (32b-excludes-last-page)
[242.282161] Starting subtest: 32b-excludes-last-page
[242.286146] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[242.387501] [057/138] (754s left) gem_pxp (create-regular-context-2)
[244.990142] Subtest create-regular-context-2: SKIP (0.000s)
[245.037441] [058/138] (752s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[245.156143] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[245.157658] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[245.227432] [059/138] (752s left) gem_exec_reloc (basic-wc-cpu-active)
[245.293058] Subtest basic-wc-cpu-active: SKIP (0.000s)
[245.332976] [060/138] (752s left) kms_color (ctm-green-to-red)
[245.449293] Starting subtest: ctm-green-to-red
[245.450107] Starting dynamic subtest: pipe-A
[246.069676] Dynamic subtest pipe-A: SUCCESS (0.619s)
[246.080631] Starting dynamic subtest: pipe-B
[246.622336] Dynamic subtest pipe-B: SUCCESS (0.552s)
[246.632062] Starting dynamic subtest: pipe-C
[247.186165] Dynamic subtest pipe-C: SUCCESS (0.564s)
[247.194141] Starting dynamic subtest: pipe-D
[247.777942] Dynamic subtest pipe-D: SUCCESS (0.592s)
[247.778962] Subtest ctm-green-to-red: SUCCESS (2.329s)
[248.001521] [061/138] (749s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[248.136843] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[248.138569] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[248.221553] [062/138] (749s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[248.462214] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[248.464089] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[248.681597] [063/138] (748s left) gem_ctx_param (invalid-get-engines)
[248.768434] Starting subtest: invalid-get-engines
[248.769322] Subtest invalid-get-engines: SUCCESS (0.000s)
[248.832966] [064/138] (748s left) prime_mmap (test_invalid_sync_flags)
[248.899904] Starting subtest: test_invalid_sync_flags
[248.900830] Starting dynamic subtest: test_invalid_sync_flags-smem
[248.901758] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[248.907512] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[248.908673] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[248.909825] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[248.978726] [065/138] (748s left) gem_mmap_wc (write-cpu-read-wc)
[249.039221] Subtest write-cpu-read-wc: SKIP (0.000s)
[249.067087] [066/138] (748s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[249.283085] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[249.285685] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s)
[249.486253] [067/138] (748s left) kms_addfb_basic (basic-y-tiled-legacy)
[249.573704] Starting subtest: basic-y-tiled-legacy
[249.576033] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[249.714074] [068/138] (747s left) drm_fdinfo (busy-idle-check-all)
[249.769528] Starting subtest: busy-idle-check-all
[249.770349] Starting dynamic subtest: rcs0
[249.794208] Dynamic subtest rcs0: SKIP (0.024s)
[249.800207] Starting dynamic subtest: bcs0
[249.801991] Dynamic subtest bcs0: SKIP (0.000s)
[249.807488] Starting dynamic subtest: vcs0
[249.809045] Dynamic subtest vcs0: SKIP (0.000s)
[249.814460] Starting dynamic subtest: vcs1
[249.816164] Dynamic subtest vcs1: SKIP (0.000s)
[249.821648] Starting dynamic subtest: vecs0
[249.823191] Dynamic subtest vecs0: SKIP (0.000s)
[249.828619] Starting dynamic subtest: vecs1
[249.830166] Dynamic subtest vecs1: SKIP (0.000s)
[249.835557] Starting dynamic subtest: ccs0
[249.837344] Dynamic subtest ccs0: SKIP (0.000s)
[249.842556] Starting dynamic subtest: ccs1
[249.844153] Dynamic subtest ccs1: SKIP (0.000s)
[249.852438] Starting dynamic subtest: ccs2
[249.854236] Dynamic subtest ccs2: SKIP (0.000s)
[249.859975] Starting dynamic subtest: ccs3
[249.862399] Dynamic subtest ccs3: SKIP (0.000s)
[249.864659] Subtest busy-idle-check-all: SKIP (0.030s)
[249.874227] [069/138] (747s left) kms_addfb_basic (small-bo)
[250.006138] Starting subtest: small-bo
[250.007079] Subtest small-bo: SUCCESS (0.000s)
[250.083688] [070/138] (747s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[250.210352] Starting subtest: disable-crc-after-crtc
[250.212197] Starting dynamic subtest: pipe-A-DP-4
[250.887155] Dynamic subtest pipe-A-DP-4: SUCCESS (0.674s)
[250.896421] Starting dynamic subtest: pipe-B-DP-4
[251.488885] Dynamic subtest pipe-B-DP-4: SUCCESS (0.600s)
[251.496406] Starting dynamic subtest: pipe-C-DP-4
[252.087217] Dynamic subtest pipe-C-DP-4: SUCCESS (0.597s)
[252.095428] Starting dynamic subtest: pipe-D-DP-4
[252.691094] Dynamic subtest pipe-D-DP-4: SUCCESS (0.601s)
[252.692043] Subtest disable-crc-after-crtc: SUCCESS (2.480s)
[252.931198] [071/138] (744s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[253.892047] Starting subtest: syncobj-backward-timeline-chain-engines
[254.048917] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.157s)
[254.371869] [072/138] (743s left) vc4/vc4_label_bo (set-bad-handle)
[254.433596] Subtest set-bad-handle: SKIP (0.000s)
[254.484284] [073/138] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[254.630893] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[254.632450] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.702137] [074/138] (742s left) prime_vgem (busy)
[254.807855] Starting subtest: busy
[254.808923] Starting dynamic subtest: rcs0
[254.872527] Dynamic subtest rcs0: SUCCESS (0.064s)
[254.880035] Starting dynamic subtest: bcs0
[254.910420] Dynamic subtest bcs0: SUCCESS (0.037s)
[254.917318] Starting dynamic subtest: vcs0
[254.953509] Dynamic subtest vcs0: SUCCESS (0.042s)
[254.978133] Starting dynamic subtest: vcs1
[255.000283] Dynamic subtest vcs1: SUCCESS (0.045s)
[255.026547] Starting dynamic subtest: vecs0
[255.041727] Dynamic subtest vecs0: SUCCESS (0.040s)
[255.055685] Starting dynamic subtest: vecs1
[255.089452] Dynamic subtest vecs1: SUCCESS (0.045s)
[255.115062] Starting dynamic subtest: ccs0
[255.136200] Dynamic subtest ccs0: SUCCESS (0.046s)
[255.162071] Starting dynamic subtest: ccs1
[255.177241] Dynamic subtest ccs1: SUCCESS (0.039s)
[255.188462] Starting dynamic subtest: ccs2
[255.220142] Dynamic subtest ccs2: SUCCESS (0.042s)
[255.235844] Starting dynamic subtest: ccs3
[255.264648] Dynamic subtest ccs3: SUCCESS (0.043s)
[255.265960] Subtest busy: SUCCESS (0.457s)
[255.405677] [075/138] (742s left) gem_mmap_gtt (isolation)
[255.486984] Subtest isolation: SKIP (0.000s)
[255.507340] [076/138] (742s left) gem_mmap_offset (open-flood)
[255.552120] Starting subtest: open-flood
[277.035206] Subtest open-flood: SUCCESS (21.484s)
[277.126531] [077/138] (720s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[277.293330] Starting subtest: x-tiled-64bpp-rotate-270
[277.335225] Subtest x-tiled-64bpp-rotate-270: SKIP (0.041s)
[277.482373] [078/138] (720s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[277.784054] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[277.786893] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.002s)
[277.961189] [079/138] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[278.127279] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[278.128845] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[278.219773] [080/138] (719s left) gem_exec_schedule (u-independent)
[278.301739] Starting subtest: u-independent
[278.302613] Starting dynamic subtest: rcs0
[278.729375] Dynamic subtest rcs0: SUCCESS (0.427s)
[278.736486] Starting dynamic subtest: bcs0
[279.138173] Dynamic subtest bcs0: SUCCESS (0.408s)
[279.144651] Starting dynamic subtest: vcs0
[279.545361] Dynamic subtest vcs0: SUCCESS (0.407s)
[279.551586] Starting dynamic subtest: vcs1
[279.960338] Dynamic subtest vcs1: SUCCESS (0.414s)
[279.966676] Starting dynamic subtest: vecs0
[280.384668] Dynamic subtest vecs0: SUCCESS (0.417s)
[280.398653] Starting dynamic subtest: vecs1
[280.798227] Dynamic subtest vecs1: SUCCESS (0.419s)
[280.805388] Starting dynamic subtest: ccs0
[281.144262] Dynamic subtest ccs0: SUCCESS (0.345s)
[281.151298] Starting dynamic subtest: ccs1
[281.492521] Dynamic subtest ccs1: SUCCESS (0.348s)
[281.499677] Starting dynamic subtest: ccs2
[281.842471] Dynamic subtest ccs2: SUCCESS (0.349s)
[281.849301] Starting dynamic subtest: ccs3
[282.181071] Dynamic subtest ccs3: SUCCESS (0.338s)
[282.181892] Subtest u-independent: SUCCESS (3.879s)
[282.552046] [081/138] (715s left) syncobj_wait (single-wait-all-for-submit-signaled)
[282.596997] Starting subtest: single-wait-all-for-submit-signaled
[282.597837] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[282.671596] [082/138] (715s left) gem_exec_balancer (parallel-keep-in-fence)
[282.997210] Starting subtest: parallel-keep-in-fence
[284.583703] Subtest parallel-keep-in-fence: SUCCESS (1.586s)
[284.647286] [083/138] (713s left) kms_cursor_crc (cursor-onscreen-256x85)
[284.920187] Starting subtest: cursor-onscreen-256x85
[284.924367] Starting dynamic subtest: pipe-A-DP-4
[287.559994] Dynamic subtest pipe-A-DP-4: SUCCESS (2.634s)
[287.604963] Starting dynamic subtest: pipe-D-DP-4
[290.206988] Dynamic subtest pipe-D-DP-4: SUCCESS (2.606s)
[290.208111] Subtest cursor-onscreen-256x85: SUCCESS (5.286s)
[290.499273] [084/138] (707s left) v3d/v3d_wait_bo (map-bo-0ns)
[290.624121] Subtest map-bo-0ns: SKIP (0.000s)
[290.678517] [085/138] (707s left) gem_exec_fence (basic-await)
[290.887260] Starting subtest: basic-await
[290.888607] Starting dynamic subtest: rcs0
[291.013941] Dynamic subtest rcs0: SUCCESS (0.135s)
[291.020173] Starting dynamic subtest: bcs0
[291.111276] Dynamic subtest bcs0: SUCCESS (0.091s)
[291.117423] Starting dynamic subtest: vcs0
[291.197350] Dynamic subtest vcs0: SUCCESS (0.091s)
[291.204069] Starting dynamic subtest: vcs1
[291.290130] Dynamic subtest vcs1: SUCCESS (0.092s)
[291.297415] Starting dynamic subtest: vecs0
[291.385406] Dynamic subtest vecs0: SUCCESS (0.095s)
[291.391392] Starting dynamic subtest: vecs1
[291.476170] Dynamic subtest vecs1: SUCCESS (0.090s)
[291.482068] Starting dynamic subtest: ccs0
[291.567237] Dynamic subtest ccs0: SUCCESS (0.090s)
[291.573854] Starting dynamic subtest: ccs1
[291.660826] Dynamic subtest ccs1: SUCCESS (0.093s)
[291.667435] Starting dynamic subtest: ccs2
[291.754858] Dynamic subtest ccs2: SUCCESS (0.093s)
[291.762109] Starting dynamic subtest: ccs3
[291.850397] Dynamic subtest ccs3: SUCCESS (0.095s)
[291.851214] Subtest basic-await: SUCCESS (0.972s)
[292.878476] [086/138] (705s left) gem_bad_reloc (negative-reloc-bltcopy)
[292.926665] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[292.966816] [087/138] (705s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[293.090694] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[293.092459] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[293.181775] [088/138] (704s left) perf_pmu (all-busy-idle-check-all)
[293.264202] Starting subtest: all-busy-idle-check-all
[293.943096] Subtest all-busy-idle-check-all: SUCCESS (0.679s)
[294.032190] [089/138] (704s left) gen9_exec_parse (allowed-single)
[294.094389] Subtest allowed-single: SKIP (0.000s)
[294.114950] [090/138] (703s left) syncobj_basic (bad-fd-to-handle)
[294.158610] Starting subtest: bad-fd-to-handle
[294.159539] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[294.231244] [091/138] (703s left) syncobj_timeline (wait-for-submit-complex)
[294.296727] Starting subtest: wait-for-submit-complex
[294.359158] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[294.465354] [092/138] (703s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[294.612815] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[295.816219] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.194s)
[295.930199] [093/138] (702s left) gem_lmem_swapping (parallel-multi)
[298.440617] Starting subtest: parallel-multi
[298.441674] Starting dynamic subtest: lmem0
[310.560035] Dynamic subtest lmem0: SUCCESS (12.111s)
[310.560964] Subtest parallel-multi: SUCCESS (12.111s)
[311.795980] [094/138] (686s left) kms_ccs (pipe-c-bad-rotation-90-yf-tiled-ccs)
[312.767106] Starting subtest: pipe-C-bad-rotation-90-yf-tiled-ccs
[312.769053] Subtest pipe-C-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[312.988900] [095/138] (685s left) kms_invalid_mode (zero-clock)
[313.140588] Starting subtest: zero-clock
[313.141524] Starting dynamic subtest: pipe-A-DP-4
[313.213019] Dynamic subtest pipe-A-DP-4: SUCCESS (0.072s)
[313.219663] Starting dynamic subtest: pipe-B-DP-4
[313.220418] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[313.225898] Starting dynamic subtest: pipe-C-DP-4
[313.226824] Dynamic subtest pipe-C-DP-4: SUCCESS (0.000s)
[313.232266] Starting dynamic subtest: pipe-D-DP-4
[313.233051] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[313.233839] Subtest zero-clock: SUCCESS (0.079s)
[313.367707] [096/138] (684s left) gem_exec_balancer (bonded-sync)
[313.425266] Starting subtest: bonded-sync
[313.427259] Subtest bonded-sync: SKIP (0.000s)
[313.746297] [097/138] (684s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[313.798532] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[313.799501] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[313.853365] [098/138] (684s left) api_intel_bb (destroy-bb)
[313.902748] Starting subtest: destroy-bb
[313.940120] Subtest destroy-bb: SUCCESS (0.037s)
[314.050786] [099/138] (684s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs)
[314.166140] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs
[314.167053] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs: SUCCESS (0.000s)
[314.478311] [100/138] (683s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[314.634836] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[317.836996] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.201s)
[318.072899] [101/138] (680s left) kms_addfb_basic (no-handle)
[318.151913] Starting subtest: no-handle
[318.152790] Subtest no-handle: SUCCESS (0.000s)
[318.291708] [102/138] (680s left) kms_pm_rpm (fences-dpms)
[320.528120] Starting subtest: fences-dpms
[320.531345] Subtest fences-dpms: SKIP (0.000s)
[320.856638] [103/138] (677s left) kms_flip (2x-flip-vs-expired-vblank)
[320.999820] Starting subtest: 2x-flip-vs-expired-vblank
[321.010204] Subtest 2x-flip-vs-expired-vblank: SKIP (0.015s)
[321.081367] [104/138] (677s left) gem_exec_schedule (preempt-hang)
[321.266606] Starting subtest: preempt-hang
[321.268472] Starting dynamic subtest: rcs0
[321.604179] Dynamic subtest rcs0: SUCCESS (0.345s)
[321.610009] Starting dynamic subtest: bcs0
[321.903843] Dynamic subtest bcs0: SUCCESS (0.299s)
[321.910455] Starting dynamic subtest: vcs0
[322.226601] Dynamic subtest vcs0: SUCCESS (0.314s)
[322.232521] Starting dynamic subtest: vcs1
[322.557900] Dynamic subtest vcs1: SUCCESS (0.330s)
[322.564042] Starting dynamic subtest: vecs0
[322.909991] Dynamic subtest vecs0: SUCCESS (0.351s)
[322.915839] Starting dynamic subtest: vecs1
[323.231242] Dynamic subtest vecs1: SUCCESS (0.320s)
[323.237188] Starting dynamic subtest: ccs0
[323.546066] Dynamic subtest ccs0: SUCCESS (0.314s)
[323.552142] Starting dynamic subtest: ccs1
[323.873895] Dynamic subtest ccs1: SUCCESS (0.331s)
[323.879782] Starting dynamic subtest: ccs2
[324.234614] Dynamic subtest ccs2: SUCCESS (0.349s)
[324.243957] Starting dynamic subtest: ccs3
[324.600372] Dynamic subtest ccs3: SUCCESS (0.374s)
[324.601181] Subtest preempt-hang: SUCCESS (3.336s)
[324.837362] [105/138] (673s left) kms_chamelium_hpd (dp-hpd-storm)
[325.071811] Subtest dp-hpd-storm: SKIP (0.000s)
[325.185920] [106/138] (673s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[325.328560] Starting subtest: y-tiled-64bpp-rotate-180
[325.330294] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[325.406821] [107/138] (673s left) kms_chamelium_frames (dp-frame-dump)
[325.629645] Subtest dp-frame-dump: SKIP (0.000s)
[325.747184] [108/138] (672s left) i915_query (hwconfig_table)
[325.807029] Starting subtest: hwconfig_table
[325.980855] Subtest hwconfig_table: SUCCESS (0.001s)
[326.005622] [109/138] (672s left) gem_ctx_param (invalid-ctx-set)
[326.089097] Starting subtest: invalid-ctx-set
[326.090086] Subtest invalid-ctx-set: SUCCESS (0.001s)
[326.151206] [110/138] (672s left) gem_exec_suspend (basic-s0)
[326.218509] Starting subtest: basic-S0
[326.219503] Starting dynamic subtest: smem
[346.782756] Dynamic subtest smem: SUCCESS (6.592s)
[346.789264] Starting dynamic subtest: lmem0
[367.827168] Dynamic subtest lmem0: SUCCESS (6.419s)
[367.828511] Subtest basic-S0: SUCCESS (13.014s)
[368.038940] [111/138] (659s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[368.164663] Starting subtest: cursorA-vs-flipA-varying-size
[379.125334] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.961s)
[379.343373] [112/138] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[379.495539] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[381.969022] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.476s)
[382.144832] [113/138] (645s left) vgem_basic (create)
[382.201643] Starting subtest: create
[382.202502] Subtest create: SUCCESS (0.000s)
[382.261241] [114/138] (645s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[382.417932] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[383.351348] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.933s)
[383.512840] [115/138] (643s left) gem_mmap_gtt (basic-small-copy-xy)
[383.575533] Subtest basic-small-copy-XY: SKIP (0.000s)
[383.593191] [116/138] (643s left) i915_module_load (load)
[383.635495] Starting subtest: load
[383.637273] Subtest load: SKIP (0.001s)
[383.689579] [117/138] (643s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[383.768099] Subtest get-values-invalid-pointer: SKIP (0.000s)
[383.862202] [118/138] (643s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[383.933296] Starting subtest: x-tiled-to-vebox-yf-tiled
[383.934896] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[384.123654] [119/138] (643s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[384.263010] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[384.279488] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s)
[384.357289] [120/138] (643s left) core_getclient
[384.493405] [121/138] (643s left) gem_workarounds (suspend-resume)
[384.554253] Starting subtest: suspend-resume
[403.833231] Subtest suspend-resume: SUCCESS (3.645s)
[403.938111] [122/138] (639s left) kms_vblank (invalid)
[404.057062] Starting subtest: invalid
[404.057947] Starting dynamic subtest: pipe-A-DP-4
[404.347393] Dynamic subtest pipe-A-DP-4: SUCCESS (0.289s)
[404.348610] Subtest invalid: SUCCESS (0.291s)
[404.559426] [123/138] (638s left) kms_cursor_crc (cursor-sliding-256x256)
[404.842958] Starting subtest: cursor-sliding-256x256
[404.847373] Starting dynamic subtest: pipe-A-DP-4
[408.962417] Dynamic subtest pipe-A-DP-4: SUCCESS (4.115s)
[409.001357] Starting dynamic subtest: pipe-D-DP-4
[413.367292] Dynamic subtest pipe-D-DP-4: SUCCESS (4.373s)
[413.368171] Subtest cursor-sliding-256x256: SUCCESS (8.524s)
[413.689748] [124/138] (629s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[413.836603] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[413.838409] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[413.922012] [125/138] (629s left) kms_plane_lowres (tiling-y)
[414.065826] Starting subtest: tiling-y
[414.067426] Subtest tiling-y: SKIP (0.000s)
[414.131208] [126/138] (629s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[414.255149] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[414.257133] Starting dynamic subtest: pipe-A-valid-mode
[414.340214] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s)
[414.342157] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.084s)
[414.512587] [127/138] (628s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[414.656464] Starting subtest: 2x-long-cursor-vs-flip-atomic
[414.658402] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[414.719966] [128/138] (628s left) gem_ctx_bad_destroy (double-destroy)
[414.765817] Starting subtest: double-destroy
[414.766624] Subtest double-destroy: SUCCESS (0.000s)
[414.825153] [129/138] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[414.983509] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[414.985429] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[415.077905] [130/138] (628s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[415.224574] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[415.226280] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[415.338329] [131/138] (628s left) kms_ccs (pipe-b-bad-aux-stride-yf-tiled-ccs)
[415.633639] Starting subtest: pipe-B-bad-aux-stride-yf-tiled-ccs
[415.635222] Subtest pipe-B-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[415.855422] [132/138] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[415.996521] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[415.998220] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[416.092802] [133/138] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[416.242714] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[416.244516] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.318351] [134/138] (627s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[416.450371] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[416.451175] Starting dynamic subtest: pipe-A-valid-mode
[418.011300] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.560s)
[418.013074] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.562s)
[418.262578] [135/138] (625s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-mc-ccs)
[418.541690] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs
[418.544255] Subtest pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[418.750888] [136/138] (624s left) gem_ctx_persistence (legacy-engines-persistence)
[418.829124] Starting subtest: legacy-engines-persistence
[418.830097] Starting dynamic subtest: render
[419.622728] Dynamic subtest render: SUCCESS (0.793s)
[419.632654] Starting dynamic subtest: bsd1
[420.387572] Dynamic subtest bsd1: SUCCESS (0.763s)
[420.403033] Starting dynamic subtest: bsd2
[421.154607] Dynamic subtest bsd2: SUCCESS (0.763s)
[421.165925] Starting dynamic subtest: blt
[421.906574] Dynamic subtest blt: SUCCESS (0.745s)
[421.918611] Starting dynamic subtest: vebox
[422.672725] Dynamic subtest vebox: SUCCESS (0.763s)
[422.674739] Subtest legacy-engines-persistence: SUCCESS (3.842s)
[422.785451] [137/138] (620s left) v3d/v3d_job_submission (threaded-job-submission)
[422.863236] Subtest threaded-job-submission: SKIP (0.000s)
[422.925668] [138/138] (620s left) gem_userptr_blits (unsync-overlap)
[422.981825] Subtest unsync-overlap: SKIP (0.000s)
[423.140915] Closing watchdogs
Done.