[50.818657] Initializing watchdogs
[50.818852]   /dev/watchdog0
[50.851411] [001/139] (960s left) gem_ctx_param (set-priority-range)
[51.121577] Starting subtest: set-priority-range
[51.161314] Subtest set-priority-range: SUCCESS (0.071s)
[51.269071] [002/139] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[51.647666] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[51.690062] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[51.768720] [003/139] (959s left) perf_pmu (multi-client)
[52.005466] Starting subtest: multi-client
[52.024578] Starting dynamic subtest: rcs0
[53.035623] Dynamic subtest rcs0: SUCCESS (1.048s)
[53.070768] Starting dynamic subtest: bcs0
[54.071058] Dynamic subtest bcs0: SUCCESS (1.033s)
[54.104464] Starting dynamic subtest: vcs0
[55.112467] Dynamic subtest vcs0: SUCCESS (1.040s)
[55.142733] Starting dynamic subtest: vecs0
[56.136401] Dynamic subtest vecs0: SUCCESS (1.025s)
[56.158033] Subtest multi-client: SUCCESS (4.149s)
[56.267251] [004/139] (955s left) kms_psr (cursor_blt)
[56.523500] Subtest cursor_blt: SKIP (0.000s)
[56.601354] [005/139] (955s left) prime_self_import (reimport-vs-gem_close-race)
[56.820881] Starting subtest: reimport-vs-gem_close-race
[62.027307] Subtest reimport-vs-gem_close-race: SUCCESS (5.025s)
[62.107184] [006/139] (949s left) vc4/vc4_perfmon (create-perfmon-invalid-events)
[62.390244] Subtest create-perfmon-invalid-events: SKIP (0.000s)
[62.471405] [007/139] (949s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[62.815921] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[62.890738] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[62.977675] [008/139] (948s left) sw_sync (sync_merge)
[63.185664] Starting subtest: sync_merge
[63.207658] Subtest sync_merge: SUCCESS (0.001s)
[63.292449] [009/139] (948s left) gem_exec_schedule (u-submit-late-slice)
[63.699176] Starting subtest: u-submit-late-slice
[63.719817] Starting dynamic subtest: rcs0
[63.741356] Dynamic subtest rcs0: SUCCESS (0.081s)
[63.773156] Starting dynamic subtest: bcs0
[63.791719] Dynamic subtest bcs0: SUCCESS (0.054s)
[63.822750] Starting dynamic subtest: vcs0
[63.841502] Dynamic subtest vcs0: SUCCESS (0.050s)
[63.877765] Starting dynamic subtest: vecs0
[63.899099] Dynamic subtest vecs0: SUCCESS (0.047s)
[63.919466] Subtest u-submit-late-slice: SUCCESS (0.237s)
[64.122356] [010/139] (948s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs)
[64.633063] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs
[64.676084] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[65.027428] [011/139] (947s left) kms_pm_dc (dc5-dpms-negative)
[66.353554] Starting subtest: dc5-dpms-negative
[70.839074] Subtest dc5-dpms-negative: SUCCESS (4.321s)
[70.924299] [012/139] (941s left) gem_spin_batch (user-each)
[71.164790] Starting subtest: user-each
[74.586513] Subtest user-each: SUCCESS (3.416s)
[74.815199] [013/139] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[75.163728] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[75.205398] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[75.289203] [014/139] (937s left) kms_3d
[75.618748] [015/139] (936s left) i915_pm_rpm (gem-evict-pwrite)
[77.592191] Starting subtest: gem-evict-pwrite
[78.705387] Subtest gem-evict-pwrite: SUCCESS (1.107s)
[79.236397] [016/139] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[79.608650] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[79.645574] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[79.728081] [017/139] (932s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[80.628628] Starting subtest: syncobj-stationary-timeline-chain-engines
[80.763212] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.130s)
[81.007291] [018/139] (931s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[81.372185] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[81.412046] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[81.500398] [019/139] (931s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-mc-ccs)
[81.958740] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs
[82.000693] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[82.356447] [020/139] (930s left) gem_create (create-ext-cpu-access-sanity-check)
[82.691818] Starting subtest: create-ext-cpu-access-sanity-check
[82.732867] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[82.813489] [021/139] (930s left) syncobj_timeline (invalid-single-wait-available-unsubmitted)
[83.050073] Starting subtest: invalid-single-wait-available-unsubmitted
[83.479313] Subtest invalid-single-wait-available-unsubmitted: FAIL (0.188s)
[83.578374] [022/139] (929s left) kms_universal_plane (universal-plane-sanity)
[83.994095] Starting subtest: universal-plane-sanity
[84.015242] Starting dynamic subtest: pipe-A-DP-1
[84.427977] Dynamic subtest pipe-A-DP-1: SUCCESS (0.411s)
[84.471784] Starting dynamic subtest: pipe-B-DP-1
[85.033424] Dynamic subtest pipe-B-DP-1: SUCCESS (0.609s)
[85.070429] Starting dynamic subtest: pipe-C-DP-1
[85.673588] Dynamic subtest pipe-C-DP-1: SUCCESS (0.617s)
[85.701451] Subtest universal-plane-sanity: SUCCESS (1.651s)
[86.010685] [023/139] (927s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[86.361828] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[86.448697] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[86.546779] [024/139] (926s left) gem_exec_reloc (basic-write-cpu-noreloc)
[86.781475] Starting subtest: basic-write-cpu-noreloc
[86.800209] Subtest basic-write-cpu-noreloc: SUCCESS (0.009s)
[86.983744] [025/139] (926s left) gem_render_copy (yf-tiled-to-vebox-linear)
[87.233709] Starting subtest: yf-tiled-to-vebox-linear
[87.273890] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[87.449663] [026/139] (926s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-sf)
[87.717161] Subtest overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[87.805280] [027/139] (925s left) core_setmaster_vs_auth
[88.151787] [028/139] (925s left) api_intel_bb (destroy-bb)
[88.393276] Starting subtest: destroy-bb
[88.412045] Subtest destroy-bb: SUCCESS (0.032s)
[88.519175] [029/139] (925s left) gem_madvise (dontneed-before-mmap)
[88.716896] Starting subtest: dontneed-before-mmap
[88.760257] Subtest dontneed-before-mmap: SUCCESS (0.014s)
[88.849284] [030/139] (924s left) prime_mmap (test_reprime)
[89.082490] Starting subtest: test_reprime
[89.103443] Starting dynamic subtest: test_reprime-smem
[89.122397] Dynamic subtest test_reprime-smem: SUCCESS (0.006s)
[89.141201] Subtest test_reprime: SUCCESS (0.007s)
[89.225940] [031/139] (924s left) kms_lease (lease-invalid-crtc)
[89.521821] Starting subtest: lease-invalid-crtc
[89.543368] Starting dynamic subtest: pipe-A-DP-1
[89.563960] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[89.597088] Starting dynamic subtest: pipe-B-DP-1
[89.616532] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[89.649577] Starting dynamic subtest: pipe-C-DP-1
[89.668223] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[89.689461] Subtest lease-invalid-crtc: SUCCESS (0.006s)
[89.778891] [032/139] (924s left) kms_ccs (pipe-b-bad-rotation-90-yf-tiled-ccs)
[90.202707] Starting subtest: pipe-B-bad-rotation-90-yf-tiled-ccs
[90.683083] Subtest pipe-B-bad-rotation-90-yf-tiled-ccs: SUCCESS (0.458s)
[91.197959] [033/139] (922s left) gem_ctx_engines (execute-allforone)
[91.431478] Starting subtest: execute-allforone
[91.452207] Subtest execute-allforone: SUCCESS (0.016s)
[91.679678] [034/139] (922s left) gem_mmap_wc (bad-object)
[91.910615] Starting subtest: bad-object
[91.929445] Subtest bad-object: SUCCESS (0.000s)
[92.035269] [035/139] (922s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[92.374306] Starting subtest: extended-modeset-hang-newfb-with-reset
[92.393066] Starting dynamic subtest: pipe-A
[95.507735] Dynamic subtest pipe-A: SUCCESS (3.126s)
[95.543697] Starting dynamic subtest: pipe-C
[98.789596] Dynamic subtest pipe-C: SUCCESS (3.290s)
[98.808361] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (6.427s)
[99.180461] [036/139] (915s left) gem_ctx_persistence (hostile)
[99.414413] Starting subtest: hostile
[102.199545] Subtest hostile: SUCCESS (2.792s)
[102.320635] [037/139] (912s left) syncobj_timeline (reset-during-wait-for-submit)
[102.546026] Starting subtest: reset-during-wait-for-submit
[102.619784] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[102.729195] [038/139] (911s left) gem_exec_balancer (individual)
[102.957168] Starting subtest: individual
[106.803655] Subtest individual: SUCCESS (3.680s)
[110.543840] [039/139] (904s left) gem_ctx_sseu (invalid-sseu)
[110.795239] Subtest invalid-sseu: SKIP (0.000s)
[110.878930] [040/139] (903s left) gem_exec_create (forked)
[111.112547] Starting subtest: forked
[111.131674] Starting dynamic subtest: smem
[131.394351] Dynamic subtest smem: SUCCESS (20.112s)
[131.414795] Subtest forked: SUCCESS (20.112s)
[131.496505] [041/139] (883s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[131.790377] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[131.811745] Starting dynamic subtest: pipe-A-DP-1
[132.743931] Dynamic subtest pipe-A-DP-1: SUCCESS (0.929s)
[132.778254] Starting dynamic subtest: pipe-B-DP-1
[133.974560] Dynamic subtest pipe-B-DP-1: SUCCESS (1.214s)
[134.027669] Starting dynamic subtest: pipe-C-DP-1
[134.882300] Dynamic subtest pipe-C-DP-1: SUCCESS (0.919s)
[134.905687] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (3.090s)
[135.333061] [042/139] (879s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[135.708708] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[137.697147] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.067s)
[137.855229] [043/139] (877s left) kms_ccs (pipe-a-bad-rotation-90-y-tiled-gen12-rc-ccs)
[138.254341] Starting subtest: pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs
[138.291938] Subtest pipe-A-bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[138.730333] [044/139] (876s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[139.048456] Starting subtest: addfb25-y-tiled-small-legacy
[139.069945] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[139.155053] [045/139] (875s left) kms_fbcon_fbt (psr)
[139.390165] Starting subtest: psr
[139.427929] Subtest psr: SKIP (0.000s)
[139.513389] [046/139] (875s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[139.845299] Starting subtest: yf-tiled-32bpp-rotate-270
[144.636251] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (4.817s)
[145.202311] [047/139] (870s left) vc4/vc4_wait_bo (used-bo-0ns)
[145.476917] Subtest used-bo-0ns: SKIP (0.000s)
[145.559256] [048/139] (869s left) perf_pmu (frequency)
[145.784833] Starting subtest: frequency
[145.803628] Starting dynamic subtest: gt0
[147.895545] Dynamic subtest gt0: SUCCESS (2.099s)
[147.934235] Starting dynamic subtest: idle-gt0
[148.387773] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[148.406700] Subtest frequency: SUCCESS (2.606s)
[148.510743] [049/139] (866s left) syncobj_wait (reset-during-wait-for-submit)
[148.742308] Starting subtest: reset-during-wait-for-submit
[148.820219] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[148.933343] [050/139] (866s left) kms_concurrent (multi-plane-atomic-lowres)
[149.225803] Starting subtest: multi-plane-atomic-lowres
[149.244571] Starting dynamic subtest: pipe-A-DP-1
[150.035981] Dynamic subtest pipe-A-DP-1: SUCCESS (0.795s)
[150.057740] Subtest multi-plane-atomic-lowres: SUCCESS (0.797s)
[150.345073] [051/139] (865s left) perf (non-system-wide-paranoid)
[150.730802] Starting subtest: non-system-wide-paranoid
[150.849269] Subtest non-system-wide-paranoid: SUCCESS (0.125s)
[150.953366] [052/139] (864s left) v3d/v3d_submit_csd (bad-flag)
[151.236532] Subtest bad-flag: SKIP (0.000s)
[151.333838] [053/139] (864s left) sw_sync (sync_multi_producer_single_consumer)
[151.535866] Starting subtest: sync_multi_producer_single_consumer
[152.604051] Subtest sync_multi_producer_single_consumer: SUCCESS (1.078s)
[152.696128] [054/139] (863s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[152.922984] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[152.991564] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[153.097775] [055/139] (862s left) perf_pmu (busy)
[153.317382] Starting subtest: busy
[153.337463] Starting dynamic subtest: rcs0
[153.848943] Dynamic subtest rcs0: SUCCESS (0.537s)
[153.901509] Starting dynamic subtest: bcs0
[154.391308] Dynamic subtest bcs0: SUCCESS (0.554s)
[154.426897] Starting dynamic subtest: vcs0
[154.937977] Dynamic subtest vcs0: SUCCESS (0.538s)
[154.973966] Starting dynamic subtest: vecs0
[155.475388] Dynamic subtest vecs0: SUCCESS (0.543s)
[155.495394] Subtest busy: SUCCESS (2.176s)
[155.604511] [056/139] (860s left) kms_atomic_transition (modeset-transition)
[155.900362] Starting subtest: modeset-transition
[155.919039] Starting dynamic subtest: 1x-outputs
[160.688618] Dynamic subtest 1x-outputs: SUCCESS (4.794s)
[160.803798] Subtest modeset-transition: SUCCESS (4.909s)
[161.181499] [057/139] (854s left) kms_force_connector_basic (force-edid)
[161.439170] Subtest force-edid: SKIP (0.000s)
[161.529175] [058/139] (854s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[161.903510] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[161.943209] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[162.033811] [059/139] (854s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[162.311222] Starting subtest: cursorB-vs-flipA-varying-size
[162.349108] Subtest cursorB-vs-flipA-varying-size: SKIP (0.004s)
[162.436904] [060/139] (853s left) gem_userptr_blits (unsync-overlap)
[162.750655] Subtest unsync-overlap: SKIP (0.000s)
[162.846840] [061/139] (853s left) api_intel_bb (reset-bb)
[163.060316] Starting subtest: reset-bb
[163.081118] Subtest reset-bb: SUCCESS (0.005s)
[163.166175] [062/139] (853s left) gen7_exec_parse (load-register-reg)
[163.418798] Subtest load-register-reg: SKIP (0.000s)
[163.505319] [063/139] (853s left) sysfs_timeslice_duration (timeout)
[163.736628] Starting subtest: timeout
[163.756177] Starting dynamic subtest: vecs0
[164.630238] Dynamic subtest vecs0: SUCCESS (0.874s)
[164.666399] Starting dynamic subtest: vcs0
[165.499474] Dynamic subtest vcs0: SUCCESS (0.874s)
[165.537726] Starting dynamic subtest: bcs0
[166.399119] Dynamic subtest bcs0: SUCCESS (0.902s)
[166.437272] Starting dynamic subtest: rcs0
[167.295088] Dynamic subtest rcs0: SUCCESS (0.897s)
[167.313727] Subtest timeout: SUCCESS (3.553s)
[167.403868] [064/139] (849s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-rc-ccs)
[167.951859] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[168.273698] [065/139] (848s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[168.633299] Starting subtest: psr-2p-primscrn-spr-indfb-move
[168.673521] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[168.759148] [066/139] (848s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc)
[169.134820] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc
[169.172131] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[169.261859] [067/139] (847s left) v3d/v3d_wait_bo (unused-bo-1ns)
[169.534055] Subtest unused-bo-1ns: SKIP (0.000s)
[169.621622] [068/139] (847s left) gem_workarounds (suspend-resume)
[169.853056] Starting subtest: suspend-resume
[187.067456] Subtest suspend-resume: SUCCESS (1.454s)
[193.479822] [069/139] (845s left) kms_invalid_mode (clock-too-high)
[193.808685] Starting subtest: clock-too-high
[193.828483] Starting dynamic subtest: pipe-A-DP-1
[193.888635] Dynamic subtest pipe-A-DP-1: SUCCESS (0.093s)
[193.929605] Starting dynamic subtest: pipe-B-DP-1
[193.952254] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s)
[193.995131] Starting dynamic subtest: pipe-C-DP-1
[194.015683] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s)
[194.035351] Subtest clock-too-high: SUCCESS (0.107s)
[194.261674] [070/139] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[194.612024] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[197.108034] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.557s)
[197.276627] [071/139] (841s left) kms_ccs (pipe-c-missing-ccs-buffer-yf-tiled-ccs)
[197.784429] Starting subtest: pipe-C-missing-ccs-buffer-yf-tiled-ccs
[197.823972] Subtest pipe-C-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s)
[198.163111] [072/139] (841s left) gem_pxp (create-regular-buffer)
[201.080564] Subtest create-regular-buffer: SKIP (0.000s)
[201.234621] [073/139] (838s left) drm_buddy (drm_buddy)
[201.438454] Starting subtest: drm_buddy
[201.635359] Starting dynamic subtest: drm_test_buddy_alloc_limit
[201.656820] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.024s)
[201.694290] Starting dynamic subtest: drm_test_buddy_alloc_range
[201.714200] Dynamic subtest drm_test_buddy_alloc_range: SUCCESS (0.000s)
[201.754309] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[201.775130] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.000s)
[201.815733] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[201.835512] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.000s)
[201.873336] Starting dynamic subtest: drm_test_buddy_alloc_smoke
[201.892026] Dynamic subtest drm_test_buddy_alloc_smoke: SUCCESS (0.170s)
[201.929672] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[322.223159] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[327.270168] Closing watchdogs
[327.275735] Initializing watchdogs
[327.276030]   /dev/watchdog0
[327.317329] [074/139] (716s left) drm_fdinfo (virtual-idle)
[327.555069] Starting subtest: virtual-idle
[329.572766] Subtest virtual-idle: SUCCESS (2.024s)
[329.663674] [075/139] (714s left) kms_content_protection (lic)
[330.004699] Starting subtest: lic
[330.049808] Starting dynamic subtest: pipe-A-DP-1
[450.788929] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[458.132199] Closing watchdogs
[458.136182] Initializing watchdogs
[458.136352]   /dev/watchdog0
[458.178706] [076/139] (586s left) kms_ccs (pipe-c-crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[458.660518] Starting subtest: pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[458.699177] Subtest pipe-C-crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.001s)
[459.047372] [077/139] (585s left) i915_hangman (gt-engine-error)
[459.281561] Starting subtest: gt-engine-error
[459.302625] Starting dynamic subtest: rcs0
[459.363851] Dynamic subtest rcs0: SUCCESS (0.086s)
[459.409486] Starting dynamic subtest: bcs0
[459.449921] Dynamic subtest bcs0: SKIP (0.003s)
[459.495009] Starting dynamic subtest: vcs0
[459.516458] Dynamic subtest vcs0: SUCCESS (0.082s)
[459.558459] Starting dynamic subtest: vecs0
[459.577254] Dynamic subtest vecs0: SUCCESS (0.080s)
[459.596101] Subtest gt-engine-error: SUCCESS (0.259s)
[459.688046] [078/139] (584s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[460.022454] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[460.099159] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.028s)
[460.197334] [079/139] (584s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[460.500914] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[460.519739] Starting dynamic subtest: pipe-A-valid-mode
[460.626789] Dynamic subtest pipe-A-valid-mode: SKIP (0.098s)
[460.667105] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.101s)
[460.936024] [080/139] (583s left) gem_eio (execbuf)
[461.210184] Starting subtest: execbuf
[461.230518] Subtest execbuf: SUCCESS (0.042s)
[461.449972] [081/139] (583s left) api_intel_allocator (default-alignment)
[461.686232] Starting subtest: default-alignment
[461.707182] Subtest default-alignment: SUCCESS (0.003s)
[461.801558] [082/139] (583s left) gem_ctx_param (root-set)
[462.025450] Starting subtest: root-set
[462.045481] Subtest root-set: SUCCESS (0.000s)
[462.142154] [083/139] (582s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[462.367130] Starting subtest: write-cpu-read-wc-unflushed
[462.603900] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.269s)
[462.721669] [084/139] (582s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[463.257572] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[463.592342] [085/139] (581s left) gem_exec_schedule (submit-late-slice)
[463.979381] Starting subtest: submit-late-slice
[464.000063] Starting dynamic subtest: rcs0
[464.020639] Dynamic subtest rcs0: SUCCESS (0.053s)
[464.059536] Starting dynamic subtest: bcs0
[464.078357] Dynamic subtest bcs0: SUCCESS (0.049s)
[464.117060] Starting dynamic subtest: vcs0
[464.137945] Dynamic subtest vcs0: SUCCESS (0.048s)
[464.180147] Starting dynamic subtest: vecs0
[464.202246] Dynamic subtest vecs0: SUCCESS (0.051s)
[464.223088] Subtest submit-late-slice: SUCCESS (0.210s)
[464.404496] [086/139] (580s left) syncobj_timeline (invalid-wait-bad-flags)
[464.632804] Starting subtest: invalid-wait-bad-flags
[464.651919] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[464.746927] [087/139] (580s left) kms_chamelium_frames (dp-frame-dump)
[465.150936] Subtest dp-frame-dump: SKIP (0.000s)
[465.452436] [088/139] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[465.798801] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[465.839141] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[465.937038] [089/139] (579s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[466.483366] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[466.812538] [090/139] (578s left) kms_psr (psr2_sprite_render)
[467.056187] Subtest psr2_sprite_render: SKIP (0.000s)
[467.153362] [091/139] (578s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[467.586706] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs
[467.628514] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[468.027354] [092/139] (577s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[468.430574] Starting subtest: psr-rgb565-draw-render
[468.481574] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[468.594891] [093/139] (577s left) kms_flip (wf_vblank-ts-check)
[468.936666] Starting subtest: wf_vblank-ts-check
[468.955389] Starting dynamic subtest: A-DP1
[480.054302] Dynamic subtest A-DP1: SUCCESS (10.971s)
[480.095029] Starting dynamic subtest: B-DP1
[490.619970] Dynamic subtest B-DP1: SUCCESS (10.740s)
[490.658896] Starting dynamic subtest: C-DP1
[501.532613] Dynamic subtest C-DP1: SUCCESS (10.742s)
[501.552231] Subtest wf_vblank-ts-check: SUCCESS (32.467s)
[501.808622] [094/139] (544s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-ccs)
[502.274578] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-ccs
[502.293616] Subtest pipe-B-missing-ccs-buffer-y-tiled-ccs: SUCCESS (0.001s)
[502.709258] [095/139] (543s left) kms_pm_rpm (universal-planes-dpms)
[504.459920] Starting subtest: universal-planes-dpms
[504.482121] Starting dynamic subtest: plane-31
[506.877191] Dynamic subtest plane-31: SUCCESS (2.418s)
[506.918062] Starting dynamic subtest: plane-39
[509.432091] Dynamic subtest plane-39: SUCCESS (2.544s)
[509.474239] Starting dynamic subtest: plane-47
[511.955449] Dynamic subtest plane-47: SUCCESS (2.523s)
[512.003818] Starting dynamic subtest: plane-55
[514.490791] Dynamic subtest plane-55: SUCCESS (2.537s)
[514.510755] Subtest universal-planes-dpms: SUCCESS (10.033s)
[514.984819] [096/139] (531s left) gem_eio (in-flight-contexts-1us)
[515.259463] Starting subtest: in-flight-contexts-1us
[526.995868] Subtest in-flight-contexts-1us: SUCCESS (11.786s)
[527.240321] [097/139] (519s left) gem_exec_reloc (basic-cpu-read-noreloc)
[527.445942] Starting subtest: basic-cpu-read-noreloc
[527.467554] Subtest basic-cpu-read-noreloc: SUCCESS (0.014s)
[527.648588] [098/139] (518s left) gem_exec_endless (dispatch)
[527.894746] Starting subtest: dispatch
[527.917503] Starting dynamic subtest: rcs0
[527.963053] Dynamic subtest rcs0: SUCCESS (0.009s)
[528.005761] Starting dynamic subtest: bcs0
[528.048311] Dynamic subtest bcs0: SKIP (0.001s)
[528.090938] Starting dynamic subtest: vcs0
[528.134429] Dynamic subtest vcs0: SUCCESS (0.008s)
[528.177787] Starting dynamic subtest: vecs0
[528.223215] Dynamic subtest vecs0: SUCCESS (0.009s)
[528.244240] Subtest dispatch: SUCCESS (0.039s)
[528.340541] [099/139] (518s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[528.665003] Starting subtest: cursor-vs-flip-varying-size
[570.082187] Subtest cursor-vs-flip-varying-size: SUCCESS (41.419s)
[570.431822] [100/139] (476s left) kms_scaling_modes (scaling-mode-center)
[570.732264] Starting subtest: scaling-mode-center
[570.776335] Subtest scaling-mode-center: SKIP (0.001s)
[570.872407] [101/139] (475s left) syncobj_eventfd (invalid-bad-flags)
[571.085656] Starting subtest: invalid-bad-flags
[571.106274] Subtest invalid-bad-flags: SUCCESS (0.000s)
[571.199905] [102/139] (475s left) gem_exec_reloc (basic-wc-noreloc)
[571.428649] Starting subtest: basic-wc-noreloc
[571.447634] Subtest basic-wc-noreloc: SUCCESS (0.008s)
[571.632757] [103/139] (475s left) kms_ccs (pipe-c-bad-aux-stride-yf-tiled-ccs)
[572.122426] Starting subtest: pipe-C-bad-aux-stride-yf-tiled-ccs
[572.167250] Subtest pipe-C-bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[572.486941] [104/139] (474s left) kms_vblank (wait-forked-busy)
[572.785315] Starting subtest: wait-forked-busy
[572.806903] Starting dynamic subtest: pipe-A-DP-1
[575.261492] Dynamic subtest pipe-A-DP-1: SUCCESS (2.458s)
[575.303990] Starting dynamic subtest: pipe-C-DP-1
[577.900867] Dynamic subtest pipe-C-DP-1: SUCCESS (2.639s)
[577.920560] Subtest wait-forked-busy: SUCCESS (5.110s)
[578.259792] [105/139] (468s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[578.489218] Starting subtest: tiled-to-untiled
[578.613986] Subtest tiled-to-untiled: SUCCESS (0.109s)
[578.725046] [106/139] (468s left) gem_userptr_blits (unsync-unmap-cycles)
[579.017319] Subtest unsync-unmap-cycles: SKIP (0.000s)
[579.122193] [107/139] (468s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[579.421324] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[579.440587] Starting dynamic subtest: pipe-A-valid-mode
[580.079399] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.651s)
[580.100765] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.656s)
[580.443766] [108/139] (466s left) gem_exec_reloc (basic-gtt-cpu)
[580.675122] Starting subtest: basic-gtt-cpu
[580.694149] Subtest basic-gtt-cpu: SUCCESS (0.018s)
[580.889718] [109/139] (466s left) kms_ccs (pipe-d-ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[581.432802] Subtest pipe-D-ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[581.765416] [110/139] (465s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[581.986171] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[582.007465] Starting dynamic subtest: smem
[582.400446] Dynamic subtest smem: SUCCESS (0.419s)
[582.421250] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.422s)
[582.628179] [111/139] (465s left) kms_plane_lowres (tiling-y)
[582.927446] Starting subtest: tiling-y
[582.951943] Starting dynamic subtest: pipe-A-DP-1
[589.196461] Dynamic subtest pipe-A-DP-1: SUCCESS (6.261s)
[589.329195] Starting dynamic subtest: pipe-B-DP-1
[595.424938] Dynamic subtest pipe-B-DP-1: SUCCESS (6.130s)
[595.589801] Starting dynamic subtest: pipe-C-DP-1
[599.701001] Dynamic subtest pipe-C-DP-1: SUCCESS (4.167s)
[599.812297] Subtest tiling-y: SUCCESS (16.872s)
[600.299562] [112/139] (447s left) gem_exec_schedule (deep)
[600.706499] Starting subtest: deep
[600.727354] Starting dynamic subtest: rcs0
[614.772220] Dynamic subtest rcs0: SUCCESS (14.097s)
[614.821268] Starting dynamic subtest: bcs0
[629.997817] Dynamic subtest bcs0: SUCCESS (15.214s)
[630.044479] Starting dynamic subtest: vcs0
[644.508870] Dynamic subtest vcs0: SUCCESS (14.515s)
[644.550676] Starting dynamic subtest: vecs0
[658.344998] Dynamic subtest vecs0: SUCCESS (13.819s)
[658.363669] Subtest deep: SUCCESS (57.671s)
[659.865970] [113/139] (387s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[660.219394] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[660.261344] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[660.356362] [114/139] (387s left) perf (invalid-oa-format-id)
[660.662030] Starting subtest: invalid-oa-format-id
[660.700926] Subtest invalid-oa-format-id: SUCCESS (0.044s)
[660.819909] [115/139] (387s left) kms_flip (basic-flip-vs-modeset)
[661.111183] Starting subtest: basic-flip-vs-modeset
[661.129677] Starting dynamic subtest: A-DP1
[662.396713] Dynamic subtest A-DP1: SUCCESS (1.280s)
[662.438881] Starting dynamic subtest: B-DP1
[663.555280] Dynamic subtest B-DP1: SUCCESS (1.155s)
[663.599936] Starting dynamic subtest: C-DP1
[664.717753] Dynamic subtest C-DP1: SUCCESS (1.158s)
[664.743759] Subtest basic-flip-vs-modeset: SUCCESS (3.607s)
[665.099900] [116/139] (383s left) gem_exec_schedule (implicit-boths)
[665.562087] Starting subtest: implicit-boths
[665.585334] Starting dynamic subtest: rcs0
[665.611109] Dynamic subtest rcs0: SUCCESS (0.141s)
[665.656476] Starting dynamic subtest: bcs0
[665.678243] Dynamic subtest bcs0: SUCCESS (0.144s)
[665.723499] Starting dynamic subtest: vcs0
[665.769647] Dynamic subtest vcs0: SUCCESS (0.128s)
[665.816954] Starting dynamic subtest: vecs0
[665.891928] Dynamic subtest vecs0: SUCCESS (0.129s)
[665.914324] Subtest implicit-boths: SUCCESS (0.557s)
[666.288117] [117/139] (381s left) gem_flink_basic (basic)
[666.527738] Starting subtest: basic
[666.550126] Subtest basic: SUCCESS (0.000s)
[666.656373] [118/139] (381s left) gem_lmem_swapping (parallel-random)
[666.912068] Subtest parallel-random: SKIP (0.000s)
[667.005876] [119/139] (381s left) kms_cursor_edge_walk (256x256-right-edge)
[667.305423] Starting subtest: 256x256-right-edge
[667.324094] Starting dynamic subtest: pipe-A-DP-1
[670.978659] Dynamic subtest pipe-A-DP-1: SUCCESS (3.663s)
[671.022764] Starting dynamic subtest: pipe-C-DP-1
[674.488194] Dynamic subtest pipe-C-DP-1: SUCCESS (3.495s)
[674.510814] Subtest 256x256-right-edge: SUCCESS (7.168s)
[674.822989] [120/139] (373s left) gem_userptr_blits (vma-merge)
[675.135173] Starting subtest: vma-merge
[695.861134] Subtest vma-merge: FAIL (20.467s)
[695.957466] [121/139] (352s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[696.310514] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[696.347852] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[696.448228] [122/139] (352s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[696.800075] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[696.839918] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[696.940314] [123/139] (351s left) kms_big_fb (linear-16bpp-rotate-0)
[697.276499] Starting subtest: linear-16bpp-rotate-0
[701.784032] Subtest linear-16bpp-rotate-0: SUCCESS (4.533s)
[702.129205] [124/139] (346s left) kms_flip (plain-flip-interruptible)
[702.424201] Starting subtest: plain-flip-interruptible
[702.443062] Starting dynamic subtest: A-DP1
[703.598719] Dynamic subtest A-DP1: SUCCESS (1.172s)
[703.638482] Starting dynamic subtest: B-DP1
[704.708331] Dynamic subtest B-DP1: SUCCESS (1.103s)
[704.750904] Starting dynamic subtest: C-DP1
[705.798354] Dynamic subtest C-DP1: SUCCESS (1.087s)
[705.819788] Subtest plain-flip-interruptible: SUCCESS (3.377s)
[706.232075] [125/139] (342s left) i915_query (engine-info)
[706.470674] Starting subtest: engine-info
[706.490400] Subtest engine-info: SUCCESS (0.003s)
[706.581148] [126/139] (342s left) kms_cursor_crc (cursor-sliding-512x512)
[706.909822] Starting subtest: cursor-sliding-512x512
[706.952101] Subtest cursor-sliding-512x512: SKIP (0.002s)
[707.044669] [127/139] (342s left) kms_fb_coherency (memset-crc)
[707.344090] Starting subtest: memset-crc
[707.363998] Starting dynamic subtest: mmap-gtt
[707.809474] Dynamic subtest mmap-gtt: SUCCESS (0.465s)
[707.951486] Starting dynamic subtest: mmap-offset-wc
[708.502740] Dynamic subtest mmap-offset-wc: SUCCESS (0.585s)
[708.638077] Starting dynamic subtest: mmap-offset-uc
[709.877964] Dynamic subtest mmap-offset-uc: SUCCESS (1.278s)
[710.011482] Starting dynamic subtest: mmap-legacy-wc
[710.584820] Dynamic subtest mmap-legacy-wc: SUCCESS (0.598s)
[710.691093] Subtest memset-crc: SUCCESS (3.337s)
[711.058097] [128/139] (338s left) gem_lmem_swapping (basic)
[711.337771] Subtest basic: SKIP (0.000s)
[711.455074] [129/139] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[711.839329] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[711.891394] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[712.013655] [130/139] (337s left) gem_ctx_shared (q-independent)
[712.259190] Starting subtest: Q-independent
[712.280569] Starting dynamic subtest: rcs0
[712.327209] Dynamic subtest rcs0: SUCCESS (0.074s)
[712.371167] Starting dynamic subtest: bcs0
[712.412122] Dynamic subtest bcs0: SUCCESS (0.075s)
[712.453082] Starting dynamic subtest: vcs0
[712.474527] Dynamic subtest vcs0: SUCCESS (0.061s)
[712.517667] Starting dynamic subtest: vecs0
[712.539033] Dynamic subtest vecs0: SUCCESS (0.057s)
[712.559956] Subtest Q-independent: SUCCESS (0.278s)
[712.778499] [131/139] (336s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[713.102543] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[713.144626] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.003s)
[713.235551] [132/139] (336s left) kms_cursor_crc (cursor-offscreen-64x64)
[713.531024] Starting subtest: cursor-offscreen-64x64
[713.552449] Starting dynamic subtest: pipe-A-DP-1
[716.041425] Dynamic subtest pipe-A-DP-1: SUCCESS (2.482s)
[716.145810] Starting dynamic subtest: pipe-C-DP-1
[718.696010] Dynamic subtest pipe-C-DP-1: SUCCESS (2.585s)
[718.717505] Subtest cursor-offscreen-64x64: SUCCESS (5.149s)
[719.084644] [133/139] (330s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[719.377709] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[719.419704] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.003s)
[719.514507] [134/139] (330s left) v3d/v3d_perfmon (destroy-valid-perfmon)
[719.785871] Subtest destroy-valid-perfmon: SKIP (0.000s)
[719.879572] [135/139] (330s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[720.153757] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[720.175159] Starting dynamic subtest: pipe-A-DP-1
[720.505567] Dynamic subtest pipe-A-DP-1: SUCCESS (0.343s)
[720.546145] Starting dynamic subtest: pipe-B-DP-1
[720.929024] Dynamic subtest pipe-B-DP-1: SUCCESS (0.397s)
[720.950990] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.773s)
[721.355550] [136/139] (328s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-ccs)
[721.758505] Starting subtest: pipe-A-crc-primary-basic-y-tiled-ccs
[722.384983] Subtest pipe-A-crc-primary-basic-y-tiled-ccs: SUCCESS (0.636s)
[722.960806] [137/139] (327s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[723.295332] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[724.804943] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.534s)
[724.977107] [138/139] (325s left) gem_ctx_param (invalid-ctx-get)
[725.212028] Starting subtest: invalid-ctx-get
[725.230780] Subtest invalid-ctx-get: SUCCESS (0.000s)
[725.330399] [139/139] (324s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[725.748804] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[726.044991] Closing watchdogs
Done.