[46.263282] Initializing watchdogs
[46.263511]   /dev/watchdog0
[46.278769] [001/142] (960s left) gem_mmap_offset (blt-coherency)
[46.508660] Starting subtest: blt-coherency
[46.558251] Subtest blt-coherency: SUCCESS (0.046s)
[46.659295] [002/142] (960s left) dumb_buffer (invalid-bpp)
[46.864411] Starting subtest: invalid-bpp
[46.867157] Subtest invalid-bpp: SUCCESS (0.000s)
[46.942609] [003/142] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[47.267901] Starting subtest: fbcpsr-rgb565-draw-blt
[47.270635] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[47.358264] [004/142] (959s left) gem_exec_reloc (basic-softpin)
[47.591111] Starting subtest: basic-softpin
[47.597816] Subtest basic-softpin: SUCCESS (0.007s)
[47.775153] [005/142] (959s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[48.081963] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[50.009775] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (1.930s)
[50.140695] [006/142] (956s left) device_reset (unbind-cold-reset-rebind)
[50.385649] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[50.457806] [007/142] (956s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[50.958950] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[50.961853] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[51.463712] [008/142] (955s left) vgem_basic (mmap)
[51.766184] Starting subtest: mmap
[51.792380] Subtest mmap: SUCCESS (0.027s)
[51.863910] [009/142] (955s left) kms_flip (2x-dpms-vs-vblank-race)
[52.161441] Starting subtest: 2x-dpms-vs-vblank-race
[52.164120] Subtest 2x-dpms-vs-vblank-race: SKIP (0.004s)
[52.281531] [010/142] (954s left) gem_exec_balancer (indices)
[52.515660] Starting subtest: indices
[56.266644] Subtest indices: SUCCESS (3.750s)
[60.215205] [011/142] (946s left) drm_fdinfo (most-busy-check-all)
[60.430742] Starting subtest: most-busy-check-all
[60.432120] Starting dynamic subtest: rcs0
[60.955944] Dynamic subtest rcs0: SUCCESS (0.525s)
[60.972460] Starting dynamic subtest: bcs0
[61.477602] Dynamic subtest bcs0: SUCCESS (0.522s)
[61.494287] Starting dynamic subtest: vcs0
[62.005567] Dynamic subtest vcs0: SUCCESS (0.527s)
[62.022502] Starting dynamic subtest: vecs0
[62.534697] Dynamic subtest vecs0: SUCCESS (0.529s)
[62.536265] Subtest most-busy-check-all: SUCCESS (2.104s)
[62.613481] [012/142] (944s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[62.945328] Starting subtest: x-tiled-16bpp-rotate-0
[66.846968] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.900s)
[67.168579] [013/142] (940s left) sw_sync (alloc_fence_invalid_timeline)
[67.369802] Starting subtest: alloc_fence_invalid_timeline
[67.371433] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[67.431040] [014/142] (939s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[67.744924] Starting subtest: fbc-indfb-scaledprimary
[70.897056] Subtest fbc-indfb-scaledprimary: SUCCESS (3.153s)
[71.030557] [015/142] (936s left) i915_pm_rpm (system-suspend-modeset)
[72.847577] Starting subtest: system-suspend-modeset
[90.179642] Subtest system-suspend-modeset: SUCCESS (2.333s)
[92.911549] [016/142] (931s left) syncobj_wait (single-wait-signaled)
[93.134256] Starting subtest: single-wait-signaled
[93.135905] Subtest single-wait-signaled: SUCCESS (0.001s)
[93.222098] [017/142] (931s left) syncobj_timeline (wait-any-snapshot)
[93.427386] Starting subtest: wait-any-snapshot
[93.511236] Subtest wait-any-snapshot: SUCCESS (0.083s)
[93.603492] [018/142] (930s left) perf_pmu (gt-awake)
[93.812656] Starting subtest: gt-awake
[96.368485] Subtest gt-awake: SUCCESS (2.556s)
[96.487286] [019/142] (927s left) gem_exec_balancer (semaphore)
[96.716378] Starting subtest: semaphore
[100.939619] Subtest semaphore: SUCCESS (4.223s)
[104.889320] [020/142] (919s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[105.095545] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[105.201763] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[105.287447] [021/142] (919s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[105.600296] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[105.602825] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[105.705912] [022/142] (918s left) kms_chamelium_audio (hdmi-audio)
[106.100454] Subtest hdmi-audio: SKIP (0.000s)
[106.389945] [023/142] (918s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[106.798613] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[106.802963] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[107.382632] [024/142] (917s left) template (a)
[107.585555] Starting subtest: A
[107.588141] Subtest A: SUCCESS (0.000s)
[107.665137] [025/142] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[107.985413] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[107.988070] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[108.083320] [026/142] (916s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[108.412199] Starting subtest: y-tiled-16bpp-rotate-90
[108.502370] Subtest y-tiled-16bpp-rotate-90: SKIP (0.088s)
[108.615484] [027/142] (916s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs)
[109.186236] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs
[109.188907] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[109.625764] [028/142] (915s left) kms_content_protection (content_type_change)
[109.960174] Starting subtest: content_type_change
[110.662360] Subtest content_type_change: SKIP (0.700s)
[111.108676] [029/142] (913s left) gem_mmap_gtt (bad-object)
[111.313230] Starting subtest: bad-object
[111.314737] Subtest bad-object: SUCCESS (0.000s)
[111.407531] [030/142] (913s left) gem_exec_params (mmapped)
[111.617417] Starting subtest: mmapped
[111.623233] Subtest mmapped: SUCCESS (0.005s)
[111.731072] [031/142] (913s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[112.040898] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[112.042971] Starting dynamic subtest: pipe-A-valid-mode
[112.134276] Dynamic subtest pipe-A-valid-mode: SKIP (0.093s)
[112.138120] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.095s)
[112.451724] [032/142] (912s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[112.930787] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[112.937247] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[113.457503] [033/142] (911s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[113.762292] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[113.764842] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[113.876983] [034/142] (911s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-sf)
[114.084947] Subtest cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[114.140596] [035/142] (910s left) kms_atomic_interruptible (legacy-cursor)
[114.438288] Starting subtest: legacy-cursor
[114.441178] Starting dynamic subtest: DP-1-pipe-A
[120.989628] Dynamic subtest DP-1-pipe-A: SUCCESS (6.548s)
[120.991244] Subtest legacy-cursor: SUCCESS (6.551s)
[121.325942] [036/142] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[121.644763] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[121.647498] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[121.743197] [037/142] (903s left) i915_pm_dc (dc5-psr)
[123.055869] Starting subtest: dc5-psr
[123.059959] Subtest dc5-psr: SKIP (0.000s)
[123.225206] [038/142] (901s left) gem_exec_schedule (preempt-queue-chain)
[123.464736] Starting subtest: preempt-queue-chain
[123.466310] Starting dynamic subtest: rcs0
[123.951900] Dynamic subtest rcs0: SUCCESS (0.485s)
[123.978715] Starting dynamic subtest: bcs0
[124.415953] Dynamic subtest bcs0: SUCCESS (0.463s)
[124.446269] Starting dynamic subtest: vcs0
[124.866983] Dynamic subtest vcs0: SUCCESS (0.451s)
[124.900133] Starting dynamic subtest: vecs0
[125.319917] Dynamic subtest vecs0: SUCCESS (0.451s)
[125.321257] Subtest preempt-queue-chain: SUCCESS (1.853s)
[125.676288] [039/142] (899s left) gem_exec_params (sol-reset-invalid)
[125.888354] Starting subtest: sol-reset-invalid
[125.891887] Subtest sol-reset-invalid: SUCCESS (0.003s)
[126.008134] [040/142] (899s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[126.313677] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[126.315058] Starting dynamic subtest: pipe-A-DP-1
[126.644508] Dynamic subtest pipe-A-DP-1: SUCCESS (0.331s)
[126.668687] Starting dynamic subtest: pipe-B-DP-1
[127.018452] Dynamic subtest pipe-B-DP-1: SUCCESS (0.370s)
[127.040834] Starting dynamic subtest: pipe-C-DP-1
[127.117756] Dynamic subtest pipe-C-DP-1: SKIP (0.094s)
[127.119276] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.806s)
[127.517728] [041/142] (897s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[128.205431] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[128.517740] [042/142] (896s left) gem_exec_schedule (semaphore-user)
[128.752339] Starting subtest: semaphore-user
[128.771633] Subtest semaphore-user: SUCCESS (0.019s)
[129.118319] [043/142] (896s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-5)
[129.413739] Starting subtest: plane-downscale-with-rotation-factor-0-5
[129.415195] Starting dynamic subtest: pipe-A-DP-1
[129.762213] Dynamic subtest pipe-A-DP-1: SKIP (0.341s)
[129.782784] Starting dynamic subtest: pipe-B-DP-1
[130.137316] Dynamic subtest pipe-B-DP-1: SKIP (0.378s)
[130.157886] Starting dynamic subtest: pipe-C-DP-1
[130.525941] Dynamic subtest pipe-C-DP-1: SKIP (0.384s)
[130.528620] Subtest plane-downscale-with-rotation-factor-0-5: SKIP (1.114s)
[130.934183] [044/142] (894s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[131.242221] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[131.244886] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[131.350640] [045/142] (894s left) kms_vblank (pipe-d-query-forked)
[131.655920] Subtest pipe-D-query-forked: SKIP (0.000s)
[131.734040] [046/142] (893s left) kms_vblank (pipe-a-ts-continuation-dpms-rpm)
[132.036212] Starting subtest: pipe-A-ts-continuation-dpms-rpm
[133.914919] Subtest pipe-A-ts-continuation-dpms-rpm: SUCCESS (1.879s)
[134.344465] [047/142] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[134.654486] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[134.657160] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[134.761773] [048/142] (890s left) kms_async_flips (alternate-sync-async-flip)
[135.067264] Starting subtest: alternate-sync-async-flip
[135.493635] Starting dynamic subtest: pipe-A-DP-1
[138.340820] Dynamic subtest pipe-A-DP-1: SUCCESS (2.846s)
[138.825670] Starting dynamic subtest: pipe-B-DP-1
[141.078287] Dynamic subtest pipe-B-DP-1: SUCCESS (2.281s)
[141.536058] Starting dynamic subtest: pipe-C-DP-1
[143.813401] Dynamic subtest pipe-C-DP-1: SUCCESS (2.303s)
[143.814835] Subtest alternate-sync-async-flip: SUCCESS (8.744s)
[144.377927] [049/142] (881s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[144.606535] Starting subtest: y-tiled-ccs-to-yf-tiled
[144.607967] Starting dynamic subtest: smem
[145.004657] Dynamic subtest smem: SUCCESS (0.392s)
[145.006121] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.393s)
[145.211242] [050/142] (880s left) perf_pmu (interrupts)
[145.420255] Starting subtest: interrupts
[146.565204] Subtest interrupts: SUCCESS (1.142s)
[146.677785] [051/142] (879s left) kms_busy (extended-pageflip-hang-oldfb)
[146.996834] Starting subtest: extended-pageflip-hang-oldfb
[146.998244] Starting dynamic subtest: pipe-A
[147.447119] Dynamic subtest pipe-A: SUCCESS (0.448s)
[147.473611] Starting dynamic subtest: pipe-C
[148.047654] Dynamic subtest pipe-C: SUCCESS (0.594s)
[148.049523] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.054s)
[148.420965] [052/142] (877s left) kms_flip (flip-vs-wf_vblank-interruptible)
[148.727795] Starting subtest: flip-vs-wf_vblank-interruptible
[148.732561] Starting dynamic subtest: A-DP1
[150.198092] Dynamic subtest A-DP1: SUCCESS (1.466s)
[150.222978] Starting dynamic subtest: B-DP1
[151.586918] Dynamic subtest B-DP1: SUCCESS (1.382s)
[151.612891] Starting dynamic subtest: C-DP1
[152.971910] Dynamic subtest C-DP1: SUCCESS (1.380s)
[152.977117] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.249s)
[153.389731] [053/142] (872s left) gem_lmem_swapping (random)
[153.604071] Subtest random: SKIP (0.000s)
[153.652455] [054/142] (872s left) kms_flip (flip-vs-panning-interruptible)
[153.958606] Starting subtest: flip-vs-panning-interruptible
[153.963651] Starting dynamic subtest: A-DP1
[164.543380] Dynamic subtest A-DP1: SUCCESS (10.580s)
[164.567874] Starting dynamic subtest: B-DP1
[175.059727] Dynamic subtest B-DP1: SUCCESS (10.514s)
[175.084203] Starting dynamic subtest: C-DP1
[185.585448] Dynamic subtest C-DP1: SUCCESS (10.523s)
[185.589857] Subtest flip-vs-panning-interruptible: SUCCESS (31.630s)
[186.043420] [055/142] (839s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[186.358692] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[186.360207] Starting dynamic subtest: pipe-A-valid-mode
[187.076387] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.715s)
[187.080059] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.719s)
[187.423815] [056/142] (838s left) kms_chamelium_frames (hdmi-crc-single)
[187.850825] Subtest hdmi-crc-single: SKIP (0.000s)
[188.151610] [057/142] (837s left) gem_userptr_blits (dmabuf-unsync)
[188.367954] Subtest dmabuf-unsync: SKIP (0.000s)
[188.530231] [058/142] (837s left) kms_atomic (plane-overlay-legacy)
[188.961092] Starting subtest: plane-overlay-legacy
[189.088289] Subtest plane-overlay-legacy: SUCCESS (0.127s)
[189.519832] [059/142] (836s left) kms_vblank (pipe-b-wait-busy)
[189.832317] Starting subtest: pipe-B-wait-busy
[192.685365] Subtest pipe-B-wait-busy: SUCCESS (2.855s)
[193.024200] [060/142] (833s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_ccs)
[193.707077] Subtest pipe-D-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.000s)
[194.028840] [061/142] (832s left) gem_ctx_engines (invalid-engines)
[194.263036] Starting subtest: invalid-engines
[194.280309] Subtest invalid-engines: SUCCESS (0.017s)
[194.478760] [062/142] (831s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[195.158341] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[195.478921] [063/142] (830s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[195.789233] Starting subtest: fbcpsr-tiling-linear
[195.792395] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[195.895580] [064/142] (830s left) gem_tiled_blits (basic)
[197.771031] Starting subtest: basic
[197.812947] Subtest basic: SUCCESS (0.044s)
[197.956602] [065/142] (828s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[198.305307] Starting subtest: multi-wait-all-available-submitted-signaled
[198.306869] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.002s)
[198.396528] [066/142] (827s left) v3d/v3d_submit_csd (bad-multisync-pad)
[198.653336] Subtest bad-multisync-pad: SKIP (0.000s)
[198.729714] [067/142] (827s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[199.070308] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[199.073465] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[199.179706] [068/142] (827s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[199.495833] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[199.498842] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[199.613573] [069/142] (826s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[200.117205] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[200.120854] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[200.592569] [070/142] (825s left) prime_mmap (test_userptr)
[200.799651] Starting subtest: test_userptr
[200.801145] Starting dynamic subtest: test_userptr-smem
[200.802456] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[200.803799] Subtest test_userptr: SUCCESS (0.005s)
[200.909249] [071/142] (825s left) kms_hdr (static-toggle)
[201.210381] Starting subtest: static-toggle
[201.212892] Subtest static-toggle: SKIP (0.000s)
[201.293936] [072/142] (825s left) syncobj_timeline (invalid-signal-illegal-handle)
[201.502601] Starting subtest: invalid-signal-illegal-handle
[201.504399] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[201.592307] [073/142] (825s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[201.913465] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[201.917047] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[202.025779] [074/142] (824s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[202.352910] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[202.383454] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.031s)
[202.492931] [075/142] (824s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[202.749408] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[202.826429] [076/142] (823s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[203.132311] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[203.138936] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.005s)
[203.243936] [077/142] (823s left) kms_cursor_crc (cursor-random-32x10)
[203.564498] Starting subtest: cursor-random-32x10
[203.682970] Subtest cursor-random-32x10: SKIP (0.116s)
[203.808761] [078/142] (823s left) kms_scaling_modes (scaling-mode-none)
[204.123585] Starting subtest: scaling-mode-none
[204.126886] Subtest scaling-mode-none: SKIP (0.001s)
[204.209387] [079/142] (822s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[204.916458] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[205.256801] [080/142] (821s left) gem_pwrite (basic-exhaustion)
[205.463829] Starting subtest: basic-exhaustion
[226.536836] Subtest basic-exhaustion: SUCCESS (21.072s)
[226.658685] [081/142] (800s left) gen9_exec_parse (basic-rejected)
[226.887296] Starting subtest: basic-rejected
[226.891312] Subtest basic-rejected: SUCCESS (0.003s)
[227.123720] [082/142] (799s left) gen9_exec_parse (valid-registers)
[227.350645] Starting subtest: valid-registers
[227.526395] Subtest valid-registers: SUCCESS (0.174s)
[227.755642] [083/142] (799s left) kms_cursor_legacy (single-move)
[228.055759] Starting subtest: single-move
[228.057192] Starting dynamic subtest: pipe-A
[233.464857] Dynamic subtest pipe-A: SUCCESS (5.407s)
[233.488882] Starting dynamic subtest: pipe-B
[238.873032] Dynamic subtest pipe-B: SUCCESS (5.405s)
[238.895571] Starting dynamic subtest: pipe-C
[244.280608] Dynamic subtest pipe-C: SUCCESS (5.405s)
[244.304272] Starting dynamic subtest: all-pipes
[249.691440] Dynamic subtest all-pipes: SUCCESS (5.409s)
[249.693130] Subtest single-move: SUCCESS (21.635s)
[249.789311] [084/142] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[250.096728] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[250.099500] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[250.206902] [085/142] (776s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[250.531286] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[250.534199] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[250.640226] [086/142] (776s left) prime_mmap (test_correct)
[250.841675] Starting subtest: test_correct
[250.843108] Starting dynamic subtest: test_correct-smem
[250.850518] Dynamic subtest test_correct-smem: SUCCESS (0.008s)
[250.852271] Subtest test_correct: SUCCESS (0.010s)
[250.955918] [087/142] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[251.261417] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[251.264317] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[251.373424] [088/142] (775s left) kms_flip (basic-flip-vs-modeset)
[251.653938] Starting subtest: basic-flip-vs-modeset
[251.655309] Starting dynamic subtest: A-DP1
[253.166849] Dynamic subtest A-DP1: SUCCESS (1.510s)
[253.189977] Starting dynamic subtest: B-DP1
[254.317836] Dynamic subtest B-DP1: SUCCESS (1.149s)
[254.346133] Starting dynamic subtest: C-DP1
[255.443344] Dynamic subtest C-DP1: SUCCESS (1.120s)
[255.444917] Subtest basic-flip-vs-modeset: SUCCESS (3.793s)
[255.804698] [089/142] (771s left) gem_softpin (safe-alignment)
[256.020508] Starting subtest: safe-alignment
[256.051214] Subtest safe-alignment: SUCCESS (0.030s)
[256.168900] [090/142] (771s left) vc4/vc4_wait_bo (unused-bo-0ns)
[256.424911] Subtest unused-bo-0ns: SKIP (0.000s)
[256.502488] [091/142] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[256.808625] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[256.811160] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[256.919583] [092/142] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[257.233777] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[257.236524] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[257.336252] [093/142] (770s left) gem_ctx_sseu (engines)
[257.549191] Subtest engines: SKIP (0.000s)
[257.618606] [094/142] (769s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[258.006672] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[258.303516] [095/142] (769s left) kms_psr (sprite_mmap_cpu)
[258.506839] Subtest sprite_mmap_cpu: SKIP (0.000s)
[258.564274] [096/142] (769s left) syncobj_basic (bad-pad-handle-to-fd)
[258.762203] Starting subtest: bad-pad-handle-to-fd
[258.763972] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[258.848564] [097/142] (768s left) kms_plane_lowres (tiling-x)
[259.147335] Starting subtest: tiling-x
[259.148645] Starting dynamic subtest: pipe-A-DP-1
[265.568537] Dynamic subtest pipe-A-DP-1: SUCCESS (6.422s)
[265.707231] Starting dynamic subtest: pipe-B-DP-1
[271.961477] Dynamic subtest pipe-B-DP-1: SUCCESS (6.273s)
[272.083450] Starting dynamic subtest: pipe-C-DP-1
[276.265046] Dynamic subtest pipe-C-DP-1: SUCCESS (4.203s)
[276.365931] Subtest tiling-x: SUCCESS (17.220s)
[276.835983] [098/142] (750s left) gem_exec_fence (invalid-timeline-fence-array)
[277.637972] Starting subtest: invalid-timeline-fence-array
[277.651385] Subtest invalid-timeline-fence-array: SUCCESS (0.013s)
[277.867894] [099/142] (749s left) syncobj_timeline (single-wait-available-signaled)
[278.070898] Starting subtest: single-wait-available-signaled
[278.072921] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[278.166467] [100/142] (749s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[278.488088] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[279.870214] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.384s)
[280.022634] [101/142] (747s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[280.225974] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s)
[280.282701] [102/142] (747s left) gem_exec_whisper (basic-fds-all)
[280.513577] Starting subtest: basic-fds-all
[301.802751] Subtest basic-fds-all: SUCCESS (21.287s)
[302.017860] [103/142] (725s left) kms_vblank (pipe-a-ts-continuation-modeset)
[302.323992] Starting subtest: pipe-A-ts-continuation-modeset
[302.965082] Subtest pipe-A-ts-continuation-modeset: SUCCESS (0.639s)
[303.305593] [104/142] (724s left) gem_ccs (suspend-resume)
[303.517660] Subtest suspend-resume: SKIP (0.000s)
[303.587356] [105/142] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[303.890466] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[303.893186] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[304.005879] [106/142] (724s left) gem_softpin (evict-snoop-interruptible)
[304.222605] Starting subtest: evict-snoop-interruptible
[304.226326] Subtest evict-snoop-interruptible: SKIP (0.000s)
[304.321972] [107/142] (723s left) kms_vblank (pipe-a-wait-busy-hang)
[304.619062] Starting subtest: pipe-A-wait-busy-hang
[312.007435] Subtest pipe-A-wait-busy-hang: SUCCESS (7.390s)
[312.349841] [108/142] (715s left) kms_vblank (pipe-c-ts-continuation-idle)
[312.663311] Starting subtest: pipe-C-ts-continuation-idle
[313.402189] Subtest pipe-C-ts-continuation-idle: SUCCESS (0.741s)
[313.747636] [109/142] (714s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[313.955695] Starting subtest: etime-single-wait-for-submit-unsubmitted
[314.064109] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[314.164107] [110/142] (714s left) gem_exec_reloc (basic-write-cpu)
[314.378545] Starting subtest: basic-write-cpu
[314.398219] Subtest basic-write-cpu: SUCCESS (0.018s)
[314.581430] [111/142] (713s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[314.792674] Starting subtest: legacy-engines-hostile-preempt
[314.797472] Starting dynamic subtest: render
[314.889835] Dynamic subtest render: SUCCESS (0.095s)
[314.917537] Starting dynamic subtest: bsd
[314.980926] Dynamic subtest bsd: SUCCESS (0.087s)
[315.007802] Starting dynamic subtest: blt
[315.074538] Dynamic subtest blt: SUCCESS (0.090s)
[315.100945] Starting dynamic subtest: vebox
[315.163463] Dynamic subtest vebox: SUCCESS (0.086s)
[315.164720] Subtest legacy-engines-hostile-preempt: SUCCESS (0.372s)
[315.264854] [112/142] (713s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[315.519759] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[315.597319] [113/142] (712s left) perf_pmu (most-busy-idle-check-all)
[315.807655] Starting subtest: most-busy-idle-check-all
[315.809191] Starting dynamic subtest: rcs0
[316.434754] Dynamic subtest rcs0: SUCCESS (0.626s)
[316.467398] Starting dynamic subtest: bcs0
[317.060692] Dynamic subtest bcs0: SUCCESS (0.623s)
[317.090720] Starting dynamic subtest: vcs0
[317.686741] Dynamic subtest vcs0: SUCCESS (0.624s)
[317.720186] Starting dynamic subtest: vecs0
[318.317835] Dynamic subtest vecs0: SUCCESS (0.628s)
[318.319627] Subtest most-busy-idle-check-all: SUCCESS (2.511s)
[318.414449] [114/142] (710s left) gem_create (create-valid-nonaligned)
[318.617400] Starting subtest: create-valid-nonaligned
[318.618881] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[318.848523] [115/142] (709s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[319.461130] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[319.466412] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[319.868642] [116/142] (708s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_ccs)
[320.551947] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_ccs
[320.557595] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.005s)
[320.902518] [117/142] (707s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[321.456471] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[321.463404] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.005s)
[321.898349] [118/142] (706s left) api_intel_bb (bb-with-allocator)
[322.104237] Starting subtest: bb-with-allocator
[322.117314] Subtest bb-with-allocator: SUCCESS (0.013s)
[322.231481] [119/142] (706s left) kms_cursor_crc (cursor-onscreen-max-size)
[322.563740] Starting subtest: cursor-onscreen-max-size
[322.568436] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[322.664592] [120/142] (706s left) i915_pm_freq_mult (media-freq)
[322.866382] Starting subtest: media-freq
[322.868059] Starting dynamic subtest: gt0
[322.871288] Dynamic subtest gt0: SKIP (0.000s)
[322.874151] Subtest media-freq: SKIP (0.003s)
[322.964372] [121/142] (705s left) kms_flip (2x-flip-vs-wf_vblank)
[323.248484] Starting subtest: 2x-flip-vs-wf_vblank
[323.251080] Subtest 2x-flip-vs-wf_vblank: SKIP (0.003s)
[323.365284] [122/142] (705s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[323.829514] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[323.832123] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[324.355221] [123/142] (704s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[324.577132] Starting subtest: y-tiled-to-vebox-y-tiled
[324.580507] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.001s)
[324.788488] [124/142] (704s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[325.098960] Starting subtest: psr-rgb565-draw-render
[325.101999] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[325.206152] [125/142] (703s left) gem_exec_fence (syncobj-timeline-signal)
[326.002668] Starting subtest: syncobj-timeline-signal
[326.011352] Subtest syncobj-timeline-signal: SUCCESS (0.010s)
[326.239656] [126/142] (702s left) syncobj_basic (create-signaled)
[326.441251] Starting subtest: create-signaled
[326.442943] Subtest create-signaled: SUCCESS (0.000s)
[326.538515] [127/142] (702s left) gem_eio (wait-wedge-10ms)
[326.777633] Starting subtest: wait-wedge-10ms
[326.865227] Subtest wait-wedge-10ms: SUCCESS (0.090s)
[327.091920] [128/142] (701s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[327.406769] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[329.211246] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (1.807s)
[329.339523] [129/142] (699s left) vc4/vc4_perfmon (get-values-valid-perfmon)
[329.593929] Subtest get-values-valid-perfmon: SKIP (0.000s)
[329.672244] [130/142] (699s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[329.977407] Starting subtest: disable-crc-after-crtc
[329.978711] Starting dynamic subtest: pipe-A-DP-1
[330.682989] Dynamic subtest pipe-A-DP-1: SUCCESS (0.701s)
[330.714981] Starting dynamic subtest: pipe-B-DP-1
[331.751177] Dynamic subtest pipe-B-DP-1: SUCCESS (1.065s)
[331.777982] Starting dynamic subtest: pipe-C-DP-1
[332.881198] Dynamic subtest pipe-C-DP-1: SUCCESS (1.127s)
[332.882454] Subtest disable-crc-after-crtc: SUCCESS (2.909s)
[333.212359] [131/142] (696s left) api_intel_allocator (execbuf-with-allocator)
[333.415620] Starting subtest: execbuf-with-allocator
[333.425770] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[333.543714] [132/142] (695s left) gem_mmap_gtt (basic-small-bo)
[333.746206] Starting subtest: basic-small-bo
[334.532272] Subtest basic-small-bo: SUCCESS (0.785s)
[334.705690] [133/142] (694s left) gem_tiled_fence_blits (normal)
[335.254016] Starting subtest: normal
[337.360275] Subtest normal: SUCCESS (2.104s)
[337.463158] [134/142] (691s left) perf (whitelisted-registers-userspace-config)
[337.943314] Starting subtest: whitelisted-registers-userspace-config
[337.944816] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[338.009647] [135/142] (691s left) kms_cursor_edge_walk (64x64-top-edge)
[338.317097] Starting subtest: 64x64-top-edge
[338.318404] Starting dynamic subtest: pipe-A-DP-1
[342.198520] Dynamic subtest pipe-A-DP-1: SUCCESS (3.880s)
[342.225682] Starting dynamic subtest: pipe-C-DP-1
[345.696326] Dynamic subtest pipe-C-DP-1: SUCCESS (3.493s)
[345.697798] Subtest 64x64-top-edge: SUCCESS (7.383s)
[346.013382] [136/142] (683s left) gem_softpin (noreloc-s3)
[346.233872] Starting subtest: noreloc-S3
[367.651075] Subtest noreloc-S3: SUCCESS (5.552s)
[367.773913] [137/142] (677s left) kms_vblank (pipe-d-ts-continuation-suspend)
[368.084499] Subtest pipe-D-ts-continuation-suspend: SKIP (0.000s)
[368.173759] [138/142] (677s left) kms_vblank (pipe-c-wait-forked-busy)
[368.481829] Starting subtest: pipe-C-wait-forked-busy
[371.470519] Subtest pipe-C-wait-forked-busy: SUCCESS (2.991s)
[371.820751] [139/142] (673s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_rc_ccs)
[372.127661] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs
[372.130432] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[372.824049] [140/142] (672s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[373.146863] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[373.152433] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[373.241221] [141/142] (672s left) gem_exec_nop (basic-sequential)
[373.470825] Starting subtest: basic-sequential
[376.585434] Subtest basic-sequential: SUCCESS (3.112s)
[376.824958] [142/142] (668s left) i915_pm_rpm (gem-idle)
[378.622961] Starting subtest: gem-idle
[384.042848] Subtest gem-idle: SUCCESS (5.419s)
[384.450600] Closing watchdogs
Done.