[41.029730] Initializing watchdogs
[41.029979]   /dev/watchdog0
[41.046459] [001/141] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[41.380758] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[41.382127] Starting dynamic subtest: pipe-A-valid-mode
[42.141883] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.757s)
[42.143386] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SUCCESS (0.760s)
[42.465831] [002/141] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[42.777914] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[45.416090] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (2.638s)
[45.563959] [003/141] (956s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[46.048681] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[46.584812] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.527s)
[47.258589] [004/141] (954s left) gem_exec_params (larger-than-life-batch)
[47.489117] Starting subtest: larger-than-life-batch
[48.660860] Subtest larger-than-life-batch: SKIP (1.155s)
[48.768973] [005/141] (952s left) gem_exec_flush (basic-wb-ro-default)
[49.125519] Starting subtest: basic-wb-ro-default
[54.605667] Subtest basic-wb-ro-default: SUCCESS (5.480s)
[54.808800] [006/141] (946s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[55.315677] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[55.318373] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[55.849083] [007/141] (945s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[56.151394] Starting subtest: cursorB-vs-flipB-legacy
[56.157730] Subtest cursorB-vs-flipB-legacy: SKIP (0.003s)
[56.235759] [008/141] (945s left) syncobj_wait (single-wait-for-submit-signaled)
[56.456983] Starting subtest: single-wait-for-submit-signaled
[56.458803] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[56.534329] [009/141] (945s left) sysfs_preempt_timeout (timeout)
[56.750429] Starting subtest: timeout
[56.752362] Starting dynamic subtest: vecs0
[57.644630] Dynamic subtest vecs0: SUCCESS (0.892s)
[57.664789] Starting dynamic subtest: vcs0
[58.527264] Dynamic subtest vcs0: SUCCESS (0.880s)
[58.542538] Starting dynamic subtest: bcs0
[59.405272] Dynamic subtest bcs0: SUCCESS (0.877s)
[59.425940] Starting dynamic subtest: rcs0
[60.313927] Dynamic subtest rcs0: SUCCESS (0.908s)
[60.315180] Subtest timeout: SUCCESS (3.561s)
[60.397814] [010/141] (941s left) testdisplay
[84.202636] [011/141] (917s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[84.781901] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[84.783494] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.002s)
[85.253632] [012/141] (916s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[85.457545] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[85.459511] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[85.536512] [013/141] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[85.854821] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[88.783734] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.931s)
[88.920985] [014/141] (913s left) tools_test (sysfs_l3_parity)
[89.127849] Starting subtest: sysfs_l3_parity
[89.386610] Subtest sysfs_l3_parity: SKIP (0.265s)
[89.454561] [015/141] (912s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[89.776467] Starting subtest: x-tiled-32bpp-rotate-0
[94.651635] Subtest x-tiled-32bpp-rotate-0: SUCCESS (4.874s)
[95.171872] [016/141] (906s left) gem_ctx_param (vm)
[95.372186] Starting subtest: vm
[95.437346] Subtest vm: SUCCESS (0.065s)
[95.719032] [017/141] (906s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[95.914535] Subtest overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[95.968251] [018/141] (906s left) gem_exec_reloc (basic-write-gtt)
[96.177927] Starting subtest: basic-write-gtt
[96.197132] Subtest basic-write-gtt: SUCCESS (0.019s)
[96.370588] [019/141] (905s left) kms_cursor_legacy (single-move)
[96.665903] Starting subtest: single-move
[96.667441] Starting dynamic subtest: pipe-A
[118.198955] Dynamic subtest pipe-A: SUCCESS (21.533s)
[118.214396] Starting dynamic subtest: pipe-B
[139.712471] Dynamic subtest pipe-B: SUCCESS (21.511s)
[139.727458] Starting dynamic subtest: pipe-C
[161.223344] Dynamic subtest pipe-C: SUCCESS (21.511s)
[161.239429] Starting dynamic subtest: all-pipes
[182.742132] Dynamic subtest all-pipes: SUCCESS (21.517s)
[182.743795] Subtest single-move: SUCCESS (86.077s)
[182.820377] [020/141] (819s left) kms_psr (primary_blt)
[183.022220] Subtest primary_blt: SKIP (0.000s)
[183.071242] [021/141] (819s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[183.386326] Starting subtest: 4-tiled-32bpp-rotate-90
[183.389253] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[183.488810] [022/141] (818s left) syncobj_timeline (32bits-limit)
[183.693154] Starting subtest: 32bits-limit
[183.694689] Subtest 32bits-limit: SUCCESS (0.003s)
[183.770764] [023/141] (818s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_rc_ccs)
[184.168635] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs
[184.171274] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[184.797898] [024/141] (817s left) gem_ccs (block-copy-compressed)
[185.007851] Subtest block-copy-compressed: SKIP (0.000s)
[185.061653] [025/141] (817s left) kms_big_fb (y-tiled-addfb-size-overflow)
[185.383266] Starting subtest: y-tiled-addfb-size-overflow
[185.385073] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.002s)
[185.479270] [026/141] (816s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[185.784297] Starting subtest: fbc-rgb565-draw-mmap-cpu
[187.941510] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.159s)
[188.061637] [027/141] (814s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[188.389724] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[189.609070] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.218s)
[189.929594] [028/141] (812s left) api_intel_bb (destroy-bb)
[190.131859] Starting subtest: destroy-bb
[190.156356] Subtest destroy-bb: SUCCESS (0.024s)
[190.261721] [029/141] (812s left) v3d/v3d_perfmon (create-perfmon-invalid-counters)
[190.528513] Subtest create-perfmon-invalid-counters: SKIP (0.000s)
[190.594389] [030/141] (811s left) gem_mmap_gtt (big-copy-xy)
[190.796493] Starting subtest: big-copy-XY
[203.127901] Subtest big-copy-XY: SUCCESS (12.332s)
[203.279306] [031/141] (799s left) gem_exec_fence (syncobj-timeline-export)
[204.300182] Starting subtest: syncobj-timeline-export
[204.307301] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[204.531490] [032/141] (798s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[204.752656] Starting subtest: y-tiled-ccs-to-yf-tiled
[204.754188] Starting dynamic subtest: smem
[205.153159] Dynamic subtest smem: SUCCESS (0.399s)
[205.155923] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.401s)
[205.349175] [033/141] (797s left) kms_universal_plane (cursor-fb-leak-pipe-d)
[205.659510] Subtest cursor-fb-leak-pipe-D: SKIP (0.000s)
[205.749249] [034/141] (796s left) gem_exec_params (invalid-bsd1-flag-on-render)
[205.960346] Starting subtest: invalid-bsd1-flag-on-render
[205.962169] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.001s)
[206.063802] [035/141] (796s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[206.778784] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[207.078723] [036/141] (795s left) gem_mmap_offset (pf-nonblock)
[207.280813] Starting subtest: pf-nonblock
[207.292828] Subtest pf-nonblock: SUCCESS (0.013s)
[207.394859] [037/141] (795s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[207.613479] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[207.616076] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[207.812432] [038/141] (795s left) i915_query (query-topology-garbage-items)
[208.025536] Starting subtest: query-topology-garbage-items
[208.027454] Subtest query-topology-garbage-items: SUCCESS (0.001s)
[208.112114] [039/141] (794s left) gem_mmap_gtt (basic-small-bo-tiledy)
[208.312409] Starting subtest: basic-small-bo-tiledY
[208.836695] Subtest basic-small-bo-tiledY: SUCCESS (0.525s)
[208.988981] [040/141] (793s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[209.328892] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[209.436169] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[209.528756] [041/141] (793s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[209.842287] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[209.847506] Starting dynamic subtest: pipe-A-valid-mode
[210.530408] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.683s)
[210.534686] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SUCCESS (0.687s)
[210.872678] [042/141] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[211.192714] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[211.195265] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[211.288352] [043/141] (791s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[211.592064] Starting subtest: 2x-long-cursor-vs-flip-atomic
[211.597590] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.006s)
[211.688946] [044/141] (791s left) kms_lease (lease_unleased_crtc)
[211.998113] Starting subtest: lease_unleased_crtc
[212.003148] Starting dynamic subtest: pipe-A-DP-1
[212.186263] Dynamic subtest pipe-A-DP-1: SUCCESS (0.184s)
[212.211516] Starting dynamic subtest: pipe-B-DP-1
[212.303875] Dynamic subtest pipe-B-DP-1: SUCCESS (0.111s)
[212.328985] Starting dynamic subtest: pipe-C-DP-1
[212.412407] Dynamic subtest pipe-C-DP-1: SUCCESS (0.098s)
[212.415212] Subtest lease_unleased_crtc: SUCCESS (0.410s)
[212.723911] [045/141] (790s left) kms_sequence (get-forked)
[213.029499] Starting subtest: get-forked
[213.034817] Starting dynamic subtest: DP-1-pipe-A
[215.382715] Dynamic subtest DP-1-pipe-A: SUCCESS (2.348s)
[215.401662] Starting dynamic subtest: DP-1-pipe-B
[218.028866] Dynamic subtest DP-1-pipe-B: SUCCESS (2.643s)
[218.048195] Starting dynamic subtest: DP-1-pipe-C
[220.809787] Dynamic subtest DP-1-pipe-C: SUCCESS (2.776s)
[220.811315] Subtest get-forked: SUCCESS (7.780s)
[221.118453] [046/141] (782s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[221.512574] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[221.778398] [047/141] (781s left) gem_ctx_persistence (legacy-engines-queued)
[221.989830] Starting subtest: legacy-engines-queued
[221.991951] Starting dynamic subtest: render
[222.043655] Dynamic subtest render: SUCCESS (0.052s)
[222.061141] Starting dynamic subtest: bsd
[222.105166] Dynamic subtest bsd: SUCCESS (0.060s)
[222.125741] Starting dynamic subtest: blt
[222.253562] Dynamic subtest blt: SUCCESS (0.147s)
[222.274044] Starting dynamic subtest: vebox
[222.312582] Dynamic subtest vebox: SUCCESS (0.057s)
[222.314071] Subtest legacy-engines-queued: SUCCESS (0.323s)
[222.406937] [048/141] (780s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done)
[222.670738] Subtest poll-write-waits-until-write-done: SKIP (0.000s)
[222.740469] [049/141] (780s left) gem_exec_balancer (fairslice)
[222.973530] Starting subtest: fairslice
[222.976111] Subtest fairslice: SKIP (0.000s)
[226.856133] [050/141] (776s left) kms_vblank (pipe-d-wait-forked-busy)
[227.159278] Subtest pipe-D-wait-forked-busy: SKIP (0.000s)
[227.240685] [051/141] (776s left) gen9_exec_parse (allowed-single)
[227.467255] Starting subtest: allowed-single
[227.477405] Subtest allowed-single: SUCCESS (0.010s)
[227.706355] [052/141] (775s left) gem_spin_batch (legacy)
[227.933917] Starting subtest: legacy
[227.935614] Starting dynamic subtest: default
[231.260676] Dynamic subtest default: SUCCESS (3.322s)
[231.280026] Starting dynamic subtest: render
[234.584955] Dynamic subtest render: SUCCESS (3.322s)
[234.601555] Starting dynamic subtest: bsd
[237.907513] Dynamic subtest bsd: SUCCESS (3.320s)
[237.923730] Starting dynamic subtest: bsd1
[241.227588] Dynamic subtest bsd1: SUCCESS (3.319s)
[241.244156] Starting dynamic subtest: blt
[244.552559] Dynamic subtest blt: SUCCESS (3.322s)
[244.569221] Starting dynamic subtest: vebox
[247.875072] Dynamic subtest vebox: SUCCESS (3.321s)
[247.876538] Subtest legacy: SUCCESS (19.939s)
[248.075619] [053/141] (755s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[248.553410] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[248.559819] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[249.111991] [054/141] (754s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[249.424498] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[249.427130] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[249.512342] [055/141] (753s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[249.816678] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[250.607070] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.793s)
[250.916979] [056/141] (752s left) gem_ctx_param (invalid-set-ringsize)
[251.122044] Starting subtest: invalid-set-ringsize
[251.123660] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[251.199808] [057/141] (752s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[251.744346] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[251.748733] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[252.267664] [058/141] (751s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[252.570055] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[254.862503] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.295s)
[255.001506] [059/141] (748s left) gem_eio (wait-1us)
[255.233330] Starting subtest: wait-1us
[255.327202] Subtest wait-1us: SUCCESS (0.090s)
[255.500847] [060/141] (748s left) kms_chamelium_color (gamma)
[255.795737] Subtest gamma: SKIP (0.000s)
[255.851479] [061/141] (747s left) kms_vblank (crtc-id)
[256.147308] Starting subtest: crtc-id
[256.444408] Subtest crtc-id: SUCCESS (0.298s)
[256.773574] [062/141] (746s left) kms_frontbuffer_tracking (basic)
[257.088210] Starting subtest: basic
[259.936347] Subtest basic: SUCCESS (2.851s)
[260.057214] [063/141] (743s left) drm_fdinfo (virtual-busy-all)
[260.264786] Starting subtest: virtual-busy-all
[260.266715] Subtest virtual-busy-all: SUCCESS (0.001s)
[260.357571] [064/141] (743s left) kms_plane_scaling (plane-upscale-with-pixel-format-20x20)
[260.654943] Starting subtest: plane-upscale-with-pixel-format-20x20
[260.656419] Starting dynamic subtest: pipe-A-DP-1
[261.150076] Dynamic subtest pipe-A-DP-1: SUCCESS (0.494s)
[261.171373] Starting dynamic subtest: pipe-B-DP-1
[261.956658] Dynamic subtest pipe-B-DP-1: SUCCESS (0.801s)
[261.981959] Starting dynamic subtest: pipe-C-DP-1
[262.315992] Dynamic subtest pipe-C-DP-1: SUCCESS (0.355s)
[262.317640] Subtest plane-upscale-with-pixel-format-20x20: SUCCESS (1.665s)
[262.700611] [065/141] (741s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[263.364681] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[263.367578] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[263.724967] [066/141] (740s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[263.927351] Starting subtest: multi-wait-for-submit-available-submitted
[263.931345] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[264.030374] [067/141] (739s left) kms_universal_plane (universal-plane-pipe-b-functional)
[264.332975] Starting subtest: universal-plane-pipe-B-functional
[267.217493] Subtest universal-plane-pipe-B-functional: SUCCESS (2.888s)
[267.529755] [068/141] (736s left) kms_busy (extended-pageflip-hang-oldfb)
[267.840196] Starting subtest: extended-pageflip-hang-oldfb
[267.841694] Starting dynamic subtest: pipe-A
[268.384749] Dynamic subtest pipe-A: SUCCESS (0.543s)
[268.410518] Starting dynamic subtest: pipe-C
[268.871608] Dynamic subtest pipe-C: SUCCESS (0.476s)
[268.873308] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.033s)
[269.197164] [069/141] (734s left) kms_cursor_crc (cursor-suspend)
[269.500784] Starting subtest: cursor-suspend
[269.504407] Starting dynamic subtest: pipe-A-DP-1
[306.206263] Dynamic subtest pipe-A-DP-1: SUCCESS (3.511s)
[306.246159] Starting dynamic subtest: pipe-C-DP-1
[343.046061] Dynamic subtest pipe-C-DP-1: SUCCESS (3.519s)
[343.050556] Subtest cursor-suspend: SUCCESS (7.042s)
[348.428374] [070/141] (727s left) kms_psr (psr2_suspend)
[348.641986] Subtest psr2_suspend: SKIP (0.000s)
[348.701538] [071/141] (726s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[349.007959] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[349.010994] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[349.118359] [072/141] (726s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[349.423022] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[349.425700] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[349.517095] [073/141] (726s left) kms_vblank (pipe-b-query-forked)
[349.809200] Starting subtest: pipe-B-query-forked
[352.561097] Subtest pipe-B-query-forked: SUCCESS (2.755s)
[352.884121] [074/141] (722s left) gem_ctx_param (set-priority-not-supported)
[353.084570] Starting subtest: set-priority-not-supported
[353.087657] Subtest set-priority-not-supported: SKIP (0.000s)
[353.184339] [075/141] (722s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[353.898394] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[354.210824] [076/141] (721s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[354.755484] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[354.758432] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[355.262672] [077/141] (720s left) gem_pread (display)
[355.462714] Starting subtest: display
[359.766139] Subtest display: SUCCESS (4.301s)
[359.862685] [078/141] (716s left) perf_pmu (busy-double-start)
[360.073971] Starting subtest: busy-double-start
[360.075794] Starting dynamic subtest: rcs0
[363.617151] Dynamic subtest rcs0: SUCCESS (3.542s)
[363.644650] Starting dynamic subtest: bcs0
[367.163964] Dynamic subtest bcs0: SUCCESS (3.545s)
[367.189360] Starting dynamic subtest: vcs0
[370.707146] Dynamic subtest vcs0: SUCCESS (3.540s)
[370.733389] Starting dynamic subtest: vecs0
[374.262166] Dynamic subtest vecs0: SUCCESS (3.551s)
[374.264292] Subtest busy-double-start: SUCCESS (14.190s)
[374.361942] [079/141] (701s left) gem_exec_schedule (pi-common)
[374.729507] Starting subtest: pi-common
[374.730999] Starting dynamic subtest: rcs0
[374.821028] Dynamic subtest rcs0: SUCCESS (0.091s)
[374.849032] Starting dynamic subtest: bcs0
[374.913427] Dynamic subtest bcs0: SUCCESS (0.090s)
[374.939512] Starting dynamic subtest: vcs0
[375.005850] Dynamic subtest vcs0: SUCCESS (0.090s)
[375.032389] Starting dynamic subtest: vecs0
[375.100543] Dynamic subtest vecs0: SUCCESS (0.092s)
[375.101849] Subtest pi-common: SUCCESS (0.373s)
[375.310203] [080/141] (700s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[375.615908] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[375.618589] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[375.714179] [081/141] (700s left) syncobj_basic (test-valid-cycle)
[375.915080] Starting subtest: test-valid-cycle
[375.916504] Subtest test-valid-cycle: SUCCESS (0.000s)
[376.013427] [082/141] (700s left) perf (unprivileged-single-ctx-counters)
[376.357536] Starting subtest: unprivileged-single-ctx-counters
[376.360174] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[376.412090] [083/141] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[376.720990] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[376.723812] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[376.830458] [084/141] (699s left) v3d/v3d_submit_csd (job-perfmon)
[377.087204] Subtest job-perfmon: SKIP (0.000s)
[377.162438] [085/141] (699s left) i915_pm_backlight (bad-brightness)
[377.463474] Subtest bad-brightness: SKIP (0.000s)
[377.513375] [086/141] (698s left) i915_suspend (fence-restore-untiled)
[377.712099] Starting subtest: fence-restore-untiled
[398.398020] Subtest fence-restore-untiled: SUCCESS (3.931s)
[401.533546] [087/141] (694s left) gem_exercise_blt (fast-copy)
[401.746996] Starting subtest: fast-copy
[401.748430] Starting dynamic subtest: linear-smem-smem
[401.808993] Dynamic subtest linear-smem-smem: SUCCESS (0.060s)
[401.835920] Starting dynamic subtest: ymajor-smem-smem
[401.863441] Dynamic subtest ymajor-smem-smem: SUCCESS (0.052s)
[401.890529] Starting dynamic subtest: yfmajor-smem-smem
[401.916371] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.050s)
[401.943275] Starting dynamic subtest: tile64-smem-smem
[401.968861] Dynamic subtest tile64-smem-smem: SUCCESS (0.050s)
[401.970462] Subtest fast-copy: SUCCESS (0.223s)
[402.093328] [088/141] (693s left) gem_media_vme
[402.359659] [089/141] (693s left) kms_plane (plane-position-covered)
[402.656121] Starting subtest: plane-position-covered
[402.657640] Starting dynamic subtest: pipe-A-planes
[404.139083] Dynamic subtest pipe-A-planes: SUCCESS (1.483s)
[404.170293] Starting dynamic subtest: pipe-B-planes
[405.921047] Dynamic subtest pipe-B-planes: SUCCESS (1.773s)
[405.922456] Subtest plane-position-covered: SUCCESS (3.269s)
[406.263058] [090/141] (689s left) perf_pmu (rc6-suspend)
[406.473893] Starting subtest: rc6-suspend
[430.924285] Subtest rc6-suspend: SUCCESS (8.433s)
[432.021973] [091/141] (681s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[432.752941] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[433.070791] [092/141] (680s left) kms_frontbuffer_tracking (psr-1p-rte)
[433.388456] Starting subtest: psr-1p-rte
[433.391566] Subtest psr-1p-rte: SKIP (0.000s)
[433.488695] [093/141] (679s left) vc4/vc4_perfmon (create-single-perfmon)
[433.744060] Subtest create-single-perfmon: SKIP (0.000s)
[433.821628] [094/141] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[434.133677] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[434.136433] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[434.237600] [095/141] (679s left) kms_cursor_crc (cursor-alpha-transparent)
[434.538822] Starting subtest: cursor-alpha-transparent
[434.543142] Starting dynamic subtest: pipe-A-DP-1
[435.091728] Dynamic subtest pipe-A-DP-1: SUCCESS (0.548s)
[435.125406] Starting dynamic subtest: pipe-C-DP-1
[435.909956] Dynamic subtest pipe-C-DP-1: SUCCESS (0.811s)
[435.911413] Subtest cursor-alpha-transparent: SUCCESS (1.373s)
[436.272758] [096/141] (677s left) kms_vblank (pipe-a-query-idle-hang)
[436.577429] Starting subtest: pipe-A-query-idle-hang
[443.239827] Subtest pipe-A-query-idle-hang: SUCCESS (6.662s)
[443.591658] [097/141] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[443.901342] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[443.904366] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[444.008062] [098/141] (669s left) i915_pm_dc (dc9-dpms)
[445.316709] Starting subtest: dc9-dpms
[448.336186] Subtest dc9-dpms: SUCCESS (3.017s)
[448.532388] [099/141] (665s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[448.852870] Starting subtest: 4-tiled-addfb-size-offset-overflow
[448.856107] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[448.968462] [100/141] (664s left) kms_cursor_crc (cursor-random-256x256)
[449.276118] Starting subtest: cursor-random-256x256
[449.289245] Starting dynamic subtest: pipe-A-DP-1
[453.090710] Dynamic subtest pipe-A-DP-1: SUCCESS (3.797s)
[453.170650] Starting dynamic subtest: pipe-C-DP-1
[457.269158] Dynamic subtest pipe-C-DP-1: SUCCESS (4.120s)
[457.270815] Subtest cursor-random-256x256: SUCCESS (7.993s)
[457.636219] [101/141] (656s left) i915_pm_rpm (modeset-stress-extra-wait)
[459.422846] Starting subtest: modeset-stress-extra-wait
[512.471340] Subtest modeset-stress-extra-wait: SUCCESS (53.047s)
[512.675570] [102/141] (601s left) syncobj_basic (bad-destroy-pad)
[512.879817] Starting subtest: bad-destroy-pad
[512.881426] Subtest bad-destroy-pad: SUCCESS (0.000s)
[512.974296] [103/141] (600s left) api_intel_bb (offset-control)
[513.179889] Starting subtest: offset-control
[513.193930] Subtest offset-control: SUCCESS (0.017s)
[513.307986] [104/141] (600s left) kms_vblank (pipe-c-query-busy)
[513.615938] Starting subtest: pipe-C-query-busy
[516.565576] Subtest pipe-C-query-busy: SUCCESS (2.950s)
[516.904982] [105/141] (596s left) sw_sync (sync_multi_consumer)
[517.106117] Starting subtest: sync_multi_consumer
[518.251992] Subtest sync_multi_consumer: SUCCESS (1.145s)
[518.320784] [106/141] (595s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[518.616168] Starting subtest: 2x-long-flip-vs-cursor-atomic
[518.621660] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.005s)
[518.721132] [107/141] (595s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[519.322861] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[519.325682] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[519.747388] [108/141] (594s left) kms_plane_scaling (planes-downscale-factor-0-25)
[520.052926] Starting subtest: planes-downscale-factor-0-25
[520.057155] Starting dynamic subtest: pipe-A-DP-1
[520.087673] Dynamic subtest pipe-A-DP-1: SKIP (0.030s)
[520.114855] Starting dynamic subtest: pipe-B-DP-1
[520.167546] Dynamic subtest pipe-B-DP-1: SKIP (0.073s)
[520.194115] Starting dynamic subtest: pipe-C-DP-1
[520.244465] Dynamic subtest pipe-C-DP-1: SKIP (0.072s)
[520.247116] Subtest planes-downscale-factor-0-25: SKIP (0.194s)
[520.347155] [109/141] (593s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[520.665906] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[522.051186] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.386s)
[522.215677] [110/141] (591s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[522.525475] Starting subtest: fbcpsr-tiling-y
[522.528202] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[522.630840] [111/141] (591s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[522.947462] Starting subtest: psr-rgb565-draw-pwrite
[522.950556] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[523.064585] [112/141] (591s left) gem_tiled_wb
[547.362676] [113/141] (566s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[547.665338] Starting subtest: nonblocking-crc-frame-sequence
[547.667076] Starting dynamic subtest: pipe-A-DP-1
[548.282867] Dynamic subtest pipe-A-DP-1: SUCCESS (0.615s)
[548.312045] Starting dynamic subtest: pipe-B-DP-1
[549.162002] Dynamic subtest pipe-B-DP-1: SUCCESS (0.871s)
[549.190848] Starting dynamic subtest: pipe-C-DP-1
[550.189879] Dynamic subtest pipe-C-DP-1: SUCCESS (1.020s)
[550.191794] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.527s)
[550.519909] [114/141] (563s left) gem_mmap_gtt (basic-write-gtt)
[550.725176] Starting subtest: basic-write-gtt
[551.474586] Subtest basic-write-gtt: SUCCESS (0.748s)
[551.585944] [115/141] (562s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[551.891910] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[551.894759] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[552.003381] [116/141] (562s left) i915_getparams_basic (basic-eu-total)
[552.204919] Starting subtest: basic-eu-total
[552.208376] Subtest basic-eu-total: SUCCESS (0.000s)
[552.304204] [117/141] (562s left) syncobj_timeline (single-wait-signaled)
[552.506459] Starting subtest: single-wait-signaled
[552.508182] Subtest single-wait-signaled: SUCCESS (0.001s)
[552.603023] [118/141] (561s left) syncobj_timeline (invalid-transfer-non-existent-point)
[552.808163] Starting subtest: invalid-transfer-non-existent-point
[552.810128] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[552.903145] [119/141] (561s left) kms_vblank (pipe-c-query-forked-busy-hang)
[553.206946] Starting subtest: pipe-C-query-forked-busy-hang
[560.232838] Subtest pipe-C-query-forked-busy-hang: SUCCESS (7.028s)
[560.569916] [120/141] (553s left) gem_exec_whisper (basic-forked-all)
[560.799192] Starting subtest: basic-forked-all
[582.912168] Subtest basic-forked-all: SUCCESS (22.111s)
[583.118158] [121/141] (531s left) kms_atomic_transition (plane-toggle-modeset-transition)
[583.417116] Starting subtest: plane-toggle-modeset-transition
[583.418590] Starting dynamic subtest: pipe-A-DP-1
[588.660233] Dynamic subtest pipe-A-DP-1: SUCCESS (5.240s)
[588.696762] Starting dynamic subtest: pipe-B-DP-1
[594.022320] Dynamic subtest pipe-B-DP-1: SUCCESS (5.349s)
[594.030348] Subtest plane-toggle-modeset-transition: SUCCESS (10.613s)
[594.368817] [122/141] (520s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[594.674757] Starting subtest: universal-plane-pipe-B-sanity
[595.497285] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.824s)
[595.819446] [123/141] (518s left) kms_flip (2x-flip-vs-suspend)
[596.105406] Starting subtest: 2x-flip-vs-suspend
[596.107967] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[596.219950] [124/141] (518s left) gem_userptr_blits (access-control)
[596.497038] Starting subtest: access-control
[596.500206] Subtest access-control: SKIP (0.000s)
[596.620905] [125/141] (518s left) drm_read (empty-block)
[597.044079] Starting subtest: empty-block
[598.043725] Subtest empty-block: SUCCESS (1.000s)
[598.170849] [126/141] (516s left) gem_exec_balancer (invalid-bonds)
[598.396103] Starting subtest: invalid-bonds
[598.410108] Subtest invalid-bonds: SUCCESS (0.015s)
[602.321448] [127/141] (512s left) gem_userptr_blits (sync-overlap)
[602.560190] Starting subtest: sync-overlap
[602.561763] Subtest sync-overlap: SUCCESS (0.001s)
[602.703778] [128/141] (512s left) vgem_basic (dmabuf-export)
[602.908453] Starting subtest: dmabuf-export
[602.929159] Subtest dmabuf-export: SUCCESS (0.020s)
[603.036000] [129/141] (511s left) gem_pxp (hw-rejects-pxp-context)
[605.754437] Starting subtest: hw-rejects-pxp-context
[605.756329] Subtest hw-rejects-pxp-context: SUCCESS (0.000s)
[605.852735] [130/141] (509s left) gen3_render_tiledx_blits
[606.119473] [131/141] (508s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[606.757938] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[606.763507] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[607.184328] [132/141] (507s left) gem_eio (wait-wedge-1us)
[607.406427] Starting subtest: wait-wedge-1us
[607.475965] Subtest wait-wedge-1us: SUCCESS (0.071s)
[607.649476] [133/141] (507s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[607.962963] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[607.965990] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[608.067572] [134/141] (507s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[608.474366] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[608.771197] [135/141] (506s left) kms_chamelium_audio (dp-audio-edid)
[609.174935] Subtest dp-audio-edid: SKIP (0.000s)
[609.469436] [136/141] (505s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[609.788674] Starting subtest: y-tiled-16bpp-rotate-180
[613.633819] Subtest y-tiled-16bpp-rotate-180: SUCCESS (3.847s)
[613.965801] [137/141] (501s left) gem_bad_reloc (negative-reloc)
[614.179953] Starting subtest: negative-reloc
[614.188795] Subtest negative-reloc: SUCCESS (0.002s)
[614.464077] [138/141] (500s left) gem_exec_fair (basic-none-vip)
[614.693335] Starting subtest: basic-none-vip
[614.695092] Starting dynamic subtest: rcs0
[620.596868] Dynamic subtest rcs0: SUCCESS (5.900s)
[620.598234] Subtest basic-none-vip: SUCCESS (5.903s)
[620.798025] [139/141] (494s left) kms_properties (connector-properties-atomic)
[621.103297] Starting subtest: connector-properties-atomic
[621.537304] Subtest connector-properties-atomic: SUCCESS (0.436s)
[621.876197] [140/141] (493s left) gem_exec_schedule (u-independent)
[622.109072] Starting subtest: u-independent
[622.110609] Starting dynamic subtest: rcs0
[622.298109] Dynamic subtest rcs0: SUCCESS (0.188s)
[622.331413] Starting dynamic subtest: bcs0
[622.494898] Dynamic subtest bcs0: SUCCESS (0.194s)
[622.524233] Starting dynamic subtest: vcs0
[622.663950] Dynamic subtest vcs0: SUCCESS (0.166s)
[622.705639] Starting dynamic subtest: vecs0
[622.850653] Dynamic subtest vecs0: SUCCESS (0.183s)
[622.851934] Subtest u-independent: SUCCESS (0.744s)
[623.191828] [141/141] (492s left) gem_render_copy (y-tiled)
[623.413201] Starting subtest: y-tiled
[623.417845] Starting dynamic subtest: smem
[623.700909] Dynamic subtest smem: SUCCESS (0.285s)
[623.702859] Subtest y-tiled: SUCCESS (0.288s)
[623.905309] Closing watchdogs
Done.