[48.736283] Initializing watchdogs
[48.736530]   /dev/watchdog0
[48.752534] [001/142] (960s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[49.283410] Starting subtest: 2x-flip-vs-cursor-legacy
[49.287651] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.005s)
[49.372800] [002/142] (959s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[49.705302] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[49.992904] [003/142] (959s left) kms_display_modes (mst-extended-mode-negative)
[50.251398] Starting subtest: mst-extended-mode-negative
[50.255334] Subtest mst-extended-mode-negative: SKIP (0.000s)
[50.303836] [004/142] (959s left) gem_ctx_param (invalid-param-set)
[50.443855] Starting subtest: invalid-param-set
[50.446527] Subtest invalid-param-set: SUCCESS (0.000s)
[50.519522] [005/142] (958s left) v3d/v3d_submit_cl (bad-extension)
[50.722432] Subtest bad-extension: SKIP (0.000s)
[50.785543] [006/142] (958s left) kms_flip (2x-flip-vs-suspend)
[51.008900] Starting subtest: 2x-flip-vs-suspend
[51.013105] Subtest 2x-flip-vs-suspend: SKIP (0.003s)
[51.118657] [007/142] (958s left) kms_prop_blob (invalid-set-prop-any)
[51.261116] Starting subtest: invalid-set-prop-any
[51.263100] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[51.334697] [008/142] (958s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[51.682328] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[51.686896] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[52.137357] [009/142] (957s left) kms_setmode (invalid-clone-single-crtc)
[52.279291] Starting subtest: invalid-clone-single-crtc
[52.285063] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[52.351833] [010/142] (957s left) kms_psr2_su (frontbuffer-xrgb8888)
[52.493299] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[52.537413] [011/142] (957s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[52.789925] Starting subtest: fbcpsr-slowdraw
[52.794659] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[52.868342] [012/142] (956s left) kms_lease (lease_revoke)
[53.109646] Starting subtest: lease_revoke
[53.111800] Starting dynamic subtest: pipe-A-DP-1
[53.226631] Dynamic subtest pipe-A-DP-1: SUCCESS (0.115s)
[53.246735] Starting dynamic subtest: pipe-B-DP-1
[53.335169] Dynamic subtest pipe-B-DP-1: SUCCESS (0.107s)
[53.355836] Starting dynamic subtest: pipe-C-DP-1
[53.442536] Dynamic subtest pipe-C-DP-1: SUCCESS (0.105s)
[53.445044] Subtest lease_revoke: SUCCESS (0.334s)
[53.536047] [013/142] (956s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[53.770779] Starting subtest: cursor-vs-flip-legacy
[91.982850] Subtest cursor-vs-flip-legacy: SUCCESS (38.213s)
[92.307402] [014/142] (917s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_mc_ccs)
[92.707438] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs
[92.711674] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[93.114405] [015/142] (916s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[93.593145] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[93.888431] [016/142] (915s left) kms_universal_plane (universal-plane-pipe-d-sanity)
[94.126483] Subtest universal-plane-pipe-D-sanity: SKIP (0.000s)
[94.206787] [017/142] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[94.464822] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[94.468790] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[94.554701] [018/142] (915s left) kms_hdr (invalid-hdr)
[94.796497] Starting subtest: invalid-hdr
[97.048237] Starting dynamic subtest: pipe-A-DP-1
[100.864423] Dynamic subtest pipe-A-DP-1: SUCCESS (3.816s)
[100.866675] Subtest invalid-hdr: SUCCESS (6.069s)
[101.225361] [019/142] (908s left) kms_vblank (pipe-a-query-forked-hang)
[101.467941] Starting subtest: pipe-A-query-forked-hang
[108.971570] Subtest pipe-A-query-forked-hang: SUCCESS (7.505s)
[109.306083] [020/142] (900s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_rc_ccs)
[109.761770] Starting subtest: pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs
[109.765834] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_rc_ccs: SKIP (0.002s)
[110.115897] [021/142] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[110.363854] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[110.367807] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[110.457630] [022/142] (899s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[110.602025] Starting subtest: invalid-multi-wait-unsubmitted
[110.604136] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[110.688879] [023/142] (899s left) vgem_basic (sysfs)
[110.907253] Starting subtest: sysfs
[110.909791] Subtest sysfs: SUCCESS (0.001s)
[110.970723] [024/142] (899s left) gem_ctx_param (non-root-set)
[111.111740] Starting subtest: non-root-set
[111.146243] Subtest non-root-set: SUCCESS (0.036s)
[111.224827] [025/142] (898s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[111.456536] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[111.458701] Starting dynamic subtest: pipe-A-DP-1
[111.539108] Dynamic subtest pipe-A-DP-1: SUCCESS (0.080s)
[111.564495] Starting dynamic subtest: pipe-B-DP-1
[111.920605] Dynamic subtest pipe-B-DP-1: SUCCESS (0.378s)
[111.945215] Starting dynamic subtest: pipe-C-DP-1
[112.037355] Dynamic subtest pipe-C-DP-1: SKIP (0.111s)
[112.039583] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.579s)
[112.454304] [026/142] (897s left) kms_vblank (pipe-a-ts-continuation-modeset)
[112.694217] Starting subtest: pipe-A-ts-continuation-modeset
[113.319309] Subtest pipe-A-ts-continuation-modeset: SUCCESS (0.627s)
[113.650897] [027/142] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[113.794633] Starting subtest: addfb25-x-tiled-legacy
[113.796754] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[113.985817] [028/142] (896s left) gem_mmap_wc (read-write-distinct)
[114.126559] Starting subtest: read-write-distinct
[114.163424] Subtest read-write-distinct: SUCCESS (0.035s)
[114.267544] [029/142] (895s left) gem_exec_whisper (basic-queues-priority-all)
[114.447254] Starting subtest: basic-queues-priority-all
[137.239091] Subtest basic-queues-priority-all: SUCCESS (22.791s)
[137.437577] [030/142] (872s left) gem_fence_thrash (bo-write-verify-y)
[137.572421] Starting subtest: bo-write-verify-y
[138.855254] Subtest bo-write-verify-y: SUCCESS (1.281s)
[138.937673] [031/142] (871s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[139.173823] Starting subtest: disable-primary-vs-flip-pipe-B
[140.163992] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (0.991s)
[140.493425] [032/142] (869s left) kms_vblank (pipe-c-wait-forked-busy)
[140.743501] Starting subtest: pipe-C-wait-forked-busy
[143.544983] Subtest pipe-C-wait-forked-busy: SUCCESS (2.801s)
[143.882610] [033/142] (866s left) gem_ctx_persistence (file)
[144.031559] Starting subtest: file
[144.116524] Subtest file: SUCCESS (0.085s)
[144.203574] [034/142] (866s left) kms_color (ctm-0-50)
[144.445691] Starting subtest: ctm-0-50
[144.447880] Starting dynamic subtest: pipe-A
[146.292415] Dynamic subtest pipe-A: SUCCESS (1.850s)
[146.311635] Starting dynamic subtest: pipe-B
[148.326364] Dynamic subtest pipe-B: SUCCESS (2.031s)
[148.345877] Starting dynamic subtest: pipe-C
[150.354109] Dynamic subtest pipe-C: SUCCESS (2.027s)
[150.356216] Subtest ctm-0-50: SUCCESS (5.910s)
[150.711723] [035/142] (859s left) kms_vblank (pipe-a-ts-continuation-idle-hang)
[150.954520] Starting subtest: pipe-A-ts-continuation-idle-hang
[158.004850] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (7.052s)
[158.347763] [036/142] (852s left) perf (gen12-group-exclusive-stream-ctx-handle)
[158.612466] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[158.616347] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[158.664698] [037/142] (851s left) gem_basic (bad-close)
[158.806868] Starting subtest: bad-close
[158.811099] Subtest bad-close: SUCCESS (0.000s)
[158.880280] [038/142] (851s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs)
[159.354269] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[159.659636] [039/142] (850s left) gem_eio (kms)
[159.931424] Starting subtest: kms
[172.139581] Subtest kms: SUCCESS (12.209s)
[172.228915] [040/142] (838s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[172.526882] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[172.531257] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[172.626510] [041/142] (838s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[172.874140] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[172.876214] Starting dynamic subtest: pipe-A-valid-mode
[172.968910] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[172.974057] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.097s)
[173.291503] [042/142] (837s left) api_intel_bb (blit-reloc-keep-cache)
[173.436336] Starting subtest: blit-reloc-keep-cache
[173.453373] Subtest blit-reloc-keep-cache: SUCCESS (0.019s)
[173.556591] [043/142] (837s left) kms_vblank (pipe-d-wait-busy)
[173.804470] Subtest pipe-D-wait-busy: SKIP (0.000s)
[173.889131] [044/142] (836s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[174.134177] Starting subtest: primary-y-tiled-reflect-x-90
[174.138735] Subtest primary-y-tiled-reflect-x-90: SKIP (0.003s)
[174.223827] [045/142] (836s left) gem_pxp (fail-invalid-protected-context)
[176.889316] Subtest fail-invalid-protected-context: SKIP (0.000s)
[176.972494] [046/142] (833s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[177.134967] Starting subtest: x-tiled-to-vebox-yf-tiled
[177.138894] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[177.339960] [047/142] (833s left) gem_exec_balancer (smoke)
[177.507969] Starting subtest: smoke
[181.215415] Subtest smoke: SUCCESS (3.707s)
[185.140486] [048/142] (825s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[185.376709] Starting subtest: cursorB-vs-flipB-atomic
[185.380748] Subtest cursorB-vs-flipB-atomic: SKIP (0.002s)
[185.471920] [049/142] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[185.719081] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[188.017978] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.303s)
[188.159534] [050/142] (822s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[188.907123] Starting subtest: syncobj-timeline-invalid-wait
[188.913441] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[189.142577] [051/142] (821s left) gen9_exec_parse (valid-registers)
[189.308427] Starting subtest: valid-registers
[189.472545] Subtest valid-registers: SUCCESS (0.163s)
[189.707266] [052/142] (821s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[189.957251] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[189.961204] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[190.057164] [053/142] (821s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[190.479959] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[190.484195] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[190.853200] [054/142] (820s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[191.214978] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs
[191.219233] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[191.663464] [055/142] (819s left) i915_pm_rc6_residency (media-rc6-accuracy)
[191.978169] Starting subtest: media-rc6-accuracy
[191.982749] Subtest media-rc6-accuracy: SKIP (0.000s)
[192.066767] [056/142] (819s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[192.213121] Starting subtest: cpuset-basic-small-copy-XY
[199.869915] Subtest cpuset-basic-small-copy-XY: SUCCESS (7.658s)
[199.949229] [057/142] (811s left) vc4/vc4_purgeable_bo (access-purged-bo-mem)
[200.278499] Subtest access-purged-bo-mem: SKIP (0.000s)
[200.347751] [058/142] (811s left) gem_ctx_isolation (dirty-switch)
[200.519802] Starting subtest: dirty-switch
[200.522068] Starting dynamic subtest: rcs0
[202.246769] Dynamic subtest rcs0: SUCCESS (1.723s)
[202.269187] Starting dynamic subtest: bcs0
[204.477271] Dynamic subtest bcs0: SUCCESS (2.231s)
[204.497554] Starting dynamic subtest: vcs0
[206.160568] Dynamic subtest vcs0: SUCCESS (1.679s)
[206.180853] Starting dynamic subtest: vecs0
[207.831126] Dynamic subtest vecs0: SUCCESS (1.669s)
[207.833713] Subtest dirty-switch: SUCCESS (7.310s)
[208.032256] [059/142] (803s left) gem_userptr_blits (userfault)
[208.192178] Starting subtest: userfault
[208.199895] Subtest userfault: SUCCESS (0.008s)
[208.366216] [060/142] (803s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[208.652051] Starting subtest: yf-tiled-16bpp-rotate-0
[212.459552] Subtest yf-tiled-16bpp-rotate-0: SUCCESS (3.805s)
[212.782864] [061/142] (798s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[212.932421] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[212.934919] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[213.013784] [062/142] (798s left) gem_exec_reloc (basic-write-read-noreloc)
[213.166821] Starting subtest: basic-write-read-noreloc
[213.173500] Subtest basic-write-read-noreloc: SUCCESS (0.006s)
[213.348771] [063/142] (798s left) kms_vblank (pipe-a-wait-busy)
[213.599071] Starting subtest: pipe-A-wait-busy
[216.071269] Subtest pipe-A-wait-busy: SUCCESS (2.474s)
[216.417528] [064/142] (795s left) gem_softpin (32b-excludes-last-page)
[216.572762] Starting subtest: 32b-excludes-last-page
[216.579083] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[216.699535] [065/142] (795s left) kms_big_fb (y-tiled-addfb)
[216.965200] Starting subtest: y-tiled-addfb
[216.967561] Subtest y-tiled-addfb: SUCCESS (0.001s)
[217.066235] [066/142] (794s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[217.521818] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[217.526036] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[217.871722] [067/142] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[218.124182] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[218.128056] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[218.219292] [068/142] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[218.467701] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[218.471797] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[218.570696] [069/142] (793s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc)
[219.034461] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[219.358611] [070/142] (792s left) gem_exec_params (cliprects-invalid)
[219.511399] Starting subtest: cliprects-invalid
[219.513728] Subtest cliprects-invalid: SUCCESS (0.001s)
[219.623196] [071/142] (792s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[219.869271] Starting subtest: flip-vs-cursor-atomic
[235.298358] Subtest flip-vs-cursor-atomic: SUCCESS (15.428s)
[235.640249] [072/142] (776s left) gem_exec_balancer (individual)
[235.810549] Starting subtest: individual
[239.678168] Subtest individual: SUCCESS (3.864s)
[243.605567] [073/142] (768s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[244.010025] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[244.014042] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[244.417444] [074/142] (767s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[244.669416] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[244.673344] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[244.765215] [075/142] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[245.016784] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[245.020872] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[245.115092] [076/142] (767s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.262151] Starting subtest: invalid-single-wait-unsubmitted
[245.264213] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.348541] [077/142] (766s left) syncobj_wait (multi-wait-for-submit-signaled)
[245.497347] Starting subtest: multi-wait-for-submit-signaled
[245.499509] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[245.581540] [078/142] (766s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[245.848400] Starting subtest: 4-tiled-32bpp-rotate-270
[245.853899] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[245.931706] [079/142] (766s left) kms_cursor_crc (cursor-random-512x170)
[246.206380] Starting subtest: cursor-random-512x170
[246.212824] Subtest cursor-random-512x170: SKIP (0.003s)
[246.314752] [080/142] (766s left) syncobj_timeline (signal-array)
[246.461504] Starting subtest: signal-array
[246.463572] Subtest signal-array: SUCCESS (0.001s)
[246.548804] [081/142] (765s left) kms_force_connector_basic (force-connector-state)
[246.694443] Subtest force-connector-state: SKIP (0.000s)
[246.749604] [082/142] (765s left) kms_cursor_crc (cursor-sliding-32x10)
[246.991041] Starting subtest: cursor-sliding-32x10
[247.116899] Subtest cursor-sliding-32x10: SKIP (0.121s)
[247.234085] [083/142] (765s left) gen9_exec_parse (batch-invalid-length)
[247.423783] Starting subtest: batch-invalid-length
[247.432490] Subtest batch-invalid-length: SUCCESS (0.009s)
[247.652214] [084/142] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[247.919219] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[247.923100] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[248.032318] [085/142] (764s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[248.270721] Starting subtest: modeset-transition-nonblocking-fencing
[248.272798] Starting dynamic subtest: 1x-outputs
[253.268092] Dynamic subtest 1x-outputs: SUCCESS (4.997s)
[253.366209] Subtest modeset-transition-nonblocking-fencing: SUCCESS (5.097s)
[253.714968] [086/142] (758s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[253.986426] Starting subtest: x-tiled-32bpp-rotate-0
[258.870747] Subtest x-tiled-32bpp-rotate-0: SUCCESS (4.883s)
[259.396261] [087/142] (753s left) kms_lease (setcrtc_implicit_plane)
[259.640044] Starting subtest: setcrtc_implicit_plane
[259.642343] Starting dynamic subtest: pipe-A-DP-1
[259.941559] Dynamic subtest pipe-A-DP-1: SUCCESS (0.295s)
[259.963203] Starting dynamic subtest: pipe-B-DP-1
[260.418722] Dynamic subtest pipe-B-DP-1: SUCCESS (0.472s)
[260.443800] Starting dynamic subtest: pipe-C-DP-1
[260.912306] Dynamic subtest pipe-C-DP-1: SUCCESS (0.489s)
[260.914421] Subtest setcrtc_implicit_plane: SUCCESS (1.271s)
[261.252303] [088/142] (751s left) fbdev (pan)
[261.397180] Starting subtest: pan
[261.442863] Subtest pan: SUCCESS (0.045s)
[261.534938] [089/142] (751s left) prime_busy (after)
[261.684155] Starting subtest: after
[261.702317] Starting dynamic subtest: rcs0
[261.713991] Dynamic subtest rcs0: SUCCESS (0.010s)
[261.735549] Starting dynamic subtest: bcs0
[261.737900] Dynamic subtest bcs0: SUCCESS (0.020s)
[261.758944] Starting dynamic subtest: vcs0
[261.761465] Dynamic subtest vcs0: SUCCESS (0.021s)
[261.783214] Starting dynamic subtest: vecs0
[261.785266] Dynamic subtest vecs0: SUCCESS (0.014s)
[261.893813] Subtest after: SUCCESS (0.209s)
[261.987301] [090/142] (750s left) i915_pm_rps (thresholds-idle-park)
[262.142311] Starting subtest: thresholds-idle-park
[262.144517] Starting dynamic subtest: gt0
[277.567473] Dynamic subtest gt0: SUCCESS (15.418s)
[277.569671] Subtest thresholds-idle-park: SUCCESS (15.423s)
[277.652751] [091/142] (735s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[278.007355] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[278.013169] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[278.457448] [092/142] (734s left) gem_userptr_blits (map-fixed-invalidate-busy)
[278.644679] Starting subtest: map-fixed-invalidate-busy
[278.646893] Starting dynamic subtest: gtt
[282.385793] Dynamic subtest gtt: SUCCESS (3.736s)
[282.407309] Starting dynamic subtest: wb
[286.049227] Dynamic subtest wb: SUCCESS (3.663s)
[286.071846] Starting dynamic subtest: wc
[289.695673] Dynamic subtest wc: SUCCESS (3.644s)
[289.717131] Starting dynamic subtest: uc
[293.338255] Dynamic subtest uc: SUCCESS (3.640s)
[293.340402] Subtest map-fixed-invalidate-busy: SUCCESS (14.694s)
[293.490420] [093/142] (719s left) drm_fdinfo (busy)
[293.643948] Starting subtest: busy
[293.646352] Starting dynamic subtest: rcs0
[294.176290] Dynamic subtest rcs0: SUCCESS (0.531s)
[294.200953] Starting dynamic subtest: bcs0
[294.707242] Dynamic subtest bcs0: SUCCESS (0.528s)
[294.732637] Starting dynamic subtest: vcs0
[295.236682] Dynamic subtest vcs0: SUCCESS (0.526s)
[295.258887] Starting dynamic subtest: vecs0
[295.771302] Dynamic subtest vecs0: SUCCESS (0.532s)
[295.773299] Subtest busy: SUCCESS (2.130s)
[295.857204] [094/142] (717s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs)
[296.289043] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs
[296.852063] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.563s)
[297.324231] [095/142] (715s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[297.473233] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[297.523805] [096/142] (715s left) kms_color (ctm-negative)
[297.769774] Starting subtest: ctm-negative
[297.772082] Starting dynamic subtest: pipe-A
[298.295547] Dynamic subtest pipe-A: SUCCESS (0.526s)
[298.321414] Starting dynamic subtest: pipe-B
[299.012481] Dynamic subtest pipe-B: SUCCESS (0.714s)
[299.033548] Starting dynamic subtest: pipe-C
[299.721063] Dynamic subtest pipe-C: SUCCESS (0.702s)
[299.723149] Subtest ctm-negative: SUCCESS (1.951s)
[300.064580] [097/142] (713s left) kms_plane_scaling (planes-downscale-factor-0-5)
[300.311442] Starting subtest: planes-downscale-factor-0-5
[300.319110] Starting dynamic subtest: pipe-A-DP-1
[300.665222] Dynamic subtest pipe-A-DP-1: SUCCESS (0.350s)
[300.692419] Starting dynamic subtest: pipe-B-DP-1
[301.050879] Dynamic subtest pipe-B-DP-1: SUCCESS (0.378s)
[301.080855] Starting dynamic subtest: pipe-C-DP-1
[301.151192] Dynamic subtest pipe-C-DP-1: SKIP (0.093s)
[301.153564] Subtest planes-downscale-factor-0-5: SUCCESS (0.839s)
[301.559971] [098/142] (711s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[301.708776] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[301.816257] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[301.910157] [099/142] (711s left) gem_exec_store (basic)
[302.079048] Starting subtest: basic
[302.140922] Subtest basic: SUCCESS (0.062s)
[302.342746] [100/142] (710s left) gem_exec_fence (concurrent)
[302.645189] Starting subtest: concurrent
[302.647565] Starting dynamic subtest: rcs0
[302.686177] Dynamic subtest rcs0: SUCCESS (0.039s)
[302.708678] Starting dynamic subtest: bcs0
[302.724672] Dynamic subtest bcs0: SUCCESS (0.036s)
[302.747542] Starting dynamic subtest: vcs0
[302.761960] Dynamic subtest vcs0: SUCCESS (0.035s)
[302.783908] Starting dynamic subtest: vecs0
[302.797837] Dynamic subtest vecs0: SUCCESS (0.032s)
[302.800178] Subtest concurrent: SUCCESS (0.154s)
[303.478773] [101/142] (709s left) gem_exec_flush (basic-wb-rw-before-default)
[303.647135] Starting subtest: basic-wb-rw-before-default
[309.122985] Subtest basic-wb-rw-before-default: SUCCESS (5.477s)
[309.329519] [102/142] (703s left) perf_pmu (module-unload)
[309.504803] Starting subtest: module-unload
[347.675215] Subtest module-unload: SUCCESS (38.169s)
[347.713651] [103/142] (665s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[351.050145] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[352.276299] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.226s)
[352.627678] [104/142] (660s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[352.894175] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[352.897984] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[352.992806] [105/142] (660s left) gem_ppgtt (shrink-vs-evict-any)
[353.162293] Starting subtest: shrink-vs-evict-any
[358.276770] Subtest shrink-vs-evict-any: SUCCESS (5.112s)
[358.363601] [106/142] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[358.613289] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[358.617130] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[358.710953] [107/142] (654s left) gem_eio (in-flight-internal-immediate)
[358.883035] Starting subtest: in-flight-internal-immediate
[360.236981] Subtest in-flight-internal-immediate: SUCCESS (1.354s)
[360.445252] [108/142] (653s left) gem_exec_parallel (basic)
[360.614137] Starting subtest: basic
[360.616382] Starting dynamic subtest: rcs0
[363.883629] Dynamic subtest rcs0: SUCCESS (3.268s)
[363.909953] Starting dynamic subtest: bcs0
[367.247210] Dynamic subtest bcs0: SUCCESS (3.358s)
[367.268311] Starting dynamic subtest: vcs0
[370.443857] Dynamic subtest vcs0: SUCCESS (3.194s)
[370.465203] Starting dynamic subtest: vecs0
[373.589775] Dynamic subtest vecs0: SUCCESS (3.143s)
[373.592164] Subtest basic: SUCCESS (12.977s)
[373.796384] [109/142] (639s left) v3d/v3d_submit_csd (single-in-sync)
[374.005591] Subtest single-in-sync: SKIP (0.000s)
[374.079156] [110/142] (639s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[374.336286] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[374.340201] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.444690] [111/142] (639s left) kms_cursor_crc (cursor-offscreen-64x64)
[374.694661] Starting subtest: cursor-offscreen-64x64
[374.708792] Starting dynamic subtest: pipe-A-DP-1
[377.205085] Dynamic subtest pipe-A-DP-1: SUCCESS (2.491s)
[377.293109] Starting dynamic subtest: pipe-C-DP-1
[379.872824] Dynamic subtest pipe-C-DP-1: SUCCESS (2.598s)
[379.875286] Subtest cursor-offscreen-64x64: SUCCESS (5.176s)
[380.246729] [112/142] (633s left) i915_pm_rpm (dpms-mode-unset-non-lpsp)
[382.069114] Starting subtest: dpms-mode-unset-non-lpsp
[383.363747] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.295s)
[383.847062] [113/142] (629s left) kms_flip (flip-vs-rmfb-interruptible)
[384.088184] Starting subtest: flip-vs-rmfb-interruptible
[384.096912] Starting dynamic subtest: A-DP1
[394.591774] Dynamic subtest A-DP1: SUCCESS (10.496s)
[394.620629] Starting dynamic subtest: B-DP1
[405.005879] Dynamic subtest B-DP1: SUCCESS (10.410s)
[405.032404] Starting dynamic subtest: C-DP1
[415.420054] Dynamic subtest C-DP1: SUCCESS (10.410s)
[415.426211] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.335s)
[415.845880] [114/142] (597s left) kms_psr (suspend)
[415.996608] Subtest suspend: SKIP (0.000s)
[416.043675] [115/142] (597s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[416.285169] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[416.290100] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[416.853435] [116/142] (597s left) gem_exec_schedule (semaphore-noskip)
[417.033247] Starting subtest: semaphore-noskip
[417.281766] Subtest semaphore-noskip: SUCCESS (0.248s)
[417.652265] [117/142] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[417.907769] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[417.911736] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.000817] [118/142] (596s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[418.243597] Starting subtest: blocking-absolute-wf_vblank-interruptible
[418.249235] Starting dynamic subtest: A-DP1
[428.890731] Dynamic subtest A-DP1: SUCCESS (10.642s)
[428.917406] Starting dynamic subtest: B-DP1
[439.484683] Dynamic subtest B-DP1: SUCCESS (10.591s)
[439.513564] Starting dynamic subtest: C-DP1
[449.931945] Dynamic subtest C-DP1: SUCCESS (10.441s)
[449.935789] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.689s)
[450.348593] [119/142] (563s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[450.805772] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[450.811778] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[451.152132] [120/142] (562s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[451.418663] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[451.420913] Starting dynamic subtest: pipe-A-valid-mode
[451.490360] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[451.494387] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.096s)
[451.808775] [121/142] (562s left) kms_frontbuffer_tracking (basic)
[452.054160] Starting subtest: basic
[454.933340] Subtest basic: SUCCESS (2.883s)
[455.061805] [122/142] (559s left) gem_create (create-size-update)
[455.204687] Starting subtest: create-size-update
[455.206773] Subtest create-size-update: SUCCESS (0.000s)
[455.446982] [123/142] (558s left) vc4/vc4_purgeable_bo (mark-willneed)
[455.653541] Subtest mark-willneed: SKIP (0.000s)
[455.727130] [124/142] (558s left) api_intel_bb (purge-bb)
[455.876825] Starting subtest: purge-bb
[455.883865] Subtest purge-bb: SUCCESS (0.005s)
[455.992380] [125/142] (558s left) syncobj_timeline (invalid-transfer-non-existent-point)
[456.138298] Starting subtest: invalid-transfer-non-existent-point
[456.141155] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[456.226363] [126/142] (558s left) gem_exec_reloc (basic-cpu-noreloc)
[456.377987] Starting subtest: basic-cpu-noreloc
[456.389073] Subtest basic-cpu-noreloc: SUCCESS (0.011s)
[456.577951] [127/142] (557s left) gem_lmem_swapping (heavy-random)
[456.730774] Subtest heavy-random: SKIP (0.000s)
[456.795766] [128/142] (557s left) kms_plane (plane-panning-bottom-right-suspend)
[457.041120] Starting subtest: plane-panning-bottom-right-suspend
[457.043369] Starting dynamic subtest: pipe-A-planes
[474.261770] Dynamic subtest pipe-A-planes: SUCCESS (2.373s)
[474.288189] Starting dynamic subtest: pipe-B-planes
[492.281010] Dynamic subtest pipe-B-planes: SUCCESS (2.475s)
[492.283219] Subtest plane-panning-bottom-right-suspend: SUCCESS (4.859s)
[497.620735] [129/142] (552s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[497.888176] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[497.896009] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[498.054752] [130/142] (551s left) kms_addfb_basic (bad-pitch-0)
[498.297653] Starting subtest: bad-pitch-0
[498.320671] Subtest bad-pitch-0: SUCCESS (0.000s)
[498.475734] [131/142] (551s left) kms_scaling_modes (scaling-mode-center)
[498.796364] Starting subtest: scaling-mode-center
[498.841548] Subtest scaling-mode-center: SKIP (0.001s)
[498.936811] [132/142] (551s left) kms_big_fb (linear-addfb)
[499.253345] Starting subtest: linear-addfb
[499.255547] Subtest linear-addfb: SUCCESS (0.000s)
[499.344796] [133/142] (550s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[499.489438] Starting subtest: invalid-multi-wait-all-unsubmitted
[499.491869] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[499.579418] [134/142] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[499.837018] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[502.031950] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.200s)
[502.197692] [135/142] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[502.451864] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[504.666008] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.219s)
[504.811666] [136/142] (545s left) syncobj_timeline (invalid-signal-zero-handles)
[504.960768] Starting subtest: invalid-signal-zero-handles
[504.963070] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[505.060789] [137/142] (545s left) v3d/v3d_job_submission (array-job-submission)
[505.267621] Subtest array-job-submission: SKIP (0.000s)
[505.344612] [138/142] (545s left) gem_exec_reloc (basic-scanout)
[505.600406] Starting subtest: basic-scanout
[505.602746] Starting dynamic subtest: rcs0
[505.847882] Dynamic subtest rcs0: SUCCESS (0.248s)
[505.875140] Starting dynamic subtest: bcs0
[506.018470] Dynamic subtest bcs0: SUCCESS (0.164s)
[506.043752] Starting dynamic subtest: vcs0
[506.180771] Dynamic subtest vcs0: SUCCESS (0.164s)
[506.209302] Starting dynamic subtest: vecs0
[506.351100] Dynamic subtest vecs0: SUCCESS (0.164s)
[506.353129] Subtest basic-scanout: SUCCESS (0.751s)
[506.479480] [139/142] (544s left) kms_flip (2x-flip-vs-panning-vs-hang)
[506.706401] Starting subtest: 2x-flip-vs-panning-vs-hang
[506.716131] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.003s)
[506.831340] [140/142] (543s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_ccs)
[507.304116] Subtest pipe-D-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[507.630134] [141/142] (542s left) sysfs_timeslice_duration (idempotent)
[507.783286] Starting subtest: idempotent
[507.785638] Starting dynamic subtest: vecs0
[507.788162] Dynamic subtest vecs0: SUCCESS (0.002s)
[507.817709] Starting dynamic subtest: vcs0
[507.819892] Dynamic subtest vcs0: SUCCESS (0.002s)
[507.845426] Starting dynamic subtest: bcs0
[507.848092] Dynamic subtest bcs0: SUCCESS (0.002s)
[507.872674] Starting dynamic subtest: rcs0
[507.875148] Dynamic subtest rcs0: SUCCESS (0.002s)
[507.877298] Subtest idempotent: SUCCESS (0.020s)
[507.914479] [142/142] (542s left) gem_exec_nop (basic-sequential)
[508.085312] Starting subtest: basic-sequential
[511.211882] Subtest basic-sequential: SUCCESS (3.125s)
[511.439731] Closing watchdogs
Done.