[46.078959] Initializing watchdogs
[46.079474]   /dev/watchdog0
[46.111961] [001/141] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[46.676658] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[56.474886] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (9.795s)
[56.757890] [002/141] (949s left) kms_color (ctm-green-to-red)
[57.240100] Starting subtest: ctm-green-to-red
[57.243568] Starting dynamic subtest: pipe-A
[58.497283] Dynamic subtest pipe-A: SUCCESS (1.258s)
[58.534287] Starting dynamic subtest: pipe-B
[60.530385] Dynamic subtest pipe-B: SUCCESS (2.029s)
[60.560999] Starting dynamic subtest: pipe-C
[62.918262] Dynamic subtest pipe-C: SUCCESS (2.389s)
[62.947244] Starting dynamic subtest: pipe-D
[65.450345] Dynamic subtest pipe-D: SUCCESS (2.528s)
[65.453610] Subtest ctm-green-to-red: SUCCESS (8.208s)
[66.384318] [003/141] (940s left) kms_cursor_crc (cursor-offscreen-512x170)
[67.627411] Starting subtest: cursor-offscreen-512x170
[67.638064] Subtest cursor-offscreen-512x170: SKIP (0.007s)
[67.953624] [004/141] (938s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[68.847857] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[69.696926] [005/141] (937s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[70.229845] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[70.236631] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[70.385610] [006/141] (936s left) syncobj_wait (reset-multiple-signaled)
[70.759991] Starting subtest: reset-multiple-signaled
[70.764238] Subtest reset-multiple-signaled: SUCCESS (0.003s)
[70.886692] [007/141] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[71.386298] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[71.392897] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[71.543835] [008/141] (935s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs)
[72.742349] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs
[72.751950] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[73.877077] [009/141] (933s left) kms_draw_crc (draw-method-render)
[74.369375] Starting subtest: draw-method-render
[74.372845] Starting dynamic subtest: xrgb8888-untiled
[75.116177] Dynamic subtest xrgb8888-untiled: SUCCESS (0.748s)
[75.144434] Starting dynamic subtest: rgb565-untiled
[75.792855] Dynamic subtest rgb565-untiled: SUCCESS (0.677s)
[75.823293] Starting dynamic subtest: xrgb2101010-untiled
[76.481376] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.688s)
[76.511053] Starting dynamic subtest: xrgb8888-xtiled
[76.892146] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.411s)
[76.923766] Starting dynamic subtest: rgb565-xtiled
[77.303226] Dynamic subtest rgb565-xtiled: SUCCESS (0.410s)
[77.333753] Starting dynamic subtest: xrgb2101010-xtiled
[77.715206] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.409s)
[77.750367] Starting dynamic subtest: xrgb8888-4tiled
[78.103275] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.387s)
[78.133171] Starting dynamic subtest: rgb565-4tiled
[78.492328] Dynamic subtest rgb565-4tiled: SUCCESS (0.388s)
[78.525465] Starting dynamic subtest: xrgb2101010-4tiled
[78.883307] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.387s)
[78.886545] Subtest draw-method-render: SUCCESS (4.516s)
[79.049676] [010/141] (928s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[79.512725] Starting subtest: map-fixed-invalidate-overlap
[79.519129] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[79.735451] [011/141] (927s left) syncobj_timeline (etime-single-wait-submitted)
[80.104691] Starting subtest: etime-single-wait-submitted
[80.210253] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[80.343435] [012/141] (927s left) gem_ctx_param (set-priority-invalid-size)
[80.719558] Starting subtest: set-priority-invalid-size
[80.723213] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[80.835504] [013/141] (926s left) vgem_basic (debugfs)
[81.348293] Starting subtest: debugfs
[81.351805] Subtest debugfs: SUCCESS (0.002s)
[81.463451] [014/141] (926s left) kms_flip (basic-flip-vs-modeset)
[81.858348] Starting subtest: basic-flip-vs-modeset
[81.886113] Starting dynamic subtest: A-eDP1
[85.484760] Dynamic subtest A-eDP1: SUCCESS (3.596s)
[85.511828] Starting dynamic subtest: B-eDP1
[87.956207] Dynamic subtest B-eDP1: SUCCESS (2.471s)
[87.982842] Starting dynamic subtest: C-eDP1
[90.398513] Dynamic subtest C-eDP1: SUCCESS (2.438s)
[90.427617] Starting dynamic subtest: D-eDP1
[92.843831] Dynamic subtest D-eDP1: SUCCESS (2.443s)
[92.868793] Subtest basic-flip-vs-modeset: SUCCESS (11.012s)
[93.787478] [015/141] (913s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[94.296177] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[107.322395] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (13.030s)
[107.489196] [016/141] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[107.705456] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[118.358271] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (10.649s)
[118.581928] [017/141] (889s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[118.970337] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[119.126631] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.157s)
[119.318676] [018/141] (888s left) kms_prop_blob (invalid-set-prop)
[119.683397] Starting subtest: invalid-set-prop
[119.686845] Subtest invalid-set-prop: SUCCESS (0.000s)
[119.794399] [019/141] (888s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[120.126523] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[124.574123] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (4.445s)
[125.088679] [020/141] (882s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[126.498400] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc
[127.486953] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.983s)
[128.881217] [021/141] (879s left) drm_fdinfo (busy-hang)
[129.266564] Starting subtest: busy-hang
[129.270320] Starting dynamic subtest: rcs0
[129.276744] Dynamic subtest rcs0: SKIP (0.003s)
[129.310988] Starting dynamic subtest: bcs0
[129.317339] Dynamic subtest bcs0: SKIP (0.002s)
[129.354294] Starting dynamic subtest: vcs0
[129.361515] Dynamic subtest vcs0: SKIP (0.001s)
[129.394743] Starting dynamic subtest: vcs1
[129.401896] Dynamic subtest vcs1: SKIP (0.001s)
[129.434757] Starting dynamic subtest: vecs0
[129.441833] Dynamic subtest vecs0: SKIP (0.001s)
[129.474520] Starting dynamic subtest: ccs0
[129.481137] Dynamic subtest ccs0: SKIP (0.001s)
[129.487638] Subtest busy-hang: SKIP (0.033s)
[129.543469] [022/141] (878s left) syncobj_wait (multi-wait-submitted-signaled)
[129.916909] Starting subtest: multi-wait-submitted-signaled
[129.921255] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[130.061597] [023/141] (878s left) gem_exec_create (legacy)
[130.483726] Starting subtest: legacy
[130.487391] Starting dynamic subtest: smem
[134.549215] Dynamic subtest smem: SUCCESS (4.068s)
[134.552846] Subtest legacy: SUCCESS (4.072s)
[134.845796] [024/141] (873s left) gen9_exec_parse (bb-start-far)
[135.254712] Subtest bb-start-far: SKIP (0.000s)
[135.377245] [025/141] (872s left) gem_mmap_wc (copy)
[135.745898] Subtest copy: SKIP (0.000s)
[135.858849] [026/141] (872s left) perf_pmu (busy-accuracy-50)
[136.257336] Starting subtest: busy-accuracy-50
[136.260564] Starting dynamic subtest: rcs0
[137.857798] Dynamic subtest rcs0: SUCCESS (1.600s)
[137.892482] Starting dynamic subtest: bcs0
[139.460508] Dynamic subtest bcs0: SUCCESS (1.599s)
[139.495119] Starting dynamic subtest: vcs0
[141.056474] Dynamic subtest vcs0: SUCCESS (1.592s)
[141.089977] Starting dynamic subtest: vcs1
[142.654339] Dynamic subtest vcs1: SUCCESS (1.594s)
[142.689131] Starting dynamic subtest: vecs0
[144.249408] Dynamic subtest vecs0: SUCCESS (1.591s)
[144.283740] Starting dynamic subtest: ccs0
[145.850931] Dynamic subtest ccs0: SUCCESS (1.598s)
[145.854815] Subtest busy-accuracy-50: SUCCESS (9.598s)
[146.066280] [027/141] (862s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[147.580705] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[147.584376] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.002s)
[148.494915] [028/141] (860s left) gem_linear_blits (interruptible)
[151.796317] Starting subtest: interruptible
[166.855506] Subtest interruptible: SUCCESS (15.059s)
[167.034463] [029/141] (841s left) v3d/v3d_create_bo (create-bo-zeroed)
[167.694975] Subtest create-bo-zeroed: SKIP (0.000s)
[167.836383] [030/141] (840s left) kms_big_fb (linear-32bpp-rotate-90)
[168.414367] Starting subtest: linear-32bpp-rotate-90
[168.475263] Subtest linear-32bpp-rotate-90: SKIP (0.057s)
[168.661882] [031/141] (840s left) kms_plane_scaling (planes-downscale-factor-0-25)
[169.138777] Starting subtest: planes-downscale-factor-0-25
[169.143454] Starting dynamic subtest: pipe-A-eDP-1
[169.233453] Dynamic subtest pipe-A-eDP-1: SKIP (0.084s)
[169.266395] Starting dynamic subtest: pipe-B-eDP-1
[169.394283] Dynamic subtest pipe-B-eDP-1: SKIP (0.150s)
[169.442595] Starting dynamic subtest: pipe-C-eDP-1
[169.525295] Dynamic subtest pipe-C-eDP-1: SKIP (0.126s)
[169.566058] Starting dynamic subtest: pipe-D-eDP-1
[169.657759] Dynamic subtest pipe-D-eDP-1: SKIP (0.124s)
[169.665759] Subtest planes-downscale-factor-0-25: SKIP (0.518s)
[169.816278] [032/141] (839s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[170.297512] Starting subtest: invalidate-primary-flip-overlay
[184.011673] Subtest invalidate-primary-flip-overlay: SUCCESS (13.716s)
[184.283159] [033/141] (824s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[184.802995] Starting subtest: psr-rgb565-draw-mmap-gtt
[184.809866] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[184.971709] [034/141] (824s left) prime_mmap_coherency (read)
[185.382712] Starting subtest: read
[190.781387] Subtest read: SUCCESS (5.398s)
[190.941315] [035/141] (818s left) perf (unprivileged-single-ctx-counters)
[191.812202] Starting subtest: unprivileged-single-ctx-counters
[191.818918] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[191.915639] [036/141] (817s left) gem_lmem_swapping (basic)
[192.305311] Subtest basic: SKIP (0.000s)
[192.427369] [037/141] (816s left) gem_pxp (create-protected-buffer)
[195.325447] Subtest create-protected-buffer: SKIP (0.000s)
[195.476630] [038/141] (813s left) kms_vblank (pipe-b-query-forked-busy)
[195.954453] Starting subtest: pipe-B-query-forked-busy
[199.525834] Subtest pipe-B-query-forked-busy: SUCCESS (3.570s)
[200.480446] [039/141] (808s left) syncobj_timeline (wait-all-complex)
[200.865343] Starting subtest: wait-all-complex
[201.083382] Subtest wait-all-complex: SUCCESS (0.218s)
[201.226315] [040/141] (808s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[201.632157] Starting subtest: yf-tiled-to-vebox-y-tiled
[201.638306] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[201.900653] [041/141] (807s left) kms_psr (sprite_plane_move)
[202.408647] Starting subtest: sprite_plane_move
[205.355942] Subtest sprite_plane_move: SUCCESS (2.947s)
[206.234921] [042/141] (803s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[207.054177] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[208.554495] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.501s)
[209.828951] [043/141] (799s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend)
[210.072733] Starting subtest: pipe-C-ts-continuation-dpms-suspend
[229.250146] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (19.177s)
[230.215550] [044/141] (779s left) kms_ccs (pipe-a-ccs-on-another-bo-yf_tiled_ccs)
[231.232162] Starting subtest: pipe-A-ccs-on-another-bo-yf_tiled_ccs
[231.239724] Subtest pipe-A-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[232.054560] [045/141] (777s left) kms_async_flips (alternate-sync-async-flip)
[232.525312] Starting subtest: alternate-sync-async-flip
[233.509392] Starting dynamic subtest: pipe-A-eDP-1
[235.360405] Dynamic subtest pipe-A-eDP-1: FAIL (1.258s)
[236.891973] Starting dynamic subtest: pipe-B-eDP-1
[239.302212] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s)
[240.331054] Starting dynamic subtest: pipe-C-eDP-1
[242.660777] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.354s)
[243.490734] Starting dynamic subtest: pipe-D-eDP-1
[245.884889] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.408s)
[245.887758] Subtest alternate-sync-async-flip: FAIL (13.364s)
[247.231116] [046/141] (762s left) gem_spin_batch (spin-all)
[247.670202] Starting subtest: spin-all
[247.745822] Subtest spin-all: SUCCESS (0.075s)
[249.653921] [047/141] (760s left) prime_busy (after-wait)
[250.047543] Starting subtest: after-wait
[250.079387] Starting dynamic subtest: rcs0
[250.114741] Dynamic subtest rcs0: SUCCESS (0.035s)
[250.169948] Starting dynamic subtest: bcs0
[250.181407] Dynamic subtest bcs0: SUCCESS (0.058s)
[250.232162] Starting dynamic subtest: vcs0
[250.235958] Dynamic subtest vcs0: SUCCESS (0.044s)
[250.281055] Starting dynamic subtest: vcs1
[250.284622] Dynamic subtest vcs1: SUCCESS (0.031s)
[250.332445] Starting dynamic subtest: vecs0
[250.336400] Dynamic subtest vecs0: SUCCESS (0.033s)
[250.379130] Starting dynamic subtest: ccs0
[250.382240] Dynamic subtest ccs0: SUCCESS (0.027s)
[250.460857] Subtest after-wait: SUCCESS (0.413s)
[250.642334] [048/141] (759s left) gem_exec_params (invalid-flag)
[251.039695] Starting subtest: invalid-flag
[251.044206] Subtest invalid-flag: SUCCESS (0.001s)
[251.240679] [049/141] (758s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[251.766300] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[251.772751] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[251.949905] [050/141] (758s left) v3d/v3d_submit_csd (bad-multisync-in-sync)
[252.423498] Subtest bad-multisync-in-sync: SKIP (0.000s)
[252.556623] [051/141] (757s left) gem_userptr_blits (unsync-unmap-after-close)
[252.957384] Subtest unsync-unmap-after-close: SKIP (0.000s)
[253.240182] [052/141] (757s left) perf (gen12-group-exclusive-stream-ctx-handle)
[253.880246] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[253.982589] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.100s)
[254.090357] [053/141] (756s left) gem_ctx_shared (disjoint-timelines)
[255.622654] Starting subtest: disjoint-timelines
[255.681790] Subtest disjoint-timelines: SUCCESS (0.059s)
[256.044754] [054/141] (754s left) gem_exec_balancer (hang)
[257.269139] Starting subtest: hang
[266.114454] Subtest hang: SUCCESS (8.846s)
[266.326534] [055/141] (744s left) gem_unref_active_buffers
[267.268801] [056/141] (743s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[267.786435] Starting subtest: fbcpsr-suspend
[310.623067] Subtest fbcpsr-suspend: SUCCESS (42.840s)
[310.908593] [057/141] (700s left) kms_addfb_basic (bo-too-small)
[311.393751] Starting subtest: bo-too-small
[311.397448] Subtest bo-too-small: SUCCESS (0.001s)
[311.584165] [058/141] (699s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[311.956534] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[312.065589] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[312.218886] [059/141] (698s left) kms_psr (psr2_basic)
[312.709198] Starting subtest: psr2_basic
[314.801961] Subtest psr2_basic: SUCCESS (2.081s)
[315.728187] [060/141] (695s left) fbdev (write)
[316.109983] Starting subtest: write
[319.803998] Subtest write: SUCCESS (3.692s)
[320.008310] [061/141] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[320.540583] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[326.354230] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (5.825s)
[326.637117] [062/141] (684s left) gem_caching (writes)
[327.026806] Subtest writes: SKIP (0.000s)
[327.149236] [063/141] (684s left) kms_content_protection (atomic)
[327.840461] Starting subtest: atomic
[331.970538] Subtest atomic: SKIP (4.123s)
[333.534200] [064/141] (678s left) gen3_render_mixed_blits
[334.013312] [065/141] (677s left) gem_exec_store (cachelines)
[334.437770] Starting subtest: cachelines
[334.441376] Starting dynamic subtest: rcs0
[334.541379] Dynamic subtest rcs0: SUCCESS (0.102s)
[334.594084] Starting dynamic subtest: bcs0
[334.635392] Dynamic subtest bcs0: SUCCESS (0.090s)
[334.686516] Starting dynamic subtest: vcs0
[336.522309] Dynamic subtest vcs0: SUCCESS (1.882s)
[336.572185] Starting dynamic subtest: vcs1
[338.570558] Dynamic subtest vcs1: SUCCESS (2.044s)
[338.616503] Starting dynamic subtest: vecs0
[340.556272] Dynamic subtest vecs0: SUCCESS (1.980s)
[340.603076] Starting dynamic subtest: ccs0
[340.647411] Dynamic subtest ccs0: SUCCESS (0.090s)
[340.650930] Subtest cachelines: SUCCESS (6.212s)
[340.958614] [066/141] (670s left) gem_ctx_persistence (legacy-engines-persistence)
[341.351592] Starting subtest: legacy-engines-persistence
[341.354938] Starting dynamic subtest: render
[342.120766] Dynamic subtest render: SUCCESS (0.766s)
[342.173847] Starting dynamic subtest: bsd1
[342.883312] Dynamic subtest bsd1: SUCCESS (0.758s)
[342.935910] Starting dynamic subtest: bsd2
[343.648709] Dynamic subtest bsd2: SUCCESS (0.760s)
[343.700649] Starting dynamic subtest: blt
[344.410802] Dynamic subtest blt: SUCCESS (0.757s)
[344.462547] Starting dynamic subtest: vebox
[345.190279] Dynamic subtest vebox: SUCCESS (0.776s)
[345.193833] Subtest legacy-engines-persistence: SUCCESS (3.841s)
[345.375568] [067/141] (666s left) kms_plane_alpha_blend (alpha-opaque-fb)
[345.890100] Starting subtest: alpha-opaque-fb
[347.635429] Starting dynamic subtest: pipe-A-eDP-1
[348.960413] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.321s)
[349.013169] Starting dynamic subtest: pipe-D-eDP-1
[351.023659] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.057s)
[351.027869] Subtest alpha-opaque-fb: SUCCESS (5.138s)
[351.979917] [068/141] (659s left) kms_flip (bo-too-big)
[352.373842] Starting subtest: bo-too-big
[352.404847] Starting dynamic subtest: A-eDP1
[354.946912] Dynamic subtest A-eDP1: SUCCESS (2.542s)
[354.993391] Starting dynamic subtest: B-eDP1
[357.389545] Dynamic subtest B-eDP1: SUCCESS (2.437s)
[357.444863] Starting dynamic subtest: C-eDP1
[359.711222] Dynamic subtest C-eDP1: SUCCESS (2.315s)
[359.757280] Starting dynamic subtest: D-eDP1
[362.000180] Dynamic subtest D-eDP1: SUCCESS (2.284s)
[362.026582] Subtest bo-too-big: SUCCESS (9.656s)
[363.602951] [069/141] (648s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[364.130869] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[367.903232] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (3.769s)
[368.453332] [070/141] (643s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs)
[369.761757] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs
[369.771335] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.004s)
[370.881672] [071/141] (641s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[371.412534] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[371.419607] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[371.572440] [072/141] (640s left) i915_pm_rc6_residency (rc6-fence)
[371.940093] Starting subtest: rc6-fence
[395.573579] Subtest rc6-fence: SUCCESS (23.634s)
[397.001296] [073/141] (615s left) kms_vblank (pipe-a-query-forked-busy-hang)
[397.488256] Starting subtest: pipe-A-query-forked-busy-hang
[411.861984] Subtest pipe-A-query-forked-busy-hang: SUCCESS (14.370s)
[412.815915] [074/141] (599s left) kms_vblank (pipe-a-accuracy-idle)
[413.289728] Starting subtest: pipe-A-accuracy-idle
[415.241874] Subtest pipe-A-accuracy-idle: SUCCESS (1.952s)
[416.198902] [075/141] (596s left) kms_getfb (getfb2-handle-zero)
[416.571078] Starting subtest: getfb2-handle-zero
[416.574844] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[416.755169] [076/141] (595s left) i915_pm_rps (engine-order)
[417.146749] Starting subtest: engine-order
[424.148718] Subtest engine-order: SUCCESS (7.002s)
[424.315845] [077/141] (588s left) debugfs_test (basic-hwmon)
[424.709964] Starting subtest: basic-hwmon
[424.717161] Subtest basic-hwmon: SKIP (0.000s)
[424.977888] [078/141] (587s left) syncobj_timeline (invalid-transfer-bad-pad)
[425.343587] Starting subtest: invalid-transfer-bad-pad
[425.347445] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[425.495754] [079/141] (587s left) kms_plane_lowres (tiling-y)
[425.999231] Starting subtest: tiling-y
[426.007951] Subtest tiling-y: SKIP (0.000s)
[426.151510] [080/141] (586s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[426.632876] Starting subtest: disable-primary-vs-flip-pipe-B
[429.967371] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (3.334s)
[430.895687] [081/141] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[431.434356] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[431.441366] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[431.608772] [082/141] (581s left) syncobj_basic (bad-flags-fd-to-handle)
[431.983751] Starting subtest: bad-flags-fd-to-handle
[431.987549] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[432.140188] [083/141] (581s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[432.651651] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[432.658189] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[432.815707] [084/141] (580s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[433.324162] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[433.331125] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[433.492482] [085/141] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[434.004729] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[434.011633] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[434.179749] [086/141] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[434.680817] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[447.384891] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (12.710s)
[447.677173] [087/141] (565s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[448.182987] Starting subtest: fbcpsr-badstride
[463.505332] Subtest fbcpsr-badstride: SUCCESS (15.328s)
[463.759869] [088/141] (549s left) vc4/vc4_perfmon (create-two-perfmon)
[464.230090] Subtest create-two-perfmon: SKIP (0.000s)
[464.366418] [089/141] (549s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[464.864492] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[469.447392] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.590s)
[469.712793] [090/141] (544s left) kms_vblank (pipe-c-ts-continuation-suspend)
[470.193155] Starting subtest: pipe-C-ts-continuation-suspend
[489.152411] Subtest pipe-C-ts-continuation-suspend: SUCCESS (18.956s)
[490.110757] [091/141] (523s left) kms_big_joiner (invalid-modeset)
[490.622572] Subtest invalid-modeset: SKIP (0.000s)
[490.751920] [092/141] (523s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[491.773735] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[491.778244] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SUCCESS (0.002s)
[493.157579] [093/141] (521s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[493.668102] Starting subtest: fbc-rgb101010-draw-blt
[499.101351] Subtest fbc-rgb101010-draw-blt: SUCCESS (5.439s)
[499.364758] [094/141] (514s left) gem_exec_fence (syncobj-invalid-wait)
[501.391499] Starting subtest: syncobj-invalid-wait
[501.395950] Subtest syncobj-invalid-wait: SUCCESS (0.002s)
[501.826855] [095/141] (512s left) kms_cursor_edge_walk (128x128-right-edge)
[502.333096] Starting subtest: 128x128-right-edge
[502.342320] Starting dynamic subtest: pipe-A-eDP-1
[506.215908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.872s)
[506.270590] Starting dynamic subtest: pipe-D-eDP-1
[509.676091] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.452s)
[509.679925] Subtest 128x128-right-edge: SUCCESS (7.346s)
[510.629045] [096/141] (503s left) kms_lease (invalid-create-leases)
[511.100901] Starting subtest: invalid-create-leases
[511.121814] Subtest invalid-create-leases: SUCCESS (0.017s)
[511.316407] [097/141] (503s left) gem_exec_params (readonly)
[511.703955] Starting subtest: readonly
[511.713187] Subtest readonly: SUCCESS (0.006s)
[511.894504] [098/141] (502s left) i915_pm_rpm (pm-tiling)
[517.990969] Starting subtest: pm-tiling
[518.001414] Subtest pm-tiling: SKIP (0.000s)
[518.940174] [099/141] (495s left) api_intel_allocator (two-level-inception)
[519.319154] Starting subtest: two-level-inception
[524.893367] Subtest two-level-inception: SUCCESS (5.578s)
[524.976706] [100/141] (489s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[525.545332] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[526.285171] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.743s)
[527.823831] [101/141] (487s left) perf (mi-rpc)
[528.429441] Starting subtest: mi-rpc
[528.437486] Subtest mi-rpc: SKIP (0.000s)
[528.538392] [102/141] (486s left) gem_exec_schedule (u-independent)
[528.964258] Starting subtest: u-independent
[528.968298] Starting dynamic subtest: rcs0
[530.516298] Dynamic subtest rcs0: SUCCESS (1.553s)
[530.567803] Starting dynamic subtest: bcs0
[532.564640] Dynamic subtest bcs0: SUCCESS (2.044s)
[532.612280] Starting dynamic subtest: vcs0
[534.587544] Dynamic subtest vcs0: SUCCESS (2.017s)
[534.635476] Starting dynamic subtest: vcs1
[536.573183] Dynamic subtest vcs1: SUCCESS (1.983s)
[536.625271] Starting dynamic subtest: vecs0
[538.550336] Dynamic subtest vecs0: SUCCESS (1.972s)
[538.599973] Starting dynamic subtest: ccs0
[540.566267] Dynamic subtest ccs0: SUCCESS (2.010s)
[540.570270] Subtest u-independent: SUCCESS (11.605s)
[541.037492] [103/141] (473s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs)
[542.397441] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs
[542.401226] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs: SUCCESS (0.001s)
[543.464559] [104/141] (471s left) kms_flip (nonblocking-read)
[543.857801] Starting subtest: nonblocking-read
[543.860993] Subtest nonblocking-read: SUCCESS (0.000s)
[544.066382] [105/141] (471s left) kms_atomic (plane-immutable-zpos)
[544.849407] Starting subtest: plane-immutable-zpos
[545.544219] Subtest plane-immutable-zpos: SUCCESS (0.694s)
[546.997414] [106/141] (468s left) i915_hangman (gt-error-state-capture)
[547.442377] Starting subtest: gt-error-state-capture
[547.446925] Starting dynamic subtest: rcs0
[558.541591] Dynamic subtest rcs0: SUCCESS (11.096s)
[558.597658] Starting dynamic subtest: bcs0
[570.508822] Dynamic subtest bcs0: SUCCESS (11.963s)
[570.560939] Starting dynamic subtest: vcs0
[576.523822] Dynamic subtest vcs0: SUCCESS (6.010s)
[576.579974] Starting dynamic subtest: vcs1
[582.539772] Dynamic subtest vcs1: SUCCESS (6.011s)
[582.595503] Starting dynamic subtest: vecs0
[588.556226] Dynamic subtest vecs0: SUCCESS (6.011s)
[588.613292] Starting dynamic subtest: ccs0
[600.523868] Dynamic subtest ccs0: SUCCESS (11.965s)
[600.528768] Subtest gt-error-state-capture: SUCCESS (53.085s)
[600.773195] [107/141] (414s left) gem_mmap_gtt (flink-race)
[601.146311] Subtest flink-race: SKIP (0.000s)
[601.286689] [108/141] (414s left) gem_mmap_wc (bad-size)
[601.661232] Subtest bad-size: SKIP (0.000s)
[601.800161] [109/141] (413s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[602.173570] Starting subtest: invalid-multi-wait-unsubmitted
[602.177365] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.001s)
[602.364252] [110/141] (413s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[602.866225] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[602.879334] Starting dynamic subtest: pipe-A-default-mode
[606.541182] Dynamic subtest pipe-A-default-mode: SUCCESS (3.663s)
[606.545111] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (3.680s)
[607.505341] [111/141] (408s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[607.995737] Starting subtest: primary-yf-tiled-reflect-x-90
[608.008281] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.007s)
[608.156989] [112/141] (407s left) gem_exec_balancer (parallel-keep-in-fence)
[609.382873] Starting subtest: parallel-keep-in-fence
[617.478205] Subtest parallel-keep-in-fence: SUCCESS (8.096s)
[617.684859] [113/141] (398s left) v3d/v3d_submit_cl (bad-multisync-extension)
[618.176994] Subtest bad-multisync-extension: SKIP (0.000s)
[618.331469] [114/141] (397s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[618.894949] Starting subtest: short-flip-after-cursor-toggle
[620.218686] Subtest short-flip-after-cursor-toggle: SUCCESS (1.323s)
[621.192309] [115/141] (394s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[621.690320] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[632.625374] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (10.939s)
[632.851838] [116/141] (383s left) gem_exec_flush (basic-wb-pro-default)
[633.179959] Starting subtest: basic-wb-pro-default
[638.998603] Subtest basic-wb-pro-default: SUCCESS (5.818s)
[639.324468] [117/141] (377s left) gem_ctx_isolation (clean)
[639.744911] Starting subtest: clean
[639.749775] Starting dynamic subtest: rcs0
[639.862627] Dynamic subtest rcs0: SUCCESS (0.116s)
[639.915219] Starting dynamic subtest: bcs0
[639.981149] Dynamic subtest bcs0: SUCCESS (0.114s)
[640.032943] Starting dynamic subtest: vcs0
[640.129110] Dynamic subtest vcs0: SUCCESS (0.143s)
[640.151317] Starting dynamic subtest: vcs1
[641.650093] Dynamic subtest vcs1: SUCCESS (1.519s)
[641.703182] Starting dynamic subtest: vecs0
[643.634385] Dynamic subtest vecs0: SUCCESS (1.981s)
[643.693750] Starting dynamic subtest: ccs0
[645.640393] Dynamic subtest ccs0: SUCCESS (2.001s)
[645.644753] Subtest clean: SUCCESS (5.898s)
[645.992351] [118/141] (370s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[646.416749] Starting subtest: basic-batch-kernel-default-cmd
[646.423271] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[646.734624] [119/141] (369s left) gem_create (create-ext-placement-all)
[647.255788] Starting subtest: create-ext-placement-all
[647.259591] Subtest create-ext-placement-all: SUCCESS (0.000s)
[647.468489] [120/141] (369s left) gem_exec_schedule (preempt-other-chain)
[647.902355] Starting subtest: preempt-other-chain
[647.905460] Starting dynamic subtest: rcs0
[648.475312] Dynamic subtest rcs0: SUCCESS (0.575s)
[648.533840] Starting dynamic subtest: bcs0
[649.059112] Dynamic subtest bcs0: SUCCESS (0.580s)
[649.111774] Starting dynamic subtest: vcs0
[649.619876] Dynamic subtest vcs0: SUCCESS (0.557s)
[649.671513] Starting dynamic subtest: vcs1
[650.165372] Dynamic subtest vcs1: SUCCESS (0.541s)
[650.219685] Starting dynamic subtest: vecs0
[650.772793] Dynamic subtest vecs0: SUCCESS (0.604s)
[650.825530] Starting dynamic subtest: ccs0
[651.349181] Dynamic subtest ccs0: SUCCESS (0.572s)
[651.354059] Subtest preempt-other-chain: SUCCESS (3.453s)
[651.819594] [121/141] (364s left) v3d/v3d_submit_csd (single-out-sync)
[652.317747] Subtest single-out-sync: SKIP (0.000s)
[652.467496] [122/141] (364s left) kms_universal_plane (universal-plane-pipe-d-functional)
[652.969410] Starting subtest: universal-plane-pipe-D-functional
[660.433655] Subtest universal-plane-pipe-D-functional: SUCCESS (7.463s)
[661.387146] [123/141] (355s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[661.895257] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[674.322172] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (12.431s)
[674.584868] [124/141] (342s left) gem_exec_fence (basic-wait-all)
[675.019832] Starting subtest: basic-wait-all
[675.096813] Subtest basic-wait-all: SUCCESS (0.080s)
[677.733952] [125/141] (339s left) kms_cdclk (mode-transition)
[678.225866] Starting subtest: mode-transition
[678.229765] Starting dynamic subtest: pipe-A-eDP-1
[678.632966] Dynamic subtest pipe-A-eDP-1: SKIP (0.402s)
[678.686367] Starting dynamic subtest: pipe-B-eDP-1
[678.693620] Dynamic subtest pipe-B-eDP-1: SKIP (0.028s)
[678.751230] Starting dynamic subtest: pipe-C-eDP-1
[678.758613] Dynamic subtest pipe-C-eDP-1: SKIP (0.028s)
[678.810759] Starting dynamic subtest: pipe-D-eDP-1
[678.817868] Dynamic subtest pipe-D-eDP-1: SKIP (0.028s)
[678.824970] Subtest mode-transition: SKIP (0.511s)
[679.575611] [126/141] (337s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[681.264259] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[681.270751] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[681.989423] [127/141] (335s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[683.596571] Starting subtest: pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs
[683.603617] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[684.403138] [128/141] (332s left) kms_plane_scaling (planes-scaler-unity-scaling)
[684.879439] Starting subtest: planes-scaler-unity-scaling
[684.883768] Starting dynamic subtest: pipe-A-eDP-1
[685.110717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.227s)
[685.170484] Starting dynamic subtest: pipe-B-eDP-1
[686.651302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s)
[686.711608] Starting dynamic subtest: pipe-C-eDP-1
[688.175189] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[688.236997] Starting dynamic subtest: pipe-D-eDP-1
[689.711180] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[689.715428] Subtest planes-scaler-unity-scaling: SUCCESS (4.839s)
[691.225470] [129/141] (326s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[691.601107] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[691.604745] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[691.762341] [130/141] (325s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs)
[693.406738] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs
[693.413637] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[694.175112] [131/141] (323s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[695.457133] Starting subtest: cursor-rapid-movement-max-size
[695.467515] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[695.724732] [132/141] (322s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[696.207272] Starting subtest: plane-use-after-nonblocking-unbind
[696.211157] Starting dynamic subtest: pipe-A-eDP-1
[696.462049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.251s)
[696.902622] Starting dynamic subtest: pipe-B-eDP-1
[697.828790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.976s)
[698.230380] Subtest plane-use-after-nonblocking-unbind: SUCCESS (2.027s)
[699.192226] [133/141] (318s left) syncobj_wait (reset-during-wait-for-submit)
[699.562946] Starting subtest: reset-during-wait-for-submit
[699.669521] Subtest reset-during-wait-for-submit: SUCCESS (0.106s)
[699.848822] [134/141] (318s left) gem_softpin (allocator-basic-reserve)
[700.242471] Starting subtest: allocator-basic-reserve
[700.763183] Subtest allocator-basic-reserve: SUCCESS (0.524s)
[700.995760] [135/141] (317s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs)
[702.337197] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs
[723.974987] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_mc_ccs: SUCCESS (21.638s)
[725.499876] [136/141] (292s left) gem_fenced_exec_thrash (too-many-fences)
[725.894074] Subtest too-many-fences: SKIP (0.000s)
[726.020387] [137/141] (292s left) gem_exec_reloc (basic-write-gtt-noreloc)
[726.421305] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[726.564635] [138/141] (291s left) gen9_exec_parse (basic-rejected)
[726.969279] Subtest basic-rejected: SKIP (0.000s)
[727.096214] [139/141] (291s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[727.649928] Starting subtest: x-tiled-8bpp-rotate-0
[731.877663] Subtest x-tiled-8bpp-rotate-0: SUCCESS (4.228s)
[732.227911] [140/141] (286s left) gem_exec_reloc (basic-gtt-active)
[732.623833] Subtest basic-gtt-active: SKIP (0.000s)
[732.763221] [141/141] (285s left) kms_chamelium_hpd (hdmi-hpd)
[733.638453] Subtest hdmi-hpd: SKIP (0.000s)
[734.506436] Closing watchdogs
Done.