[29.854203] Initializing watchdogs
[29.854253]   /dev/watchdog0
[29.875768] [001/142] (960s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[30.051445] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[30.053037] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[30.194203] [002/142] (960s left) gem_eio (suspend)
[30.237487] Starting subtest: suspend
[41.018283] Subtest suspend: SUCCESS (10.782s)
[47.119142] [003/142] (949s left) kms_plane_scaling (intel-max-src-size)
[47.214365] Starting subtest: intel-max-src-size
[47.215103] Starting dynamic subtest: pipe-A-HDMI-A-1
[47.402990] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.019s)
[47.403702] Subtest intel-max-src-size: FAIL (0.019s)
[47.411584] [004/142] (949s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[47.502276] Starting subtest: x-tiled-32bpp-rotate-270
[47.562870] Subtest x-tiled-32bpp-rotate-270: SKIP (0.060s)
[47.619992] [005/142] (948s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[47.709876] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[48.050215] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.340s)
[48.150797] [006/142] (948s left) gem_watchdog (default-physical)
[48.202724] Starting subtest: default-physical
[49.466157] Subtest default-physical: SUCCESS (1.258s)
[49.510392] [007/142] (946s left) kms_cursor_crc (cursor-onscreen-512x170)
[49.610351] Starting subtest: cursor-onscreen-512x170
[49.612928] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[49.665860] [008/142] (946s left) gem_softpin (invalid)
[49.715533] Starting subtest: invalid
[49.718813] Subtest invalid: SUCCESS (0.003s)
[49.784965] [009/142] (946s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[52.352967] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[52.382105] [010/142] (944s left) kms_big_fb (linear-64bpp-rotate-180)
[52.468333] Starting subtest: linear-64bpp-rotate-180
[53.680433] Subtest linear-64bpp-rotate-180: SUCCESS (1.208s)
[53.846357] [011/142] (942s left) syncobj_wait (invalid-signal-zero-handles)
[53.880975] Starting subtest: invalid-signal-zero-handles
[53.881937] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[53.917763] [012/142] (942s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[54.127293] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs
[54.129166] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[54.215233] [013/142] (942s left) gem_exec_fair (basic-pace)
[54.256594] Starting subtest: basic-pace
[54.257543] Starting dynamic subtest: rcs0
[58.708751] Dynamic subtest rcs0: FAIL (4.432s)
[58.712575] Starting dynamic subtest: bcs0
[63.133825] Dynamic subtest bcs0: FAIL (4.418s)
[63.137504] Starting dynamic subtest: vcs0
[67.528208] Dynamic subtest vcs0: FAIL (4.395s)
[67.531931] Starting dynamic subtest: vcs1
[71.929667] Dynamic subtest vcs1: FAIL (4.400s)
[71.933485] Starting dynamic subtest: vecs0
[76.321942] Dynamic subtest vecs0: FAIL (4.392s)
[76.322646] Subtest basic-pace: FAIL (22.037s)
[76.446985] [014/142] (920s left) kms_cursor_crc (cursor-sliding-32x10)
[76.543952] Starting subtest: cursor-sliding-32x10
[76.587941] Subtest cursor-sliding-32x10: SKIP (0.043s)
[76.643410] [015/142] (919s left) api_intel_allocator (two-level-inception-interruptible)
[76.678545] Starting subtest: two-level-inception-interruptible
[82.132250] Subtest two-level-inception-interruptible: SUCCESS (5.418s)
[82.144515] [016/142] (914s left) kms_vblank (pipe-a-wait-forked)
[82.257196] Starting subtest: pipe-A-wait-forked
[83.478151] Subtest pipe-A-wait-forked: SUCCESS (1.220s)
[83.572400] [017/142] (913s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[83.659803] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[84.844365] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (1.186s)
[84.930133] [018/142] (911s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[85.020881] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[85.021704] Starting dynamic subtest: pipe-A-valid-mode
[85.069548] Dynamic subtest pipe-A-valid-mode: SKIP (0.047s)
[85.071123] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.049s)
[85.138845] [019/142] (911s left) syncobj_basic (bad-fd-to-handle)
[85.176036] Starting subtest: bad-fd-to-handle
[85.176802] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[85.223692] [020/142] (911s left) gem_ctx_isolation (preservation)
[85.265715] Starting subtest: preservation
[85.266551] Starting dynamic subtest: rcs0
[85.345678] Dynamic subtest rcs0: SUCCESS (0.080s)
[85.349833] Starting dynamic subtest: bcs0
[85.452294] Dynamic subtest bcs0: SUCCESS (0.106s)
[85.456436] Starting dynamic subtest: vcs0
[85.562570] Dynamic subtest vcs0: SUCCESS (0.110s)
[85.566691] Starting dynamic subtest: vcs1
[85.675852] Dynamic subtest vcs1: SUCCESS (0.112s)
[85.679743] Starting dynamic subtest: vecs0
[85.792121] Dynamic subtest vecs0: SUCCESS (0.116s)
[85.792847] Subtest preservation: SUCCESS (0.525s)
[85.976190] [021/142] (910s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[86.024701] Starting subtest: yf-tiled-to-vebox-x-tiled
[86.025475] Starting dynamic subtest: smem
[86.119845] Dynamic subtest smem: SUCCESS (0.095s)
[86.120687] Subtest yf-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[86.273135] [022/142] (910s left) gem_ccs (suspend-resume)
[86.317852] Starting subtest: suspend-resume
[86.319535] Subtest suspend-resume: SKIP (0.000s)
[86.356581] [023/142] (910s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[86.503753] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[86.505158] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[86.656799] [024/142] (910s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[86.747006] Starting subtest: 4-tiled-32bpp-rotate-0
[86.748530] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[86.815617] [025/142] (909s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[86.909817] Starting subtest: cursorB-vs-flipB-toggle
[86.912116] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[86.948454] [026/142] (909s left) kms_hdmi_inject (inject-audio)
[87.037304] Starting subtest: inject-audio
[87.177797] Subtest inject-audio: SUCCESS (0.141s)
[87.332893] [027/142] (909s left) api_intel_allocator (open-vm)
[87.376034] Starting subtest: open-vm
[87.377457] Subtest open-vm: SUCCESS (0.002s)
[87.441533] [028/142] (909s left) syncobj_wait (single-wait-submitted)
[87.478684] Starting subtest: single-wait-submitted
[87.576632] Subtest single-wait-submitted: SUCCESS (0.102s)
[87.619850] [029/142] (909s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[87.702036] Starting subtest: 2x-absolute-wf_vblank-interruptible
[87.715308] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.012s)
[87.754150] [030/142] (909s left) gem_ctx_shared (exec-shared-gtt)
[87.795224] Starting subtest: exec-shared-gtt
[87.796020] Starting dynamic subtest: rcs0
[87.798399] Dynamic subtest rcs0: SUCCESS (0.003s)
[87.803387] Starting dynamic subtest: bcs0
[87.804176] Dynamic subtest bcs0: SUCCESS (0.002s)
[87.809183] Starting dynamic subtest: vcs0
[87.809894] Dynamic subtest vcs0: SUCCESS (0.002s)
[87.813916] Starting dynamic subtest: vcs1
[87.814635] Dynamic subtest vcs1: SUCCESS (0.002s)
[87.818457] Starting dynamic subtest: vecs0
[87.819236] Dynamic subtest vecs0: SUCCESS (0.002s)
[87.819996] Subtest exec-shared-gtt: SUCCESS (0.012s)
[87.968090] [031/142] (908s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[88.011710] Starting subtest: multi-wait-all-for-submit-available-submitted
[88.012471] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[88.046126] [032/142] (908s left) kms_chamelium_frames (hdmi-crc-fast)
[88.193610] Subtest hdmi-crc-fast: SKIP (0.000s)
[88.247805] [033/142] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[88.332525] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[88.333891] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[88.376820] [034/142] (908s left) debugfs_test (read_all_entries)
[88.412117] Starting subtest: read_all_entries
[88.458771] Subtest read_all_entries: SUCCESS (0.046s)
[88.544245] [035/142] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[88.631757] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[88.633149] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[88.680698] [036/142] (908s left) i915_pm_rpm (pm-tiling)
[90.182669] Starting subtest: pm-tiling
[91.635930] Subtest pm-tiling: SUCCESS (1.453s)
[91.724377] [037/142] (905s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[91.814989] Starting subtest: fbc-rgb101010-draw-mmap-wc
[94.260294] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.447s)
[94.350488] [038/142] (902s left) gem_exec_reloc (basic-write-gtt-active)
[94.396779] Starting subtest: basic-write-gtt-active
[94.523173] Subtest basic-write-gtt-active: SUCCESS (0.118s)
[94.615176] [039/142] (902s left) gem_exec_schedule (preempt-self)
[94.669959] Starting subtest: preempt-self
[94.670749] Starting dynamic subtest: rcs0
[94.678388] Dynamic subtest rcs0: SUCCESS (0.008s)
[94.683057] Starting dynamic subtest: bcs0
[94.686600] Dynamic subtest bcs0: SUCCESS (0.008s)
[94.691082] Starting dynamic subtest: vcs0
[94.694425] Dynamic subtest vcs0: SUCCESS (0.008s)
[94.698977] Starting dynamic subtest: vcs1
[94.703934] Dynamic subtest vcs1: SUCCESS (0.009s)
[94.708716] Starting dynamic subtest: vecs0
[94.712364] Dynamic subtest vecs0: SUCCESS (0.008s)
[94.713138] Subtest preempt-self: SUCCESS (0.042s)
[94.991282] [040/142] (901s left) i915_query (query-regions-garbage-items)
[95.035432] Starting subtest: query-regions-garbage-items
[95.036159] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[95.073604] [041/142] (901s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[95.111686] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[95.216799] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[95.265701] [042/142] (901s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_mc_ccs)
[95.476060] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs
[95.477871] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[95.574326] [043/142] (901s left) gem_mmap_gtt (medium-copy)
[95.608060] Starting subtest: medium-copy
[98.882990] Subtest medium-copy: SUCCESS (3.275s)
[98.931062] [044/142] (898s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[99.120829] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[99.122330] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[99.268911] [045/142] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[99.356954] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[99.358391] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[99.417478] [046/142] (897s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[99.462229] Starting subtest: tiled-to-untiled
[99.577505] Subtest tiled-to-untiled: SUCCESS (0.114s)
[99.642088] [047/142] (897s left) gem_render_copy (y-tiled)
[99.688832] Starting subtest: y-tiled
[99.689577] Starting dynamic subtest: smem
[99.786216] Dynamic subtest smem: SUCCESS (0.097s)
[99.787045] Subtest y-tiled: SUCCESS (0.097s)
[99.937233] [048/142] (897s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[100.033536] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[100.892132] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (0.860s)
[100.995313] [049/142] (896s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[101.140203] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[101.141691] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[101.306790] [050/142] (895s left) kms_vrr (flip-suspend)
[101.390349] Starting subtest: flip-suspend
[101.391839] Subtest flip-suspend: SKIP (0.000s)
[101.422780] [051/142] (895s left) syncobj_timeline (etime-multi-wait-all-submitted)
[101.477927] Starting subtest: etime-multi-wait-all-submitted
[101.576854] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[101.626712] [052/142] (895s left) kms_addfb_basic (legacy-format)
[101.673504] Starting subtest: legacy-format
[101.727263] Subtest legacy-format: SUCCESS (0.052s)
[101.824257] [053/142] (895s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[102.037765] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs
[102.039388] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[102.131504] [054/142] (895s left) syncobj_wait (wait-any-snapshot)
[102.168005] Starting subtest: wait-any-snapshot
[102.248935] Subtest wait-any-snapshot: SUCCESS (0.081s)
[102.290192] [055/142] (894s left) kms_selftest (drm_plane)
[102.325047] Starting subtest: drm_plane
[102.335662] Starting dynamic subtest: drm_plane_helper-drm_test_check_plane_state
[102.336457] Dynamic subtest drm_plane_helper-drm_test_check_plane_state: SUCCESS (0.000s)
[102.341556] Starting dynamic subtest: drm_plane_helper-drm_test_check_invalid_plane_state
[102.342315] Dynamic subtest drm_plane_helper-drm_test_check_invalid_plane_state: SUCCESS (0.000s)
[102.343052] Subtest drm_plane: SUCCESS (0.012s)
[102.422575] [056/142] (894s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted)
[102.457305] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted
[102.458068] Subtest invalid-multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[102.497171] [057/142] (894s left) kms_atomic (test-only)
[102.683162] Starting subtest: test-only
[103.019777] Subtest test-only: SUCCESS (0.336s)
[103.111044] [058/142] (894s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[103.200779] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[103.202195] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[103.251353] [059/142] (893s left) gem_spin_batch (resubmit-all)
[103.292409] Starting subtest: resubmit-all
[103.293232] Starting dynamic subtest: rcs0
[103.295591] Dynamic subtest rcs0: SUCCESS (0.003s)
[103.301095] Starting dynamic subtest: bcs0
[103.301862] Dynamic subtest bcs0: SUCCESS (0.001s)
[103.306680] Starting dynamic subtest: vcs0
[103.307397] Dynamic subtest vcs0: SUCCESS (0.002s)
[103.311951] Starting dynamic subtest: vcs1
[103.312670] Dynamic subtest vcs1: SUCCESS (0.001s)
[103.316888] Starting dynamic subtest: vecs0
[103.317613] Dynamic subtest vecs0: SUCCESS (0.001s)
[103.318307] Subtest resubmit-all: SUCCESS (0.011s)
[103.451212] [060/142] (893s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[103.506013] Subtest get-values-valid-perfmon: SKIP (0.000s)
[103.534203] [061/142] (893s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[103.621219] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[104.549265] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (0.930s)
[104.643062] [062/142] (892s left) gem_userptr_blits (readonly-pwrite-unsync)
[104.693298] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[104.787114] [063/142] (892s left) kms_rotation_crc (multiplane-rotation)
[104.881783] Starting subtest: multiplane-rotation
[114.835168] Subtest multiplane-rotation: SUCCESS (9.953s)
[114.910766] [064/142] (882s left) kms_color (invalid-ctm-matrix-sizes)
[115.001212] Starting subtest: invalid-ctm-matrix-sizes
[115.001957] Starting dynamic subtest: pipe-A
[115.004947] Dynamic subtest pipe-A: SUCCESS (0.004s)
[115.009615] Starting dynamic subtest: pipe-B
[115.011953] Dynamic subtest pipe-B: SUCCESS (0.006s)
[115.016587] Starting dynamic subtest: pipe-C
[115.019427] Dynamic subtest pipe-C: SUCCESS (0.007s)
[115.023808] Starting dynamic subtest: pipe-D
[115.027851] Dynamic subtest pipe-D: SUCCESS (0.008s)
[115.028672] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.028s)
[115.061577] [065/142] (882s left) prime_mmap (test_forked_cpu_write)
[115.101467] Starting subtest: test_forked_cpu_write
[115.102247] Starting dynamic subtest: test_forked_cpu_write-smem
[115.111119] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.010s)
[115.111954] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[115.187561] [066/142] (882s left) kms_cdclk (plane-scaling)
[115.232349] Subtest plane-scaling: SKIP (0.000s)
[115.254842] [067/142] (882s left) gem_exec_reloc (basic-write-cpu-noreloc)
[115.298945] Starting subtest: basic-write-cpu-noreloc
[115.301088] Subtest basic-write-cpu-noreloc: SUCCESS (0.002s)
[115.386557] [068/142] (881s left) gem_mmap_gtt (basic-read-write-distinct)
[115.425813] Starting subtest: basic-read-write-distinct
[115.427622] Subtest basic-read-write-distinct: SUCCESS (0.002s)
[115.495234] [069/142] (881s left) v3d/v3d_submit_cl (multiple-job-submission)
[115.549456] Subtest multiple-job-submission: SKIP (0.000s)
[115.578532] [070/142] (881s left) gem_lmem_swapping (basic)
[115.621605] Subtest basic: SKIP (0.000s)
[115.638372] [071/142] (881s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[115.723140] Starting subtest: plane-downscale-factor-0-75-with-rotation
[115.725235] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.759062] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.032s)
[115.764928] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.850884] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.091s)
[115.855673] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.950935] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.098s)
[115.955725] Starting dynamic subtest: pipe-D-HDMI-A-1
[116.051955] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.099s)
[116.053450] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.328s)
[116.185828] [072/142] (881s left) gem_exec_schedule (implicit-write-read)
[116.232715] Starting subtest: implicit-write-read
[116.233411] Starting dynamic subtest: rcs0
[116.284139] Dynamic subtest rcs0: SUCCESS (0.051s)
[116.293791] Starting dynamic subtest: bcs0
[116.340290] Dynamic subtest bcs0: SUCCESS (0.054s)
[116.350468] Starting dynamic subtest: vcs0
[116.395661] Dynamic subtest vcs0: SUCCESS (0.054s)
[116.405194] Starting dynamic subtest: vcs1
[116.452963] Dynamic subtest vcs1: SUCCESS (0.056s)
[116.463809] Starting dynamic subtest: vecs0
[116.508706] Dynamic subtest vecs0: SUCCESS (0.054s)
[116.509965] Subtest implicit-write-read: SUCCESS (0.276s)
[116.783017] [073/142] (880s left) gen9_exec_parse (bb-start-param)
[116.827802] Subtest bb-start-param: SKIP (0.000s)
[116.848664] [074/142] (880s left) kms_flip (blocking-wf_vblank)
[116.919945] Starting subtest: blocking-wf_vblank
[116.922630] Starting dynamic subtest: A-HDMI-A1
[124.742784] Dynamic subtest A-HDMI-A1: SUCCESS (7.800s)
[124.747689] Starting dynamic subtest: B-HDMI-A1
[132.531192] Dynamic subtest B-HDMI-A1: SUCCESS (7.777s)
[132.541815] Starting dynamic subtest: C-HDMI-A1
[140.320127] Dynamic subtest C-HDMI-A1: SUCCESS (7.786s)
[140.329240] Starting dynamic subtest: D-HDMI-A1
[148.077778] Dynamic subtest D-HDMI-A1: SUCCESS (7.783s)
[148.078568] Subtest blocking-wf_vblank: SUCCESS (31.157s)
[148.188365] [075/142] (849s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[148.391376] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs
[148.393026] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[148.510049] [076/142] (848s left) gem_busy (semaphore)
[148.687788] Starting subtest: semaphore
[148.689085] Starting dynamic subtest: rcs0
[148.707563] Dynamic subtest rcs0: SUCCESS (0.027s)
[148.715815] Starting dynamic subtest: bcs0
[148.724600] Dynamic subtest bcs0: SUCCESS (0.016s)
[148.734497] Starting dynamic subtest: vcs0
[148.741512] Dynamic subtest vcs0: SUCCESS (0.015s)
[148.752695] Starting dynamic subtest: vcs1
[148.757429] Dynamic subtest vcs1: SUCCESS (0.015s)
[148.764452] Starting dynamic subtest: vecs0
[148.777779] Dynamic subtest vecs0: SUCCESS (0.019s)
[148.778966] Subtest semaphore: SUCCESS (0.099s)
[148.976510] [077/142] (848s left) gem_eio (wait-1us)
[149.029557] Starting subtest: wait-1us
[149.176402] Subtest wait-1us: SUCCESS (0.146s)
[149.265173] [078/142] (848s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[149.492853] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[149.495563] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[149.569698] [079/142] (847s left) kms_lease (atomic-implicit-crtc)
[149.653303] Starting subtest: atomic-implicit-crtc
[149.654103] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.654930] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[149.664485] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.665299] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[149.671351] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.672145] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.005s)
[149.678083] Starting dynamic subtest: pipe-D-HDMI-A-1
[149.678825] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.005s)
[149.679575] Subtest atomic-implicit-crtc: SUCCESS (0.023s)
[149.736927] [080/142] (847s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[149.826114] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[149.826865] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.841471] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s)
[149.846319] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.869876] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.027s)
[149.874736] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.899125] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.027s)
[149.903904] Starting dynamic subtest: pipe-D-HDMI-A-1
[149.926839] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.027s)
[149.928286] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.101s)
[149.986289] [081/142] (847s left) kms_dsc (dsc-with-output-formats-with-bpc)
[150.069085] Starting subtest: dsc-with-output-formats-with-bpc
[150.071617] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[150.102349] [082/142] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[150.192782] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[150.194434] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[150.239192] [083/142] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[150.331927] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[150.333425] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[150.382435] [084/142] (847s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[150.471256] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[152.440252] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.968s)
[152.528246] [085/142] (845s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[152.722776] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[152.724235] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[152.834766] [086/142] (844s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_rc_ccs)
[153.021664] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs
[153.023456] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[153.136723] [087/142] (844s left) kms_psr (psr2_cursor_mmap_gtt)
[153.176863] Subtest psr2_cursor_mmap_gtt: SKIP (0.000s)
[153.197124] [088/142] (844s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[153.362543] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[153.364209] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[153.497500] [089/142] (844s left) kms_vblank (pipe-b-wait-busy-hang)
[153.580017] Starting subtest: pipe-B-wait-busy-hang
[155.076274] Subtest pipe-B-wait-busy-hang: SUCCESS (1.496s)
[155.191903] [090/142] (842s left) device_reset (unbind-reset-rebind)
[155.573878] Starting subtest: unbind-reset-rebind
[156.087956] Subtest unbind-reset-rebind: SUCCESS (0.522s)
[156.288713] [091/142] (841s left) kms_atomic_transition (plane-all-modeset-transition)
[156.375392] Starting subtest: plane-all-modeset-transition
[156.376234] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.256710] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.880s)
[171.319403] Starting dynamic subtest: pipe-B-HDMI-A-1
[184.872809] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (13.558s)
[184.927612] Subtest plane-all-modeset-transition: SUCCESS (28.553s)
[185.012953] [092/142] (812s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[185.116865] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[185.118280] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[185.163170] [093/142] (812s left) gem_exec_params (invalid-fence-in)
[185.201930] Starting subtest: invalid-fence-in
[185.202723] Subtest invalid-fence-in: SUCCESS (0.000s)
[185.273426] [094/142] (812s left) gem_ctx_persistence (heartbeat-many)
[185.319999] Starting subtest: heartbeat-many
[185.638996] Subtest heartbeat-many: SUCCESS (0.318s)
[185.688184] [095/142] (812s left) gem_exec_flush (basic-batch-kernel-default-wb)
[185.737051] Starting subtest: basic-batch-kernel-default-wb
[191.293009] Subtest basic-batch-kernel-default-wb: SUCCESS (5.556s)
[191.458872] [096/142] (806s left) gem_exec_schedule (u-fairslice)
[191.517842] Starting subtest: u-fairslice
[191.518571] Starting dynamic subtest: rcs0
[193.538182] Dynamic subtest rcs0: SUCCESS (2.010s)
[193.546276] Starting dynamic subtest: bcs0
[195.548554] Dynamic subtest bcs0: SUCCESS (2.009s)
[195.556820] Starting dynamic subtest: vcs0
[197.559400] Dynamic subtest vcs0: SUCCESS (2.010s)
[197.567357] Starting dynamic subtest: vcs1
[199.569405] Dynamic subtest vcs1: SUCCESS (2.010s)
[199.577376] Starting dynamic subtest: vecs0
[201.579099] Dynamic subtest vecs0: SUCCESS (2.009s)
[201.580279] Subtest u-fairslice: SUCCESS (10.051s)
[201.844970] [097/142] (795s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_mc_ccs)
[202.024011] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs
[202.025808] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[202.170638] [098/142] (795s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[202.303553] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[202.359728] [099/142] (795s left) kms_frontbuffer_tracking (psr-1p-rte)
[202.445926] Starting subtest: psr-1p-rte
[202.447364] Subtest psr-1p-rte: SKIP (0.000s)
[202.501737] [100/142] (795s left) gem_exec_gttfill (engines)
[202.543529] Starting subtest: engines
[202.544342] Starting dynamic subtest: rcs0
[225.296272] Dynamic subtest rcs0: SUCCESS (22.752s)
[225.302638] Starting dynamic subtest: bcs0
[247.933292] Dynamic subtest bcs0: SUCCESS (22.636s)
[247.940047] Starting dynamic subtest: vcs0
[270.438278] Dynamic subtest vcs0: SUCCESS (22.504s)
[270.443525] Starting dynamic subtest: vcs1
[293.150696] Dynamic subtest vcs1: SUCCESS (22.710s)
[293.156096] Starting dynamic subtest: vecs0
[315.768714] Dynamic subtest vecs0: SUCCESS (22.619s)
[315.769555] Subtest engines: SUCCESS (113.225s)
[315.907775] [101/142] (681s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[316.038039] Starting subtest: yf-tiled-64bpp-rotate-90
[316.039675] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[316.098086] [102/142] (681s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[316.177574] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[316.190638] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.012s)
[316.231790] [103/142] (681s left) perf_pmu (rc6-suspend)
[316.275317] Starting subtest: rc6-suspend
[338.217530] Subtest rc6-suspend: SUCCESS (7.557s)
[340.260189] [104/142] (673s left) gem_exec_balancer (busy)
[340.310139] Starting subtest: busy
[340.718155] Subtest busy: SUCCESS (0.408s)
[340.953385] [105/142] (673s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[341.048841] Starting subtest: psr-1p-pri-indfb-multidraw
[341.050239] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[341.099271] [106/142] (672s left) gem_workarounds (reset-context)
[341.149836] Starting subtest: reset-context
[341.156760] Subtest reset-context: SUCCESS (0.006s)
[341.229855] [107/142] (672s left) kms_setmode (invalid-clone-single-crtc)
[341.270384] Starting subtest: invalid-clone-single-crtc
[341.272627] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[341.303825] [108/142] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[341.399046] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[341.400420] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[341.460263] [109/142] (672s left) sw_sync (sync_busy)
[341.507816] Starting subtest: sync_busy
[341.509673] Subtest sync_busy: SUCCESS (0.002s)
[341.537731] [110/142] (672s left) gem_mmap_wc (write-prefaulted)
[341.573536] Starting subtest: write-prefaulted
[341.608939] Subtest write-prefaulted: SUCCESS (0.036s)
[341.669670] [111/142] (672s left) kms_prime (basic-modeset-hybrid)
[342.310839] Subtest basic-modeset-hybrid: SKIP (0.000s)
[342.377406] [112/142] (671s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[342.468124] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[342.468960] Starting dynamic subtest: pipe-A-valid-mode
[342.522113] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s)
[342.523496] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.054s)
[342.593486] [113/142] (671s left) kms_frontbuffer_tracking (fbc-suspend)
[342.678702] Starting subtest: fbc-suspend
[377.278387] Subtest fbc-suspend: SUCCESS (5.012s)
[381.415490] [114/142] (666s left) syncobj_timeline (single-wait-all-signaled)
[381.462802] Starting subtest: single-wait-all-signaled
[381.463638] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[381.502362] [115/142] (666s left) vc4/vc4_tiling (set-get)
[381.562669] Subtest set-get: SKIP (0.000s)
[381.593674] [116/142] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[381.685005] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[381.686415] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[381.737014] [117/142] (666s left) kms_legacy_colorkey (invalid-plane)
[381.817952] Starting subtest: invalid-plane
[381.818776] Starting dynamic subtest: zero-id
[381.819581] Dynamic subtest zero-id: SUCCESS (0.000s)
[381.826659] Starting dynamic subtest: outrange-id
[381.827503] Dynamic subtest outrange-id: SUCCESS (0.000s)
[381.828303] Subtest invalid-plane: SUCCESS (0.001s)
[381.859034] [118/142] (665s left) kms_cursor_crc (cursor-random-32x32)
[381.946800] Starting subtest: cursor-random-32x32
[381.989670] Subtest cursor-random-32x32: SKIP (0.042s)
[382.050980] [119/142] (665s left) perf_pmu (busy-idle-check-all)
[382.091274] Starting subtest: busy-idle-check-all
[382.092084] Starting dynamic subtest: rcs0
[382.709400] Dynamic subtest rcs0: SUCCESS (0.617s)
[382.717517] Starting dynamic subtest: bcs0
[383.332496] Dynamic subtest bcs0: SUCCESS (0.621s)
[383.341570] Starting dynamic subtest: vcs0
[383.952487] Dynamic subtest vcs0: SUCCESS (0.618s)
[383.961485] Starting dynamic subtest: vcs1
[384.572445] Dynamic subtest vcs1: SUCCESS (0.618s)
[384.581443] Starting dynamic subtest: vecs0
[385.196550] Dynamic subtest vecs0: SUCCESS (0.622s)
[385.197972] Subtest busy-idle-check-all: SUCCESS (3.106s)
[385.240168] [120/142] (662s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_ccs)
[385.445008] Starting subtest: pipe-C-random-ccs-data-y_tiled_ccs
[385.447680] Subtest pipe-C-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[385.547896] [121/142] (662s left) i915_pm_freq_api (freq-reset)
[385.582149] Subtest freq-reset: SKIP (0.000s)
[385.599768] [122/142] (662s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[385.690144] Starting subtest: psr-farfromfence-mmap-gtt
[385.691528] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[385.756970] [123/142] (662s left) v3d/v3d_wait_bo (used-bo-1ns)
[385.818217] Subtest used-bo-1ns: SKIP (0.000s)
[385.850219] [124/142] (661s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[385.909946] Subtest mark-purgeable-twice: SKIP (0.000s)
[385.940449] [125/142] (661s left) gem_mmap_offset (bad-extensions)
[385.983249] Starting subtest: bad-extensions
[385.983991] Subtest bad-extensions: SUCCESS (0.000s)
[386.040564] [126/142] (661s left) gem_exec_whisper (basic-sync-all)
[386.088150] Starting subtest: basic-sync-all
[389.017206] Subtest basic-sync-all: SUCCESS (2.928s)
[389.171377] [127/142] (658s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[389.315049] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[389.316805] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[389.472534] [128/142] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[389.561327] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[389.562744] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[389.621059] [129/142] (658s left) gem_exec_flush (basic-uc-ro-default)
[389.670378] Starting subtest: basic-uc-ro-default
[395.094428] Subtest basic-uc-ro-default: SUCCESS (5.424s)
[395.264517] [130/142] (652s left) gem_spin_batch (spin-all)
[395.323601] Starting subtest: spin-all
[395.330890] Subtest spin-all: SUCCESS (0.007s)
[395.493495] [131/142] (652s left) drm_fdinfo (isolation)
[395.537951] Starting subtest: isolation
[395.538761] Starting dynamic subtest: rcs0
[396.056226] Dynamic subtest rcs0: SUCCESS (0.517s)
[396.067276] Starting dynamic subtest: bcs0
[396.583354] Dynamic subtest bcs0: SUCCESS (0.526s)
[396.592681] Starting dynamic subtest: vcs0
[397.101260] Dynamic subtest vcs0: SUCCESS (0.517s)
[397.110815] Starting dynamic subtest: vcs1
[397.631451] Dynamic subtest vcs1: SUCCESS (0.523s)
[397.638049] Starting dynamic subtest: vecs0
[398.146267] Dynamic subtest vecs0: SUCCESS (0.518s)
[398.147732] Subtest isolation: SUCCESS (2.609s)
[398.195851] [132/142] (649s left) kms_vblank (pipe-c-accuracy-idle)
[398.283871] Starting subtest: pipe-C-accuracy-idle
[399.520535] Subtest pipe-C-accuracy-idle: SUCCESS (1.237s)
[399.625324] [133/142] (648s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[399.714770] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[399.716143] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[399.773114] [134/142] (648s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[399.872772] Starting subtest: fbcpsr-rgb101010-draw-render
[399.874333] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[399.942416] [135/142] (648s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[400.034583] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[400.626640] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.592s)
[400.726348] [136/142] (647s left) kms_flip (2x-flip-vs-rmfb)
[400.800719] Starting subtest: 2x-flip-vs-rmfb
[400.813347] Subtest 2x-flip-vs-rmfb: SKIP (0.012s)
[400.859564] [137/142] (647s left) syncobj_timeline (wait-all-for-submit-snapshot)
[400.896746] Starting subtest: wait-all-for-submit-snapshot
[400.978993] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[401.030266] [138/142] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[401.119422] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[402.288023] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (1.169s)
[402.385819] [139/142] (645s left) gem_basic (create-fd-close)
[402.428805] Starting subtest: create-fd-close
[402.430285] Subtest create-fd-close: SUCCESS (0.000s)
[402.484792] [140/142] (645s left) kms_psr (primary_blt)
[402.525872] Subtest primary_blt: SKIP (0.000s)
[402.544360] [141/142] (645s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[402.637453] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[402.639567] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[402.704238] [142/142] (645s left) gem_exec_balancer (parallel-keep-submit-fence)
[402.943613] Starting subtest: parallel-keep-submit-fence
[403.802932] Subtest parallel-keep-submit-fence: SUCCESS (0.859s)
[403.841880] Closing watchdogs
Done.