[43.266921] Initializing watchdogs
[43.266966]   /dev/watchdog0
[43.273167] [001/142] (960s left) kms_busy (basic-hang)
[43.368777] Starting subtest: basic-hang
[43.371464] Starting dynamic subtest: flip-pipe-A
[44.163173] Dynamic subtest flip-pipe-A: SUCCESS (0.793s)
[44.173180] Starting dynamic subtest: modeset-pipe-A
[47.917690] Dynamic subtest modeset-pipe-A: SUCCESS (3.753s)
[47.931498] Starting dynamic subtest: flip-pipe-D
[49.250494] Dynamic subtest flip-pipe-D: SUCCESS (1.326s)
[49.261403] Starting dynamic subtest: modeset-pipe-D
[52.892087] Dynamic subtest modeset-pipe-D: SUCCESS (3.642s)
[52.897784] Subtest basic-hang: SUCCESS (9.522s)
[53.801960] [002/142] (949s left) gem_partial_pwrite_pread (write-uncached)
[53.873526] Subtest write-uncached: SKIP (0.000s)
[53.901615] [003/142] (949s left) kms_atomic_interruptible (universal-setplane-primary)
[53.983895] Starting subtest: universal-setplane-primary
[53.986355] Starting dynamic subtest: eDP-1-pipe-A
[61.498138] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.513s)
[61.500147] Subtest universal-setplane-primary: SUCCESS (7.514s)
[62.424231] [004/142] (941s left) gem_mmap_gtt (basic-copy)
[62.480116] Subtest basic-copy: SKIP (0.000s)
[62.505644] [005/142] (941s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_mc_ccs)
[62.873311] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs
[64.057193] Subtest pipe-B-random-ccs-data-4_tiled_mtl_mc_ccs: SUCCESS (1.184s)
[65.246130] [006/142] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[65.313491] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[65.317444] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[65.390773] [007/142] (938s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[65.467656] Starting subtest: y-tiled-16bpp-rotate-270
[65.471587] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[65.548444] [008/142] (938s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[65.601043] Subtest untiled-to-tiled: SKIP (0.000s)
[65.619776] [009/142] (938s left) kms_plane_multiple (tiling-yf)
[65.702788] Starting subtest: tiling-yf
[65.707055] Subtest tiling-yf: SKIP (0.000s)
[65.752960] [010/142] (938s left) gem_exec_reloc (basic-gtt-noreloc)
[65.809782] Subtest basic-gtt-noreloc: SKIP (0.000s)
[65.867655] [011/142] (938s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[65.963381] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[66.925895] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.961s)
[67.806028] [012/142] (936s left) syncobj_wait (invalid-single-wait-unsubmitted)
[67.851348] Starting subtest: invalid-single-wait-unsubmitted
[67.854167] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[67.898286] [013/142] (936s left) gem_workarounds (reset-fd)
[67.986414] Starting subtest: reset-fd
[68.076428] Subtest reset-fd: SUCCESS (0.090s)
[68.169163] [014/142] (935s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[68.578835] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[68.583776] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[69.483338] [015/142] (934s left) syncobj_timeline (invalid-single-wait-available-unsubmitted)
[69.543322] Starting subtest: invalid-single-wait-available-unsubmitted
[69.545412] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.000s)
[69.603288] [016/142] (934s left) syncobj_timeline (device-signal-unordered)
[69.646910] Starting subtest: device-signal-unordered
[69.649303] Subtest device-signal-unordered: SUCCESS (0.000s)
[69.700160] [017/142] (934s left) gem_exec_balancer (bonded-true-hang)
[69.947668] Starting subtest: bonded-true-hang
[69.952239] Subtest bonded-true-hang: SKIP (0.000s)
[70.012396] [018/142] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[70.112045] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[75.103782] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (5.000s)
[75.204438] [019/142] (928s left) perf (unprivileged-single-ctx-counters)
[75.345372] Starting subtest: unprivileged-single-ctx-counters
[75.349974] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[75.374122] [020/142] (928s left) gem_exec_store (pages)
[75.426374] Starting subtest: pages
[75.428753] Starting dynamic subtest: rcs0
[75.510698] Dynamic subtest rcs0: SUCCESS (0.089s)
[75.522780] Starting dynamic subtest: bcs0
[75.586485] Dynamic subtest bcs0: SUCCESS (0.076s)
[75.598935] Starting dynamic subtest: vcs0
[75.639719] Dynamic subtest vcs0: SUCCESS (0.053s)
[75.651167] Starting dynamic subtest: vcs1
[75.683467] Dynamic subtest vcs1: SUCCESS (0.043s)
[75.691256] Starting dynamic subtest: vecs0
[75.727865] Dynamic subtest vecs0: SUCCESS (0.044s)
[75.734145] Starting dynamic subtest: ccs0
[75.789792] Dynamic subtest ccs0: SUCCESS (0.062s)
[75.792247] Subtest pages: SUCCESS (0.368s)
[75.963958] [021/142] (928s left) syncobj_wait (signal)
[76.007651] Starting subtest: signal
[76.009969] Subtest signal: SUCCESS (0.000s)
[76.061716] [022/142] (928s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[76.121681] Starting subtest: saturated-hostile-nopreempt
[76.124175] Starting dynamic subtest: rcs0
[76.156188] Dynamic subtest rcs0: SKIP (0.033s)
[76.168807] Starting dynamic subtest: bcs0
[76.176061] Dynamic subtest bcs0: SKIP (0.016s)
[76.186330] Starting dynamic subtest: vcs0
[76.193898] Dynamic subtest vcs0: SKIP (0.022s)
[76.202434] Starting dynamic subtest: vcs1
[76.207297] Dynamic subtest vcs1: SKIP (0.012s)
[76.219673] Starting dynamic subtest: vecs0
[76.224934] Dynamic subtest vecs0: SKIP (0.018s)
[76.236477] Starting dynamic subtest: ccs0
[76.243825] Dynamic subtest ccs0: SKIP (0.018s)
[76.248146] Subtest saturated-hostile-nopreempt: SKIP (0.119s)
[76.307409] [023/142] (927s left) gem_exec_schedule (pi-shared-iova)
[76.496560] Starting subtest: pi-shared-iova
[76.498654] Starting dynamic subtest: rcs0
[76.563241] Dynamic subtest rcs0: SUCCESS (0.070s)
[76.568490] Starting dynamic subtest: vcs0
[76.623792] Dynamic subtest vcs0: SUCCESS (0.060s)
[76.636578] Starting dynamic subtest: vcs1
[76.649049] Dynamic subtest vcs1: SUCCESS (0.025s)
[76.661995] Starting dynamic subtest: vecs0
[76.672252] Dynamic subtest vecs0: SUCCESS (0.023s)
[76.684548] Starting dynamic subtest: ccs0
[76.700753] Dynamic subtest ccs0: SUCCESS (0.028s)
[76.703263] Subtest pi-shared-iova: SUCCESS (0.208s)
[78.521810] [024/142] (925s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[78.645083] Starting subtest: cursor-rapid-movement-128x128
[78.647399] Starting dynamic subtest: pipe-A-eDP-1
[79.222290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[79.255419] Starting dynamic subtest: pipe-D-eDP-1
[80.551142] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[80.553618] Subtest cursor-rapid-movement-128x128: SUCCESS (1.907s)
[81.447554] [025/142] (922s left) gem_lmem_swapping (parallel-multi)
[81.509987] Subtest parallel-multi: SKIP (0.000s)
[81.525557] [026/142] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[81.610071] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[86.275785] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.672s)
[86.418545] [027/142] (917s left) kms_feature_discovery (display-3x)
[86.500824] Starting subtest: display-3x
[86.505829] Subtest display-3x: SKIP (0.000s)
[86.559655] [028/142] (917s left) kms_vblank (pipe-d-ts-continuation-dpms-suspend)
[86.649931] Starting subtest: pipe-D-ts-continuation-dpms-suspend
[104.715723] Subtest pipe-D-ts-continuation-dpms-suspend: SUCCESS (3.067s)
[105.594121] [029/142] (913s left) kms_flip (flip-vs-panning-interruptible)
[105.654853] Starting subtest: flip-vs-panning-interruptible
[105.656809] Starting dynamic subtest: A-eDP1
[114.436418] Dynamic subtest A-eDP1: SUCCESS (8.780s)
[114.450733] Starting dynamic subtest: B-eDP1
[123.204205] Dynamic subtest B-eDP1: SUCCESS (8.766s)
[123.220930] Starting dynamic subtest: C-eDP1
[131.961967] Dynamic subtest C-eDP1: SUCCESS (8.757s)
[131.976026] Starting dynamic subtest: D-eDP1
[140.728920] Dynamic subtest D-eDP1: SUCCESS (8.766s)
[140.736303] Subtest flip-vs-panning-interruptible: SUCCESS (35.083s)
[142.020843] [030/142] (877s left) kms_addfb_basic (bad-pitch-256)
[142.088915] Starting subtest: bad-pitch-256
[142.091250] Subtest bad-pitch-256: SUCCESS (0.000s)
[142.209576] [031/142] (877s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[142.281691] Starting subtest: stress-mm-invalidate-close-overlap
[144.442034] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.162s)
[145.052349] [032/142] (874s left) gem_mmap_gtt (basic-short)
[145.125291] Subtest basic-short: SKIP (0.000s)
[145.161544] [033/142] (874s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[145.239666] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[145.244328] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[145.328584] [034/142] (874s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[145.411681] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[145.416166] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[145.502898] [035/142] (874s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[145.564279] Starting subtest: 4-tiled-8bpp-rotate-180
[146.630343] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.066s)
[146.738457] [036/142] (872s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[146.831966] Starting subtest: x-tiled-32bpp-rotate-270
[146.848274] Subtest x-tiled-32bpp-rotate-270: SKIP (0.015s)
[146.953306] [037/142] (872s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend)
[147.030180] Starting subtest: pipe-C-ts-continuation-dpms-suspend
[165.738759] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (3.069s)
[166.685746] [038/142] (868s left) syncobj_wait (invalid-signal-one-illegal-handle)
[166.734580] Starting subtest: invalid-signal-one-illegal-handle
[166.736580] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[166.793804] [039/142] (868s left) gem_exec_flush (basic-wb-rw-default)
[166.863586] Starting subtest: basic-wb-rw-default
[172.327809] Subtest basic-wb-rw-default: SUCCESS (5.464s)
[172.510264] [040/142] (862s left) kms_addfb_basic (master-rmfb)
[172.557667] Starting subtest: master-rmfb
[172.559966] Subtest master-rmfb: SUCCESS (0.001s)
[172.680392] [041/142] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[172.744268] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[172.748150] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[172.838900] [042/142] (862s left) gem_softpin (safe-alignment)
[172.895112] Starting subtest: safe-alignment
[172.919179] Subtest safe-alignment: SUCCESS (0.024s)
[174.067819] [043/142] (861s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[174.452167] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[174.458286] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[175.311384] [044/142] (860s left) gem_exec_schedule (implicit-read-write)
[175.383931] Starting subtest: implicit-read-write
[175.386237] Starting dynamic subtest: rcs0
[175.437593] Dynamic subtest rcs0: SUCCESS (0.057s)
[175.449587] Starting dynamic subtest: vcs0
[175.491214] Dynamic subtest vcs0: SUCCESS (0.053s)
[175.507080] Starting dynamic subtest: vcs1
[175.547602] Dynamic subtest vcs1: SUCCESS (0.055s)
[175.562295] Starting dynamic subtest: vecs0
[175.600878] Dynamic subtest vecs0: SUCCESS (0.052s)
[175.615871] Starting dynamic subtest: ccs0
[175.658009] Dynamic subtest ccs0: SUCCESS (0.056s)
[175.660424] Subtest implicit-read-write: SUCCESS (0.279s)
[177.187794] [045/142] (858s left) kms_vblank (pipe-d-query-busy)
[177.265940] Starting subtest: pipe-D-query-busy
[180.269791] Subtest pipe-D-query-busy: SUCCESS (3.005s)
[181.211366] [046/142] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[181.282515] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[181.287300] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[181.368950] [047/142] (854s left) kms_vblank (pipe-a-wait-forked-busy-hang)
[181.428938] Starting subtest: pipe-A-wait-forked-busy-hang
[195.859636] Subtest pipe-A-wait-forked-busy-hang: SUCCESS (14.433s)
[196.763595] [048/142] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[196.824217] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[199.875871] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.058s)
[200.005214] [049/142] (835s left) gem_tiled_pread_basic
[200.081663] [050/142] (835s left) v3d/v3d_wait_bo (bad-pad)
[200.178012] Subtest bad-pad: SKIP (0.000s)
[200.227554] [051/142] (835s left) i915_pm_rpm (debugfs-forcewake-user)
[202.248987] Starting subtest: debugfs-forcewake-user
[215.856536] Subtest debugfs-forcewake-user: SUCCESS (13.608s)
[216.215669] [052/142] (819s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[216.262079] Starting subtest: etime-single-wait-all-for-submit-submitted
[216.364536] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[216.435520] [053/142] (819s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[216.509230] Starting subtest: rel-constants-invalid-rel-gen5
[216.511356] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[216.591041] [054/142] (819s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[216.658913] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[216.661302] Starting dynamic subtest: pipe-A-eDP-1
[217.043988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[217.055389] Starting dynamic subtest: pipe-B-eDP-1
[218.634501] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.588s)
[218.652142] Starting dynamic subtest: pipe-C-eDP-1
[220.178551] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.541s)
[220.195056] Starting dynamic subtest: pipe-D-eDP-1
[221.749733] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.566s)
[221.753273] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (5.092s)
[223.004305] [055/142] (812s left) vc4/vc4_tiling (get-bad-modifier)
[223.063152] Subtest get-bad-modifier: SKIP (0.000s)
[223.111766] [056/142] (812s left) kms_flip (busy-flip)
[223.170150] Starting subtest: busy-flip
[223.172745] Starting dynamic subtest: A-eDP1
[224.965485] Dynamic subtest A-eDP1: SUCCESS (1.798s)
[224.981281] Starting dynamic subtest: B-eDP1
[226.757456] Dynamic subtest B-eDP1: SUCCESS (1.790s)
[226.772746] Starting dynamic subtest: C-eDP1
[228.539760] Dynamic subtest C-eDP1: SUCCESS (1.779s)
[228.555441] Starting dynamic subtest: D-eDP1
[230.330014] Dynamic subtest D-eDP1: SUCCESS (1.790s)
[230.337356] Subtest busy-flip: SUCCESS (7.172s)
[231.646031] [057/142] (804s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_mc_ccs)
[232.015714] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs
[233.180832] Subtest pipe-A-random-ccs-data-4_tiled_mtl_mc_ccs: SUCCESS (1.164s)
[234.346429] [058/142] (801s left) kms_chamelium_frames (hdmi-crc-single)
[234.689104] Subtest hdmi-crc-single: SKIP (0.000s)
[235.576662] [059/142] (800s left) gem_create (hog-create)
[235.624102] Starting subtest: hog-create
[235.626465] Starting dynamic subtest: smem0
[269.073603] Dynamic subtest smem0: SUCCESS (33.447s)
[269.076542] Subtest hog-create: SUCCESS (33.449s)
[269.258614] [060/142] (766s left) syncobj_wait (invalid-wait-illegal-handle)
[269.310215] Starting subtest: invalid-wait-illegal-handle
[269.312761] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[269.372288] [061/142] (766s left) prime_mmap (test_map_unmap)
[269.408839] Starting subtest: test_map_unmap
[269.411290] Starting dynamic subtest: test_map_unmap-smem
[269.461199] Dynamic subtest test_map_unmap-smem: SUCCESS (0.054s)
[269.463706] Subtest test_map_unmap: SUCCESS (0.055s)
[269.561195] [062/142] (766s left) v3d/v3d_submit_csd (bad-in-sync)
[269.649900] Subtest bad-in-sync: SKIP (0.000s)
[269.699143] [063/142] (766s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[269.781034] Starting subtest: fbc-rgb565-draw-render
[272.825247] Subtest fbc-rgb565-draw-render: SUCCESS (3.048s)
[272.957278] [064/142] (763s left) kms_fbcon_fbt (psr-suspend)
[273.016635] Starting subtest: psr-suspend
[320.185850] Subtest psr-suspend: SUCCESS (17.795s)
[320.245110] [065/142] (745s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[320.314583] Starting subtest: yf-tiled-32bpp-rotate-180
[320.318317] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[320.394746] [066/142] (745s left) kms_mmap_write_crc (main)
[320.490436] Starting subtest: main
[320.492916] Starting dynamic subtest: pipe-A-eDP-1
[324.052870] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.562s)
[324.055318] Subtest main: SUCCESS (3.564s)
[324.943556] [067/142] (740s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[325.351704] Starting subtest: pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[325.357630] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[326.222093] [068/142] (739s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[326.297389] Starting subtest: addfb25-yf-tiled-legacy
[326.299378] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[326.386667] [069/142] (739s left) gem_exec_whisper (basic-contexts-priority-all)
[326.464830] Starting subtest: basic-contexts-priority-all
[357.567173] Subtest basic-contexts-priority-all: SUCCESS (31.102s)
[357.743030] [070/142] (707s left) kms_ccs (pipe-c-bad-rotation-90-yf_tiled_ccs)
[358.156107] Starting subtest: pipe-C-bad-rotation-90-yf_tiled_ccs
[358.161539] Subtest pipe-C-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[359.004555] [071/142] (706s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[361.578678] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[361.642943] [072/142] (703s left) device_reset (cold-reset-bound)
[361.771534] Subtest cold-reset-bound: SKIP (0.000s)
[361.837644] [073/142] (703s left) kms_psr2_sf (overlay-plane-update-sf-dmg-area)
[367.002982] Starting subtest: overlay-plane-update-sf-dmg-area
[367.005664] Starting dynamic subtest: pipe-A-eDP-1
[373.833555] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.826s)
[373.848376] Starting dynamic subtest: pipe-B-eDP-1
[380.651948] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.817s)
[380.654613] Subtest overlay-plane-update-sf-dmg-area: SUCCESS (13.650s)
[381.595016] [074/142] (684s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[381.652196] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[381.654496] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[381.720811] [075/142] (683s left) gem_exec_fence (submit-chain)
[381.916969] Starting subtest: submit-chain
[381.934630] Subtest submit-chain: SUCCESS (0.019s)
[383.509774] [076/142] (682s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[383.583691] Starting subtest: fbc-rgb565-draw-blt
[386.624225] Subtest fbc-rgb565-draw-blt: SUCCESS (3.046s)
[386.762174] [077/142] (678s left) kms_frontbuffer_tracking (fbc-tiling-4)
[386.850061] Starting subtest: fbc-tiling-4
[389.921652] Subtest fbc-tiling-4: SUCCESS (3.074s)
[390.041747] [078/142] (675s left) kms_prime (basic-crc-vgem)
[390.585612] Starting subtest: basic-crc-vgem
[390.587707] Starting dynamic subtest: second-to-first
[391.610012] Dynamic subtest second-to-first: SUCCESS (1.028s)
[391.612121] Subtest basic-crc-vgem: SUCCESS (1.029s)
[391.686864] [079/142] (674s left) gen9_exec_parse (allowed-all)
[391.763734] Subtest allowed-all: SKIP (0.000s)
[391.828105] [080/142] (673s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[392.248372] Starting subtest: pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[392.254291] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[393.117043] [081/142] (672s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[393.515928] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[393.520661] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[394.394585] [082/142] (671s left) gem_exec_nop (basic-series)
[394.470295] Starting subtest: basic-series
[410.420402] Subtest basic-series: SUCCESS (15.951s)
[410.630719] [083/142] (655s left) v3d/v3d_get_param (get-bad-param)
[410.697192] Subtest get-bad-param: SKIP (0.000s)
[410.748327] [084/142] (655s left) kms_psr (psr2_suspend)
[410.827223] Starting subtest: psr2_suspend
[428.598363] Subtest psr2_suspend: SUCCESS (2.906s)
[429.545369] [085/142] (651s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs)
[429.908880] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs
[429.913621] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[430.825855] [086/142] (650s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[431.209904] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[432.069348] [087/142] (648s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[432.138915] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[432.163476] [088/142] (648s left) gem_exec_fence (syncobj-unused-fence)
[432.593772] Starting subtest: syncobj-unused-fence
[432.599968] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[434.401229] [089/142] (646s left) gem_userptr_blits (access-control)
[434.478171] Starting subtest: access-control
[434.483019] Subtest access-control: SKIP (0.000s)
[434.572329] [090/142] (646s left) perf_pmu (semaphore-wait)
[434.633241] Starting subtest: semaphore-wait
[434.635606] Starting dynamic subtest: rcs0
[435.140065] Dynamic subtest rcs0: SUCCESS (0.509s)
[435.158488] Starting dynamic subtest: bcs0
[435.652985] Dynamic subtest bcs0: SUCCESS (0.510s)
[435.670868] Starting dynamic subtest: vcs0
[436.163865] Dynamic subtest vcs0: SUCCESS (0.509s)
[436.181501] Starting dynamic subtest: vcs1
[436.675503] Dynamic subtest vcs1: SUCCESS (0.509s)
[436.693923] Starting dynamic subtest: vecs0
[437.185260] Dynamic subtest vecs0: SUCCESS (0.509s)
[437.203422] Starting dynamic subtest: ccs0
[437.697912] Dynamic subtest ccs0: SUCCESS (0.510s)
[437.701048] Subtest semaphore-wait: SUCCESS (3.066s)
[437.809753] [091/142] (643s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[437.850156] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[437.854757] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[438.033212] [092/142] (642s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[438.118680] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[438.121153] Starting dynamic subtest: pipe-A-eDP-1
[438.560036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[438.573162] Starting dynamic subtest: pipe-B-eDP-1
[440.173404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[440.183337] Starting dynamic subtest: pipe-C-eDP-1
[441.772080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.597s)
[441.789402] Starting dynamic subtest: pipe-D-eDP-1
[443.403567] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.628s)
[443.406117] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (5.288s)
[444.643913] [093/142] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[444.698318] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[449.346280] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.650s)
[449.468125] [094/142] (631s left) kms_cursor_crc (cursor-sliding-512x512)
[449.597555] Starting subtest: cursor-sliding-512x512
[449.602142] Subtest cursor-sliding-512x512: SKIP (0.001s)
[449.713376] [095/142] (631s left) sysfs_timeslice_duration (idempotent)
[449.769687] Starting subtest: idempotent
[449.772370] Starting dynamic subtest: vecs0
[449.774444] Dynamic subtest vecs0: SUCCESS (0.000s)
[449.781893] Starting dynamic subtest: ccs0
[449.784145] Dynamic subtest ccs0: SUCCESS (0.000s)
[449.790593] Starting dynamic subtest: vcs0
[449.792857] Dynamic subtest vcs0: SUCCESS (0.000s)
[449.799317] Starting dynamic subtest: bcs0
[449.801182] Dynamic subtest bcs0: SUCCESS (0.000s)
[449.807286] Starting dynamic subtest: rcs0
[449.809353] Dynamic subtest rcs0: SUCCESS (0.000s)
[449.826864] Starting dynamic subtest: vcs1
[449.828925] Dynamic subtest vcs1: SUCCESS (0.000s)
[449.830967] Subtest idempotent: SUCCESS (0.004s)
[449.855613] [096/142] (631s left) i915_pm_rps (thresholds)
[449.911628] Starting subtest: thresholds
[449.914074] Starting dynamic subtest: gt0
[449.919135] Dynamic subtest gt0: SKIP (0.003s)
[449.929077] Starting dynamic subtest: gt1
[449.933431] Dynamic subtest gt1: SKIP (0.001s)
[449.937833] Subtest thresholds: SKIP (0.006s)
[449.978405] [097/142] (631s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[450.101747] Starting subtest: cursor-vs-flip-atomic
[478.377431] Subtest cursor-vs-flip-atomic: SUCCESS (28.275s)
[479.278725] [098/142] (601s left) gem_ctx_sseu (engines)
[479.341138] Subtest engines: SKIP (0.000s)
[479.358010] [099/142] (601s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[479.435762] Starting subtest: primary-yf-tiled-reflect-x-0
[479.495461] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[479.599932] [100/142] (601s left) vc4/vc4_perfmon (destroy-valid-perfmon)
[479.695160] Subtest destroy-valid-perfmon: SKIP (0.000s)
[479.747623] [101/142] (601s left) gem_userptr_blits (unsync-unmap-after-close)
[479.829259] Subtest unsync-unmap-after-close: SKIP (0.000s)
[479.950525] [102/142] (601s left) kms_lease (lease-uevent)
[480.007276] Starting subtest: lease-uevent
[481.021634] Subtest lease-uevent: SUCCESS (1.015s)
[481.088947] [103/142] (600s left) kms_color (ctm-max)
[481.163347] Starting subtest: ctm-max
[481.165805] Starting dynamic subtest: pipe-A
[481.911268] Dynamic subtest pipe-A: SUCCESS (0.747s)
[481.929917] Starting dynamic subtest: pipe-B
[483.436738] Dynamic subtest pipe-B: SUCCESS (1.522s)
[483.452972] Starting dynamic subtest: pipe-C
[484.847142] Dynamic subtest pipe-C: SUCCESS (1.412s)
[484.866933] Starting dynamic subtest: pipe-D
[486.273239] Dynamic subtest pipe-D: SUCCESS (1.422s)
[486.275747] Subtest ctm-max: SUCCESS (5.108s)
[487.198022] [104/142] (594s left) api_intel_bb (intel-bb-blit-none)
[487.239290] Starting subtest: intel-bb-blit-none
[491.221832] Subtest intel-bb-blit-none: SUCCESS (3.984s)
[491.320408] [105/142] (590s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[491.402365] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[491.406337] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[491.492993] [106/142] (589s left) gem_mmap_gtt (fault-concurrent-y)
[491.549515] Subtest fault-concurrent-Y: SKIP (0.000s)
[491.577544] [107/142] (589s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[491.626250] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[491.628804] Starting dynamic subtest: pipe-A-default-mode
[491.924594] Dynamic subtest pipe-A-default-mode: SKIP (0.294s)
[491.930264] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.295s)
[492.823353] [108/142] (588s left) kms_dsc (dsc-with-bpc-formats)
[492.874461] Starting subtest: dsc-with-bpc-formats
[492.881533] Subtest dsc-with-bpc-formats: SKIP (0.006s)
[492.942240] [109/142] (588s left) gem_pread (self)
[492.997306] Subtest self: SKIP (0.000s)
[493.039669] [110/142] (588s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[493.427592] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[493.435279] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[494.298839] [111/142] (587s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[494.703379] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs
[494.712357] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[495.575719] [112/142] (585s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[495.624110] Starting subtest: 2x-flip-vs-modeset-vs-hang
[495.643206] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.019s)
[495.715384] [113/142] (585s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[495.792546] Starting subtest: psr-modesetfrombusy
[500.056732] Subtest psr-modesetfrombusy: SUCCESS (4.272s)
[500.164887] [114/142] (581s left) gem_ctx_exec (basic-norecovery)
[500.219935] Starting subtest: basic-norecovery
[500.540697] Subtest basic-norecovery: SUCCESS (0.320s)
[500.638996] [115/142] (580s left) kms_atomic_transition (plane-toggle-modeset-transition)
[500.697563] Starting subtest: plane-toggle-modeset-transition
[500.699671] Starting dynamic subtest: pipe-A-eDP-1
[515.111245] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.411s)
[515.132289] Starting dynamic subtest: pipe-B-eDP-1
[529.000761] Dynamic subtest pipe-B-eDP-1: SUCCESS (13.882s)
[529.003391] Subtest plane-toggle-modeset-transition: SUCCESS (28.302s)
[529.903500] [116/142] (551s left) kms_big_fb (linear-16bpp-rotate-90)
[530.000334] Starting subtest: linear-16bpp-rotate-90
[530.015899] Subtest linear-16bpp-rotate-90: SKIP (0.015s)
[530.113929] [117/142] (551s left) gem_ccs (block-copy-compressed)
[530.179710] Starting subtest: block-copy-compressed
[530.184623] Subtest block-copy-compressed: SKIP (0.000s)
[530.244577] [118/142] (551s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[530.681976] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[531.702631] Subtest pipe-B-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.021s)
[532.901045] [119/142] (548s left) kms_vblank (pipe-a-query-busy)
[532.969415] Starting subtest: pipe-A-query-busy
[534.859435] Subtest pipe-A-query-busy: SUCCESS (1.889s)
[535.787800] [120/142] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[535.875869] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[535.879652] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[535.967207] [121/142] (545s left) core_getclient
[536.073913] [122/142] (545s left) gem_spin_batch (resubmit)
[536.165800] Starting subtest: resubmit
[536.168383] Starting dynamic subtest: rcs0
[536.170861] Dynamic subtest rcs0: SUCCESS (0.004s)
[536.188857] Starting dynamic subtest: bcs0
[536.190953] Dynamic subtest bcs0: SUCCESS (0.001s)
[536.204191] Starting dynamic subtest: vcs0
[536.206139] Dynamic subtest vcs0: SUCCESS (0.002s)
[536.215068] Starting dynamic subtest: vcs1
[536.217019] Dynamic subtest vcs1: SUCCESS (0.002s)
[536.231357] Starting dynamic subtest: vecs0
[536.233393] Dynamic subtest vecs0: SUCCESS (0.002s)
[536.246917] Starting dynamic subtest: ccs0
[536.248891] Dynamic subtest ccs0: SUCCESS (0.002s)
[536.250864] Subtest resubmit: SUCCESS (0.020s)
[536.400196] [123/142] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[536.481396] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[536.485799] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[536.571151] [124/142] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[536.651689] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[539.507970] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.862s)
[539.629825] [125/142] (542s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[539.728908] Starting subtest: cursorB-vs-flipB-legacy
[539.732815] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[539.818847] [126/142] (542s left) syncobj_timeline (single-wait-all-available-submitted)
[539.876106] Starting subtest: single-wait-all-available-submitted
[539.878240] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[539.949323] [127/142] (542s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[540.014375] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[540.016490] Starting dynamic subtest: pipe-A-default-mode
[540.302573] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[540.307544] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.286s)
[541.219383] [128/142] (540s left) drm_fdinfo (virtual-busy-all)
[541.254916] Starting subtest: virtual-busy-all
[541.259570] Subtest virtual-busy-all: SKIP (0.000s)
[541.309354] [129/142] (540s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[543.513670] Starting subtest: dpms-mode-unset-non-lpsp
[546.885327] Subtest dpms-mode-unset-non-lpsp: SKIP (3.369s)
[547.721003] [130/142] (534s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[547.798863] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[547.803471] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[547.894075] [131/142] (534s left) perf (buffer-fill)
[548.008222] Starting subtest: buffer-fill
[548.011010] Starting dynamic subtest: 0-rcs0
[550.117784] Dynamic subtest 0-rcs0: SUCCESS (2.108s)
[550.127019] Starting dynamic subtest: 1-vcs1
[554.294904] Dynamic subtest 1-vcs1: SUCCESS (4.176s)
[554.298088] Subtest buffer-fill: SUCCESS (6.285s)
[554.331083] [132/142] (527s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[554.429941] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[554.434746] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[555.629553] [133/142] (526s left) kms_cursor_crc (cursor-offscreen-512x170)
[555.771881] Starting subtest: cursor-offscreen-512x170
[555.776662] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[555.881172] [134/142] (526s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[556.240181] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[556.245184] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[557.164473] [135/142] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[557.246337] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[557.250590] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[557.328689] [136/142] (524s left) kms_vblank (pipe-a-ts-continuation-modeset)
[557.373133] Starting subtest: pipe-A-ts-continuation-modeset
[558.930758] Subtest pipe-A-ts-continuation-modeset: SUCCESS (1.555s)
[559.852982] [137/142] (522s left) gen9_exec_parse (valid-registers)
[559.912141] Subtest valid-registers: SKIP (0.000s)
[559.932759] [138/142] (522s left) kms_properties (invalid-properties-atomic)
[560.010140] Starting subtest: invalid-properties-atomic
[560.239388] Subtest invalid-properties-atomic: SUCCESS (0.229s)
[560.301628] [139/142] (521s left) gem_mmap_gtt (big-bo)
[560.382078] Subtest big-bo: SKIP (0.000s)
[560.401686] [140/142] (521s left) perf_pmu (busy-accuracy-98)
[560.435331] Starting subtest: busy-accuracy-98
[560.437604] Starting dynamic subtest: rcs0
[563.479929] Dynamic subtest rcs0: SUCCESS (3.042s)
[563.500151] Starting dynamic subtest: bcs0
[566.536351] Dynamic subtest bcs0: SUCCESS (3.055s)
[566.555173] Starting dynamic subtest: vcs0
[569.577422] Dynamic subtest vcs0: SUCCESS (3.039s)
[569.592996] Starting dynamic subtest: vcs1
[572.621578] Dynamic subtest vcs1: SUCCESS (3.043s)
[572.641110] Starting dynamic subtest: vecs0
[575.668862] Dynamic subtest vecs0: SUCCESS (3.046s)
[575.685085] Starting dynamic subtest: ccs0
[578.719015] Dynamic subtest ccs0: SUCCESS (3.048s)
[578.721572] Subtest busy-accuracy-98: SUCCESS (18.282s)
[578.831703] [141/142] (503s left) gem_exec_capture (capture-recoverable)
[578.897352] Starting subtest: capture-recoverable
[578.900346] Subtest capture-recoverable: SUCCESS (0.001s)
[578.999276] [142/142] (503s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs)
[579.387179] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs
[579.395595] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[580.252944] Closing watchdogs
Done.