[29.847570] Initializing watchdogs
[29.847617]   /dev/watchdog0
[29.852118] [001/142] (960s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[29.992045] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[29.993394] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[30.092680] [002/142] (960s left) gem_eio (suspend)
[30.131502] Starting subtest: suspend
[43.338482] Subtest suspend: SUCCESS (13.207s)
[46.480373] [003/142] (946s left) kms_plane_scaling (intel-max-src-size)
[46.560374] Starting subtest: intel-max-src-size
[46.561422] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.783099] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.161s)
[46.783813] Subtest intel-max-src-size: FAIL (0.161s)
[46.816266] [004/142] (946s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[46.911956] Starting subtest: x-tiled-32bpp-rotate-270
[46.968320] Subtest x-tiled-32bpp-rotate-270: SKIP (0.059s)
[47.092781] [005/142] (946s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[47.180293] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[47.565286] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.385s)
[47.702901] [006/142] (945s left) gem_watchdog (default-physical)
[47.739128] Starting subtest: default-physical
[48.992453] Subtest default-physical: SUCCESS (1.256s)
[49.049585] [007/142] (944s left) kms_cursor_crc (cursor-onscreen-512x170)
[49.132874] Starting subtest: cursor-onscreen-512x170
[49.134454] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[49.217165] [008/142] (944s left) gem_softpin (invalid)
[49.248237] Starting subtest: invalid
[49.251468] Subtest invalid: SUCCESS (0.003s)
[49.358630] [009/142] (944s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[51.908465] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[51.978580] [010/142] (941s left) kms_big_fb (linear-64bpp-rotate-180)
[52.072378] Starting subtest: linear-64bpp-rotate-180
[53.864390] Subtest linear-64bpp-rotate-180: SUCCESS (1.798s)
[54.062626] [011/142] (939s left) syncobj_wait (invalid-signal-zero-handles)
[54.095700] Starting subtest: invalid-signal-zero-handles
[54.096435] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[54.179562] [012/142] (939s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[54.360428] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[54.458734] [013/142] (939s left) gem_exec_fair (basic-pace)
[54.509205] Starting subtest: basic-pace
[54.509916] Starting dynamic subtest: rcs0
[60.091855] Dynamic subtest rcs0: SUCCESS (5.574s)
[60.095860] Starting dynamic subtest: bcs0
[64.527672] Dynamic subtest bcs0: FAIL (4.424s)
[64.537710] Starting dynamic subtest: vcs0
[68.957100] Dynamic subtest vcs0: FAIL (4.417s)
[68.969724] Starting dynamic subtest: vecs0
[73.366187] Dynamic subtest vecs0: FAIL (4.408s)
[73.367345] Subtest basic-pace: FAIL (18.825s)
[73.535444] [014/142] (920s left) kms_cursor_crc (cursor-sliding-32x10)
[73.625371] Starting subtest: cursor-sliding-32x10
[73.652481] Subtest cursor-sliding-32x10: SKIP (0.026s)
[73.762492] [015/142] (919s left) api_intel_allocator (two-level-inception-interruptible)
[73.805988] Starting subtest: two-level-inception-interruptible
[79.249822] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[79.304216] [016/142] (914s left) kms_vblank (pipe-a-wait-forked)
[79.403332] Starting subtest: pipe-A-wait-forked
[82.001728] Subtest pipe-A-wait-forked: SUCCESS (2.598s)
[82.143410] [017/142] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[82.241596] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[84.826502] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.587s)
[84.989721] [018/142] (908s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[85.077941] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[85.078853] Starting dynamic subtest: pipe-A-valid-mode
[85.122237] Dynamic subtest pipe-A-valid-mode: SKIP (0.043s)
[85.123670] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.044s)
[85.222310] [019/142] (908s left) syncobj_basic (bad-fd-to-handle)
[85.254341] Starting subtest: bad-fd-to-handle
[85.255048] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[85.337044] [020/142] (908s left) gem_ctx_isolation (preservation)
[85.384876] Starting subtest: preservation
[85.385583] Starting dynamic subtest: rcs0
[85.439306] Dynamic subtest rcs0: SUCCESS (0.054s)
[85.443387] Starting dynamic subtest: bcs0
[85.536302] Dynamic subtest bcs0: SUCCESS (0.097s)
[85.540322] Starting dynamic subtest: vcs0
[85.622211] Dynamic subtest vcs0: SUCCESS (0.086s)
[85.626210] Starting dynamic subtest: vecs0
[85.706918] Dynamic subtest vecs0: SUCCESS (0.085s)
[85.707617] Subtest preservation: SUCCESS (0.322s)
[85.926496] [021/142] (907s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[85.970257] Starting subtest: yf-tiled-to-vebox-x-tiled
[85.970968] Starting dynamic subtest: smem
[86.079186] Dynamic subtest smem: SUCCESS (0.109s)
[86.079894] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.109s)
[86.273605] [022/142] (907s left) gem_ccs (suspend-resume)
[86.317543] Starting subtest: suspend-resume
[86.318932] Subtest suspend-resume: SKIP (0.000s)
[86.406046] [023/142] (907s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[86.546582] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[86.548184] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[86.670563] [024/142] (907s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[86.760350] Starting subtest: 4-tiled-32bpp-rotate-0
[86.761699] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[86.861995] [025/142] (906s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[86.954904] Starting subtest: cursorB-vs-flipB-toggle
[86.956376] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[87.036915] [026/142] (906s left) kms_hdmi_inject (inject-audio)
[87.129007] Starting subtest: inject-audio
[87.333760] Subtest inject-audio: SUCCESS (0.204s)
[87.545460] [027/142] (906s left) api_intel_allocator (open-vm)
[87.591687] Starting subtest: open-vm
[87.592411] Subtest open-vm: SUCCESS (0.001s)
[87.696882] [028/142] (906s left) syncobj_wait (single-wait-submitted)
[87.739559] Starting subtest: single-wait-submitted
[87.841372] Subtest single-wait-submitted: SUCCESS (0.102s)
[87.907279] [029/142] (905s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[87.995913] Starting subtest: 2x-absolute-wf_vblank-interruptible
[87.998046] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.001s)
[88.095662] [030/142] (905s left) gem_ctx_shared (exec-shared-gtt)
[88.146252] Starting subtest: exec-shared-gtt
[88.146960] Starting dynamic subtest: rcs0
[88.148995] Dynamic subtest rcs0: SUCCESS (0.003s)
[88.153357] Starting dynamic subtest: bcs0
[88.154049] Dynamic subtest bcs0: SUCCESS (0.002s)
[88.158050] Starting dynamic subtest: vcs0
[88.158734] Dynamic subtest vcs0: SUCCESS (0.002s)
[88.162654] Starting dynamic subtest: vecs0
[88.163346] Dynamic subtest vecs0: SUCCESS (0.002s)
[88.164027] Subtest exec-shared-gtt: SUCCESS (0.009s)
[88.355487] [031/142] (905s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[88.407054] Starting subtest: multi-wait-all-for-submit-available-submitted
[88.407750] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[88.492339] [032/142] (905s left) kms_chamelium_frames (hdmi-crc-fast)
[88.626067] Subtest hdmi-crc-fast: SKIP (0.000s)
[88.678429] [033/142] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[88.765453] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[88.766834] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[88.871670] [034/142] (905s left) debugfs_test (read_all_entries)
[88.916787] Starting subtest: read_all_entries
[88.975346] Subtest read_all_entries: SUCCESS (0.058s)
[89.118303] [035/142] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[89.204877] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[89.206383] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[89.307025] [036/142] (904s left) i915_pm_rpm (pm-tiling)
[90.728879] Starting subtest: pm-tiling
[92.200563] Subtest pm-tiling: SUCCESS (1.471s)
[92.396284] [037/142] (901s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[92.488499] Starting subtest: fbc-rgb101010-draw-mmap-wc
[95.214775] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.728s)
[95.333944] [038/142] (898s left) gem_exec_reloc (basic-write-gtt-active)
[95.380294] Subtest basic-write-gtt-active: SKIP (0.000s)
[95.435999] [039/142] (898s left) gem_exec_schedule (preempt-self)
[95.490449] Starting subtest: preempt-self
[95.491167] Starting dynamic subtest: rcs0
[95.497239] Dynamic subtest rcs0: SUCCESS (0.007s)
[95.501487] Starting dynamic subtest: bcs0
[95.503108] Dynamic subtest bcs0: SUCCESS (0.006s)
[95.507266] Starting dynamic subtest: vcs0
[95.508981] Dynamic subtest vcs0: SUCCESS (0.006s)
[95.513245] Starting dynamic subtest: vecs0
[95.514790] Dynamic subtest vecs0: SUCCESS (0.006s)
[95.515468] Subtest preempt-self: SUCCESS (0.024s)
[95.808075] [040/142] (898s left) i915_query (query-regions-garbage-items)
[95.851490] Starting subtest: query-regions-garbage-items
[95.852201] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[95.926593] [041/142] (898s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[95.964416] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[96.065362] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[96.156408] [042/142] (897s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[96.338744] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[96.441251] [043/142] (897s left) gem_mmap_gtt (medium-copy)
[96.478748] Starting subtest: medium-copy
[100.650963] Subtest medium-copy: SUCCESS (4.173s)
[100.721609] [044/142] (893s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[100.915988] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[100.917361] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[101.033097] [045/142] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[101.128743] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[101.130124] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[101.232549] [046/142] (892s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[101.273108] Starting subtest: tiled-to-untiled
[101.274485] Subtest tiled-to-untiled: SKIP (0.000s)
[101.383819] [047/142] (892s left) gem_render_copy (y-tiled)
[101.429510] Starting subtest: y-tiled
[101.430242] Starting dynamic subtest: smem
[101.552552] Dynamic subtest smem: SUCCESS (0.121s)
[101.553311] Subtest y-tiled: SUCCESS (0.122s)
[101.735159] [048/142] (892s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[101.826901] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[103.727486] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (1.902s)
[103.883120] [049/142] (890s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[104.024784] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[104.026348] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[104.157284] [050/142] (890s left) kms_vrr (flip-suspend)
[104.245245] Starting subtest: flip-suspend
[104.246777] Subtest flip-suspend: SKIP (0.000s)
[104.328802] [051/142] (889s left) syncobj_timeline (etime-multi-wait-all-submitted)
[104.378239] Starting subtest: etime-multi-wait-all-submitted
[104.481357] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[104.575549] [052/142] (889s left) kms_addfb_basic (legacy-format)
[104.617639] Starting subtest: legacy-format
[104.674352] Subtest legacy-format: SUCCESS (0.031s)
[104.789487] [053/142] (889s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[104.936720] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[105.025070] [054/142] (889s left) syncobj_wait (wait-any-snapshot)
[105.059481] Starting subtest: wait-any-snapshot
[105.140078] Subtest wait-any-snapshot: SUCCESS (0.081s)
[105.195234] [055/142] (889s left) kms_selftest (drm_plane)
[105.228106] Starting subtest: drm_plane
[105.237965] Starting dynamic subtest: drm_plane_helper-drm_test_check_plane_state
[105.238763] Dynamic subtest drm_plane_helper-drm_test_check_plane_state: SUCCESS (0.000s)
[105.243412] Starting dynamic subtest: drm_plane_helper-drm_test_check_invalid_plane_state
[105.244136] Dynamic subtest drm_plane_helper-drm_test_check_invalid_plane_state: SUCCESS (0.000s)
[105.244850] Subtest drm_plane: SUCCESS (0.010s)
[105.346879] [056/142] (889s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted)
[105.377578] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted
[105.378371] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[105.441220] [057/142] (888s left) kms_atomic (test-only)
[105.611557] Starting subtest: test-only
[105.897673] Subtest test-only: SUCCESS (0.286s)
[106.009183] [058/142] (888s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[106.091859] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[106.093262] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[106.160271] [059/142] (888s left) gem_spin_batch (resubmit-all)
[106.196098] Starting subtest: resubmit-all
[106.196808] Starting dynamic subtest: rcs0
[106.198716] Dynamic subtest rcs0: SUCCESS (0.002s)
[106.203680] Starting dynamic subtest: bcs0
[106.204378] Dynamic subtest bcs0: SUCCESS (0.001s)
[106.208839] Starting dynamic subtest: vcs0
[106.209527] Dynamic subtest vcs0: SUCCESS (0.001s)
[106.213954] Starting dynamic subtest: vecs0
[106.214652] Dynamic subtest vecs0: SUCCESS (0.001s)
[106.215333] Subtest resubmit-all: SUCCESS (0.006s)
[106.368801] [060/142] (888s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[106.433985] Subtest get-values-valid-perfmon: SKIP (0.000s)
[106.501424] [061/142] (887s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[106.591830] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[108.541125] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (1.951s)
[108.678541] [062/142] (885s left) gem_userptr_blits (readonly-pwrite-unsync)
[108.723432] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[108.856684] [063/142] (885s left) kms_rotation_crc (multiplane-rotation)
[108.940997] Starting subtest: multiplane-rotation
[130.569135] Subtest multiplane-rotation: SUCCESS (21.629s)
[130.696023] [064/142] (863s left) kms_color (invalid-ctm-matrix-sizes)
[130.787332] Starting subtest: invalid-ctm-matrix-sizes
[130.788142] Starting dynamic subtest: pipe-A
[130.790268] Dynamic subtest pipe-A: SUCCESS (0.004s)
[130.795284] Starting dynamic subtest: pipe-B
[130.795995] Dynamic subtest pipe-B: SUCCESS (0.003s)
[130.796706] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.009s)
[130.884790] [065/142] (863s left) prime_mmap (test_forked_cpu_write)
[130.926190] Starting subtest: test_forked_cpu_write
[130.926883] Starting dynamic subtest: test_forked_cpu_write-smem
[130.933589] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[130.934289] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[131.037073] [066/142] (863s left) kms_cdclk (plane-scaling)
[131.078574] Subtest plane-scaling: SKIP (0.000s)
[131.108438] [067/142] (863s left) gem_exec_reloc (basic-write-cpu-noreloc)
[131.143939] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[131.183582] [068/142] (863s left) gem_mmap_gtt (basic-read-write-distinct)
[131.221556] Starting subtest: basic-read-write-distinct
[131.223445] Subtest basic-read-write-distinct: SUCCESS (0.002s)
[131.322984] [069/142] (863s left) v3d/v3d_submit_cl (multiple-job-submission)
[131.403571] Subtest multiple-job-submission: SKIP (0.000s)
[131.473062] [070/142] (863s left) gem_lmem_swapping (basic)
[131.512611] Subtest basic: SKIP (0.000s)
[131.546653] [071/142] (863s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[131.628179] Starting subtest: plane-downscale-factor-0-75-with-rotation
[131.628991] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.711149] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.082s)
[131.721882] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.826529] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.113s)
[131.827903] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.199s)
[131.974290] [072/142] (862s left) gem_exec_schedule (implicit-write-read)
[132.020544] Starting subtest: implicit-write-read
[132.021262] Starting dynamic subtest: rcs0
[132.065231] Dynamic subtest rcs0: SUCCESS (0.045s)
[132.071963] Starting dynamic subtest: bcs0
[132.110911] Dynamic subtest bcs0: SUCCESS (0.044s)
[132.122852] Starting dynamic subtest: vcs0
[132.164339] Dynamic subtest vcs0: SUCCESS (0.051s)
[132.174843] Starting dynamic subtest: vecs0
[132.213821] Dynamic subtest vecs0: SUCCESS (0.048s)
[132.215226] Subtest implicit-write-read: SUCCESS (0.195s)
[132.546201] [073/142] (862s left) gen9_exec_parse (bb-start-param)
[132.584388] Subtest bb-start-param: SKIP (0.000s)
[132.612810] [074/142] (862s left) kms_flip (blocking-wf_vblank)
[132.695512] Starting subtest: blocking-wf_vblank
[132.696411] Starting dynamic subtest: A-HDMI-A1
[148.390688] Dynamic subtest A-HDMI-A1: SUCCESS (15.694s)
[148.398986] Starting dynamic subtest: B-HDMI-A1
[164.034605] Dynamic subtest B-HDMI-A1: SUCCESS (15.642s)
[164.037050] Subtest blocking-wf_vblank: SUCCESS (31.343s)
[164.208472] [075/142] (830s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[164.369039] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[164.470613] [076/142] (830s left) gem_busy (semaphore)
[164.645730] Starting subtest: semaphore
[164.646746] Starting dynamic subtest: rcs0
[164.686269] Dynamic subtest rcs0: SUCCESS (0.044s)
[164.701977] Starting dynamic subtest: bcs0
[164.709126] Dynamic subtest bcs0: SUCCESS (0.021s)
[164.721935] Starting dynamic subtest: vcs0
[164.727851] Dynamic subtest vcs0: SUCCESS (0.017s)
[164.737097] Starting dynamic subtest: vecs0
[164.741791] Dynamic subtest vecs0: SUCCESS (0.013s)
[164.742559] Subtest semaphore: SUCCESS (0.101s)
[164.972532] [077/142] (829s left) gem_eio (wait-1us)
[165.014993] Starting subtest: wait-1us
[165.159780] Subtest wait-1us: SUCCESS (0.145s)
[165.298882] [078/142] (829s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[165.473564] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[165.583466] [079/142] (829s left) kms_lease (atomic-implicit-crtc)
[165.667732] Starting subtest: atomic-implicit-crtc
[165.668496] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.669248] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[165.676117] Starting dynamic subtest: pipe-B-HDMI-A-1
[165.676851] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[165.677535] Subtest atomic-implicit-crtc: SUCCESS (0.009s)
[165.750823] [080/142] (829s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[165.835287] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[165.837549] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.846485] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.009s)
[165.851260] Starting dynamic subtest: pipe-B-HDMI-A-1
[165.864841] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.017s)
[165.866206] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.029s)
[165.969420] [081/142] (828s left) kms_dsc (dsc-with-output-formats-with-bpc)
[166.063808] Starting subtest: dsc-with-output-formats-with-bpc
[166.066225] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[166.149249] [082/142] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[166.240716] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[166.242077] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[166.342172] [083/142] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[166.432098] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[166.433415] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.532348] [084/142] (828s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[166.621428] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[168.184692] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.564s)
[168.329913] [085/142] (826s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[168.480441] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[168.589109] [086/142] (826s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs)
[168.743839] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[168.852387] [087/142] (826s left) kms_psr (psr2_cursor_mmap_gtt)
[168.893491] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[168.924595] [088/142] (826s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[169.078568] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[169.079926] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[169.196109] [089/142] (825s left) kms_vblank (pipe-b-wait-busy-hang)
[169.284560] Starting subtest: pipe-B-wait-busy-hang
[172.099052] Subtest pipe-B-wait-busy-hang: SUCCESS (2.816s)
[172.253505] [090/142] (822s left) device_reset (unbind-reset-rebind)
[172.299953] Starting subtest: unbind-reset-rebind
[173.889498] Subtest unbind-reset-rebind: SUCCESS (1.589s)
[174.151235] [091/142] (820s left) kms_atomic_transition (plane-all-modeset-transition)
[174.248568] Starting subtest: plane-all-modeset-transition
[174.249462] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.101025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (19.852s)
[194.182792] Starting dynamic subtest: pipe-B-HDMI-A-1
[209.095144] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.919s)
[209.142731] Subtest plane-all-modeset-transition: SUCCESS (34.895s)
[209.290167] [092/142] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[209.377565] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[209.379026] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[209.473778] [093/142] (785s left) gem_exec_params (invalid-fence-in)
[209.516277] Starting subtest: invalid-fence-in
[209.517026] Subtest invalid-fence-in: SUCCESS (0.000s)
[209.613564] [094/142] (785s left) gem_ctx_persistence (heartbeat-many)
[209.651869] Starting subtest: heartbeat-many
[209.898740] Subtest heartbeat-many: SUCCESS (0.246s)
[209.994207] [095/142] (785s left) gem_exec_flush (basic-batch-kernel-default-wb)
[210.034976] Starting subtest: basic-batch-kernel-default-wb
[215.787805] Subtest basic-batch-kernel-default-wb: SUCCESS (5.753s)
[215.994250] [096/142] (779s left) gem_exec_schedule (u-fairslice)
[216.057817] Starting subtest: u-fairslice
[216.058509] Starting dynamic subtest: rcs0
[218.075180] Dynamic subtest rcs0: SUCCESS (2.011s)
[218.084088] Starting dynamic subtest: bcs0
[220.088053] Dynamic subtest bcs0: SUCCESS (2.011s)
[220.097250] Starting dynamic subtest: vcs0
[222.098755] Dynamic subtest vcs0: SUCCESS (2.008s)
[222.108214] Starting dynamic subtest: vecs0
[224.107041] Dynamic subtest vecs0: SUCCESS (2.008s)
[224.108165] Subtest u-fairslice: SUCCESS (8.041s)
[224.415079] [097/142] (770s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_mc_ccs)
[224.575742] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs
[224.577113] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[224.698350] [098/142] (770s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[224.830430] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[224.881429] [099/142] (770s left) kms_frontbuffer_tracking (psr-1p-rte)
[224.961700] Starting subtest: psr-1p-rte
[224.963041] Subtest psr-1p-rte: SKIP (0.000s)
[225.050432] [100/142] (770s left) gem_exec_gttfill (engines)
[225.095481] Starting subtest: engines
[225.096203] Starting dynamic subtest: rcs0
[247.512162] Dynamic subtest rcs0: SUCCESS (22.416s)
[247.519161] Starting dynamic subtest: bcs0
[269.721121] Dynamic subtest bcs0: SUCCESS (22.208s)
[269.727457] Starting dynamic subtest: vcs0
[291.956025] Dynamic subtest vcs0: SUCCESS (22.234s)
[291.962054] Starting dynamic subtest: vecs0
[314.231016] Dynamic subtest vecs0: SUCCESS (22.274s)
[314.231748] Subtest engines: SUCCESS (89.136s)
[314.421303] [101/142] (680s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[314.534964] Starting subtest: yf-tiled-64bpp-rotate-90
[314.536581] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[314.634928] [102/142] (680s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[314.719599] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[314.720972] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.001s)
[314.842587] [103/142] (680s left) perf_pmu (rc6-suspend)
[314.881491] Starting subtest: rc6-suspend
[338.059473] Subtest rc6-suspend: SUCCESS (23.176s)
[338.384074] [104/142] (657s left) gem_exec_balancer (busy)
[338.425120] Starting subtest: busy
[338.830316] Subtest busy: SUCCESS (0.405s)
[339.788084] [105/142] (655s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[339.876031] Starting subtest: psr-1p-pri-indfb-multidraw
[339.877431] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[339.982190] [106/142] (655s left) gem_workarounds (reset-context)
[340.028537] Starting subtest: reset-context
[340.034260] Subtest reset-context: SUCCESS (0.005s)
[340.175896] [107/142] (655s left) kms_setmode (invalid-clone-single-crtc)
[340.209812] Starting subtest: invalid-clone-single-crtc
[340.211899] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[340.289487] [108/142] (655s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[340.373157] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[340.374467] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[340.479643] [109/142] (655s left) sw_sync (sync_busy)
[340.523441] Starting subtest: sync_busy
[340.525067] Subtest sync_busy: SUCCESS (0.001s)
[340.586498] [110/142] (655s left) gem_mmap_wc (write-prefaulted)
[340.627223] Starting subtest: write-prefaulted
[340.683943] Subtest write-prefaulted: SUCCESS (0.058s)
[340.773760] [111/142] (654s left) kms_prime (basic-modeset-hybrid)
[341.366079] Subtest basic-modeset-hybrid: SKIP (0.000s)
[341.475901] [112/142] (654s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[341.559189] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[341.559865] Starting dynamic subtest: pipe-A-valid-mode
[341.614256] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[341.615768] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.054s)
[341.727464] [113/142] (653s left) kms_frontbuffer_tracking (fbc-suspend)
[341.815166] Starting subtest: fbc-suspend
[380.404802] Subtest fbc-suspend: SUCCESS (38.591s)
[381.546463] [114/142] (615s left) syncobj_timeline (single-wait-all-signaled)
[381.590954] Starting subtest: single-wait-all-signaled
[381.591745] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[381.670186] [115/142] (615s left) vc4/vc4_tiling (set-get)
[381.733383] Subtest set-get: SKIP (0.000s)
[381.792143] [116/142] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[381.873459] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[381.875040] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[381.977518] [117/142] (614s left) kms_legacy_colorkey (invalid-plane)
[382.060813] Starting subtest: invalid-plane
[382.061597] Starting dynamic subtest: zero-id
[382.062382] Dynamic subtest zero-id: SUCCESS (0.000s)
[382.069596] Starting dynamic subtest: outrange-id
[382.070329] Dynamic subtest outrange-id: SUCCESS (0.000s)
[382.071054] Subtest invalid-plane: SUCCESS (0.001s)
[382.146165] [118/142] (614s left) kms_cursor_crc (cursor-random-32x32)
[382.233117] Starting subtest: cursor-random-32x32
[382.262438] Subtest cursor-random-32x32: SKIP (0.028s)
[382.365233] [119/142] (614s left) perf_pmu (busy-idle-check-all)
[382.395368] Starting subtest: busy-idle-check-all
[382.396162] Starting dynamic subtest: rcs0
[383.013288] Dynamic subtest rcs0: SUCCESS (0.617s)
[383.023024] Starting dynamic subtest: bcs0
[383.632362] Dynamic subtest bcs0: SUCCESS (0.617s)
[383.643570] Starting dynamic subtest: vcs0
[384.260270] Dynamic subtest vcs0: SUCCESS (0.626s)
[384.270036] Starting dynamic subtest: vecs0
[384.886313] Dynamic subtest vecs0: SUCCESS (0.624s)
[384.887548] Subtest busy-idle-check-all: SUCCESS (2.491s)
[384.965463] [120/142] (611s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[385.124868] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[385.234588] [121/142] (611s left) i915_pm_freq_api (freq-reset)
[385.270851] Subtest freq-reset: SKIP (0.000s)
[385.290465] [122/142] (611s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[385.373937] Starting subtest: psr-farfromfence-mmap-gtt
[385.375465] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[385.469190] [123/142] (611s left) v3d/v3d_wait_bo (used-bo-1ns)
[385.530119] Subtest used-bo-1ns: SKIP (0.000s)
[385.602406] [124/142] (611s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[385.663138] Subtest mark-purgeable-twice: SKIP (0.000s)
[385.734804] [125/142] (611s left) gem_mmap_offset (bad-extensions)
[385.771713] Starting subtest: bad-extensions
[385.772399] Subtest bad-extensions: SUCCESS (0.000s)
[385.887149] [126/142] (611s left) gem_exec_whisper (basic-sync-all)
[385.927969] Starting subtest: basic-sync-all
[387.495071] Subtest basic-sync-all: SUCCESS (1.567s)
[387.680321] [127/142] (609s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[387.831377] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[387.832703] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[387.958334] [128/142] (609s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[388.044071] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[388.045444] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[388.148672] [129/142] (608s left) gem_exec_flush (basic-uc-ro-default)
[388.192733] Starting subtest: basic-uc-ro-default
[393.618169] Subtest basic-uc-ro-default: SUCCESS (5.425s)
[393.828466] [130/142] (603s left) gem_spin_batch (spin-all)
[393.896675] Starting subtest: spin-all
[393.901566] Subtest spin-all: SUCCESS (0.005s)
[394.105663] [131/142] (602s left) drm_fdinfo (isolation)
[394.142721] Starting subtest: isolation
[394.143416] Starting dynamic subtest: rcs0
[394.663356] Dynamic subtest rcs0: SUCCESS (0.520s)
[394.673064] Starting dynamic subtest: bcs0
[395.181318] Dynamic subtest bcs0: SUCCESS (0.516s)
[395.191014] Starting dynamic subtest: vcs0
[395.696314] Dynamic subtest vcs0: SUCCESS (0.513s)
[395.706759] Starting dynamic subtest: vecs0
[396.211265] Dynamic subtest vecs0: SUCCESS (0.513s)
[396.212483] Subtest isolation: SUCCESS (2.069s)
[396.284342] [132/142] (600s left) kms_vblank (pipe-c-accuracy-idle)
[396.368462] Subtest pipe-C-accuracy-idle: SKIP (0.000s)
[396.458987] [133/142] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[396.542140] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[396.543521] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[396.650277] [134/142] (600s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[396.739436] Starting subtest: fbcpsr-rgb101010-draw-render
[396.740891] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[396.839624] [135/142] (600s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[396.925817] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[398.064762] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.140s)
[398.209133] [136/142] (598s left) kms_flip (2x-flip-vs-rmfb)
[398.285362] Starting subtest: 2x-flip-vs-rmfb
[398.287766] Subtest 2x-flip-vs-rmfb: SKIP (0.002s)
[398.416731] [137/142] (598s left) syncobj_timeline (wait-all-for-submit-snapshot)
[398.451122] Starting subtest: wait-all-for-submit-snapshot
[398.532922] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[398.626359] [138/142] (598s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[398.708556] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[401.171484] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.465s)
[401.316918] [139/142] (595s left) gem_basic (create-fd-close)
[401.350870] Starting subtest: create-fd-close
[401.352262] Subtest create-fd-close: SUCCESS (0.000s)
[401.452596] [140/142] (595s left) kms_psr (primary_blt)
[401.492056] Subtest primary_blt: SKIP (0.000s)
[401.524451] [141/142] (595s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[401.610575] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[401.612108] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[401.719807] [142/142] (595s left) gem_exec_balancer (parallel-keep-submit-fence)
[402.651619] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[402.732838] Closing watchdogs
Done.