[41.449653] Initializing watchdogs
[41.449716]   /dev/watchdog0
[41.455248] [001/141] (960s left) kms_cursor_crc (cursor-onscreen-128x42)
[41.716171] Starting subtest: cursor-onscreen-128x42
[41.725841] Starting dynamic subtest: pipe-A-DP-4
[44.309906] Dynamic subtest pipe-A-DP-4: SUCCESS (2.585s)
[44.333909] Starting dynamic subtest: pipe-D-DP-4
[47.047229] Dynamic subtest pipe-D-DP-4: SUCCESS (2.717s)
[47.048133] Subtest cursor-onscreen-128x42: SUCCESS (5.330s)
[47.330316] [002/141] (954s left) feature_discovery (display-3x)
[47.459255] Starting subtest: display-3x
[47.460833] Subtest display-3x: SKIP (0.000s)
[47.511696] [003/141] (954s left) api_intel_allocator (fork-simple-stress-signal)
[47.568587] Starting subtest: fork-simple-stress-signal
[53.018848] Subtest fork-simple-stress-signal: SUCCESS (5.415s)
[53.090552] [004/141] (948s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_mtl_mc_ccs)
[53.427916] Starting subtest: pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs
[53.429568] Subtest pipe-C-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[53.627778] [005/141] (948s left) gem_pread (bench)
[53.687401] Subtest bench: SKIP (0.000s)
[53.719399] [006/141] (948s left) core_auth (getclient-master-drop)
[53.767648] Starting subtest: getclient-master-drop
[53.776734] Subtest getclient-master-drop: SUCCESS (0.009s)
[53.830545] [007/141] (948s left) syncobj_wait (wait-all-for-submit-complex)
[53.913197] Starting subtest: wait-all-for-submit-complex
[54.138359] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[54.208149] [008/141] (947s left) gem_lmem_evict (dontneed-evict-race)
[56.777712] Starting subtest: dontneed-evict-race
[58.877938] Subtest dontneed-evict-race: SUCCESS (2.091s)
[60.034765] [009/141] (942s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[60.846033] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[60.847555] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.916910] [010/141] (941s left) gen3_render_mixed_blits
[60.996327] [011/141] (941s left) api_intel_bb (object-noreloc-purge-cache-simple)
[61.052639] Starting subtest: object-noreloc-purge-cache-simple
[61.075743] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.024s)
[61.170534] [012/141] (940s left) syncobj_timeline (single-wait-all-signaled)
[61.227591] Starting subtest: single-wait-all-signaled
[61.228434] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[61.288706] [013/141] (940s left) kms_plane_scaling (invalid-parameters)
[61.429771] Starting subtest: invalid-parameters
[61.430598] Starting dynamic subtest: less-than-1-height-src
[61.438860] Dynamic subtest less-than-1-height-src: SUCCESS (0.009s)
[61.443700] Starting dynamic subtest: less-than-1-width-src
[61.448088] Dynamic subtest less-than-1-width-src: SUCCESS (0.009s)
[61.448883] Subtest invalid-parameters: SUCCESS (0.018s)
[61.524735] [014/141] (940s left) perf (global-sseu-config)
[61.814086] Subtest global-sseu-config: SKIP (0.000s)
[61.834470] [015/141] (940s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[61.968510] Starting subtest: 4-tiled-64bpp-rotate-0
[63.649853] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.672s)
[63.783194] [016/141] (938s left) kms_lease (setcrtc_implicit_plane)
[63.947364] Starting subtest: setcrtc_implicit_plane
[63.949328] Starting dynamic subtest: pipe-A-DP-4
[64.280198] Dynamic subtest pipe-A-DP-4: SUCCESS (0.331s)
[64.285357] Starting dynamic subtest: pipe-B-DP-4
[64.537799] Dynamic subtest pipe-B-DP-4: SUCCESS (0.257s)
[64.543407] Starting dynamic subtest: pipe-C-DP-4
[64.917871] Dynamic subtest pipe-C-DP-4: SUCCESS (0.379s)
[64.923215] Starting dynamic subtest: pipe-D-DP-4
[65.356273] Dynamic subtest pipe-D-DP-4: SUCCESS (0.437s)
[65.357155] Subtest setcrtc_implicit_plane: SUCCESS (1.408s)
[65.524645] [017/141] (936s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[65.658232] Starting subtest: yf-tiled-addfb-size-offset-overflow
[65.660038] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[65.724538] [018/141] (936s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[65.863578] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[65.865269] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[65.925092] [019/141] (936s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[66.189677] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[66.191270] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[66.419272] [020/141] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[66.553478] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[66.555285] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.635660] [021/141] (935s left) gem_vm_create (isolation)
[66.696265] Starting subtest: isolation
[66.705428] Subtest isolation: SUCCESS (0.009s)
[66.789714] [022/141] (935s left) sw_sync (sync_merge_same)
[66.839390] Starting subtest: sync_merge_same
[66.840363] Subtest sync_merge_same: SUCCESS (0.000s)
[66.885771] [023/141] (935s left) i915_pm_lpsp (kms-lpsp)
[68.022969] Starting subtest: kms-lpsp
[68.023890] Starting dynamic subtest: kms-lpsp-DP
[68.025409] Dynamic subtest kms-lpsp-DP: SKIP (0.000s)
[68.026956] Subtest kms-lpsp: SKIP (0.000s)
[68.136091] [024/141] (934s left) i915_pm_rpm (modeset-non-lpsp)
[70.502671] Starting subtest: modeset-non-lpsp
[71.485967] Subtest modeset-non-lpsp: SUCCESS (0.983s)
[71.635595] [025/141] (930s left) kms_universal_plane (universal-plane-pipe-d-functional)
[71.794403] Starting subtest: universal-plane-pipe-D-functional
[74.201495] Subtest universal-plane-pipe-D-functional: SUCCESS (2.407s)
[74.368434] [026/141] (927s left) gem_ctx_isolation (preservation-reset)
[74.545679] Starting subtest: preservation-reset
[74.546848] Starting dynamic subtest: rcs0
[75.059892] Dynamic subtest rcs0: SUCCESS (0.510s)
[75.065587] Starting dynamic subtest: bcs0
[75.636963] Dynamic subtest bcs0: SUCCESS (0.579s)
[75.642403] Starting dynamic subtest: vcs0
[76.140765] Dynamic subtest vcs0: SUCCESS (0.502s)
[76.146286] Starting dynamic subtest: vcs1
[76.718879] Dynamic subtest vcs1: SUCCESS (0.578s)
[76.724691] Starting dynamic subtest: vecs0
[77.265305] Dynamic subtest vecs0: SUCCESS (0.546s)
[77.270880] Starting dynamic subtest: vecs1
[77.828545] Dynamic subtest vecs1: SUCCESS (0.563s)
[77.834168] Starting dynamic subtest: ccs0
[78.391879] Dynamic subtest ccs0: SUCCESS (0.563s)
[78.397428] Starting dynamic subtest: ccs1
[78.952480] Dynamic subtest ccs1: SUCCESS (0.560s)
[78.957979] Starting dynamic subtest: ccs2
[79.470746] Dynamic subtest ccs2: SUCCESS (0.518s)
[79.476157] Starting dynamic subtest: ccs3
[79.996598] Dynamic subtest ccs3: SUCCESS (0.526s)
[79.997505] Subtest preservation-reset: SUCCESS (5.448s)
[80.172689] [027/141] (922s left) i915_module_load (reload-with-fault-injection)
[80.224221] Starting subtest: reload-with-fault-injection
[105.643960] Subtest reload-with-fault-injection: SUCCESS (25.410s)
[105.665564] [028/141] (896s left) kms_vblank (pipe-a-query-forked-busy)
[107.037264] Starting subtest: pipe-A-query-forked-busy
[109.498147] Subtest pipe-A-query-forked-busy: SUCCESS (2.458s)
[109.674833] [029/141] (892s left) v3d/v3d_get_param (get-bad-param)
[109.765162] Subtest get-bad-param: SKIP (0.000s)
[109.814215] [030/141] (892s left) gem_linear_blits (normal)
[110.336545] Starting subtest: normal
[117.140989] Subtest normal: SUCCESS (6.805s)
[117.380421] [031/141] (884s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[117.554881] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[117.556418] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[117.645764] [032/141] (884s left) gem_exec_reloc (basic-cpu-noreloc)
[117.710663] Subtest basic-cpu-noreloc: SKIP (0.000s)
[117.772440] [033/141] (884s left) gem_mmap_gtt (basic-read)
[117.831161] Subtest basic-read: SKIP (0.000s)
[117.854798] [034/141] (884s left) kms_psr (psr2_sprite_plane_onoff)
[117.914012] Subtest psr2_sprite_plane_onoff: SKIP (0.000s)
[117.938480] [035/141] (884s left) i915_query (query-topology-unsupported)
[117.996974] Starting subtest: query-topology-unsupported
[117.999277] Subtest query-topology-unsupported: SKIP (0.000s)
[118.067908] [036/141] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[118.230675] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[118.232418] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[118.312740] [037/141] (884s left) perf (invalid-open-flags)
[118.610185] Starting subtest: invalid-open-flags
[118.611059] Subtest invalid-open-flags: SUCCESS (0.000s)
[118.626728] [038/141] (883s left) gem_render_copy (linear-to-vebox-yf-tiled)
[118.689135] Starting subtest: linear-to-vebox-yf-tiled
[118.690763] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[118.846418] [039/141] (883s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[118.967495] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[118.983853] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.015s)
[119.046742] [040/141] (883s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[119.180251] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[119.181947] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[119.263302] [041/141] (883s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[119.326188] Starting subtest: legacy-engines-hostile-preempt
[119.327048] Starting dynamic subtest: render
[119.384040] Dynamic subtest render: SUCCESS (0.058s)
[119.390118] Starting dynamic subtest: bsd1
[119.427068] Dynamic subtest bsd1: SUCCESS (0.042s)
[119.432662] Starting dynamic subtest: bsd2
[119.486031] Dynamic subtest bsd2: SUCCESS (0.058s)
[119.491848] Starting dynamic subtest: blt
[119.509093] Dynamic subtest blt: SUCCESS (0.022s)
[119.514463] Starting dynamic subtest: vebox
[119.571084] Dynamic subtest vebox: SUCCESS (0.061s)
[119.572173] Subtest legacy-engines-hostile-preempt: SUCCESS (0.245s)
[119.672567] [042/141] (882s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[119.809861] Starting subtest: primary-4-tiled-reflect-x-0
[129.208189] Subtest primary-4-tiled-reflect-x-0: SUCCESS (9.398s)
[129.488056] [043/141] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[129.619529] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[129.621129] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[129.704809] [044/141] (872s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[129.833615] Starting subtest: pipe-C-ts-continuation-idle-hang
[144.019995] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (14.187s)
[144.193518] [045/141] (858s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[144.252562] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[144.356585] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[144.451950] [046/141] (858s left) gem_ctx_persistence (process)
[144.523759] Starting subtest: process
[144.656580] Subtest process: SUCCESS (0.132s)
[144.763483] [047/141] (857s left) gem_exec_reloc (basic-write-read-noreloc)
[144.836581] Subtest basic-write-read-noreloc: SKIP (0.000s)
[144.886123] [048/141] (857s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs)
[145.187979] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs
[145.190361] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[145.376058] [049/141] (857s left) gem_exec_fair (basic-flow)
[145.441465] Subtest basic-flow: SKIP (0.000s)
[145.501462] [050/141] (857s left) gem_mmap_offset (basic-uaf)
[145.571897] Starting subtest: basic-uaf
[145.572731] Subtest basic-uaf: SUCCESS (0.000s)
[145.700219] [051/141] (856s left) kms_cursor_edge_walk (128x128-left-edge)
[145.847822] Starting subtest: 128x128-left-edge
[145.848752] Starting dynamic subtest: pipe-A-DP-4
[149.311846] Dynamic subtest pipe-A-DP-4: SUCCESS (3.463s)
[149.318902] Starting dynamic subtest: pipe-D-DP-4
[152.587509] Dynamic subtest pipe-D-DP-4: SUCCESS (3.274s)
[152.588308] Subtest 128x128-left-edge: SUCCESS (6.741s)
[152.751685] [052/141] (849s left) gem_create (create-size-update)
[152.810498] Starting subtest: create-size-update
[152.811424] Subtest create-size-update: SUCCESS (0.000s)
[153.057569] [053/141] (849s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[153.127118] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[153.128189] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[153.185481] [054/141] (849s left) syncobj_timeline (invalid-signal-illegal-handle)
[153.242978] Starting subtest: invalid-signal-illegal-handle
[153.243961] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[153.302819] [055/141] (849s left) syncobj_wait (wait-all-for-submit-snapshot)
[153.370621] Starting subtest: wait-all-for-submit-snapshot
[153.451070] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[153.554595] [056/141] (849s left) gem_exec_nop (basic-sequential)
[153.634102] Starting subtest: basic-sequential
[159.089617] Subtest basic-sequential: SUCCESS (5.456s)
[159.272713] [057/141] (843s left) syncobj_basic (bad-flags-handle-to-fd)
[159.331366] Starting subtest: bad-flags-handle-to-fd
[159.332186] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[159.391354] [058/141] (843s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[159.548477] Starting subtest: fbcpsr-rgb565-draw-blt
[159.550047] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[159.635044] [059/141] (843s left) kms_big_fb (4-tiled-addfb-size-overflow)
[159.770078] Starting subtest: 4-tiled-addfb-size-overflow
[159.770936] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.001s)
[159.851277] [060/141] (843s left) gem_workarounds (suspend-resume-context)
[159.920130] Starting subtest: suspend-resume-context
[177.513186] Subtest suspend-resume-context: SUCCESS (2.252s)
[177.617414] [061/141] (840s left) drm_fdinfo (busy)
[177.682118] Subtest busy: SKIP (0.000s)
[177.710043] [062/141] (840s left) kms_plane_scaling (planes-upscale-20x20)
[177.840144] Starting subtest: planes-upscale-20x20
[177.841046] Starting dynamic subtest: pipe-A-DP-4
[177.916571] Dynamic subtest pipe-A-DP-4: SUCCESS (0.076s)
[177.925390] Starting dynamic subtest: pipe-B-DP-4
[178.103936] Dynamic subtest pipe-B-DP-4: SUCCESS (0.186s)
[178.112658] Starting dynamic subtest: pipe-C-DP-4
[178.293066] Dynamic subtest pipe-C-DP-4: SUCCESS (0.187s)
[178.301993] Starting dynamic subtest: pipe-D-DP-4
[178.481707] Dynamic subtest pipe-D-DP-4: SUCCESS (0.187s)
[178.482624] Subtest planes-upscale-20x20: SUCCESS (0.643s)
[178.686780] [063/141] (839s left) gem_userptr_blits (probe)
[178.764232] Starting subtest: probe
[179.059770] Subtest probe: SUCCESS (0.287s)
[179.164030] [064/141] (839s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[179.299154] Starting subtest: cursorB-vs-flipB-atomic
[179.301364] Subtest cursorB-vs-flipB-atomic: SKIP (0.002s)
[179.370319] [065/141] (838s left) syncobj_basic (bad-handle-to-fd)
[179.426181] Starting subtest: bad-handle-to-fd
[179.427001] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[179.497297] [066/141] (838s left) kms_ccs (pipe-a-crc-sprite-planes-basic-yf_tiled_ccs)
[179.738817] Starting subtest: pipe-A-crc-sprite-planes-basic-yf_tiled_ccs
[179.741657] Subtest pipe-A-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[179.988163] [067/141] (838s left) v3d/v3d_wait_bo (map-bo-1ns)
[180.071125] Subtest map-bo-1ns: SKIP (0.000s)
[180.125453] [068/141] (838s left) gem_exec_schedule (preempt-other-chain)
[180.199153] Starting subtest: preempt-other-chain
[180.199974] Starting dynamic subtest: rcs0
[181.542597] Dynamic subtest rcs0: SUCCESS (1.334s)
[181.550244] Starting dynamic subtest: bcs0
[182.865269] Dynamic subtest bcs0: SUCCESS (1.322s)
[182.873167] Starting dynamic subtest: vcs0
[184.721966] Dynamic subtest vcs0: SUCCESS (1.856s)
[184.729263] Starting dynamic subtest: vcs1
[186.043044] Dynamic subtest vcs1: SUCCESS (1.320s)
[186.050460] Starting dynamic subtest: vecs0
[188.123371] Dynamic subtest vecs0: SUCCESS (2.080s)
[188.130762] Starting dynamic subtest: vecs1
[189.435795] Dynamic subtest vecs1: SUCCESS (1.312s)
[189.443246] Starting dynamic subtest: ccs0
[191.943193] Dynamic subtest ccs0: SUCCESS (2.483s)
[191.950720] Starting dynamic subtest: ccs1
[193.845211] Dynamic subtest ccs1: SUCCESS (1.926s)
[193.852638] Starting dynamic subtest: ccs2
[195.167023] Dynamic subtest ccs2: SUCCESS (1.321s)
[195.174564] Starting dynamic subtest: ccs3
[197.323374] Dynamic subtest ccs3: SUCCESS (2.154s)
[197.324763] Subtest preempt-other-chain: SUCCESS (17.115s)
[197.656988] [069/141] (820s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[197.870115] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[197.871839] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[198.136632] [070/141] (820s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[198.272473] Starting subtest: x-tiled-16bpp-rotate-270
[198.319575] Subtest x-tiled-16bpp-rotate-270: SKIP (0.047s)
[198.420076] [071/141] (819s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[198.488341] Starting subtest: single-wait-all-for-submit-unsubmitted
[198.594546] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[198.669770] [072/141] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[198.803704] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[198.805383] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[198.885905] [073/141] (819s left) kms_vblank (pipe-d-wait-busy-hang)
[199.010377] Starting subtest: pipe-D-wait-busy-hang
[213.370875] Subtest pipe-D-wait-busy-hang: SUCCESS (14.359s)
[213.525666] [074/141] (804s left) gem_ringfill (legacy-basic)
[213.934762] Starting subtest: legacy-basic
[213.936209] Starting dynamic subtest: default
[214.023766] Dynamic subtest default: SUCCESS (0.088s)
[214.033450] Starting dynamic subtest: render
[214.066552] Dynamic subtest render: SUCCESS (0.041s)
[214.094323] Starting dynamic subtest: bsd
[214.115770] Dynamic subtest bsd: SUCCESS (0.047s)
[214.143731] Starting dynamic subtest: bsd1
[214.165280] Dynamic subtest bsd1: SUCCESS (0.047s)
[214.180493] Starting dynamic subtest: bsd2
[214.210413] Dynamic subtest bsd2: SUCCESS (0.044s)
[214.229782] Starting dynamic subtest: blt
[214.258682] Dynamic subtest blt: SUCCESS (0.046s)
[214.287250] Starting dynamic subtest: vebox
[214.307353] Dynamic subtest vebox: SUCCESS (0.047s)
[214.308586] Subtest legacy-basic: SUCCESS (0.373s)
[214.418121] [075/141] (804s left) gem_exec_params (rs-invalid)
[214.490239] Starting subtest: rs-invalid
[214.492284] Subtest rs-invalid: SUCCESS (0.001s)
[214.585823] [076/141] (803s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[214.852813] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[214.854511] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[215.090005] [077/141] (803s left) kms_ccs (pipe-c-crc-primary-basic-yf_tiled_ccs)
[215.369920] Starting subtest: pipe-C-crc-primary-basic-yf_tiled_ccs
[215.371723] Subtest pipe-C-crc-primary-basic-yf_tiled_ccs: SKIP (0.000s)
[215.568923] [078/141] (802s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[215.627771] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[215.628582] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[215.684959] [079/141] (802s left) gem_exec_schedule (semaphore-noskip)
[215.760743] Starting subtest: semaphore-noskip
[217.604151] Subtest semaphore-noskip: SUCCESS (1.835s)
[217.982784] [080/141] (800s left) kms_pwrite_crc
[218.864598] [081/141] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[218.997541] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[218.999226] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[219.064280] [082/141] (799s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[219.183863] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[219.190319] Starting dynamic subtest: A-DP4
[227.257525] Dynamic subtest A-DP4: SUCCESS (8.067s)
[227.265729] Starting dynamic subtest: B-DP4
[235.286696] Dynamic subtest B-DP4: SUCCESS (8.008s)
[235.294380] Starting dynamic subtest: C-DP4
[243.274147] Dynamic subtest C-DP4: SUCCESS (8.007s)
[243.281979] Starting dynamic subtest: D-DP4
[251.282454] Dynamic subtest D-DP4: SUCCESS (8.007s)
[251.283442] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.099s)
[251.521934] [083/141] (767s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[251.585055] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[251.630426] [084/141] (767s left) gem_eio (in-flight-immediate)
[251.904546] Starting subtest: in-flight-immediate
[256.969769] Subtest in-flight-immediate: SUCCESS (5.065s)
[257.299221] [085/141] (761s left) gem_sync (basic-all)
[257.372601] Starting subtest: basic-all
[259.498210] Subtest basic-all: SUCCESS (2.125s)
[259.712622] [086/141] (758s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[259.890369] Starting subtest: cursor-rapid-movement-32x32
[259.922887] Subtest cursor-rapid-movement-32x32: SKIP (0.031s)
[260.254825] [087/141] (758s left) gem_eio (suspend)
[260.560475] Starting subtest: suspend
[274.514578] Subtest suspend: SUCCESS (13.957s)
[274.847420] [088/141] (743s left) v3d/v3d_submit_cl (multisync-out-syncs)
[274.935053] Subtest multisync-out-syncs: SKIP (0.000s)
[274.992976] [089/141] (743s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[275.155740] Starting subtest: psr-indfb-scaledprimary
[275.157479] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[275.235923] [090/141] (743s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_mc_ccs)
[275.527121] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs
[275.529687] Subtest pipe-C-random-ccs-data-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[275.717912] [091/141] (743s left) gem_mmap_gtt (basic-small-copy-xy)
[275.778993] Subtest basic-small-copy-XY: SKIP (0.000s)
[275.810384] [092/141] (743s left) kms_color (ctm-signed)
[275.944553] Starting subtest: ctm-signed
[275.945640] Starting dynamic subtest: pipe-A
[276.983694] Dynamic subtest pipe-A: SUCCESS (1.039s)
[276.992209] Starting dynamic subtest: pipe-B
[278.018696] Dynamic subtest pipe-B: SUCCESS (1.034s)
[278.027837] Starting dynamic subtest: pipe-C
[279.060252] Dynamic subtest pipe-C: SUCCESS (1.041s)
[279.069090] Starting dynamic subtest: pipe-D
[280.191638] Dynamic subtest pipe-D: SUCCESS (1.131s)
[280.192552] Subtest ctm-signed: SUCCESS (4.248s)
[280.358183] [093/141] (738s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[280.492948] Starting subtest: x-tiled-8bpp-rotate-0
[281.923561] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.431s)
[282.041060] [094/141] (736s left) kms_addfb_basic (invalid-set-prop-any)
[282.127716] Starting subtest: invalid-set-prop-any
[282.128666] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[282.275532] [095/141] (736s left) kms_vblank (pipe-b-ts-continuation-idle)
[282.404869] Starting subtest: pipe-B-ts-continuation-idle
[282.819538] Subtest pipe-B-ts-continuation-idle: SUCCESS (0.415s)
[282.972374] [096/141] (735s left) kms_content_protection (legacy)
[283.153169] Starting subtest: legacy
[283.377308] Starting dynamic subtest: pipe-A-DP-4
[404.256288] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[404.578719] Closing watchdogs
[404.580546] Initializing watchdogs
[404.580590]   /dev/watchdog0
[404.590879] [097/141] (614s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[404.723221] Starting subtest: coverage-vs-premult-vs-constant
[404.927084] Starting dynamic subtest: pipe-A-DP-4
[405.347838] Dynamic subtest pipe-A-DP-4: SUCCESS (0.420s)
[405.357553] Starting dynamic subtest: pipe-D-DP-4
[405.823422] Dynamic subtest pipe-D-DP-4: SUCCESS (0.474s)
[405.824345] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.101s)
[406.017546] [098/141] (612s left) gem_exec_async (concurrent-writes)
[406.085702] Starting subtest: concurrent-writes
[406.086660] Starting dynamic subtest: rcs0
[406.124534] Dynamic subtest rcs0: SUCCESS (0.039s)
[406.133728] Starting dynamic subtest: bcs0
[406.137975] Dynamic subtest bcs0: SUCCESS (0.013s)
[406.146820] Starting dynamic subtest: vcs0
[406.150760] Dynamic subtest vcs0: SUCCESS (0.012s)
[406.159474] Starting dynamic subtest: vcs1
[406.162813] Dynamic subtest vcs1: SUCCESS (0.011s)
[406.171594] Starting dynamic subtest: vecs0
[406.174990] Dynamic subtest vecs0: SUCCESS (0.011s)
[406.183557] Starting dynamic subtest: vecs1
[406.187172] Dynamic subtest vecs1: SUCCESS (0.011s)
[406.195720] Starting dynamic subtest: ccs0
[406.199123] Dynamic subtest ccs0: SUCCESS (0.011s)
[406.207674] Starting dynamic subtest: ccs1
[406.211477] Dynamic subtest ccs1: SUCCESS (0.012s)
[406.219988] Starting dynamic subtest: ccs2
[406.223088] Dynamic subtest ccs2: SUCCESS (0.011s)
[406.231520] Starting dynamic subtest: ccs3
[406.235139] Dynamic subtest ccs3: SUCCESS (0.011s)
[406.236042] Subtest concurrent-writes: SUCCESS (0.150s)
[406.451055] [099/141] (612s left) perf_pmu (frequency)
[406.514222] Starting subtest: frequency
[406.515135] Starting dynamic subtest: gt0
[408.648759] Dynamic subtest gt0: SUCCESS (2.130s)
[408.657722] Starting dynamic subtest: idle-gt0
[409.162277] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[409.163181] Subtest frequency: SUCCESS (2.640s)
[409.236517] [100/141] (609s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[409.377303] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[409.378379] Starting dynamic subtest: pipe-A-valid-mode
[411.088124] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.710s)
[411.089916] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.712s)
[411.258537] [101/141] (607s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs)
[411.388847] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs
[411.390568] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[411.742568] [102/141] (607s left) i915_hangman (engine-engine-error)
[411.815482] Starting subtest: engine-engine-error
[411.816295] Starting dynamic subtest: rcs0
[412.727893] Dynamic subtest rcs0: SUCCESS (0.912s)
[412.738549] Starting dynamic subtest: bcs0
[413.502697] Dynamic subtest bcs0: SUCCESS (0.774s)
[413.512205] Starting dynamic subtest: vcs0
[414.274684] Dynamic subtest vcs0: SUCCESS (0.771s)
[414.287447] Starting dynamic subtest: vcs1
[415.041513] Dynamic subtest vcs1: SUCCESS (0.766s)
[415.050676] Starting dynamic subtest: vecs0
[415.856741] Dynamic subtest vecs0: SUCCESS (0.814s)
[415.868641] Starting dynamic subtest: vecs1
[416.651574] Dynamic subtest vecs1: SUCCESS (0.794s)
[416.661008] Starting dynamic subtest: ccs0
[420.764613] Dynamic subtest ccs0: SUCCESS (4.112s)
[420.775945] Starting dynamic subtest: ccs1
[424.803643] Dynamic subtest ccs1: SUCCESS (4.038s)
[424.814342] Starting dynamic subtest: ccs2
[428.771990] Dynamic subtest ccs2: SUCCESS (3.967s)
[428.784004] Starting dynamic subtest: ccs3
[432.799752] Dynamic subtest ccs3: SUCCESS (4.027s)
[432.800865] Subtest engine-engine-error: SUCCESS (20.985s)
[432.932736] [103/141] (586s left) kms_chamelium_frames (hdmi-aspect-ratio)
[433.133626] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[433.239050] [104/141] (585s left) kms_getfb (getfb-handle-protection)
[433.299211] Starting subtest: getfb-handle-protection
[433.307395] Subtest getfb-handle-protection: SUCCESS (0.008s)
[433.394281] [105/141] (585s left) kms_psr (cursor_blt)
[433.457193] Subtest cursor_blt: SKIP (0.000s)
[433.485545] [106/141] (585s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[433.699956] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[433.805595] [107/141] (585s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[433.937240] Starting subtest: basic-flip-after-cursor-atomic
[434.930146] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.994s)
[435.113225] [108/141] (584s left) kms_vblank (pipe-a-accuracy-idle)
[435.245038] Starting subtest: pipe-A-accuracy-idle
[437.500552] Subtest pipe-A-accuracy-idle: SUCCESS (2.256s)
[437.652057] [109/141] (581s left) gem_mmap_gtt (bad-object)
[437.710645] Subtest bad-object: SKIP (0.000s)
[437.744233] [110/141] (581s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[437.810179] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[437.969456] [111/141] (581s left) kms_psr2_sf (primary-plane-update-sf-dmg-area)
[438.029363] Subtest primary-plane-update-sf-dmg-area: SKIP (0.000s)
[438.062353] [112/141] (581s left) perf_pmu (interrupts-sync)
[438.132831] Starting subtest: interrupts-sync
[439.248215] Subtest interrupts-sync: SUCCESS (1.106s)
[439.360284] [113/141] (579s left) perf_pmu (multi-client)
[439.423927] Starting subtest: multi-client
[439.424833] Starting dynamic subtest: rcs0
[440.496996] Dynamic subtest rcs0: SUCCESS (1.063s)
[440.506558] Starting dynamic subtest: bcs0
[441.548238] Dynamic subtest bcs0: SUCCESS (1.049s)
[441.557768] Starting dynamic subtest: vcs0
[442.598662] Dynamic subtest vcs0: SUCCESS (1.047s)
[442.607477] Starting dynamic subtest: vcs1
[443.650201] Dynamic subtest vcs1: SUCCESS (1.048s)
[443.659549] Starting dynamic subtest: vecs0
[444.700921] Dynamic subtest vecs0: SUCCESS (1.047s)
[444.709797] Starting dynamic subtest: vecs1
[445.751429] Dynamic subtest vecs1: SUCCESS (1.047s)
[445.760639] Starting dynamic subtest: ccs0
[446.804401] Dynamic subtest ccs0: SUCCESS (1.050s)
[446.813737] Starting dynamic subtest: ccs1
[447.855307] Dynamic subtest ccs1: SUCCESS (1.048s)
[447.864759] Starting dynamic subtest: ccs2
[448.906272] Dynamic subtest ccs2: SUCCESS (1.048s)
[448.915344] Starting dynamic subtest: ccs3
[449.957401] Dynamic subtest ccs3: SUCCESS (1.048s)
[449.958266] Subtest multi-client: SUCCESS (10.526s)
[450.060621] [114/141] (569s left) gem_sync (basic-each)
[450.130181] Starting subtest: basic-each
[452.327686] Subtest basic-each: SUCCESS (2.197s)
[452.561380] [115/141] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[452.701088] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[452.702777] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[452.770045] [116/141] (566s left) kms_flip (2x-nonexisting-fb)
[452.891794] Starting subtest: 2x-nonexisting-fb
[452.910833] Subtest 2x-nonexisting-fb: SKIP (0.020s)
[452.986150] [117/141] (566s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[453.317623] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[453.319348] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[453.470114] [118/141] (565s left) kms_fb_coherency (memset-crc)
[453.608194] Starting subtest: memset-crc
[453.609414] Starting dynamic subtest: mmap-offset-fixed
[454.068571] Dynamic subtest mmap-offset-fixed: SUCCESS (0.460s)
[454.173672] Subtest memset-crc: SUCCESS (0.566s)
[454.348166] [119/141] (564s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[454.483588] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[454.485302] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[454.548724] [120/141] (564s left) i915_query (query-regions-sanity-check)
[454.607436] Starting subtest: query-regions-sanity-check
[454.627986] Subtest query-regions-sanity-check: SUCCESS (0.021s)
[454.756996] [121/141] (564s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs)
[455.011750] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs
[455.013459] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SKIP (0.000s)
[455.266191] [122/141] (564s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[455.401793] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[455.403461] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[455.481954] [123/141] (563s left) gem_exec_fence (syncobj-timeline-chain-engines)
[456.022247] Starting subtest: syncobj-timeline-chain-engines
[456.189301] Subtest syncobj-timeline-chain-engines: SUCCESS (0.167s)
[456.504896] [124/141] (562s left) vc4/vc4_tiling (set-bad-flags)
[456.597314] Subtest set-bad-flags: SKIP (0.000s)
[456.655684] [125/141] (562s left) gem_exec_balancer (sliced)
[456.739495] Starting subtest: sliced
[456.741943] Subtest sliced: SKIP (0.000s)
[457.016789] [126/141] (562s left) v3d/v3d_mmap (mmap-bo)
[457.097388] Subtest mmap-bo: SKIP (0.000s)
[457.150940] [127/141] (562s left) kms_vblank (pipe-c-ts-continuation-dpms-suspend)
[457.282073] Starting subtest: pipe-C-ts-continuation-dpms-suspend
[476.639446] Subtest pipe-C-ts-continuation-dpms-suspend: SUCCESS (3.015s)
[476.793165] [128/141] (559s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[477.116810] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[477.118528] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[477.278588] [129/141] (558s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[477.413645] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[477.415200] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[477.512111] [130/141] (558s left) kms_addfb_basic (small-bo)
[477.643869] Starting subtest: small-bo
[477.644794] Subtest small-bo: SUCCESS (0.000s)
[477.728869] [131/141] (558s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[477.970885] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[478.082636] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SUCCESS (0.111s)
[478.403636] [132/141] (557s left) kms_ccs (pipe-b-random-ccs-data-yf_tiled_ccs)
[478.654278] Starting subtest: pipe-B-random-ccs-data-yf_tiled_ccs
[478.656899] Subtest pipe-B-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[478.883373] [133/141] (557s left) kms_vblank (pipe-a-ts-continuation-idle-hang)
[479.014928] Starting subtest: pipe-A-ts-continuation-idle-hang
[492.703697] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (13.689s)
[492.857354] [134/141] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[493.000568] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[493.002464] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[493.074549] [135/141] (542s left) kms_vblank (pipe-b-ts-continuation-modeset-hang)
[493.206956] Starting subtest: pipe-B-ts-continuation-modeset-hang
[507.737484] Subtest pipe-B-ts-continuation-modeset-hang: SUCCESS (14.531s)
[507.887167] [136/141] (528s left) kms_invalid_mode (clock-too-high)
[508.022713] Starting subtest: clock-too-high
[508.025702] Starting dynamic subtest: DP-4-pipe-A
[508.111694] Dynamic subtest DP-4-pipe-A: SUCCESS (0.088s)
[508.121956] Starting dynamic subtest: DP-4-pipe-B
[508.123789] Dynamic subtest DP-4-pipe-B: SUCCESS (0.006s)
[508.132842] Starting dynamic subtest: DP-4-pipe-C
[508.134484] Dynamic subtest DP-4-pipe-C: SUCCESS (0.007s)
[508.143627] Starting dynamic subtest: DP-4-pipe-D
[508.145163] Dynamic subtest DP-4-pipe-D: SUCCESS (0.007s)
[508.145945] Subtest clock-too-high: SUCCESS (0.115s)
[508.291266] [137/141] (527s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[508.426960] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[508.428548] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[508.508146] [138/141] (527s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[508.566697] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[508.673560] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[508.791336] [139/141] (527s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_rc_ccs)
[509.122949] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs
[509.124730] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[509.292364] [140/141] (526s left) gem_exec_suspend (basic-s0)
[509.359881] Starting subtest: basic-S0
[509.360707] Starting dynamic subtest: smem
[529.036317] Dynamic subtest smem: SUCCESS (4.673s)
[529.049798] Starting dynamic subtest: lmem0
[548.073320] Dynamic subtest lmem0: SUCCESS (4.394s)
[548.074252] Subtest basic-S0: SUCCESS (9.070s)
[548.310780] [141/141] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[548.445274] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[548.447025] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[548.536576] Closing watchdogs
Done.