[50.550395] Initializing watchdogs
[50.550586]   /dev/watchdog0
[50.567665] [001/142] (960s left) kms_psr (primary_mmap_gtt)
[50.746838] Subtest primary_mmap_gtt: SKIP (0.000s)
[50.804759] [002/142] (960s left) kms_psr (psr2_sprite_mmap_cpu)
[50.946279] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[50.984728] [003/142] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[51.241037] Starting subtest: psr-rgb101010-draw-render
[51.245059] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[51.337078] [004/142] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[51.593958] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[51.597774] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[51.669805] [005/142] (959s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[51.932645] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[53.286362] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.354s)
[53.621575] [006/142] (957s left) i915_query (query-topology-known-pci-ids)
[53.768737] Starting subtest: query-topology-known-pci-ids
[53.772690] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[53.851900] [007/142] (957s left) kms_addfb_basic (bad-pitch-1024)
[53.995318] Starting subtest: bad-pitch-1024
[53.997594] Subtest bad-pitch-1024: SUCCESS (0.000s)
[54.185871] [008/142] (957s left) kms_ccs (pipe-a-missing-ccs-buffer-yf_tiled_ccs)
[54.558080] Starting subtest: pipe-A-missing-ccs-buffer-yf_tiled_ccs
[54.560189] Subtest pipe-A-missing-ccs-buffer-yf_tiled_ccs: SUCCESS (0.000s)
[55.006356] [009/142] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[55.257533] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[55.261438] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[55.355700] [010/142] (956s left) kms_addfb_basic (too-high)
[55.594839] Starting subtest: too-high
[55.597018] Subtest too-high: SUCCESS (0.002s)
[55.688483] [011/142] (955s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs)
[56.159918] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs
[56.163971] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[56.488262] [012/142] (954s left) kms_pm_lpsp (kms-lpsp)
[57.733176] Starting subtest: kms-lpsp
[57.735158] Starting dynamic subtest: kms-lpsp-DP
[57.738965] Dynamic subtest kms-lpsp-DP: SKIP (0.000s)
[57.742918] Subtest kms-lpsp: SKIP (0.001s)
[57.888390] [013/142] (953s left) gem_ctx_isolation (nonpriv-switch)
[58.066814] Starting subtest: nonpriv-switch
[58.069018] Starting dynamic subtest: rcs0
[60.533804] Dynamic subtest rcs0: SUCCESS (2.465s)
[60.548760] Starting dynamic subtest: bcs0
[63.751414] Dynamic subtest bcs0: SUCCESS (3.218s)
[63.766606] Starting dynamic subtest: vcs0
[66.176888] Dynamic subtest vcs0: SUCCESS (2.424s)
[66.195910] Starting dynamic subtest: vecs0
[68.565591] Dynamic subtest vecs0: SUCCESS (2.390s)
[68.567837] Subtest nonpriv-switch: SUCCESS (10.498s)
[68.756180] [014/142] (942s left) gem_exec_schedule (smoketest)
[69.069230] Starting subtest: smoketest
[69.071410] Starting dynamic subtest: rcs0
[74.535862] Dynamic subtest rcs0: SUCCESS (5.458s)
[74.555163] Starting dynamic subtest: bcs0
[79.998656] Dynamic subtest bcs0: SUCCESS (5.463s)
[80.014166] Starting dynamic subtest: vcs0
[85.463541] Dynamic subtest vcs0: SUCCESS (5.464s)
[85.482879] Starting dynamic subtest: vecs0
[90.920279] Dynamic subtest vecs0: SUCCESS (5.456s)
[90.922363] Subtest smoketest: SUCCESS (21.844s)
[91.108552] [015/142] (920s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[91.255244] Starting subtest: multi-wait-all-for-submit-signaled
[91.257717] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.002s)
[91.338902] [016/142] (920s left) gem_exec_whisper (basic-fds-all)
[91.507845] Starting subtest: basic-fds-all
[109.656535] Subtest basic-fds-all: SUCCESS (18.146s)
[109.857989] [017/142] (901s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[110.112131] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[110.115944] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[110.207501] [018/142] (901s left) kms_addfb_basic (master-rmfb)
[110.348961] Starting subtest: master-rmfb
[110.351172] Subtest master-rmfb: SUCCESS (0.001s)
[110.540909] [019/142] (901s left) gem_userptr_blits (relocations)
[110.699560] Starting subtest: relocations
[110.703577] Subtest relocations: SKIP (0.004s)
[110.874560] [020/142] (900s left) syncobj_timeline (reset-during-wait-for-submit)
[111.018854] Starting subtest: reset-during-wait-for-submit
[111.122805] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[111.208991] [021/142] (900s left) gem_exec_suspend (basic)
[111.375796] Starting subtest: basic
[111.377955] Starting dynamic subtest: smem
[112.859055] Dynamic subtest smem: SUCCESS (1.483s)
[112.861131] Subtest basic: SUCCESS (1.484s)
[113.059791] [022/142] (898s left) prime_mmap (test_correct)
[113.199437] Starting subtest: test_correct
[113.201491] Starting dynamic subtest: test_correct-smem
[113.206593] Dynamic subtest test_correct-smem: SUCCESS (0.007s)
[113.208788] Subtest test_correct: SUCCESS (0.008s)
[113.307404] [023/142] (898s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[113.752349] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[113.756425] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SKIP (0.001s)
[114.100687] [024/142] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[114.341437] Starting subtest: basic-flip-before-cursor-atomic
[115.426408] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.086s)
[115.775604] [025/142] (896s left) gem_mmap_gtt (basic-small-bo-tiledx)
[115.917786] Starting subtest: basic-small-bo-tiledX
[117.350384] Subtest basic-small-bo-tiledX: SUCCESS (1.433s)
[117.516791] [026/142] (894s left) gem_exec_reloc (basic-concurrent16)
[117.783120] Starting subtest: basic-concurrent16
[123.271260] Subtest basic-concurrent16: SUCCESS (5.486s)
[123.488876] [027/142] (888s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[123.887484] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[123.891786] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s)
[124.293329] [028/142] (887s left) kms_chamelium_edid (dp-edid-read)
[124.620924] Subtest dp-edid-read: SKIP (0.000s)
[124.896170] [029/142] (887s left) v3d/v3d_submit_cl (bad-multisync-extension)
[125.122859] Subtest bad-multisync-extension: SKIP (0.000s)
[125.190604] [030/142] (886s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_mc_ccs)
[125.668955] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[125.982108] [031/142] (886s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[126.127832] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[126.233140] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[126.309561] [032/142] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[126.567760] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[126.572827] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.659979] [033/142] (885s left) kms_rotation_crc (bad-pixel-format)
[126.894353] Starting subtest: bad-pixel-format
[128.658722] Subtest bad-pixel-format: SUCCESS (1.767s)
[129.082889] [034/142] (883s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted)
[129.230755] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted
[129.233177] Subtest invalid-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.002s)
[129.316914] [035/142] (883s left) prime_udl
[129.514820] [036/142] (882s left) gem_softpin (allocator-basic)
[129.667288] Starting subtest: allocator-basic
[129.893774] Subtest allocator-basic: SUCCESS (0.225s)
[130.030241] [037/142] (882s left) vgem_basic (bad-fence)
[130.245456] Starting subtest: bad-fence
[130.247894] Subtest bad-fence: SUCCESS (0.000s)
[130.313507] [038/142] (882s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[130.643389] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[130.934093] [039/142] (881s left) kms_fb_coherency (memset-crc)
[131.177032] Starting subtest: memset-crc
[131.179169] Starting dynamic subtest: mmap-gtt
[131.806681] Dynamic subtest mmap-gtt: SUCCESS (0.629s)
[131.931397] Starting dynamic subtest: mmap-offset-wc
[132.499024] Dynamic subtest mmap-offset-wc: SUCCESS (0.582s)
[132.610952] Starting dynamic subtest: mmap-offset-uc
[133.871479] Dynamic subtest mmap-offset-uc: SUCCESS (1.278s)
[134.002477] Starting dynamic subtest: mmap-legacy-wc
[134.584051] Dynamic subtest mmap-legacy-wc: SUCCESS (0.596s)
[134.682710] Subtest memset-crc: SUCCESS (3.506s)
[135.029935] [040/142] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[135.284767] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[135.288749] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[135.375483] [041/142] (877s left) gem_userptr_blits (unsync-unmap-cycles)
[135.533330] Subtest unsync-unmap-cycles: SKIP (0.000s)
[135.692488] [042/142] (876s left) gem_softpin (evict-active-interruptible)
[135.843490] Starting subtest: evict-active-interruptible
[135.869310] Subtest evict-active-interruptible: SUCCESS (0.024s)
[135.978957] [043/142] (876s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[136.217202] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[136.219547] Starting dynamic subtest: pipe-A-valid-mode
[136.900800] Dynamic subtest pipe-A-valid-mode: SKIP (0.680s)
[136.904797] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.682s)
[137.306972] [044/142] (875s left) kms_content_protection (atomic)
[137.585957] Starting subtest: atomic
[137.618056] Starting dynamic subtest: pipe-A-DP-1
[258.420914] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[259.210817] Closing watchdogs
[259.219362] Initializing watchdogs
[259.219549]   /dev/watchdog0
[259.244354] [045/142] (753s left) gem_pxp (reject-modify-context-protection-off-3)
[261.910533] Subtest reject-modify-context-protection-off-3: SKIP (0.000s)
[261.991566] [046/142] (750s left) gem_userptr_blits (vma-merge)
[262.201391] Starting subtest: vma-merge
[282.430334] Subtest vma-merge: FAIL (20.198s)
[282.491523] [047/142] (730s left) kms_addfb_basic (basic)
[282.632483] Starting subtest: basic
[282.634751] Subtest basic: SUCCESS (0.000s)
[282.821944] [048/142] (730s left) gem_eio (in-flight-external)
[282.995458] Starting subtest: in-flight-external
[283.066781] Subtest in-flight-external: SUCCESS (0.072s)
[283.274793] [049/142] (729s left) kms_flip (busy-flip)
[283.502619] Starting subtest: busy-flip
[283.505084] Starting dynamic subtest: A-DP1
[300.991559] Dynamic subtest A-DP1: SUCCESS (17.487s)
[301.013084] Starting dynamic subtest: B-DP1
[318.322518] Dynamic subtest B-DP1: SUCCESS (17.272s)
[318.341987] Starting dynamic subtest: C-DP1
[335.247385] Dynamic subtest C-DP1: SUCCESS (16.981s)
[335.249671] Subtest busy-flip: SUCCESS (51.749s)
[352.110336] [050/142] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[352.358728] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[352.362706] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[352.456793] [051/142] (660s left) kms_plane_lowres (tiling-yf)
[352.705340] Starting subtest: tiling-yf
[352.707558] Starting dynamic subtest: pipe-A-DP-1
[359.031422] Dynamic subtest pipe-A-DP-1: SUCCESS (6.326s)
[359.165509] Starting dynamic subtest: pipe-B-DP-1
[365.389133] Dynamic subtest pipe-B-DP-1: SUCCESS (6.243s)
[365.525874] Starting dynamic subtest: pipe-C-DP-1
[369.693156] Dynamic subtest pipe-C-DP-1: SUCCESS (4.190s)
[369.791859] Subtest tiling-yf: SUCCESS (17.087s)
[370.270700] [052/142] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[370.533657] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[370.537746] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[370.645745] [053/142] (642s left) kms_cursor_legacy (forked-move)
[370.895923] Starting subtest: forked-move
[370.898276] Starting dynamic subtest: pipe-A
[376.376789] Dynamic subtest pipe-A: SUCCESS (5.480s)
[376.398893] Starting dynamic subtest: pipe-B
[381.847603] Dynamic subtest pipe-B: SUCCESS (5.469s)
[381.867823] Starting dynamic subtest: pipe-C
[387.309837] Dynamic subtest pipe-C: SUCCESS (5.460s)
[387.334848] Starting dynamic subtest: all-pipes
[392.770060] Dynamic subtest all-pipes: SUCCESS (5.458s)
[392.773091] Subtest forked-move: SUCCESS (21.875s)
[392.865658] [054/142] (620s left) syncobj_timeline (invalid-wait-illegal-handle)
[393.010838] Starting subtest: invalid-wait-illegal-handle
[393.013098] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[393.097312] [055/142] (620s left) kms_ccs (pipe-a-crc-primary-basic-y_tiled_gen12_rc_ccs_cc)
[393.442242] Starting subtest: pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc
[393.446825] Subtest pipe-A-crc-primary-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.002s)
[393.957371] [056/142] (619s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[394.466772] Starting subtest: pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[394.535518] Subtest pipe-C-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[394.851623] [057/142] (618s left) gem_exec_balancer (hang)
[398.836738] Starting subtest: hang
[402.415973] Subtest hang: SUCCESS (3.580s)
[402.520804] [058/142] (610s left) kms_psr (psr2_primary_mmap_cpu)
[402.667808] Subtest psr2_primary_mmap_cpu: SKIP (0.000s)
[402.720209] [059/142] (610s left) gem_exec_reloc (basic-gtt-wc)
[402.873926] Starting subtest: basic-gtt-wc
[402.893105] Subtest basic-gtt-wc: SUCCESS (0.019s)
[403.085104] [060/142] (610s left) gem_exec_store (pages)
[403.251776] Starting subtest: pages
[403.254535] Starting dynamic subtest: rcs0
[403.351086] Dynamic subtest rcs0: SUCCESS (0.096s)
[403.371168] Starting dynamic subtest: bcs0
[403.439950] Dynamic subtest bcs0: SUCCESS (0.087s)
[403.461376] Starting dynamic subtest: vcs0
[403.533571] Dynamic subtest vcs0: SUCCESS (0.091s)
[403.554111] Starting dynamic subtest: vecs0
[403.635196] Dynamic subtest vecs0: SUCCESS (0.099s)
[403.637500] Subtest pages: SUCCESS (0.385s)
[403.838899] [061/142] (609s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[404.302441] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs
[404.306714] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[404.633816] [062/142] (608s left) gem_close_race (multigpu-basic-process)
[404.810522] Starting subtest: multigpu-basic-process
[404.814798] Subtest multigpu-basic-process: SKIP (0.000s)
[405.014966] [063/142] (608s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[405.253797] Starting subtest: 2x-long-cursor-vs-flip-legacy
[405.258605] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.004s)
[405.348437] [064/142] (608s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[405.614216] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[406.907209] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.293s)
[407.250575] [065/142] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[407.502199] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[407.506113] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[407.598453] [066/142] (606s left) kms_properties (invalid-properties-atomic)
[407.834321] Starting subtest: invalid-properties-atomic
[408.076782] Subtest invalid-properties-atomic: SUCCESS (0.243s)
[408.166491] [067/142] (605s left) kms_atomic_transition (plane-all-transition-fencing)
[408.410266] Starting subtest: plane-all-transition-fencing
[408.412420] Starting dynamic subtest: pipe-A-DP-1
[412.406953] Dynamic subtest pipe-A-DP-1: SUCCESS (3.996s)
[412.529947] Starting dynamic subtest: pipe-B-DP-1
[416.956182] Dynamic subtest pipe-B-DP-1: SUCCESS (4.450s)
[417.053662] Subtest plane-all-transition-fencing: SUCCESS (8.644s)
[417.383241] [068/142] (596s left) api_intel_bb (lot-of-buffers)