[28.303999] Initializing watchdogs [28.304067] /dev/watchdog0 [28.308931] [001/141] (960s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled) [28.361338] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled [28.362116] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [28.393467] [002/141] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [28.503165] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [28.504543] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [28.558962] [003/141] (960s left) kms_prime (basic-crc-hybrid) [29.125541] Subtest basic-crc-hybrid: SKIP (0.000s) [29.185414] [004/141] (959s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [29.239975] Starting subtest: basic-write-cpu-read-gtt [29.475564] Subtest basic-write-cpu-read-gtt: SUCCESS (0.228s) [29.519669] [005/141] (959s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [29.930941] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs [29.932467] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s) [30.027601] [006/141] (958s left) syncobj_timeline (wait-delayed-signal) [30.074848] Starting subtest: wait-delayed-signal [30.175610] Subtest wait-delayed-signal: SUCCESS (0.101s) [30.210932] [007/141] (958s left) kms_cursor_legacy (flip-vs-cursor-legacy) [30.305328] Starting subtest: flip-vs-cursor-legacy [35.183404] Subtest flip-vs-cursor-legacy: SUCCESS (4.878s) [35.289957] [008/141] (953s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [35.393756] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [35.395226] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [35.447824] [009/141] (953s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [35.644433] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [35.648238] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s) [35.957757] [010/141] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [36.057018] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [36.058636] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [36.115699] [011/141] (952s left) perf_pmu (interrupts) [36.165875] Starting subtest: interrupts [37.245289] Subtest interrupts: SUCCESS (1.070s) [37.297889] [012/141] (951s left) gem_lmem_swapping (heavy-verify-multi-ccs) [37.353462] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [37.367111] [013/141] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [37.469550] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [37.470942] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [37.524954] [014/141] (951s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [37.624669] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [37.626244] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [37.682944] [015/141] (951s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling) [37.778330] Starting subtest: planes-downscale-factor-0-5-unity-scaling [37.779931] Starting dynamic subtest: pipe-A-HDMI-A-1 [37.903487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.124s) [37.907914] Starting dynamic subtest: pipe-B-HDMI-A-1 [38.020027] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.115s) [38.024549] Starting dynamic subtest: pipe-C-HDMI-A-1 [38.137700] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.116s) [38.142189] Starting dynamic subtest: pipe-D-HDMI-A-1 [38.254118] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.115s) [38.254882] Subtest planes-downscale-factor-0-5-unity-scaling: SUCCESS (0.476s) [38.391158] [016/141] (950s left) gem_mmap_offset (bad-object) [38.439886] Starting subtest: bad-object [38.440644] Subtest bad-object: SUCCESS (0.001s) [38.490975] [017/141] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [38.591730] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [38.593122] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [38.632701] [018/141] (950s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [38.742656] Starting subtest: yf-tiled-16bpp-rotate-270 [38.744440] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [38.800645] [019/141] (950s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_rc_ccs_cc) [38.899558] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc [38.901127] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [39.310330] [020/141] (949s left) kms_chamelium_frames (hdmi-frame-dump) [39.463833] Subtest hdmi-frame-dump: SKIP (0.000s) [39.522184] [021/141] (949s left) gem_exec_fence (basic-busy) [39.685134] Starting subtest: basic-busy [39.685931] Starting dynamic subtest: rcs0 [39.713961] Dynamic subtest rcs0: SUCCESS (0.029s) [39.718394] Starting dynamic subtest: bcs0 [39.734962] Dynamic subtest bcs0: SUCCESS (0.021s) [39.740063] Starting dynamic subtest: vcs0 [39.773914] Dynamic subtest vcs0: SUCCESS (0.039s) [39.778200] Starting dynamic subtest: vcs1 [39.797856] Dynamic subtest vcs1: SUCCESS (0.024s) [39.802537] Starting dynamic subtest: vecs0 [39.820872] Dynamic subtest vecs0: SUCCESS (0.023s) [39.821691] Subtest basic-busy: SUCCESS (0.136s) [40.204585] [022/141] (948s left) syncobj_wait (wait-for-submit-snapshot) [40.256275] Starting subtest: wait-for-submit-snapshot [40.337151] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [40.370708] [023/141] (948s left) gen7_exec_parse (basic-rejected) [40.423507] Subtest basic-rejected: SKIP (0.000s) [40.447375] [024/141] (948s left) kms_big_fb (y-tiled-8bpp-rotate-270) [40.550104] Starting subtest: y-tiled-8bpp-rotate-270 [40.605540] Subtest y-tiled-8bpp-rotate-270: SKIP (0.055s) [40.671093] [025/141] (948s left) api_intel_allocator (simple-allocator) [40.720806] Starting subtest: simple-allocator [40.721628] Starting dynamic subtest: basic [40.722371] Dynamic subtest basic: SUCCESS (0.002s) [40.726609] Starting dynamic subtest: parallel-one [40.788172] Dynamic subtest parallel-one: SUCCESS (0.066s) [40.791937] Starting dynamic subtest: print [40.792666] Dynamic subtest print: SUCCESS (0.000s) [40.796451] Starting dynamic subtest: reuse [40.797298] Dynamic subtest reuse: SUCCESS (0.000s) [40.800953] Starting dynamic subtest: reserve [40.801717] Dynamic subtest reserve: SUCCESS (0.000s) [40.805371] Starting dynamic subtest: fork-reopen-allocator [40.806093] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [40.806792] Subtest simple-allocator: SUCCESS (0.081s) [40.841884] [026/141] (948s left) gem_exec_balancer (hog) [40.894976] Starting subtest: hog [41.781264] Subtest hog: SUCCESS (0.878s) [42.003544] [027/141] (947s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [42.057934] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [42.058680] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [42.094839] [028/141] (946s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [42.531831] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [42.534621] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s) [42.614438] [029/141] (946s left) gem_ccs (suspend-resume) [42.664555] Starting subtest: suspend-resume [42.666031] Subtest suspend-resume: SKIP (0.000s) [42.696895] [030/141] (946s left) gem_ctx_bad_destroy (invalid-pad) [42.744958] Starting subtest: invalid-pad [42.745781] Subtest invalid-pad: SUCCESS (0.000s) [42.780027] [031/141] (946s left) syncobj_wait (invalid-single-wait-unsubmitted) [42.827063] Starting subtest: invalid-single-wait-unsubmitted [42.827951] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [42.864419] [032/141] (946s left) i915_module_load (reload-no-display) [42.919341] Starting subtest: reload-no-display [44.679237] Subtest reload-no-display: SUCCESS (1.752s) [44.689843] [033/141] (944s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [45.333458] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [45.346819] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s) [45.435110] [034/141] (943s left) kms_vblank (pipe-d-query-busy) [45.531047] Starting subtest: pipe-D-query-busy [46.856391] Subtest pipe-D-query-busy: SUCCESS (1.325s) [46.942751] [035/141] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [47.042981] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [47.044498] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [47.100959] [036/141] (942s left) gem_ctx_persistence (engines-mixed) [47.153735] Starting subtest: engines-mixed [47.154528] Starting dynamic subtest: rcs0 [47.196293] Dynamic subtest rcs0: SUCCESS (0.042s) [47.202192] Starting dynamic subtest: bcs0 [47.238629] Dynamic subtest bcs0: SUCCESS (0.042s) [47.248068] Starting dynamic subtest: vcs0 [47.285663] Dynamic subtest vcs0: SUCCESS (0.047s) [47.295428] Starting dynamic subtest: vcs1 [47.343986] Dynamic subtest vcs1: SUCCESS (0.058s) [47.348193] Starting dynamic subtest: vecs0 [47.396081] Dynamic subtest vecs0: SUCCESS (0.052s) [47.396856] Subtest engines-mixed: SUCCESS (0.242s) [47.433882] [037/141] (941s left) kms_psr (psr2_sprite_plane_onoff) [47.483712] Subtest psr2_sprite_plane_onoff: SKIP (0.000s) [47.504676] [038/141] (941s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [47.605883] Starting subtest: 2x-cursor-vs-flip-legacy [47.609290] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s) [47.642667] [039/141] (941s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [47.738260] Starting subtest: cursor-vs-flip-atomic-transitions [76.138406] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (28.400s) [76.224493] [040/141] (912s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [76.275894] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [76.276633] Starting dynamic subtest: smem [76.357889] Dynamic subtest smem: SUCCESS (0.082s) [76.358649] Subtest y-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.082s) [76.500827] [041/141] (912s left) kms_plane_alpha_blend (constant-alpha-min) [76.605135] Starting subtest: constant-alpha-min [76.673135] Starting dynamic subtest: pipe-A-HDMI-A-1 [77.036693] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.363s) [77.043042] Starting dynamic subtest: pipe-D-HDMI-A-1 [77.451572] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.412s) [77.452381] Subtest constant-alpha-min: SUCCESS (0.847s) [77.557742] [042/141] (911s left) kms_cursor_crc (cursor-offscreen-128x128) [77.656594] Starting subtest: cursor-offscreen-128x128 [77.661878] Starting dynamic subtest: pipe-A-HDMI-A-1 [78.887686] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.226s) [78.912286] Starting dynamic subtest: pipe-D-HDMI-A-1 [80.944551] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.036s) [80.945293] Subtest cursor-offscreen-128x128: SUCCESS (3.288s) [81.043644] [043/141] (908s left) device_reset (unbind-cold-reset-rebind) [81.428151] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [81.453051] [044/141] (907s left) kms_prop_blob (invalid-set-prop) [81.509369] Starting subtest: invalid-set-prop [81.510203] Subtest invalid-set-prop: SUCCESS (0.000s) [81.551911] [045/141] (907s left) i915_pm_rps (min-max-config-loaded) [81.604255] Starting subtest: min-max-config-loaded [81.928787] Subtest min-max-config-loaded: SUCCESS (0.320s) [82.001948] [046/141] (907s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs) [82.319893] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs [82.416773] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs: SUCCESS (0.096s) [82.673736] [047/141] (906s left) kms_addfb_basic (unused-handle) [82.720924] Starting subtest: unused-handle [82.721630] Subtest unused-handle: SUCCESS (0.000s) [82.823212] [048/141] (906s left) kms_vblank (pipe-c-ts-continuation-modeset-hang) [82.920836] Starting subtest: pipe-C-ts-continuation-modeset-hang [97.249377] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (14.329s) [97.353899] [049/141] (891s left) v3d/v3d_wait_bo (used-bo-0ns) [97.425050] Subtest used-bo-0ns: SKIP (0.000s) [97.453986] [050/141] (891s left) kms_cursor_crc (cursor-random-32x32) [97.551009] Starting subtest: cursor-random-32x32 [97.593618] Subtest cursor-random-32x32: SKIP (0.041s) [97.646246] [051/141] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [97.746416] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [97.747877] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [97.795826] [052/141] (891s left) gem_mmap_gtt (cpuset-medium-copy-xy) [97.843196] Starting subtest: cpuset-medium-copy-XY [108.533307] Subtest cpuset-medium-copy-XY: SUCCESS (10.689s) [108.583471] [053/141] (880s left) kms_vblank (pipe-a-query-forked-busy-hang) [108.727149] Starting subtest: pipe-A-query-forked-busy-hang [122.852865] Subtest pipe-A-query-forked-busy-hang: SUCCESS (14.126s) [122.956774] [054/141] (866s left) perf (oa-exponents) [123.056435] Starting subtest: oa-exponents [123.057251] Starting dynamic subtest: 0-rcs0 [126.484332] Dynamic subtest 0-rcs0: SUCCESS (3.420s) [126.485166] Subtest oa-exponents: SUCCESS (3.420s) [126.497557] [055/141] (862s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [126.604822] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [126.606480] Starting dynamic subtest: pipe-A-valid-mode [126.662155] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s) [126.663635] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.057s) [126.735300] [056/141] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [126.838227] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [126.839757] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [126.893680] [057/141] (862s left) kms_lease (lease_get) [126.992174] Starting subtest: lease_get [126.994090] Starting dynamic subtest: pipe-A-HDMI-A-1 [126.995135] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [126.999962] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.000782] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [127.005325] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.006096] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [127.010415] Starting dynamic subtest: pipe-D-HDMI-A-1 [127.011163] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s) [127.011945] Subtest lease_get: SUCCESS (0.009s) [127.036083] [058/141] (862s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs) [127.287021] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs [127.289326] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s) [127.568285] [059/141] (861s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [127.622410] Starting subtest: y-tiled-to-vebox-x-tiled [127.623250] Starting dynamic subtest: smem [127.719758] Dynamic subtest smem: SUCCESS (0.097s) [127.720582] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.098s) [127.868732] [060/141] (861s left) vc4/vc4_tiling (get-bad-modifier) [127.938832] Subtest get-bad-modifier: SKIP (0.000s) [127.977941] [061/141] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [128.085527] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [129.238717] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.155s) [129.322599] [062/141] (860s left) kms_frontbuffer_tracking (fbc-tiling-y) [129.434132] Starting subtest: fbc-tiling-y [130.572269] Subtest fbc-tiling-y: SUCCESS (1.144s) [130.659984] [063/141] (858s left) kms_rotation_crc (multiplane-rotation) [130.762912] Starting subtest: multiplane-rotation [140.140959] Subtest multiplane-rotation: SUCCESS (9.378s) [140.220343] [064/141] (849s left) kms_flip (2x-plain-flip-ts-check) [140.303512] Starting subtest: 2x-plain-flip-ts-check [140.315624] Subtest 2x-plain-flip-ts-check: SKIP (0.012s) [140.361891] [065/141] (849s left) gem_render_copy_redux (flink) [140.416132] Starting subtest: flink [141.373785] Subtest flink: SUCCESS (0.958s) [141.453841] [066/141] (848s left) drm_fdinfo (virtual-busy) [141.512433] Starting subtest: virtual-busy [144.147744] Subtest virtual-busy: SUCCESS (2.635s) [144.191445] [067/141] (845s left) i915_pm_rpm (pm-tiling) [155.823673] Starting subtest: pm-tiling [157.200043] Subtest pm-tiling: SUCCESS (1.376s) [157.284494] [068/141] (832s left) gem_exec_reloc (basic-cpu-read) [157.335568] Starting subtest: basic-cpu-read [157.339819] Subtest basic-cpu-read: SUCCESS (0.004s) [157.428962] [069/141] (832s left) gem_ctx_engines (independent) [157.483717] Starting subtest: independent [157.484589] Starting dynamic subtest: rcs0 [157.544590] Dynamic subtest rcs0: SUCCESS (0.060s) [157.549895] Starting dynamic subtest: bcs0 [157.600587] Dynamic subtest bcs0: SUCCESS (0.055s) [157.605593] Starting dynamic subtest: vcs0 [157.655498] Dynamic subtest vcs0: SUCCESS (0.054s) [157.661562] Starting dynamic subtest: vcs1 [157.712056] Dynamic subtest vcs1: SUCCESS (0.056s) [157.716865] Starting dynamic subtest: vecs0 [157.765437] Dynamic subtest vecs0: SUCCESS (0.053s) [157.770498] Starting dynamic subtest: all-engines [157.900660] Dynamic subtest all-engines: SUCCESS (0.126s) [157.901407] Subtest independent: SUCCESS (0.409s) [158.046858] [070/141] (831s left) kms_cursor_crc (cursor-rapid-movement-64x21) [158.154879] Starting subtest: cursor-rapid-movement-64x21 [158.159936] Starting dynamic subtest: pipe-A-HDMI-A-1 [158.389252] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.230s) [158.415745] Starting dynamic subtest: pipe-D-HDMI-A-1 [159.442081] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.030s) [159.442929] Subtest cursor-rapid-movement-64x21: SUCCESS (1.288s) [159.532984] [071/141] (830s left) v3d/v3d_perfmon (destroy-valid-perfmon) [159.602156] Subtest destroy-valid-perfmon: SKIP (0.000s) [159.631923] [072/141] (829s left) gem_ctx_param (invalid-size-get) [159.681964] Starting subtest: invalid-size-get [159.682817] Subtest invalid-size-get: SUCCESS (0.000s) [159.715312] [073/141] (829s left) gem_pxp (create-regular-context-2) [162.311364] Subtest create-regular-context-2: SKIP (0.000s) [162.326493] [074/141] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [162.431635] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [162.433266] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [162.490762] [075/141] (827s left) gem_exec_reloc (basic-gtt-cpu-active) [162.541249] Starting subtest: basic-gtt-cpu-active [162.663986] Subtest basic-gtt-cpu-active: SUCCESS (0.116s) [162.762609] [076/141] (826s left) kms_frontbuffer_tracking (fbc-suspend) [162.862731] Starting subtest: fbc-suspend [199.101868] Subtest fbc-suspend: SUCCESS (6.479s) [204.232900] [077/141] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [204.338501] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [204.339917] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [204.392682] [078/141] (820s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [204.489306] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [204.490856] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [204.526126] [079/141] (819s left) v3d/v3d_submit_csd (bad-multisync-pad) [204.595802] Subtest bad-multisync-pad: SKIP (0.000s) [204.631140] [080/141] (819s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [204.740990] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [204.742558] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [204.800685] [081/141] (819s left) sysfs_timeslice_duration (timeout) [204.854390] Starting subtest: timeout [204.855254] Starting dynamic subtest: vecs0 [205.705907] Dynamic subtest vecs0: SUCCESS (0.850s) [205.713162] Starting dynamic subtest: vcs0 [206.560859] Dynamic subtest vcs0: SUCCESS (0.854s) [206.568109] Starting dynamic subtest: bcs0 [207.408335] Dynamic subtest bcs0: SUCCESS (0.847s) [207.416353] Starting dynamic subtest: rcs0 [208.268067] Dynamic subtest rcs0: SUCCESS (0.858s) [208.275573] Starting dynamic subtest: vcs1 [209.120805] Dynamic subtest vcs1: SUCCESS (0.852s) [209.121913] Subtest timeout: SUCCESS (4.266s) [209.165959] [082/141] (815s left) kms_dsc (dsc-with-output-formats) [209.269705] Starting subtest: dsc-with-output-formats [209.271293] Subtest dsc-with-output-formats: SKIP (0.000s) [209.310016] [083/141] (815s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [209.409799] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [210.579507] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (1.172s) [210.673984] [084/141] (813s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted) [210.726052] Starting subtest: invalid-single-wait-all-available-unsubmitted [210.726915] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s) [210.759484] [085/141] (813s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [210.812561] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [210.835413] [086/141] (813s left) gen9_exec_parse (bb-start-param) [210.887814] Subtest bb-start-param: SKIP (0.000s) [210.910696] [087/141] (813s left) kms_flip (2x-flip-vs-wf_vblank) [210.996468] Starting subtest: 2x-flip-vs-wf_vblank [211.009085] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s) [211.052559] [088/141] (813s left) perf (per-context-mode-unprivileged) [211.136183] Starting subtest: per-context-mode-unprivileged [211.137860] Subtest per-context-mode-unprivileged: SKIP (0.000s) [211.157660] [089/141] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [211.261470] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [211.262899] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [211.318681] [090/141] (813s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [211.414686] Starting subtest: primary-y-tiled-reflect-x-0 [216.226871] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.812s) [216.353321] [091/141] (808s left) syncobj_wait (single-wait-all-for-submit-submitted) [216.401238] Starting subtest: single-wait-all-for-submit-submitted [216.508723] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s) [216.552327] [092/141] (808s left) kms_pipe_crc_basic (suspend-read-crc) [216.656768] Starting subtest: suspend-read-crc [216.658547] Starting dynamic subtest: pipe-A-HDMI-A-1 [233.304531] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.942s) [233.311623] Starting dynamic subtest: pipe-B-HDMI-A-1 [250.435626] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.327s) [250.443699] Starting dynamic subtest: pipe-C-HDMI-A-1 [268.698366] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.860s) [268.704812] Starting dynamic subtest: pipe-D-HDMI-A-1 [286.953237] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.398s) [286.954087] Subtest suspend-read-crc: SUCCESS (10.539s) [291.076446] [093/141] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [291.185061] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt [291.186858] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [291.249812] [094/141] (797s left) kms_cursor_legacy (cursorb-vs-flipa-toggle) [291.347905] Starting subtest: cursorB-vs-flipA-toggle [291.351298] Subtest cursorB-vs-flipA-toggle: SKIP (0.003s) [291.387228] [095/141] (797s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [291.487240] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [292.632161] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.146s) [292.726820] [096/141] (795s left) gem_ctx_persistence (process) [292.785726] Starting subtest: process [292.876884] Subtest process: SUCCESS (0.089s) [292.930318] [097/141] (795s left) gem_ppgtt (blt-vs-render-ctxn) [292.987081] Starting subtest: blt-vs-render-ctxN [325.459332] Subtest blt-vs-render-ctxN: SUCCESS (32.472s) [325.539830] [098/141] (762s left) perf_pmu (busy-accuracy-50) [325.639012] Starting subtest: busy-accuracy-50 [325.639844] Starting dynamic subtest: rcs0 [327.160069] Dynamic subtest rcs0: SUCCESS (1.520s) [327.167475] Starting dynamic subtest: bcs0 [328.686865] Dynamic subtest bcs0: SUCCESS (1.521s) [328.695305] Starting dynamic subtest: vcs0 [330.204794] Dynamic subtest vcs0: SUCCESS (1.522s) [330.213494] Starting dynamic subtest: vcs1 [331.729495] Dynamic subtest vcs1: SUCCESS (1.524s) [331.738330] Starting dynamic subtest: vecs0 [333.253692] Dynamic subtest vecs0: SUCCESS (1.524s) [333.254569] Subtest busy-accuracy-50: SUCCESS (7.614s) [333.296661] [099/141] (755s left) kms_ccs (pipe-d-bad-pixel-format-yf_tiled_ccs) [333.677771] Starting subtest: pipe-D-bad-pixel-format-yf_tiled_ccs [333.679321] Subtest pipe-D-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [333.833140] [100/141] (754s left) kms_ccs (pipe-d-random-ccs-data-y_tiled_gen12_rc_ccs_cc) [334.245718] Starting subtest: pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc [334.344157] Subtest pipe-D-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.098s) [334.519207] [101/141] (754s left) gem_madvise (dontneed-before-exec) [334.567310] Starting subtest: dontneed-before-exec [334.569972] Subtest dontneed-before-exec: SUCCESS (0.002s) [334.635393] [102/141] (753s left) kms_chamelium_color (ctm-negative) [334.735089] Subtest ctm-negative: SKIP (0.000s) [334.753850] [103/141] (753s left) gem_madvise (dontneed-before-mmap) [334.799582] Starting subtest: dontneed-before-mmap [334.803345] Subtest dontneed-before-mmap: SUCCESS (0.004s) [334.869527] [104/141] (753s left) gem_set_tiling_vs_gtt [335.332499] [105/141] (753s left) i915_pm_rpm (gem-evict-pwrite) [346.948018] Starting subtest: gem-evict-pwrite [347.480820] Subtest gem-evict-pwrite: SUCCESS (0.533s) [347.649502] [106/141] (740s left) gem_exec_fence (syncobj-signal) [347.972271] Starting subtest: syncobj-signal [347.974063] Subtest syncobj-signal: SUCCESS (0.002s) [348.247585] [107/141] (740s left) kms_color (ctm-red-to-blue) [348.350573] Starting subtest: ctm-red-to-blue [348.351422] Starting dynamic subtest: pipe-A [348.626807] Dynamic subtest pipe-A: SUCCESS (0.277s) [348.633864] Starting dynamic subtest: pipe-B [349.185519] Dynamic subtest pipe-B: SUCCESS (0.557s) [349.192661] Starting dynamic subtest: pipe-C [349.999197] Dynamic subtest pipe-C: SUCCESS (0.814s) [350.006088] Starting dynamic subtest: pipe-D [350.384108] Dynamic subtest pipe-D: SUCCESS (0.384s) [350.385016] Subtest ctm-red-to-blue: SUCCESS (2.035s) [350.484268] [108/141] (738s left) prime_self_import (basic-with_one_bo) [350.531539] Starting subtest: basic-with_one_bo [350.534086] Subtest basic-with_one_bo: SUCCESS (0.002s) [350.568586] [109/141] (738s left) gem_exec_parallel (engines) [350.621673] Starting subtest: engines [350.622494] Starting dynamic subtest: basic [352.056756] Dynamic subtest basic: SUCCESS (1.435s) [352.062406] Starting dynamic subtest: contexts [355.100797] Dynamic subtest contexts: SUCCESS (3.043s) [355.106553] Starting dynamic subtest: fds [357.733264] Dynamic subtest fds: SUCCESS (2.632s) [357.748016] Starting dynamic subtest: userptr [359.258930] Dynamic subtest userptr: SUCCESS (1.525s) [359.259960] Subtest engines: SUCCESS (8.637s) [359.413837] [110/141] (729s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [359.713602] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [360.530074] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.816s) [360.826525] [111/141] (727s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs) [361.202346] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs [362.027013] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.824s) [362.248453] [112/141] (726s left) gem_exec_big (single) [362.299344] Starting subtest: single [365.473705] Subtest single: SUCCESS (3.174s) [365.948080] [113/141] (722s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs) [366.207957] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs [366.209397] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s) [366.521991] [114/141] (722s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [366.619697] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [366.621436] Starting dynamic subtest: pipe-A-valid-mode [366.673063] Dynamic subtest pipe-A-valid-mode: SKIP (0.052s) [366.674697] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.053s) [366.748383] [115/141] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [366.851406] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [366.853080] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [366.915474] [116/141] (721s left) fbdev (unaligned-write) [366.967268] Starting subtest: unaligned-write [367.082704] Subtest unaligned-write: SUCCESS (0.114s) [367.117172] [117/141] (721s left) kms_vrr (flip-dpms) [367.214319] Starting subtest: flip-dpms [367.215821] Subtest flip-dpms: SKIP (0.000s) [367.233197] [118/141] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [367.333882] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [367.335298] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [367.389808] [119/141] (721s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs) [367.665231] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs [367.666067] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SUCCESS (0.000s) [367.929889] [120/141] (720s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs) [368.139531] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs [368.142402] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.002s) [368.466841] [121/141] (720s left) gem_mmap_wc (invalid-flags) [368.515115] Starting subtest: invalid-flags [368.515872] Subtest invalid-flags: SUCCESS (0.000s) [368.574759] [122/141] (720s left) gem_exec_schedule (preempt-other) [368.638345] Starting subtest: preempt-other [368.639150] Starting dynamic subtest: rcs0 [368.661028] Dynamic subtest rcs0: SUCCESS (0.022s) [368.667060] Starting dynamic subtest: bcs0 [368.683944] Dynamic subtest bcs0: SUCCESS (0.022s) [368.690451] Starting dynamic subtest: vcs0 [368.705302] Dynamic subtest vcs0: SUCCESS (0.021s) [368.711652] Starting dynamic subtest: vcs1 [368.727795] Dynamic subtest vcs1: SUCCESS (0.022s) [368.734140] Starting dynamic subtest: vecs0 [368.750410] Dynamic subtest vecs0: SUCCESS (0.022s) [368.751324] Subtest preempt-other: SUCCESS (0.112s) [369.078668] [123/141] (719s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [369.186615] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [369.877518] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.691s) [369.975172] [124/141] (718s left) gem_userptr_blits (stress-purge) [370.037231] Starting subtest: stress-purge [375.452936] Subtest stress-purge: SUCCESS (5.416s) [375.531722] [125/141] (713s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [375.670479] Starting subtest: nonblocking-modeset-vs-cursor-atomic [375.931648] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.261s) [376.032128] [126/141] (712s left) gem_workarounds (reset) [376.091981] Starting subtest: reset [376.099957] Subtest reset: SUCCESS (0.008s) [376.164311] [127/141] (712s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [376.218799] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [376.322559] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s) [376.364585] [128/141] (712s left) gem_exec_whisper (basic-fds-all) [376.419756] Starting subtest: basic-fds-all [379.831360] Subtest basic-fds-all: SUCCESS (3.410s) [379.993277] [129/141] (708s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [380.106421] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [380.108027] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [380.164784] [130/141] (708s left) gem_exec_schedule (reorder-wide) [380.337958] Starting subtest: reorder-wide [380.339537] Starting dynamic subtest: rcs0 [380.402891] Dynamic subtest rcs0: SUCCESS (0.065s) [380.420257] Starting dynamic subtest: bcs0 [380.476168] Dynamic subtest bcs0: SUCCESS (0.072s) [380.487639] Starting dynamic subtest: vcs0 [380.539968] Dynamic subtest vcs0: SUCCESS (0.062s) [380.550980] Starting dynamic subtest: vcs1 [380.609930] Dynamic subtest vcs1: SUCCESS (0.069s) [380.620770] Starting dynamic subtest: vecs0 [380.675123] Dynamic subtest vecs0: SUCCESS (0.063s) [380.676247] Subtest reorder-wide: SUCCESS (0.339s) [380.832864] [131/141] (708s left) gem_ctx_param (root-set) [380.889880] Starting subtest: root-set [380.890739] Subtest root-set: SUCCESS (0.000s) [380.940767] [132/141] (708s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc) [381.272606] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc [381.436084] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.163s) [381.681223] [133/141] (707s left) kms_big_fb (4-tiled-64bpp-rotate-270) [381.783143] Starting subtest: 4-tiled-64bpp-rotate-270 [381.784803] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s) [381.830895] [134/141] (707s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_mc_ccs) [381.928152] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs [381.929747] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s) [382.371312] [135/141] (706s left) kms_cursor_legacy (cursor-vs-flip-toggle) [382.468171] Starting subtest: cursor-vs-flip-toggle [411.335644] Subtest cursor-vs-flip-toggle: SUCCESS (28.868s) [411.441387] [136/141] (677s left) kms_addfb_basic (addfb25-y-tiled-legacy) [411.542940] Starting subtest: addfb25-y-tiled-legacy [411.543732] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [411.589519] [137/141] (677s left) perf (buffer-fill) [411.683685] Starting subtest: buffer-fill [411.684580] Starting dynamic subtest: 0-rcs0 [413.898238] Dynamic subtest 0-rcs0: SUCCESS (2.214s) [413.899192] Subtest buffer-fill: SUCCESS (2.215s) [413.920106] [138/141] (675s left) kms_vblank (pipe-c-wait-busy) [414.045404] Starting subtest: pipe-C-wait-busy [415.899815] Subtest pipe-C-wait-busy: SUCCESS (1.855s) [415.993400] [139/141] (673s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [416.095798] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip [416.394992] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.299s) [416.492620] [140/141] (672s left) perf_pmu (render-node-busy) [416.544930] Starting subtest: render-node-busy [416.545772] Starting dynamic subtest: rcs0 [417.085985] Dynamic subtest rcs0: SUCCESS (0.541s) [417.094377] Starting dynamic subtest: bcs0 [417.625227] Dynamic subtest bcs0: SUCCESS (0.538s) [417.634435] Starting dynamic subtest: vcs0 [418.162209] Dynamic subtest vcs0: SUCCESS (0.535s) [418.171222] Starting dynamic subtest: vcs1 [418.696084] Dynamic subtest vcs1: SUCCESS (0.533s) [418.705372] Starting dynamic subtest: vecs0 [419.238019] Dynamic subtest vecs0: SUCCESS (0.541s) [419.239530] Subtest render-node-busy: SUCCESS (2.694s) [419.280742] [141/141] (669s left) gem_exec_flush (basic-wb-set-default) [419.340713] Starting subtest: basic-wb-set-default [424.760375] Subtest basic-wb-set-default: SUCCESS (5.420s) [424.924978] Closing watchdogs Done.