[42.416559] Initializing watchdogs
[42.416814]   /dev/watchdog0
[42.452541] [001/142] (960s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[42.999147] Starting subtest: pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[43.037725] Subtest pipe-A-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[43.620306] [002/142] (959s left) syncobj_wait (multi-wait-submitted)
[43.929043] Starting subtest: multi-wait-submitted
[44.025288] Subtest multi-wait-submitted: SUCCESS (0.109s)
[44.155464] [003/142] (958s left) gem_pxp (create-valid-protected-context)
[47.162530] Subtest create-valid-protected-context: SKIP (0.000s)
[47.306483] [004/142] (955s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[47.718663] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[47.760041] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[47.870645] [005/142] (955s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[48.331170] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[48.372182] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[48.470422] [006/142] (954s left) dumb_buffer (map-uaf)
[48.770939] Starting subtest: map-uaf
[48.809105] Subtest map-uaf: SUCCESS (0.066s)
[48.935806] [007/142] (954s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[49.295422] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[49.314648] Starting dynamic subtest: pipe-A-valid-mode
[50.035440] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.730s)
[50.057288] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (0.732s)
[50.400141] [008/142] (953s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted)
[50.725977] Starting subtest: invalid-multi-wait-available-unsubmitted
[50.745526] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s)
[50.852182] [009/142] (952s left) gem_bad_reloc (negative-reloc-bltcopy)
[51.149419] Starting subtest: negative-reloc-bltcopy
[54.813621] Subtest negative-reloc-bltcopy: SUCCESS (3.506s)
[55.086335] [010/142] (948s left) gem_exec_balancer (bonded-chain)
[55.384442] Starting subtest: bonded-chain
[59.246254] Subtest bonded-chain: SUCCESS (3.693s)
[63.000400] [011/142] (940s left) gem_mmap_wc (write-read)
[63.296674] Starting subtest: write-read
[63.318311] Subtest write-read: SUCCESS (0.031s)
[63.431386] [012/142] (940s left) kms_psr (no_drrs)
[63.752402] Subtest no_drrs: SKIP (0.000s)
[63.837386] [013/142] (940s left) gem_exec_schedule (preempt-other-chain)
[64.295954] Starting subtest: preempt-other-chain
[64.317802] Starting dynamic subtest: rcs0
[64.339621] Dynamic subtest rcs0: SUCCESS (0.113s)
[64.376531] Starting dynamic subtest: bcs0
[64.398246] Dynamic subtest bcs0: SUCCESS (0.109s)
[64.433426] Starting dynamic subtest: vcs0
[64.472481] Dynamic subtest vcs0: SUCCESS (0.109s)
[64.509302] Starting dynamic subtest: vecs0
[64.576595] Dynamic subtest vecs0: SUCCESS (0.104s)
[64.597445] Subtest preempt-other-chain: SUCCESS (0.438s)
[64.953240] [014/142] (939s left) gem_ctx_shared (q-in-order)
[65.250211] Starting subtest: Q-in-order
[65.268765] Starting dynamic subtest: rcs0
[65.483821] Dynamic subtest rcs0: SUCCESS (0.240s)
[65.516785] Starting dynamic subtest: bcs0
[65.592465] Dynamic subtest bcs0: SUCCESS (0.106s)
[65.629285] Starting dynamic subtest: vcs0
[65.684387] Dynamic subtest vcs0: SUCCESS (0.092s)
[65.720183] Starting dynamic subtest: vecs0
[65.769938] Dynamic subtest vecs0: SUCCESS (0.087s)
[65.789092] Subtest Q-in-order: SUCCESS (0.527s)
[66.018244] [015/142] (938s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[66.902223] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[67.244538] [016/142] (937s left) gem_exec_whisper (basic-contexts-priority-all)
[67.616458] Starting subtest: basic-contexts-priority-all
[91.556592] Subtest basic-contexts-priority-all: SUCCESS (23.952s)
[91.753693] [017/142] (912s left) vc4/vc4_tiling (set-bad-handle)
[92.094417] Subtest set-bad-handle: SKIP (0.000s)
[92.178887] [018/142] (912s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs)
[92.726863] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs
[92.782655] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[93.288624] [019/142] (911s left) drm_fdinfo (most-busy-idle-check-all)
[93.619902] Starting subtest: most-busy-idle-check-all
[93.638966] Starting dynamic subtest: rcs0
[94.221473] Dynamic subtest rcs0: SUCCESS (0.622s)
[94.262550] Starting dynamic subtest: bcs0
[94.845379] Dynamic subtest bcs0: SUCCESS (0.626s)
[94.880927] Starting dynamic subtest: vcs0
[95.468348] Dynamic subtest vcs0: SUCCESS (0.621s)
[95.506762] Starting dynamic subtest: vecs0
[96.091577] Dynamic subtest vecs0: SUCCESS (0.627s)
[96.110886] Subtest most-busy-idle-check-all: SUCCESS (2.497s)
[96.194495] [020/142] (908s left) kms_universal_plane (universal-plane-pipe-c-sanity)
[96.560142] Starting subtest: universal-plane-pipe-C-sanity
[97.531282] Subtest universal-plane-pipe-C-sanity: SUCCESS (0.959s)
[97.879369] [021/142] (906s left) v3d/v3d_submit_cl (bad-multisync-in-sync)
[98.220939] Subtest bad-multisync-in-sync: SKIP (0.000s)
[98.328233] [022/142] (906s left) gem_exec_schedule (u-fairslice-all)
[98.782142] Starting subtest: u-fairslice-all
[100.757487] Subtest u-fairslice-all: SUCCESS (2.121s)
[101.126305] [023/142] (903s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[101.489128] Starting subtest: FB-8BPC-Vs-Panel-8BPC
[101.509887] Starting dynamic subtest: pipe-A-DP-1
[101.913141] Dynamic subtest pipe-A-DP-1: SUCCESS (0.412s)
[101.932403] Subtest FB-8BPC-Vs-Panel-8BPC: SUCCESS (0.413s)
[102.265081] [024/142] (902s left) prime_busy (before)
[102.562468] Starting subtest: before
[102.585134] Starting dynamic subtest: rcs0
[102.606701] Dynamic subtest rcs0: SUCCESS (0.011s)
[102.643204] Starting dynamic subtest: bcs0
[102.663153] Dynamic subtest bcs0: SUCCESS (0.020s)
[102.697065] Starting dynamic subtest: vcs0
[102.716078] Dynamic subtest vcs0: SUCCESS (0.023s)
[102.752895] Starting dynamic subtest: vecs0
[102.773464] Dynamic subtest vecs0: SUCCESS (0.018s)
[102.795747] Subtest before: SUCCESS (0.202s)
[102.901871] [025/142] (902s left) kms_atomic_interruptible (legacy-cursor)
[103.261688] Starting subtest: legacy-cursor
[103.280562] Starting dynamic subtest: DP-1-pipe-A
[109.831730] Dynamic subtest DP-1-pipe-A: SUCCESS (6.555s)
[109.854315] Subtest legacy-cursor: SUCCESS (6.558s)
[110.187747] [026/142] (895s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs)
[110.893613] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs
[110.935912] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[111.268817] [027/142] (894s left) i915_suspend (sysfs-reader)
[111.566214] Starting subtest: sysfs-reader
[130.096303] Subtest sysfs-reader: SUCCESS (3.649s)
[135.265615] [028/142] (890s left) gem_exec_params (invalid-ring2)
[135.570208] Starting subtest: invalid-ring2
[135.591903] Subtest invalid-ring2: SUCCESS (0.001s)
[135.684653] [029/142] (889s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[136.160076] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[136.489499] [030/142] (889s left) i915_pm_rpm (modeset-non-lpsp-stress-no-wait)
[138.570800] Starting subtest: modeset-non-lpsp-stress-no-wait
[144.546286] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (5.962s)
[144.803030] [031/142] (880s left) v3d/v3d_get_param (base-params)
[145.175209] Subtest base-params: SKIP (0.000s)
[145.282648] [032/142] (880s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[145.844940] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[145.888756] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[146.382949] [033/142] (879s left) perf (create-destroy-userspace-config)
[146.869141] Starting subtest: create-destroy-userspace-config
[146.954354] Subtest create-destroy-userspace-config: SUCCESS (0.089s)
[147.063524] [034/142] (878s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[147.498228] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[147.537261] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[147.652589] [035/142] (878s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[148.046130] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[149.163403] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.136s)
[149.637978] [036/142] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[150.079041] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[150.116646] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[150.229080] [037/142] (876s left) kms_flip (bo-too-big)
[150.591974] Starting subtest: bo-too-big
[150.610979] Starting dynamic subtest: A-DP1
[153.730468] Dynamic subtest A-DP1: SUCCESS (2.966s)
[153.811639] Starting dynamic subtest: B-DP1
[156.682577] Dynamic subtest B-DP1: SUCCESS (2.950s)
[156.725208] Starting dynamic subtest: C-DP1
[159.551525] Dynamic subtest C-DP1: SUCCESS (2.880s)
[159.573068] Subtest bo-too-big: SUCCESS (8.805s)
[160.038496] [038/142] (866s left) i915_pm_rpm (dpms-lpsp)
[161.896138] Starting subtest: dpms-lpsp
[161.936348] Subtest dpms-lpsp: SKIP (0.000s)
[162.417420] [039/142] (864s left) i915_query (query-regions-unallocated)
[162.713948] Starting subtest: query-regions-unallocated
[162.733181] Subtest query-regions-unallocated: SUCCESS (0.000s)
[162.847336] [040/142] (863s left) kms_hdr (bpc-switch-dpms)
[163.215355] Starting subtest: bpc-switch-dpms
[165.347646] Starting dynamic subtest: pipe-A-DP-1
[166.766088] Dynamic subtest pipe-A-DP-1: SUCCESS (1.394s)
[166.792068] Subtest bpc-switch-dpms: SUCCESS (3.535s)
[167.181882] [041/142] (859s left) gem_lmem_swapping (massive-random)
[167.506607] Subtest massive-random: SKIP (0.000s)
[167.616505] [042/142] (859s left) syncobj_wait (invalid-wait-bad-flags)
[167.909064] Starting subtest: invalid-wait-bad-flags
[167.928029] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[168.038952] [043/142] (858s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[168.403607] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[168.425967] Starting dynamic subtest: pipe-A-DP-1
[168.742478] Dynamic subtest pipe-A-DP-1: SUCCESS (0.323s)
[168.784359] Starting dynamic subtest: pipe-B-DP-1
[169.109188] Dynamic subtest pipe-B-DP-1: SUCCESS (0.361s)
[169.171342] Starting dynamic subtest: pipe-C-DP-1
[169.245793] Dynamic subtest pipe-C-DP-1: SKIP (0.098s)
[169.266177] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.794s)
[169.636750] [044/142] (857s left) kms_busy (extended-pageflip-hang-newfb)
[170.021010] Starting subtest: extended-pageflip-hang-newfb
[170.040421] Starting dynamic subtest: pipe-A
[173.994311] Dynamic subtest pipe-A: SUCCESS (3.980s)
[174.037210] Starting dynamic subtest: pipe-C
[178.022632] Dynamic subtest pipe-C: SUCCESS (3.965s)
[178.044391] Subtest extended-pageflip-hang-newfb: SUCCESS (7.956s)
[178.355907] [045/142] (848s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[178.650896] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[178.671014] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[178.778764] [046/142] (848s left) gem_userptr_blits (unsync-unmap)
[179.159962] Subtest unsync-unmap: SKIP (0.000s)
[179.270614] [047/142] (848s left) kms_addfb_basic (bad-pitch-63)
[179.573461] Starting subtest: bad-pitch-63
[179.592784] Subtest bad-pitch-63: SUCCESS (0.000s)
[179.789379] [048/142] (847s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[180.428830] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs
[180.471144] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[180.865326] [049/142] (846s left) syncobj_timeline (single-wait-signaled)
[181.153791] Starting subtest: single-wait-signaled
[181.174997] Subtest single-wait-signaled: SUCCESS (0.001s)
[181.285919] [050/142] (846s left) core_auth (getclient-master-drop)
[181.566951] Starting subtest: getclient-master-drop
[181.606147] Subtest getclient-master-drop: SUCCESS (0.005s)
[181.719185] [051/142] (846s left) i915_fb_tiling
[182.133743] [052/142] (845s left) kms_ccs (pipe-d-bad-rotation-90-yf_tiled_ccs)
[182.894260] Subtest pipe-D-bad-rotation-90-yf_tiled_ccs: SKIP (0.000s)
[183.232955] [053/142] (844s left) gen7_exec_parse (oacontrol-tracking)
[183.555601] Subtest oacontrol-tracking: SKIP (0.000s)
[183.662369] [054/142] (844s left) gem_mmap_wc (pf-nonblock)
[183.938269] Starting subtest: pf-nonblock
[183.957198] Subtest pf-nonblock: SUCCESS (0.007s)
[184.083463] [055/142] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[184.528421] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[184.568739] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[184.682240] [056/142] (843s left) gem_userptr_blits (vma-merge)
[185.051267] Starting subtest: vma-merge
[205.871110] Subtest vma-merge: FAIL (20.558s)
[205.960232] [057/142] (822s left) gem_mmap_wc (write)
[206.254043] Starting subtest: write
[206.412285] Subtest write: SUCCESS (0.190s)
[206.531130] [058/142] (822s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs)
[207.121229] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs
[207.184650] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[207.631272] [059/142] (821s left) gem_ctx_param (invalid-size-get)
[207.925903] Starting subtest: invalid-size-get
[207.947008] Subtest invalid-size-get: SUCCESS (0.000s)
[208.055181] [060/142] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[208.507714] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[208.545290] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[208.652687] [061/142] (820s left) kms_cursor_crc (cursor-onscreen-256x256)
[209.054114] Starting subtest: cursor-onscreen-256x256
[209.080521] Starting dynamic subtest: pipe-A-DP-1
[211.419203] Dynamic subtest pipe-A-DP-1: SUCCESS (2.349s)
[211.522585] Starting dynamic subtest: pipe-C-DP-1
[214.123141] Dynamic subtest pipe-C-DP-1: SUCCESS (2.642s)
[214.143057] Subtest cursor-onscreen-256x256: SUCCESS (5.067s)
[214.497916] [062/142] (814s left) gem_exec_fair (basic-pace-solo)
[214.976382] Starting subtest: basic-pace-solo
[214.997266] Starting dynamic subtest: rcs0
[219.601179] Dynamic subtest rcs0: SUCCESS (4.812s)
[219.622987] Subtest basic-pace-solo: SUCCESS (4.814s)
[219.835748] [063/142] (809s left) gem_exec_fence (nb-await)
[220.265233] Starting subtest: nb-await
[220.287277] Starting dynamic subtest: rcs0
[220.343953] Dynamic subtest rcs0: SUCCESS (0.074s)
[220.388330] Starting dynamic subtest: bcs0
[220.428760] Dynamic subtest bcs0: SUCCESS (0.067s)
[220.472636] Starting dynamic subtest: vcs0
[220.491955] Dynamic subtest vcs0: SUCCESS (0.071s)
[220.538829] Starting dynamic subtest: vecs0
[220.560790] Dynamic subtest vecs0: SUCCESS (0.069s)
[220.582226] Subtest nb-await: SUCCESS (0.292s)
[221.253898] [064/142] (808s left) gem_softpin (noreloc)
[221.555211] Starting subtest: noreloc
[227.255765] Subtest noreloc: SUCCESS (5.542s)
[227.350833] [065/142] (802s left) sysfs_heartbeat_interval (idempotent)
[227.645583] Starting subtest: idempotent
[227.667149] Starting dynamic subtest: vecs0
[227.688697] Dynamic subtest vecs0: SUCCESS (0.003s)
[227.730458] Starting dynamic subtest: vcs0
[227.751482] Dynamic subtest vcs0: SUCCESS (0.005s)
[227.790342] Starting dynamic subtest: bcs0
[227.809397] Dynamic subtest bcs0: SUCCESS (0.003s)
[227.847786] Starting dynamic subtest: rcs0
[227.866826] Dynamic subtest rcs0: SUCCESS (0.004s)
[227.888319] Subtest idempotent: SUCCESS (0.023s)
[227.984152] [066/142] (801s left) i915_hwmon (hwmon-read)
[228.299131] Subtest hwmon-read: SKIP (0.000s)
[228.388041] [067/142] (801s left) v3d/v3d_wait_bo (bad-pad)
[228.722699] Subtest bad-pad: SKIP (0.000s)
[228.818629] [068/142] (800s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[229.256795] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[229.298251] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[229.411698] [069/142] (800s left) kms_psr (psr2_no_drrs)
[229.722898] Subtest psr2_no_drrs: SKIP (0.000s)
[229.812392] [070/142] (800s left) gen3_render_tiledx_blits
[230.218972] [071/142] (799s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[230.504356] Starting subtest: invalid-signal-one-illegal-handle
[230.524683] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[230.620980] [072/142] (799s left) gem_exec_capture (capture-invisible)
[230.918236] Starting subtest: capture-invisible
[230.940231] Starting dynamic subtest: smem0
[230.980465] Dynamic subtest smem0: SKIP (0.000s)
[231.018154] Subtest capture-invisible: SKIP (0.002s)
[231.111457] [073/142] (799s left) kms_lease (lease_invalid_crtc)
[231.476600] Starting subtest: lease_invalid_crtc
[231.497402] Starting dynamic subtest: pipe-A-DP-1
[231.517270] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[231.557172] Starting dynamic subtest: pipe-B-DP-1
[231.575947] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[231.614144] Starting dynamic subtest: pipe-C-DP-1
[231.634154] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[231.655806] Subtest lease_invalid_crtc: SUCCESS (0.010s)
[231.772425] [074/142] (798s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[232.129864] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[232.169207] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.003s)
[232.289160] [075/142] (798s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[232.685678] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[232.771238] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.019s)
[232.884308] [076/142] (797s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[233.486820] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[233.527821] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.005s)
[233.954849] [077/142] (796s left) gem_ctx_persistence (engines-hostile)
[234.252298] Starting subtest: engines-hostile
[234.271255] Starting dynamic subtest: rcs0
[234.332075] Dynamic subtest rcs0: SUCCESS (0.090s)
[234.373211] Starting dynamic subtest: bcs0
[234.417454] Dynamic subtest bcs0: SUCCESS (0.087s)
[234.457041] Starting dynamic subtest: vcs0
[234.496095] Dynamic subtest vcs0: SUCCESS (0.086s)
[234.534469] Starting dynamic subtest: vecs0
[234.601028] Dynamic subtest vecs0: SUCCESS (0.087s)
[234.622154] Subtest engines-hostile: SUCCESS (0.358s)
[234.730519] [078/142] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[235.173266] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[237.164499] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.073s)
[237.335619] [079/142] (793s left) kms_flip (2x-absolute-wf_vblank)
[237.692014] Starting subtest: 2x-absolute-wf_vblank
[237.730447] Subtest 2x-absolute-wf_vblank: SKIP (0.003s)
[237.855837] [080/142] (793s left) gem_ccs (block-multicopy-inplace)
[238.176382] Subtest block-multicopy-inplace: SKIP (0.000s)
[238.267240] [081/142] (792s left) kms_psr (psr2_sprite_render)
[238.579646] Subtest psr2_sprite_render: SKIP (0.000s)
[238.669028] [082/142] (792s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[239.024613] Starting subtest: flip-vs-dpms-off-vs-modeset
[239.047507] Starting dynamic subtest: A-DP1
[240.288524] Dynamic subtest A-DP1: SUCCESS (1.274s)
[240.331084] Starting dynamic subtest: B-DP1
[241.382028] Dynamic subtest B-DP1: SUCCESS (1.104s)
[241.423212] Starting dynamic subtest: C-DP1
[242.504555] Dynamic subtest C-DP1: SUCCESS (1.120s)
[242.526919] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (3.511s)
[242.897641] [083/142] (788s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[243.352367] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[243.391158] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[243.512497] [084/142] (787s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[243.883612] Starting subtest: plane-all-modeset-transition-fencing
[243.904606] Starting dynamic subtest: pipe-A-DP-1
[301.596159] Dynamic subtest pipe-A-DP-1: SUCCESS (57.720s)
[301.767256] Starting dynamic subtest: pipe-B-DP-1
[359.376061] Dynamic subtest pipe-B-DP-1: SUCCESS (57.680s)
[359.497911] Subtest plane-all-modeset-transition-fencing: SUCCESS (115.604s)
[359.880989] [085/142] (671s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[360.393985] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[360.447396] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[360.999593] [086/142] (670s left) gem_eio (in-flight-suspend)
[367.365842] Starting subtest: in-flight-suspend
[400.178721] Subtest in-flight-suspend: SUCCESS (8.231s)
[405.583873] [087/142] (661s left) kms_plane_scaling (plane-upscale-with-modifiers-factor-0-25)
[405.943387] Starting subtest: plane-upscale-with-modifiers-factor-0-25
[405.962474] Starting dynamic subtest: pipe-A-DP-1
[406.501789] Dynamic subtest pipe-A-DP-1: SUCCESS (0.549s)
[406.569641] Starting dynamic subtest: pipe-B-DP-1
[407.342717] Dynamic subtest pipe-B-DP-1: SUCCESS (0.835s)
[407.395517] Starting dynamic subtest: pipe-C-DP-1
[408.008033] Dynamic subtest pipe-C-DP-1: SUCCESS (0.661s)
[408.027414] Subtest plane-upscale-with-modifiers-factor-0-25: SUCCESS (2.060s)
[408.457454] [088/142] (659s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[408.912224] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[408.950121] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[409.066644] [089/142] (658s left) kms_ccs (pipe-d-missing-ccs-buffer-yf_tiled_ccs)
[409.815598] Subtest pipe-D-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[410.165150] [090/142] (657s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[410.922012] Subtest pipe-D-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[411.264265] [091/142] (656s left) prime_busy (hang)
[411.550692] Starting subtest: hang
[411.572897] Starting dynamic subtest: rcs0
[418.451642] Dynamic subtest rcs0: SUCCESS (6.901s)
[418.492003] Starting dynamic subtest: bcs0
[425.490781] Dynamic subtest bcs0: SUCCESS (7.035s)
[425.530912] Starting dynamic subtest: vcs0
[432.469769] Dynamic subtest vcs0: SUCCESS (6.974s)
[432.511640] Starting dynamic subtest: vecs0
[439.443767] Dynamic subtest vecs0: SUCCESS (6.972s)
[439.465478] Subtest hang: SUCCESS (27.895s)
[439.579234] [092/142] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[440.027177] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[440.064788] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[440.180349] [093/142] (627s left) api_intel_allocator (two-level-inception)
[440.476776] Starting subtest: two-level-inception
[445.976581] Subtest two-level-inception: SUCCESS (5.527s)
[446.110869] [094/142] (622s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[446.400056] Starting subtest: multi-wait-for-submit-available-submitted
[446.419124] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.002s)
[446.540087] [095/142] (621s left) prime_self_import (basic-with_one_bo)
[446.814568] Starting subtest: basic-with_one_bo
[446.857172] Subtest basic-with_one_bo: SUCCESS (0.008s)
[446.969265] [096/142] (621s left) sw_sync (alloc_merge_fence)
[447.251819] Starting subtest: alloc_merge_fence
[447.271028] Subtest alloc_merge_fence: SUCCESS (0.001s)
[447.383490] [097/142] (621s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[447.740335] Starting subtest: plane-use-after-nonblocking-unbind
[447.762789] Starting dynamic subtest: pipe-A-DP-1
[447.898629] Dynamic subtest pipe-A-DP-1: SUCCESS (0.146s)
[448.033453] Starting dynamic subtest: pipe-B-DP-1
[448.574342] Dynamic subtest pipe-B-DP-1: SUCCESS (0.577s)
[448.667030] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.928s)
[449.060401] [098/142] (619s left) kms_vblank (pipe-a-query-busy-hang)
[449.427331] Starting subtest: pipe-A-query-busy-hang
[456.660999] Subtest pipe-A-query-busy-hang: SUCCESS (7.108s)
[456.941369] [099/142] (611s left) kms_vblank (pipe-d-wait-forked-hang)
[457.320645] Subtest pipe-D-wait-forked-hang: SKIP (0.000s)
[457.518685] [100/142] (611s left) gem_exec_gttfill (multigpu-basic)
[457.957634] Starting subtest: multigpu-basic
[458.012543] Subtest multigpu-basic: SKIP (0.000s)
[458.142571] [101/142] (610s left) gem_fence_thrash (bo-write-verify-x)
[458.444819] Starting subtest: bo-write-verify-x
[459.614570] Subtest bo-write-verify-x: SUCCESS (1.195s)
[459.735677] [102/142] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[460.178913] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[462.680198] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.584s)
[462.854861] [103/142] (606s left) gem_mmap_wc (read-write)
[463.126737] Starting subtest: read-write
[463.148587] Subtest read-write: SUCCESS (0.031s)
[463.269377] [104/142] (605s left) gem_render_copy (linear-to-vebox-y-tiled)
[463.572810] Starting subtest: linear-to-vebox-y-tiled
[463.612510] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[463.788959] [105/142] (605s left) gem_softpin (allocator-basic-reserve)
[464.056764] Starting subtest: allocator-basic-reserve
[464.273240] Subtest allocator-basic-reserve: SUCCESS (0.236s)
[464.434439] [106/142] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[464.833150] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[464.876082] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[464.994256] [107/142] (604s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[465.416930] Starting subtest: psr-rgb101010-draw-mmap-gtt
[465.458820] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[465.572742] [108/142] (604s left) kms_chamelium_edid (hdmi-edid-read)
[466.061396] Subtest hdmi-edid-read: SKIP (0.000s)
[466.388787] [109/142] (603s left) api_intel_allocator (fork-simple-once)
[466.674330] Starting subtest: fork-simple-once
[466.696151] Subtest fork-simple-once: SUCCESS (0.043s)
[466.843800] [110/142] (603s left) core_setmaster_vs_auth
[467.249434] [111/142] (602s left) gem_ctx_bad_destroy (invalid-pad)
[467.545029] Starting subtest: invalid-pad
[467.564082] Subtest invalid-pad: SUCCESS (0.000s)
[467.661936] [112/142] (602s left) vc4/vc4_purgeable_bo (mark-willneed)
[468.017514] Subtest mark-willneed: SKIP (0.000s)
[468.113455] [113/142] (602s left) kms_invalid_mode (int-max-clock)
[468.484758] Starting subtest: int-max-clock
[468.503874] Starting dynamic subtest: DP-1-pipe-A
[468.578772] Dynamic subtest DP-1-pipe-A: SUCCESS (0.103s)
[468.622917] Starting dynamic subtest: DP-1-pipe-B
[468.644918] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[468.686054] Starting dynamic subtest: DP-1-pipe-C
[468.705373] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[468.724352] Subtest int-max-clock: SUCCESS (0.144s)
[468.980094] [114/142] (601s left) kms_vblank (pipe-d-query-busy-hang)
[469.359274] Subtest pipe-D-query-busy-hang: SKIP (0.000s)
[469.558254] [115/142] (600s left) kms_plane (plane-panning-top-left)
[469.928561] Starting subtest: plane-panning-top-left
[469.947819] Starting dynamic subtest: pipe-A-planes
[470.745515] Dynamic subtest pipe-A-planes: SUCCESS (0.802s)
[470.796676] Starting dynamic subtest: pipe-B-planes
[471.847369] Dynamic subtest pipe-B-planes: SUCCESS (1.090s)
[471.869194] Subtest plane-panning-top-left: SUCCESS (1.903s)
[472.235506] [116/142] (598s left) kms_vblank (pipe-a-query-forked-busy)
[472.595291] Starting subtest: pipe-A-query-forked-busy
[475.056208] Subtest pipe-A-query-forked-busy: SUCCESS (2.455s)
[475.430529] [117/142] (595s left) kms_atomic_transition (modeset-transition-fencing)
[475.790117] Starting subtest: modeset-transition-fencing
[475.810074] Starting dynamic subtest: 1x-outputs
[480.663288] Dynamic subtest 1x-outputs: SUCCESS (4.873s)
[480.786114] Subtest modeset-transition-fencing: SUCCESS (4.997s)
[481.169998] [118/142] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[481.629587] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[483.995488] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (2.451s)
[484.188198] [119/142] (586s left) gem_ctx_create (basic-files)
[484.484819] Starting subtest: basic-files
[486.527062] Subtest basic-files: SUCCESS (2.042s)
[486.821148] [120/142] (584s left) gem_mmap_gtt (basic-write-read-distinct)
[487.117909] Starting subtest: basic-write-read-distinct
[487.139777] Subtest basic-write-read-distinct: SUCCESS (0.033s)
[487.282918] [121/142] (583s left) kms_big_fb (linear-32bpp-rotate-270)
[487.686377] Starting subtest: linear-32bpp-rotate-270
[487.770737] Subtest linear-32bpp-rotate-270: SKIP (0.085s)
[487.920898] [122/142] (583s left) gem_mmap (bad-size)
[488.215021] Starting subtest: bad-size
[488.236706] Subtest bad-size: SUCCESS (0.002s)
[488.354273] [123/142] (582s left) kms_cursor_crc (cursor-random-64x21)
[488.720208] Starting subtest: cursor-random-64x21
[488.739210] Starting dynamic subtest: pipe-A-DP-1
[492.523203] Dynamic subtest pipe-A-DP-1: SUCCESS (3.802s)
[492.632006] Starting dynamic subtest: pipe-C-DP-1
[496.762453] Dynamic subtest pipe-C-DP-1: SUCCESS (4.149s)
[496.783469] Subtest cursor-random-64x21: SUCCESS (8.030s)
[497.160827] [124/142] (574s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[497.523319] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[497.543534] Starting dynamic subtest: pipe-A-valid-mode
[497.950842] Dynamic subtest pipe-A-valid-mode: SKIP (0.398s)
[497.988556] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.402s)
[498.358688] [125/142] (573s left) prime_vgem (coherency-gtt)
[498.677878] Starting subtest: coherency-gtt
[498.716064] Subtest coherency-gtt: SKIP (0.000s)
[498.846347] [126/142] (572s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[499.262183] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[499.357047] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[499.504489] [127/142] (572s left) perf (gen12-oa-tlb-invalidate)
[499.913748] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s)
[500.057400] [128/142] (571s left) sw_sync (sync_expired_merge)
[500.343889] Starting subtest: sync_expired_merge
[501.402788] Subtest sync_expired_merge: SUCCESS (1.074s)
[501.541406] [129/142] (570s left) kms_chamelium_color (ctm-0-50)
[501.939418] Subtest ctm-0-50: SKIP (0.000s)
[502.060102] [130/142] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[502.474390] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[502.516139] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[502.635352] [131/142] (569s left) kms_cursor_crc (cursor-alpha-opaque)
[502.994769] Starting subtest: cursor-alpha-opaque
[503.013789] Starting dynamic subtest: pipe-A-DP-1
[503.548845] Dynamic subtest pipe-A-DP-1: SUCCESS (0.550s)
[503.592589] Starting dynamic subtest: pipe-C-DP-1
[504.423577] Dynamic subtest pipe-C-DP-1: SUCCESS (0.853s)
[504.443100] Subtest cursor-alpha-opaque: SUCCESS (1.413s)
[504.832015] [132/142] (567s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[505.210096] Starting subtest: cursorA-vs-flipA-toggle
[516.251100] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.045s)
[516.610426] [133/142] (555s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[517.306430] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[517.348787] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[517.712591] [134/142] (554s left) kms_cursor_legacy (forked-move)
[518.102127] Starting subtest: forked-move
[518.123079] Starting dynamic subtest: pipe-A
[523.559226] Dynamic subtest pipe-A: SUCCESS (5.463s)
[523.610137] Starting dynamic subtest: pipe-B
[529.058894] Dynamic subtest pipe-B: SUCCESS (5.499s)
[529.102344] Starting dynamic subtest: pipe-C
[534.526101] Dynamic subtest pipe-C: SUCCESS (5.463s)
[534.567293] Starting dynamic subtest: all-pipes
[540.030173] Dynamic subtest all-pipes: SUCCESS (5.498s)
[540.051188] Subtest forked-move: SUCCESS (21.935s)
[540.162944] [135/142] (532s left) kms_ccs (pipe-a-missing-ccs-buffer-yf_tiled_ccs)
[540.666790] Starting subtest: pipe-A-missing-ccs-buffer-yf_tiled_ccs
[540.686679] Subtest pipe-A-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.001s)
[541.279417] [136/142] (531s left) gem_ctx_freq (sysfs)
[541.579831] Starting subtest: sysfs
[541.598738] Starting dynamic subtest: gt0
[546.530342] Dynamic subtest gt0: SUCCESS (4.957s)
[546.551390] Subtest sysfs: SUCCESS (4.960s)
[546.644409] [137/142] (526s left) kms_plane_multiple (tiling-y)
[547.009960] Starting subtest: tiling-y
[547.032123] Starting dynamic subtest: pipe-A-DP-1
[548.862399] Dynamic subtest pipe-A-DP-1: SUCCESS (1.838s)
[548.906643] Starting dynamic subtest: pipe-B-DP-1
[550.903811] Dynamic subtest pipe-B-DP-1: SUCCESS (2.049s)
[550.955918] Starting dynamic subtest: pipe-C-DP-1
[552.908445] Dynamic subtest pipe-C-DP-1: SUCCESS (1.974s)
[552.938909] Subtest tiling-y: SUCCESS (5.875s)
[553.515106] [138/142] (519s left) gem_exec_suspend (basic)
[553.860916] Starting subtest: basic
[553.881864] Starting dynamic subtest: smem
[555.215135] Dynamic subtest smem: SUCCESS (1.359s)
[555.234075] Subtest basic: SUCCESS (1.362s)
[555.465866] [139/142] (517s left) kms_setmode (invalid-clone-single-crtc)
[555.765372] Starting subtest: invalid-clone-single-crtc
[555.823846] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[555.940144] [140/142] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[556.362059] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[556.400991] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[556.519546] [141/142] (516s left) gem_exec_reloc (basic-cpu-active)
[556.815933] Starting subtest: basic-cpu-active
[556.938239] Subtest basic-cpu-active: SUCCESS (0.146s)
[557.182211] [142/142] (516s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[557.580793] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[557.664029] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[557.738637] Closing watchdogs
Done.