[40.262825] Initializing watchdogs
[40.262881]   /dev/watchdog0
[40.268778] [001/142] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[40.453312] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[40.454858] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[40.530053] [002/142] (960s left) api_intel_bb (object-noreloc-purge-cache-simple)
[40.594346] Starting subtest: object-noreloc-purge-cache-simple
[40.627515] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.034s)
[40.743892] [003/142] (960s left) template (a)
[40.815422] Starting subtest: A
[40.816359] Subtest A: SUCCESS (0.000s)
[40.876653] [004/142] (959s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs)
[41.089057] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs
[41.090955] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[41.308089] [005/142] (959s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[41.558858] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[41.561654] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.002s)
[41.781933] [006/142] (959s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_mc_ccs)
[42.050150] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs
[42.051971] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[42.253220] [007/142] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[42.415157] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[42.416763] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[42.479403] [008/142] (958s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[42.541078] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[42.570355] [009/142] (958s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[42.618472] Starting subtest: etime-multi-wait-for-submit-submitted
[42.722097] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[42.813098] [010/142] (958s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[42.942664] Starting subtest: 2x-long-cursor-vs-flip-legacy
[42.945491] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[42.994209] [011/142] (958s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[43.108128] Starting subtest: basic-flip-after-cursor-legacy
[44.172424] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.064s)
[44.419809] [012/142] (956s left) prime_vgem (basic-write)
[44.568239] Starting subtest: basic-write
[44.575093] Subtest basic-write: SKIP (0.006s)
[44.680189] [013/142] (956s left) prime_vgem (fence-wait)
[44.752701] Starting subtest: fence-wait
[44.753950] Starting dynamic subtest: rcs0
[45.813975] Dynamic subtest rcs0: SUCCESS (1.052s)
[45.819377] Starting dynamic subtest: bcs0
[46.873666] Dynamic subtest bcs0: SUCCESS (1.058s)
[46.883396] Starting dynamic subtest: vcs0
[47.918697] Dynamic subtest vcs0: SUCCESS (1.044s)
[47.928270] Starting dynamic subtest: vcs1
[48.963106] Dynamic subtest vcs1: SUCCESS (1.043s)
[48.972557] Starting dynamic subtest: vecs0
[50.007472] Dynamic subtest vecs0: SUCCESS (1.044s)
[50.016808] Starting dynamic subtest: vecs1
[51.050126] Dynamic subtest vecs1: SUCCESS (1.042s)
[51.059443] Starting dynamic subtest: ccs0
[52.092592] Dynamic subtest ccs0: SUCCESS (1.042s)
[52.101609] Starting dynamic subtest: ccs1
[53.135370] Dynamic subtest ccs1: SUCCESS (1.042s)
[53.144040] Starting dynamic subtest: ccs2
[54.178581] Dynamic subtest ccs2: SUCCESS (1.043s)
[54.187668] Starting dynamic subtest: ccs3
[55.221499] Dynamic subtest ccs3: SUCCESS (1.042s)
[55.223560] Subtest fence-wait: SUCCESS (10.459s)
[55.312881] [014/142] (945s left) sw_sync (sync_busy_fork_unixsocket)
[55.354923] Starting subtest: sync_busy_fork_unixsocket
[55.363805] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[55.414929] [015/142] (945s left) gem_userptr_blits (unsync-overlap)
[55.471448] Subtest unsync-overlap: SKIP (0.000s)
[55.567555] [016/142] (945s left) gem_exec_fence (syncobj-channel)
[56.418223] Starting subtest: syncobj-channel
[57.446096] Subtest syncobj-channel: SUCCESS (1.017s)
[57.780118] [017/142] (943s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[57.949429] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[57.951148] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.011987] [018/142] (943s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[58.285810] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[58.287591] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[58.458776] [019/142] (942s left) gem_mmap (basic-small-bo)
[58.542845] Subtest basic-small-bo: SKIP (0.000s)
[58.571627] [020/142] (942s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[58.685362] Starting subtest: primary-y-tiled-reflect-x-270
[58.687180] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[58.746296] [021/142] (942s left) gem_ctx_param (invalid-param-get)
[58.797560] Starting subtest: invalid-param-get
[58.798553] Subtest invalid-param-get: SUCCESS (0.000s)
[58.889301] [022/142] (942s left) kms_vblank (pipe-b-wait-idle)
[59.048424] Starting subtest: pipe-B-wait-idle
[61.473484] Subtest pipe-B-wait-idle: SUCCESS (2.425s)
[61.662309] [023/142] (939s left) gem_exec_fence (long-history)
[62.507245] Starting subtest: long-history
[69.157666] Subtest long-history: SUCCESS (6.644s)
[70.291298] [024/142] (931s left) gem_mmap_wc (bad-offset)
[70.337946] Subtest bad-offset: SKIP (0.000s)
[70.369568] [025/142] (930s left) kms_prop_blob (invalid-get-prop-any)
[70.437913] Starting subtest: invalid-get-prop-any
[70.438953] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[70.508294] [026/142] (930s left) gem_lmem_evict (dontneed-evict-race)
[72.974749] Starting subtest: dontneed-evict-race
[75.066992] Subtest dontneed-evict-race: SUCCESS (2.084s)
[75.963314] [027/142] (925s left) vgem_basic (create)
[76.001563] Starting subtest: create
[76.002497] Subtest create: SUCCESS (0.000s)
[76.010315] [028/142] (925s left) kms_frontbuffer_tracking (fbc-2p-rte)
[76.796266] Starting subtest: fbc-2p-rte
[76.797833] Subtest fbc-2p-rte: SKIP (0.000s)
[76.936918] [029/142] (924s left) kms_cursor_edge_walk (64x64-top-bottom)
[77.078258] Starting subtest: 64x64-top-bottom
[77.079150] Starting dynamic subtest: pipe-A-DP-4
[80.523658] Dynamic subtest pipe-A-DP-4: SUCCESS (3.444s)
[80.530415] Starting dynamic subtest: pipe-D-DP-4
[83.844555] Dynamic subtest pipe-D-DP-4: SUCCESS (3.320s)
[83.845497] Subtest 64x64-top-bottom: SUCCESS (6.766s)
[84.079447] [030/142] (917s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[84.240065] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[84.240977] Starting dynamic subtest: pipe-A-valid-mode
[86.014953] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.774s)
[86.017057] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (1.775s)
[86.246806] [031/142] (915s left) kms_plane (invalid-pixel-format-settings)
[86.407395] Starting subtest: invalid-pixel-format-settings
[86.451208] Subtest invalid-pixel-format-settings: SUCCESS (0.043s)
[86.524125] [032/142] (914s left) gem_exec_schedule (preempt-user)
[86.606798] Starting subtest: preempt-user
[86.607849] Starting dynamic subtest: rcs0
[86.660401] Dynamic subtest rcs0: SUCCESS (0.054s)
[86.665593] Starting dynamic subtest: bcs0
[86.686408] Dynamic subtest bcs0: SUCCESS (0.026s)
[86.692929] Starting dynamic subtest: vcs0
[86.711981] Dynamic subtest vcs0: SUCCESS (0.025s)
[86.717269] Starting dynamic subtest: vcs1
[86.737868] Dynamic subtest vcs1: SUCCESS (0.026s)
[86.743534] Starting dynamic subtest: vecs0
[86.764590] Dynamic subtest vecs0: SUCCESS (0.027s)
[86.769740] Starting dynamic subtest: vecs1
[86.789600] Dynamic subtest vecs1: SUCCESS (0.025s)
[86.794927] Starting dynamic subtest: ccs0
[86.817222] Dynamic subtest ccs0: SUCCESS (0.027s)
[86.822486] Starting dynamic subtest: ccs1
[86.842506] Dynamic subtest ccs1: SUCCESS (0.025s)
[86.847717] Starting dynamic subtest: ccs2
[86.867121] Dynamic subtest ccs2: SUCCESS (0.024s)
[86.872352] Starting dynamic subtest: ccs3
[86.892730] Dynamic subtest ccs3: SUCCESS (0.025s)
[86.893678] Subtest preempt-user: SUCCESS (0.286s)
[87.227713] [033/142] (914s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[87.343475] Starting subtest: flip-vs-cursor-busy-crc-legacy
[88.165697] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s)
[88.386110] [034/142] (913s left) gem_ctx_create (basic-files)
[88.481653] Starting subtest: basic-files
[90.492760] Subtest basic-files: SUCCESS (2.011s)
[91.347184] [035/142] (910s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[91.392207] Starting subtest: multi-wait-for-submit-available-submitted
[91.393154] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[91.458684] [036/142] (910s left) kms_invalid_mode (bad-vsync-start)
[91.583119] Starting subtest: bad-vsync-start
[91.584032] Starting dynamic subtest: DP-4-pipe-A
[91.662817] Dynamic subtest DP-4-pipe-A: SUCCESS (0.080s)
[91.669068] Starting dynamic subtest: DP-4-pipe-B
[91.669922] Dynamic subtest DP-4-pipe-B: SUCCESS (0.001s)
[91.676396] Starting dynamic subtest: DP-4-pipe-C
[91.677253] Dynamic subtest DP-4-pipe-C: SUCCESS (0.001s)
[91.683396] Starting dynamic subtest: DP-4-pipe-D
[91.684354] Dynamic subtest DP-4-pipe-D: SUCCESS (0.001s)
[91.685337] Subtest bad-vsync-start: SUCCESS (0.086s)
[91.851696] [037/142] (909s left) gem_mmap_wc (read-write-distinct)
[91.941168] Subtest read-write-distinct: SKIP (0.000s)
[91.963127] [038/142] (909s left) gem_ctx_param (invalid-ctx-set)
[92.006158] Starting subtest: invalid-ctx-set
[92.007011] Subtest invalid-ctx-set: SUCCESS (0.000s)
[92.088924] [039/142] (909s left) kms_universal_plane (universal-plane-pipe-a-functional)
[92.244434] Starting subtest: universal-plane-pipe-A-functional
[94.549199] Subtest universal-plane-pipe-A-functional: SUCCESS (2.304s)
[94.792655] [040/142] (906s left) gem_ctx_persistence (engines-queued)
[94.890926] Starting subtest: engines-queued
[94.891872] Starting dynamic subtest: rcs0
[94.946250] Dynamic subtest rcs0: SUCCESS (0.055s)
[94.951660] Starting dynamic subtest: bcs0
[94.972155] Dynamic subtest bcs0: SUCCESS (0.026s)
[94.978221] Starting dynamic subtest: vcs0
[95.035644] Dynamic subtest vcs0: SUCCESS (0.063s)
[95.049980] Starting dynamic subtest: vcs1
[95.075628] Dynamic subtest vcs1: SUCCESS (0.040s)
[95.087168] Starting dynamic subtest: vecs0
[95.133562] Dynamic subtest vecs0: SUCCESS (0.057s)
[95.146851] Starting dynamic subtest: vecs1
[95.178774] Dynamic subtest vecs1: SUCCESS (0.045s)
[95.192229] Starting dynamic subtest: ccs0
[95.355827] Dynamic subtest ccs0: SUCCESS (0.177s)
[95.361300] Starting dynamic subtest: ccs1
[95.497254] Dynamic subtest ccs1: SUCCESS (0.141s)
[95.502450] Starting dynamic subtest: ccs2
[95.639563] Dynamic subtest ccs2: SUCCESS (0.142s)
[95.644988] Starting dynamic subtest: ccs3
[95.786103] Dynamic subtest ccs3: SUCCESS (0.146s)
[95.787010] Subtest engines-queued: SUCCESS (0.895s)
[95.874464] [041/142] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[95.994259] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[95.995930] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[96.069432] [042/142] (905s left) kms_flip (flip-vs-suspend)
[96.198657] Starting subtest: flip-vs-suspend
[96.203636] Starting dynamic subtest: A-DP4
[134.772366] Dynamic subtest A-DP4: SUCCESS (7.537s)
[134.779580] Starting dynamic subtest: B-DP4
[174.758110] Dynamic subtest B-DP4: SUCCESS (7.154s)
[174.769737] Starting dynamic subtest: C-DP4
[214.771286] Dynamic subtest C-DP4: SUCCESS (7.055s)
[214.778506] Starting dynamic subtest: D-DP4
[254.791438] Dynamic subtest D-DP4: SUCCESS (7.170s)
[254.796039] Subtest flip-vs-suspend: SUCCESS (28.927s)
[255.030654] [043/142] (876s left) kms_busy (extended-pageflip-hang-oldfb)
[255.157649] Starting subtest: extended-pageflip-hang-oldfb
[255.158464] Starting dynamic subtest: pipe-A
[255.396485] Dynamic subtest pipe-A: SUCCESS (0.236s)
[255.419373] Starting dynamic subtest: pipe-D
[255.672292] Dynamic subtest pipe-D: SUCCESS (0.268s)
[255.673304] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.515s)
[255.936672] [044/142] (875s left) kms_content_protection (atomic-dpms)
[256.143173] Starting subtest: atomic-dpms
[256.167996] Starting dynamic subtest: pipe-A-DP-4
[376.617010] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[376.925896] Closing watchdogs
[376.927499] Initializing watchdogs
[376.927538]   /dev/watchdog0
[376.937524] [045/142] (754s left) vc4/vc4_wait_bo (used-bo-1ns)
[377.021128] Subtest used-bo-1ns: SKIP (0.000s)
[377.069885] [046/142] (754s left) kms_psr (psr2_no_drrs)
[377.116676] Subtest psr2_no_drrs: SKIP (0.000s)
[377.145903] [047/142] (754s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_ccs)
[377.384387] Starting subtest: pipe-C-crc-primary-basic-y_tiled_ccs
[377.386261] Subtest pipe-C-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[377.590208] [048/142] (753s left) perf_pmu (pmu-read)
[377.681895] Starting subtest: pmu-read
[377.686336] Subtest pmu-read: SUCCESS (0.004s)
[377.766864] [049/142] (753s left) i915_pm_rpm (system-suspend-modeset)
[380.248809] Starting subtest: system-suspend-modeset
[402.407422] Subtest system-suspend-modeset: SUCCESS (6.181s)
[402.815800] [050/142] (744s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[402.978111] Starting subtest: fbcpsr-stridechange
[402.979825] Subtest fbcpsr-stridechange: SKIP (0.000s)
[403.052627] [051/142] (744s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[403.258905] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[403.374422] [052/142] (744s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs)
[403.623995] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs
[403.625658] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[403.838878] [053/142] (743s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[404.000697] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[404.002527] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.093013] [054/142] (743s left) vc4/vc4_lookup_fail (bad-color-write)
[404.184783] Subtest bad-color-write: SKIP (0.000s)
[404.247734] [055/142] (743s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[404.397137] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[404.398846] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[404.472168] [056/142] (743s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[404.604349] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[434.426032] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.822s)
[434.626629] [057/142] (713s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[434.750827] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[435.684237] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.933s)
[435.823628] [058/142] (711s left) kms_fbcon_fbt (fbc)
[435.880785] Starting subtest: fbc
[439.518818] Subtest fbc: SUCCESS (3.628s)
[439.541760] [059/142] (708s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_mc_ccs)
[439.794665] Starting subtest: pipe-D-random-ccs-data-4_tiled_mtl_mc_ccs
[439.797440] Subtest pipe-D-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[439.986071] [060/142] (707s left) kms_psr (sprite_render)
[440.060351] Subtest sprite_render: SKIP (0.000s)
[440.087806] [061/142] (707s left) gen9_exec_parse (basic-rejected)
[440.143344] Subtest basic-rejected: SKIP (0.000s)
[440.170983] [062/142] (707s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[440.296772] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[440.298690] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[440.363945] [063/142] (707s left) kms_pm_backlight (fade-with-dpms)
[440.492092] Subtest fade-with-dpms: SKIP (0.000s)
[440.521444] [064/142] (707s left) kms_vrr (negative-basic)
[440.638905] Starting subtest: negative-basic
[440.639857] Starting dynamic subtest: pipe-A-DP-4
[446.170955] Dynamic subtest pipe-A-DP-4: SUCCESS (5.531s)
[446.171879] Subtest negative-basic: SUCCESS (5.533s)
[446.392387] [065/142] (701s left) kms_chamelium_color (ctm-0-25)
[446.539749] Subtest ctm-0-25: SKIP (0.000s)
[446.573460] [066/142] (701s left) gem_spin_batch (resubmit-all)
[446.625245] Starting subtest: resubmit-all
[446.626080] Starting dynamic subtest: rcs0
[446.649915] Dynamic subtest rcs0: SUCCESS (0.024s)
[446.657509] Starting dynamic subtest: bcs0
[446.658324] Dynamic subtest bcs0: SUCCESS (0.003s)
[446.665660] Starting dynamic subtest: vcs0
[446.666467] Dynamic subtest vcs0: SUCCESS (0.002s)
[446.673856] Starting dynamic subtest: vcs1
[446.674725] Dynamic subtest vcs1: SUCCESS (0.003s)
[446.682063] Starting dynamic subtest: vecs0
[446.682865] Dynamic subtest vecs0: SUCCESS (0.003s)
[446.690008] Starting dynamic subtest: vecs1
[446.690801] Dynamic subtest vecs1: SUCCESS (0.003s)
[446.698080] Starting dynamic subtest: ccs0
[446.698902] Dynamic subtest ccs0: SUCCESS (0.002s)
[446.706373] Starting dynamic subtest: ccs1
[446.707420] Dynamic subtest ccs1: SUCCESS (0.002s)
[446.714526] Starting dynamic subtest: ccs2
[446.715433] Dynamic subtest ccs2: SUCCESS (0.003s)
[446.722737] Starting dynamic subtest: ccs3
[446.723840] Dynamic subtest ccs3: SUCCESS (0.003s)
[446.724851] Subtest resubmit-all: SUCCESS (0.056s)
[446.937247] [067/142] (701s left) perf_pmu (busy-check-all)
[446.995345] Starting subtest: busy-check-all
[446.996188] Starting dynamic subtest: rcs0
[447.569716] Dynamic subtest rcs0: SUCCESS (0.574s)
[447.580156] Starting dynamic subtest: bcs0
[448.120462] Dynamic subtest bcs0: SUCCESS (0.549s)
[448.132549] Starting dynamic subtest: vcs0
[448.672402] Dynamic subtest vcs0: SUCCESS (0.549s)
[448.684807] Starting dynamic subtest: vcs1
[449.224432] Dynamic subtest vcs1: SUCCESS (0.549s)
[449.236457] Starting dynamic subtest: vecs0
[449.776434] Dynamic subtest vecs0: SUCCESS (0.549s)
[449.788804] Starting dynamic subtest: vecs1
[450.329747] Dynamic subtest vecs1: SUCCESS (0.550s)
[450.341525] Starting dynamic subtest: ccs0
[450.882340] Dynamic subtest ccs0: SUCCESS (0.549s)
[450.894438] Starting dynamic subtest: ccs1
[451.434396] Dynamic subtest ccs1: SUCCESS (0.549s)
[451.446779] Starting dynamic subtest: ccs2
[451.986436] Dynamic subtest ccs2: SUCCESS (0.549s)
[451.998365] Starting dynamic subtest: ccs3
[452.538262] Dynamic subtest ccs3: SUCCESS (0.549s)
[452.540412] Subtest busy-check-all: SUCCESS (5.544s)
[452.626276] [068/142] (695s left) gem_exec_reloc (basic-cpu)
[452.675791] Subtest basic-cpu: SKIP (0.000s)
[452.721879] [069/142] (695s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[452.827527] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[452.844046] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[452.915524] [070/142] (695s left) kms_cursor_crc (cursor-onscreen-512x170)
[453.217920] Starting subtest: cursor-onscreen-512x170
[453.220003] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[453.389580] [071/142] (694s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[453.548827] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[453.550647] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[453.892345] [072/142] (694s left) syncobj_wait (multi-wait-signaled)
[453.946088] Starting subtest: multi-wait-signaled
[453.946938] Subtest multi-wait-signaled: SUCCESS (0.000s)
[454.028081] [073/142] (694s left) i915_pm_rpm (modeset-non-lpsp)
[456.180896] Starting subtest: modeset-non-lpsp
[456.962959] Subtest modeset-non-lpsp: SUCCESS (0.779s)
[457.178017] [074/142] (691s left) kms_lease (simple-lease)
[457.320368] Starting subtest: simple-lease
[457.321185] Starting dynamic subtest: pipe-A-DP-4
[457.762916] Dynamic subtest pipe-A-DP-4: SUCCESS (0.441s)
[457.774474] Starting dynamic subtest: pipe-B-DP-4
[458.153136] Dynamic subtest pipe-B-DP-4: SUCCESS (0.388s)
[458.164630] Starting dynamic subtest: pipe-C-DP-4
[458.540155] Dynamic subtest pipe-C-DP-4: SUCCESS (0.385s)
[458.553992] Starting dynamic subtest: pipe-D-DP-4
[458.929240] Dynamic subtest pipe-D-DP-4: SUCCESS (0.387s)
[458.931907] Subtest simple-lease: SUCCESS (1.609s)
[459.180999] [075/142] (689s left) gem_exec_schedule (u-semaphore-noskip)
[459.261698] Starting subtest: u-semaphore-noskip
[461.334566] Subtest u-semaphore-noskip: SUCCESS (2.064s)
[461.659105] [076/142] (686s left) kms_universal_plane (cursor-fb-leak-pipe-b)
[461.776639] Starting subtest: cursor-fb-leak-pipe-B
[462.431521] Subtest cursor-fb-leak-pipe-B: SUCCESS (0.655s)
[462.672267] [077/142] (685s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[462.817523] Starting subtest: 4-tiled-64bpp-rotate-270
[462.875660] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.057s)
[463.022448] [078/142] (685s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[463.108223] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[463.171548] [079/142] (685s left) kms_chamelium_frames (dp-frame-dump)
[463.401858] Subtest dp-frame-dump: SKIP (0.000s)
[463.518870] [080/142] (684s left) perf_pmu (frequency)
[463.584768] Starting subtest: frequency
[463.585751] Starting dynamic subtest: gt0
[465.829351] Dynamic subtest gt0: FAIL (2.159s)
[465.849429] Starting dynamic subtest: idle-gt0
[466.260941] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[466.262162] Subtest frequency: FAIL (2.668s)
[466.328640] [081/142] (682s left) syncobj_timeline (single-wait-signaled)
[466.373441] Starting subtest: single-wait-signaled
[466.374501] Subtest single-wait-signaled: SUCCESS (0.000s)
[466.452713] [082/142] (682s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[466.740345] Starting subtest: pipe-D-bad-pixel-format-y_tiled_ccs
[466.742084] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[466.950618] [083/142] (681s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[467.202250] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[467.204216] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[467.442847] [084/142] (681s left) gen3_render_tiledy_blits
[467.539707] [085/142] (681s left) gen9_exec_parse (bb-secure)
[467.589499] Subtest bb-secure: SKIP (0.000s)
[467.623875] [086/142] (681s left) kms_flip (flip-vs-rmfb)
[467.732998] Starting subtest: flip-vs-rmfb
[467.742639] Starting dynamic subtest: A-DP4
[475.586056] Dynamic subtest A-DP4: SUCCESS (7.843s)
[475.624808] Starting dynamic subtest: B-DP4
[483.347765] Dynamic subtest B-DP4: SUCCESS (7.757s)
[483.382043] Starting dynamic subtest: C-DP4
[491.123535] Dynamic subtest C-DP4: SUCCESS (7.772s)
[491.161807] Starting dynamic subtest: D-DP4
[498.903059] Dynamic subtest D-DP4: SUCCESS (7.775s)
[498.908600] Subtest flip-vs-rmfb: SUCCESS (31.174s)
[499.255320] [087/142] (649s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[499.496690] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[499.498463] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[499.710265] [088/142] (649s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[500.039233] Starting subtest: cursor-rapid-movement-512x170
[500.042013] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[500.180505] [089/142] (648s left) gem_ctx_param (basic)
[500.250670] Starting subtest: basic
[500.251573] Subtest basic: SUCCESS (0.000s)
[500.318373] [090/142] (648s left) core_auth (basic-auth)
[500.374415] Starting subtest: basic-auth
[500.375292] Subtest basic-auth: SUCCESS (0.001s)
[500.443529] [091/142] (648s left) i915_query (query-topology-matches-eu-total)
[500.530518] Starting subtest: query-topology-matches-eu-total
[500.531364] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[500.598927] [092/142] (648s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[500.857915] Starting subtest: parallel-dmabuf-import-out-fence
[502.521015] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.663s)
[502.583537] [093/142] (646s left) drm_fdinfo (virtual-busy)
[502.633726] Starting subtest: virtual-busy
[502.635941] Subtest virtual-busy: SKIP (0.000s)
[502.701439] [094/142] (646s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[502.754686] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[502.756878] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[502.980398] [095/142] (645s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[503.043437] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[503.091337] [096/142] (645s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[503.292869] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[503.294580] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[503.556338] [097/142] (645s left) kms_concurrent (pipe-a)
[503.695493] Starting subtest: pipe-A
[503.696413] Starting dynamic subtest: DP-4
[504.220724] Dynamic subtest DP-4: SUCCESS (0.522s)
[504.221857] Subtest pipe-A: SUCCESS (0.524s)
[504.464176] [098/142] (644s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[504.619907] Starting subtest: x-tiled-16bpp-rotate-0
[506.174782] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.554s)
[506.320115] [099/142] (642s left) kms_flip (basic-flip-vs-dpms)
[506.451889] Starting subtest: basic-flip-vs-dpms
[506.457922] Starting dynamic subtest: A-DP4
[507.305497] Dynamic subtest A-DP4: SUCCESS (0.844s)
[507.326237] Starting dynamic subtest: B-DP4
[508.133174] Dynamic subtest B-DP4: SUCCESS (0.826s)
[508.155011] Starting dynamic subtest: C-DP4
[508.974533] Dynamic subtest C-DP4: SUCCESS (0.839s)
[508.997462] Starting dynamic subtest: D-DP4
[509.799727] Dynamic subtest D-DP4: SUCCESS (0.822s)
[509.800916] Subtest basic-flip-vs-dpms: SUCCESS (3.350s)
[510.072482] [100/142] (639s left) gem_exec_whisper (basic-sync)
[510.162332] Starting subtest: basic-sync
[516.399009] Subtest basic-sync: SUCCESS (6.235s)
[516.613834] [101/142] (632s left) gem_pxp (reject-modify-context-protection-off-2)
[519.217610] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[519.247393] [102/142] (629s left) gem_exec_balancer (full-pulse)
[519.297834] Starting subtest: full-pulse
[520.703657] Subtest full-pulse: SUCCESS (1.406s)
[520.998402] [103/142] (628s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render)
[521.140504] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render
[523.243171] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (2.104s)
[523.388650] [104/142] (625s left) kms_addfb_basic (addfb25-4-tiled)
[523.512954] Starting subtest: addfb25-4-tiled
[523.513897] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[523.593885] [105/142] (625s left) kms_universal_plane (cursor-fb-leak-pipe-a)
[523.727930] Starting subtest: cursor-fb-leak-pipe-A
[524.216024] Subtest cursor-fb-leak-pipe-A: SUCCESS (0.487s)
[524.469596] [106/142] (624s left) template (b)
[524.533398] Starting subtest: B
[524.534457] Subtest B: SUCCESS (0.000s)
[524.630211] [107/142] (624s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[524.777952] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[525.676759] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.899s)
[525.866767] [108/142] (623s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[525.994060] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[525.995649] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[526.064437] [109/142] (623s left) kms_tiled_display (basic-test-pattern)
[526.249370] Subtest basic-test-pattern: SKIP (0.000s)
[526.270265] [110/142] (623s left) kms_display_modes (mst-extended-mode-negative)
[526.386193] Starting subtest: mst-extended-mode-negative
[526.389493] Subtest mst-extended-mode-negative: SKIP (0.000s)
[526.420214] [111/142] (623s left) gem_tiled_blits (interruptible)
[526.468545] Subtest interruptible: SKIP (0.000s)
[526.503596] [112/142] (622s left) gem_exec_alignment (pi)