[43.446663] Initializing watchdogs
[43.446711]   /dev/watchdog0
[43.451500] [001/142] (960s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[43.519823] Starting subtest: basic-flip-before-cursor-legacy
[44.620547] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.102s)
[44.767600] [002/142] (959s left) kms_chamelium_frames (dp-crc-fast)
[44.904813] Subtest dp-crc-fast: SKIP (0.000s)
[44.952421] [003/142] (959s left) gem_exec_schedule (u-semaphore-noskip)
[45.002899] Starting subtest: u-semaphore-noskip
[45.190909] Subtest u-semaphore-noskip: SUCCESS (0.187s)
[45.522284] [004/142] (958s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[45.573082] Starting subtest: single-wait-all-for-submit-signaled
[45.573851] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[45.643907] [005/142] (958s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[45.729974] Starting subtest: primary-yf-tiled-reflect-x-180
[45.840575] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.110s)
[45.928059] [006/142] (958s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_mc_ccs)
[46.082873] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[46.179999] [007/142] (957s left) syncobj_basic (bad-pad-handle-to-fd)
[46.220767] Starting subtest: bad-pad-handle-to-fd
[46.221470] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[46.292218] [008/142] (957s left) i915_pm_freq_mult (media-freq)
[46.338112] Starting subtest: media-freq
[46.338834] Starting dynamic subtest: gt0
[46.340172] Dynamic subtest gt0: SKIP (0.000s)
[46.341504] Subtest media-freq: SKIP (0.000s)
[46.408710] [009/142] (957s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[46.492569] Starting subtest: cursorB-vs-flipA-atomic
[46.495398] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[46.580046] [010/142] (957s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[46.667195] Starting subtest: psr-rgb565-draw-pwrite
[46.668833] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[46.761034] [011/142] (957s left) kms_fbcon_fbt (fbc)
[46.814229] Starting subtest: fbc
[50.195915] Subtest fbc: SUCCESS (3.381s)
[50.230341] [012/142] (953s left) kms_cursor_crc (cursor-alpha-transparent)
[50.310898] Starting subtest: cursor-alpha-transparent
[50.313197] Starting dynamic subtest: pipe-A-HDMI-A-2
[50.776989] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.464s)
[50.783111] Starting dynamic subtest: pipe-B-HDMI-A-2
[51.148719] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.370s)
[51.149543] Subtest cursor-alpha-transparent: SUCCESS (0.837s)
[51.298228] [013/142] (952s left) gem_flink_basic (basic)
[51.339820] Starting subtest: basic
[51.340494] Subtest basic: SUCCESS (0.000s)
[51.432539] [014/142] (952s left) sw_sync (sync_multi_consumer)
[51.475677] Starting subtest: sync_multi_consumer
[51.831877] Subtest sync_multi_consumer: SUCCESS (0.356s)
[51.878253] [015/142] (952s left) gem_exec_whisper (basic-fds-all)
[51.926966] Starting subtest: basic-fds-all
[54.230975] Subtest basic-fds-all: SUCCESS (2.304s)
[54.433039] [016/142] (949s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[54.516725] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[54.840149] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.323s)
[55.001954] [017/142] (949s left) kms_cdclk (plane-scaling)
[55.045369] Subtest plane-scaling: SKIP (0.000s)
[55.074525] [018/142] (949s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[55.146916] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[55.148350] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[55.248471] [019/142] (949s left) kms_rotation_crc (cursor-rotation-180)
[55.321710] Starting subtest: cursor-rotation-180
[55.944308] Subtest cursor-rotation-180: SUCCESS (0.623s)
[56.103272] [020/142] (948s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[56.175499] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[56.176210] Starting dynamic subtest: pipe-A-HDMI-A-2
[56.292364] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.115s)
[56.306083] Starting dynamic subtest: pipe-B-HDMI-A-2
[56.408509] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.113s)
[56.409828] Subtest planes-upscale-20x20-downscale-factor-0-5: SUCCESS (0.233s)
[56.568517] [021/142] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[56.642869] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[56.644198] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[56.743508] [022/142] (947s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[56.820788] Starting subtest: yf-tiled-8bpp-rotate-0
[56.822167] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[56.902202] [023/142] (947s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[57.039077] Starting subtest: pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[57.040536] Subtest pipe-B-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[57.146991] [024/142] (947s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled)
[57.181142] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled
[57.181846] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[57.268517] [025/142] (947s left) perf_pmu (busy-accuracy-98)
[57.314386] Starting subtest: busy-accuracy-98
[57.315081] Starting dynamic subtest: rcs0
[60.336284] Dynamic subtest rcs0: SUCCESS (3.022s)
[60.342579] Starting dynamic subtest: bcs0
[63.359206] Dynamic subtest bcs0: SUCCESS (3.023s)
[63.365932] Starting dynamic subtest: vcs0
[66.382317] Dynamic subtest vcs0: SUCCESS (3.023s)
[66.389067] Starting dynamic subtest: vecs0
[69.406163] Dynamic subtest vecs0: SUCCESS (3.024s)
[69.406870] Subtest busy-accuracy-98: SUCCESS (12.092s)
[69.493956] [026/142] (934s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[69.534620] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[69.636475] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[69.721274] [027/142] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[69.808163] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[69.809505] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.907274] [028/142] (934s left) kms_plane (plane-position-hole-dpms)
[69.987772] Starting subtest: plane-position-hole-dpms
[69.988666] Starting dynamic subtest: pipe-A-planes
[72.117589] Dynamic subtest pipe-A-planes: SUCCESS (2.129s)
[72.123909] Starting dynamic subtest: pipe-B-planes
[73.940641] Dynamic subtest pipe-B-planes: SUCCESS (1.822s)
[73.941313] Subtest plane-position-hole-dpms: SUCCESS (3.954s)
[74.079452] [029/142] (930s left) gem_exec_balancer (nohangcheck)
[75.104701] Starting subtest: nohangcheck
[75.943528] Subtest nohangcheck: SUCCESS (0.839s)
[76.012362] [030/142] (928s left) i915_power (sanity)
[76.051495] Starting subtest: sanity
[76.052867] Subtest sanity: SKIP (0.000s)
[76.131283] [031/142] (928s left) syncobj_timeline (multi-wait-for-submit-signaled)
[76.169138] Starting subtest: multi-wait-for-submit-signaled
[76.169852] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[76.239089] [032/142] (928s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[76.331287] Starting subtest: y-tiled-64bpp-rotate-0
[78.135476] Subtest y-tiled-64bpp-rotate-0: SUCCESS (1.804s)
[78.277808] [033/142] (926s left) api_intel_bb (object-noreloc-keep-cache-simple)
[78.309620] Starting subtest: object-noreloc-keep-cache-simple
[78.311685] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.002s)
[78.426382] [034/142] (926s left) gem_unfence_active_buffers
[78.621706] [035/142] (925s left) gem_basic (create-fd-close)
[78.667127] Starting subtest: create-fd-close
[78.668461] Subtest create-fd-close: SUCCESS (0.000s)
[78.772781] [036/142] (925s left) api_intel_bb (simple-bb)
[78.821617] Starting subtest: simple-bb
[78.823090] Subtest simple-bb: SUCCESS (0.002s)
[78.925430] [037/142] (925s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[79.003524] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[79.004205] Starting dynamic subtest: pipe-A-HDMI-A-2
[79.146859] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.143s)
[79.161767] Starting dynamic subtest: pipe-B-HDMI-A-2
[79.284651] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.134s)
[79.285901] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.281s)
[79.432458] [038/142] (925s left) kms_vblank (pipe-c-ts-continuation-modeset-rpm)
[79.519126] Subtest pipe-C-ts-continuation-modeset-rpm: SKIP (0.000s)
[79.602175] [039/142] (925s left) gem_unref_active_buffers
[79.774577] [040/142] (924s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[79.849558] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[79.850258] Starting dynamic subtest: pipe-A-valid-mode
[79.903723] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[79.905262] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.054s)
[80.005709] [041/142] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[80.079351] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[80.080709] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.171775] [042/142] (924s left) kms_flip (flip-vs-rmfb)
[80.240240] Starting subtest: flip-vs-rmfb
[80.240953] Starting dynamic subtest: A-HDMI-A2
[95.408882] Dynamic subtest A-HDMI-A2: SUCCESS (15.167s)
[95.418241] Starting dynamic subtest: B-HDMI-A2
[110.574921] Dynamic subtest B-HDMI-A2: SUCCESS (15.164s)
[110.576482] Subtest flip-vs-rmfb: SUCCESS (30.337s)
[110.714244] [043/142] (894s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[110.789663] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[110.790470] Starting dynamic subtest: pipe-A-valid-mode
[110.826955] Dynamic subtest pipe-A-valid-mode: SKIP (0.036s)
[110.828268] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.038s)
[110.928072] [044/142] (893s left) gem_wait (invalid-buf)
[110.973816] Starting subtest: invalid-buf
[110.974493] Subtest invalid-buf: SUCCESS (0.000s)
[111.171384] [045/142] (893s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[111.253491] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[111.254813] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[111.345138] [046/142] (893s left) gen9_exec_parse (bb-secure)
[111.377302] Subtest bb-secure: SKIP (0.000s)
[111.396813] [047/142] (893s left) gem_create (create-ext-placement-all)
[111.556893] Starting subtest: create-ext-placement-all
[111.561543] Subtest create-ext-placement-all: SUCCESS (0.000s)
[111.652120] [048/142] (893s left) drm_fdinfo (idle)
[111.697088] Starting subtest: idle
[111.697875] Starting dynamic subtest: rcs0
[112.230027] Dynamic subtest rcs0: FAIL (0.523s)
[112.238200] Starting dynamic subtest: bcs0
[112.723645] Dynamic subtest bcs0: SUCCESS (0.501s)
[112.730653] Starting dynamic subtest: vcs0
[113.226755] Dynamic subtest vcs0: SUCCESS (0.502s)
[113.234460] Starting dynamic subtest: vecs0
[113.729876] Dynamic subtest vecs0: SUCCESS (0.502s)
[113.731317] Subtest idle: FAIL (2.033s)
[113.798834] [049/142] (891s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[113.874358] Starting subtest: cursor-rapid-movement-512x170
[113.876567] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[113.984163] [050/142] (890s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[114.030682] Starting subtest: multi-wait-all-for-submit-unsubmitted
[114.132391] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[114.212628] [051/142] (890s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[114.257240] Starting subtest: multi-wait-for-submit-unsubmitted
[114.364742] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[114.439884] [052/142] (890s left) kms_lease (lease_again)
[114.517733] Starting subtest: lease_again
[114.518442] Starting dynamic subtest: pipe-A-HDMI-A-2
[114.520375] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[114.524167] Starting dynamic subtest: pipe-B-HDMI-A-2
[114.524870] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[114.525584] Subtest lease_again: SUCCESS (0.003s)
[114.610499] [053/142] (890s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[114.691596] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[114.692956] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[114.801282] [054/142] (890s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[114.876396] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[114.877758] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.001s)
[114.990303] [055/142] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[115.063816] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[115.065184] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.154176] [056/142] (889s left) kms_vblank (pipe-d-accuracy-idle)
[115.233237] Subtest pipe-D-accuracy-idle: SKIP (0.000s)
[115.311757] [057/142] (889s left) perf (create-destroy-userspace-config)
[115.421101] Starting subtest: create-destroy-userspace-config
[115.434655] Subtest create-destroy-userspace-config: SUCCESS (0.014s)
[115.465678] [058/142] (889s left) gem_exec_fence (syncobj-channel)
[115.785215] Starting subtest: syncobj-channel
[116.801194] Subtest syncobj-channel: SUCCESS (1.015s)
[117.111391] [059/142] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[117.192771] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[117.194096] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[117.286632] [060/142] (887s left) kms_concurrent (pipe-b)
[117.360924] Starting subtest: pipe-B
[117.361623] Starting dynamic subtest: HDMI-A-2
[117.657560] Dynamic subtest HDMI-A-2: SUCCESS (0.296s)
[117.658270] Subtest pipe-B: SUCCESS (0.297s)
[117.761312] [061/142] (887s left) kms_pm_lpsp (screens-disabled)
[118.844979] Starting subtest: screens-disabled
[118.846359] Subtest screens-disabled: SKIP (0.000s)
[118.982895] [062/142] (886s left) gem_linear_blits (basic)
[119.362485] Starting subtest: basic
[119.366117] Subtest basic: SUCCESS (0.004s)
[119.497685] [063/142] (885s left) kms_color (ctm-0-75)
[119.608631] Starting subtest: ctm-0-75
[119.609445] Starting dynamic subtest: pipe-A
[121.387853] Dynamic subtest pipe-A: SUCCESS (1.779s)
[121.397137] Starting dynamic subtest: pipe-B
[122.982249] Dynamic subtest pipe-B: SUCCESS (1.593s)
[122.983042] Subtest ctm-0-75: SUCCESS (3.374s)
[123.128263] [064/142] (882s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[123.201822] Starting subtest: cursor-vs-flip-varying-size
[151.849027] Subtest cursor-vs-flip-varying-size: SUCCESS (28.647s)
[151.979804] [065/142] (853s left) gem_exec_fence (parallel)
[152.158157] Starting subtest: parallel
[152.159385] Starting dynamic subtest: rcs0
[154.307581] Dynamic subtest rcs0: SUCCESS (2.149s)
[154.312195] Starting dynamic subtest: bcs0
[156.456752] Dynamic subtest bcs0: SUCCESS (2.148s)
[156.461215] Starting dynamic subtest: vcs0
[158.606396] Dynamic subtest vcs0: SUCCESS (2.150s)
[158.610816] Starting dynamic subtest: vecs0
[160.755859] Dynamic subtest vecs0: SUCCESS (2.149s)
[160.756568] Subtest parallel: SUCCESS (8.599s)
[161.220189] [066/142] (844s left) kms_psr (sprite_blt)
[161.260826] Subtest sprite_blt: SKIP (0.000s)
[161.274652] [067/142] (844s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[161.316451] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[161.317201] Starting dynamic subtest: smem
[161.404098] Dynamic subtest smem: SUCCESS (0.087s)
[161.404829] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SUCCESS (0.088s)
[161.586136] [068/142] (843s left) kms_cursor_crc (cursor-sliding-512x512)
[161.669369] Starting subtest: cursor-sliding-512x512
[161.670800] Subtest cursor-sliding-512x512: SKIP (0.001s)
[161.776864] [069/142] (843s left) gem_ctx_persistence (engines-mixed-process)
[161.823015] Starting subtest: engines-mixed-process
[161.823768] Starting dynamic subtest: rcs0
[162.175432] Dynamic subtest rcs0: SUCCESS (0.352s)
[162.192133] Starting dynamic subtest: bcs0
[162.525060] Dynamic subtest bcs0: SUCCESS (0.348s)
[162.542740] Starting dynamic subtest: vcs0
[162.868614] Dynamic subtest vcs0: SUCCESS (0.342s)
[162.885943] Starting dynamic subtest: vecs0
[163.202367] Dynamic subtest vecs0: SUCCESS (0.332s)
[163.203573] Subtest engines-mixed-process: SUCCESS (1.380s)
[163.295371] [070/142] (842s left) kms_atomic (crtc-invalid-params-fence)
[163.410129] Starting subtest: crtc-invalid-params-fence
[163.526850] Subtest crtc-invalid-params-fence: SUCCESS (0.117s)
[163.706368] [071/142] (841s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[163.787239] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[163.788608] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[163.897547] [072/142] (841s left) kms_vblank (pipe-d-wait-idle)
[163.975301] Subtest pipe-D-wait-idle: SKIP (0.000s)
[164.044638] [073/142] (841s left) v3d/v3d_submit_cl (bad-bo)
[164.129440] Subtest bad-bo: SKIP (0.000s)
[164.198516] [074/142] (841s left) kms_getfb (getfb-handle-not-fb)
[164.238847] Starting subtest: getfb-handle-not-fb
[164.271992] Subtest getfb-handle-not-fb: SUCCESS (0.033s)
[164.371476] [075/142] (841s left) kms_ccs (pipe-c-crc-primary-basic-y_tiled_gen12_mc_ccs)
[164.526483] Subtest pipe-C-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[164.630823] [076/142] (840s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[164.758040] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[164.855834] [077/142] (840s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_gen12_rc_ccs)
[164.997919] Subtest pipe-D-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[165.101070] [078/142] (840s left) kms_vblank (pipe-c-query-forked)
[165.177488] Subtest pipe-C-query-forked: SKIP (0.000s)
[165.253113] [079/142] (840s left) kms_hdr (bpc-switch)
[165.339778] Starting subtest: bpc-switch
[165.341412] Subtest bpc-switch: SKIP (0.000s)
[165.421655] [080/142] (840s left) gem_exec_flush (basic-wb-prw-default)
[165.462190] Starting subtest: basic-wb-prw-default
[170.895027] Subtest basic-wb-prw-default: SUCCESS (5.433s)
[171.105560] [081/142] (834s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[171.199632] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[171.268742] [082/142] (834s left) gem_eio (wait-wedge-1us)
[171.315644] Starting subtest: wait-wedge-1us
[171.557063] Subtest wait-wedge-1us: SUCCESS (0.241s)
[171.697608] [083/142] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[171.774788] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[171.776143] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[171.876825] [084/142] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[171.948906] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[171.950268] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[172.045483] [085/142] (833s left) gen7_exec_parse (oacontrol-tracking)
[172.090958] Subtest oacontrol-tracking: SKIP (0.000s)
[172.114970] [086/142] (833s left) gem_pipe_control_store_loop (reused-buffer)
[172.157063] Starting subtest: reused-buffer
[174.306030] Subtest reused-buffer: SUCCESS (2.149s)
[174.403438] [087/142] (831s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[174.535576] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[175.832040] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (1.296s)
[175.987106] [088/142] (829s left) kms_psr (psr2_primary_mmap_gtt)
[176.016391] Subtest psr2_primary_mmap_gtt: SKIP (0.000s)
[176.055086] [089/142] (829s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[176.090852] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[176.091556] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[176.164342] [090/142] (829s left) gem_lmem_swapping (massive)
[176.202822] Subtest massive: SKIP (0.000s)
[176.216533] [091/142] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-blt)
[176.296062] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-blt
[176.297469] Subtest fbcpsr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[176.396246] [092/142] (829s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[176.474275] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[176.475640] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[176.566385] [093/142] (829s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[176.686333] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[176.687851] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[176.790632] [094/142] (829s left) kms_flip (plain-flip-ts-check-interruptible)
[176.863223] Starting subtest: plain-flip-ts-check-interruptible
[176.864973] Starting dynamic subtest: A-HDMI-A2
[192.374225] Dynamic subtest A-HDMI-A2: SUCCESS (15.508s)
[192.382316] Starting dynamic subtest: B-HDMI-A2
[207.821577] Dynamic subtest B-HDMI-A2: SUCCESS (15.445s)
[207.825209] Subtest plain-flip-ts-check-interruptible: SUCCESS (30.961s)
[207.983228] [095/142] (797s left) kms_getfb (getfb-handle-zero)
[208.015295] Starting subtest: getfb-handle-zero
[208.016029] Subtest getfb-handle-zero: SUCCESS (0.000s)
[208.125576] [096/142] (797s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_mtl_rc_ccs)
[208.252416] Subtest pipe-D-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[208.355889] [097/142] (797s left) kms_psr (psr2_cursor_plane_onoff)
[208.390565] Subtest psr2_cursor_plane_onoff: SKIP (0.000s)
[208.407326] [098/142] (797s left) gem_mmap_gtt (cpuset-big-copy-odd)
[208.442733] Starting subtest: cpuset-big-copy-odd
[229.424466] Subtest cpuset-big-copy-odd: SUCCESS (20.982s)
[229.525920] [099/142] (776s left) kms_color (ctm-blue-to-red)
[229.645107] Starting subtest: ctm-blue-to-red
[229.645812] Starting dynamic subtest: pipe-A
[230.156850] Dynamic subtest pipe-A: SUCCESS (0.510s)
[230.164994] Starting dynamic subtest: pipe-B
[230.582773] Dynamic subtest pipe-B: SUCCESS (0.426s)
[230.583453] Subtest ctm-blue-to-red: SUCCESS (0.938s)
[230.720724] [100/142] (775s left) gem_exec_schedule (preempt-contexts)
[230.772711] Starting subtest: preempt-contexts
[230.773433] Starting dynamic subtest: rcs0
[230.795892] Dynamic subtest rcs0: SUCCESS (0.023s)
[230.801013] Starting dynamic subtest: bcs0
[230.817702] Dynamic subtest bcs0: SUCCESS (0.021s)
[230.823078] Starting dynamic subtest: vcs0
[230.838721] Dynamic subtest vcs0: SUCCESS (0.021s)
[230.844189] Starting dynamic subtest: vecs0
[230.859899] Dynamic subtest vecs0: SUCCESS (0.021s)
[230.860627] Subtest preempt-contexts: SUCCESS (0.087s)
[231.179573] [101/142] (774s left) kms_vblank (pipe-a-wait-busy-hang)
[231.253434] Starting subtest: pipe-A-wait-busy-hang
[237.376929] Subtest pipe-A-wait-busy-hang: SUCCESS (6.124s)
[237.524809] [102/142] (768s left) sw_sync (alloc_fence)
[237.563117] Starting subtest: alloc_fence
[237.563826] Subtest alloc_fence: SUCCESS (0.000s)
[237.610647] [103/142] (768s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_rc_ccs_cc)
[237.744365] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[237.841468] [104/142] (768s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[237.911778] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[237.913111] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[238.021836] [105/142] (768s left) gem_exec_balancer (parallel-contexts)
[239.016952] Subtest parallel-contexts: SKIP (0.000s)
[239.094641] [106/142] (767s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[239.177512] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[239.581390] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.404s)
[239.750543] [107/142] (766s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[239.792847] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[239.793537] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[239.881135] [108/142] (766s left) gem_mmap (basic-small-bo)
[239.918730] Starting subtest: basic-small-bo
[239.990167] Subtest basic-small-bo: SUCCESS (0.072s)
[240.099230] [109/142] (766s left) kms_ccs (pipe-a-bad-pixel-format-yf_tiled_ccs)
[240.215723] Starting subtest: pipe-A-bad-pixel-format-yf_tiled_ccs
[240.217197] Subtest pipe-A-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[240.372387] [110/142] (765s left) vc4/vc4_wait_bo (used-bo)
[240.425397] Subtest used-bo: SKIP (0.000s)
[240.485887] [111/142] (765s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc)
[240.624301] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc
[240.625670] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[240.738107] [112/142] (765s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[240.813911] Starting subtest: addfb25-y-tiled-small-legacy
[240.814605] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[240.909978] [113/142] (765s left) kms_flip (2x-plain-flip-ts-check)
[240.979383] Starting subtest: 2x-plain-flip-ts-check
[240.980757] Subtest 2x-plain-flip-ts-check: SKIP (0.001s)
[241.080580] [114/142] (765s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[241.159830] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[241.163142] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[241.251464] [115/142] (765s left) perf (invalid-open-flags)
[241.355052] Starting subtest: invalid-open-flags
[241.355780] Subtest invalid-open-flags: SUCCESS (0.000s)
[241.383487] [116/142] (764s left) gem_mmap_offset (clear)
[241.422355] Starting subtest: clear
[241.423111] Starting dynamic subtest: smem0
[263.992045] Dynamic subtest smem0: SUCCESS (22.568s)
[263.992743] Subtest clear: SUCCESS (22.569s)
[264.132458] [117/142] (742s left) gem_pxp (reject-modify-context-protection-off-2)
[266.679212] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[266.754290] [118/142] (739s left) gem_vm_create (create-ext)
[266.794568] Starting subtest: create-ext
[266.796186] Subtest create-ext: SUCCESS (0.001s)
[266.906437] [119/142] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[266.982870] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[266.984229] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[267.096506] [120/142] (739s left) kms_cursor_legacy (single-move)
[267.169109] Starting subtest: single-move
[267.169937] Starting dynamic subtest: pipe-A
[272.549623] Dynamic subtest pipe-A: SUCCESS (5.379s)
[272.554783] Starting dynamic subtest: pipe-B
[277.927346] Dynamic subtest pipe-B: SUCCESS (5.377s)
[277.932370] Starting dynamic subtest: all-pipes
[283.305271] Dynamic subtest all-pipes: SUCCESS (5.377s)
[283.305991] Subtest single-move: SUCCESS (16.136s)
[283.377518] [121/142] (723s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs)
[283.521820] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[283.624568] [122/142] (722s left) gem_softpin (allocator-fork)
[283.668902] Starting subtest: allocator-fork
[285.868059] Subtest allocator-fork: SUCCESS (2.199s)
[285.979018] [123/142] (720s left) gem_mmap_gtt (basic)
[286.019124] Starting subtest: basic
[286.019849] Subtest basic: SUCCESS (0.000s)
[286.078125] [124/142] (720s left) kms_plane_alpha_blend (alpha-transparent-fb)
[286.149821] Starting subtest: alpha-transparent-fb
[286.207654] Starting dynamic subtest: pipe-A-HDMI-A-2
[286.689722] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.482s)
[286.695650] Starting dynamic subtest: pipe-B-HDMI-A-2
[287.201654] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.511s)
[287.202336] Subtest alpha-transparent-fb: SUCCESS (1.052s)
[287.346604] [125/142] (719s left) gem_mmap_gtt (basic-small-copy-odd)
[287.381343] Starting subtest: basic-small-copy-odd
[289.934482] Subtest basic-small-copy-odd: SUCCESS (2.554s)
[290.005996] [126/142] (716s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[290.127404] Starting subtest: x-tiled-8bpp-rotate-270
[290.193161] Subtest x-tiled-8bpp-rotate-270: SKIP (0.065s)
[290.306578] [127/142] (716s left) v3d/v3d_perfmon (create-perfmon-0)
[290.368682] Subtest create-perfmon-0: SKIP (0.000s)
[290.437737] [128/142] (716s left) gem_ctx_sseu (invalid-sseu)
[290.476662] Subtest invalid-sseu: SKIP (0.000s)
[290.514072] [129/142] (716s left) gem_ppgtt (flink-and-close-vma-leak)
[290.557041] Starting subtest: flink-and-close-vma-leak
[290.559781] Subtest flink-and-close-vma-leak: SUCCESS (0.002s)
[290.667098] [130/142] (716s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[290.742153] Starting subtest: flip-vs-cursor-crc-legacy
[291.339789] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.598s)
[291.487792] [131/142] (715s left) gem_ctx_persistence (engines-hang)
[291.526708] Starting subtest: engines-hang
[291.527378] Starting dynamic subtest: rcs0
[291.571345] Dynamic subtest rcs0: SUCCESS (0.044s)
[291.592141] Starting dynamic subtest: bcs0
[291.617287] Dynamic subtest bcs0: SUCCESS (0.044s)
[291.635441] Starting dynamic subtest: vcs0
[291.657274] Dynamic subtest vcs0: SUCCESS (0.038s)
[291.675067] Starting dynamic subtest: vecs0
[291.701345] Dynamic subtest vecs0: SUCCESS (0.042s)
[291.702549] Subtest engines-hang: SUCCESS (0.175s)
[291.793183] [132/142] (714s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[291.852922] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[291.922911] [133/142] (714s left) perf_pmu (most-busy-idle-check-all)
[291.966259] Starting subtest: most-busy-idle-check-all
[291.966950] Starting dynamic subtest: rcs0
[292.577385] Dynamic subtest rcs0: SUCCESS (0.610s)
[292.587917] Starting dynamic subtest: bcs0
[293.195288] Dynamic subtest bcs0: SUCCESS (0.616s)
[293.205943] Starting dynamic subtest: vcs0
[293.817406] Dynamic subtest vcs0: SUCCESS (0.620s)
[293.828053] Starting dynamic subtest: vecs0
[294.435423] Dynamic subtest vecs0: SUCCESS (0.616s)
[294.436640] Subtest most-busy-idle-check-all: SUCCESS (2.470s)
[294.517109] [134/142] (712s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[294.589852] Starting subtest: fbcpsr-tiling-4
[294.591171] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[294.696411] [135/142] (712s left) gem_render_copy_redux (normal)
[294.740318] Starting subtest: normal
[295.091411] Subtest normal: SUCCESS (0.351s)
[295.195902] [136/142] (711s left) i915_pm_rpm (i2c)
[296.583076] Starting subtest: i2c
[298.512978] Subtest i2c: SUCCESS (1.932s)
[298.714696] [137/142] (708s left) sysfs_preempt_timeout (timeout)
[298.754012] Starting subtest: timeout
[298.754741] Starting dynamic subtest: vecs0
[299.595996] Dynamic subtest vecs0: SUCCESS (0.841s)
[299.603913] Starting dynamic subtest: vcs0
[300.429304] Dynamic subtest vcs0: SUCCESS (0.832s)
[300.438148] Starting dynamic subtest: bcs0
[301.261688] Dynamic subtest bcs0: SUCCESS (0.831s)
[301.268845] Starting dynamic subtest: rcs0
[302.095800] Dynamic subtest rcs0: SUCCESS (0.833s)
[302.096732] Subtest timeout: SUCCESS (3.342s)
[302.179486] [138/142] (704s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[302.309657] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[302.311056] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[302.411593] [139/142] (704s left) kms_vblank (pipe-b-ts-continuation-modeset)
[302.485668] Starting subtest: pipe-B-ts-continuation-modeset
[302.862149] Subtest pipe-B-ts-continuation-modeset: SUCCESS (0.378s)
[302.992123] [140/142] (703s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs_cc)
[303.108811] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc
[303.110161] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[303.222938] [141/142] (703s left) gem_ccs (block-copy-compressed)
[303.260961] Starting subtest: block-copy-compressed
[303.262373] Subtest block-copy-compressed: SKIP (0.000s)
[303.335505] [142/142] (703s left) gem_exec_schedule (lateslice)
[303.387373] Starting subtest: lateslice
[303.388113] Starting dynamic subtest: rcs0
[303.398889] Dynamic subtest rcs0: SUCCESS (0.012s)
[303.404792] Starting dynamic subtest: bcs0
[303.412853] Dynamic subtest bcs0: SUCCESS (0.013s)
[303.418458] Starting dynamic subtest: vcs0
[303.423791] Dynamic subtest vcs0: SUCCESS (0.010s)
[303.429356] Starting dynamic subtest: vecs0
[303.436942] Dynamic subtest vecs0: SUCCESS (0.012s)
[303.437707] Subtest lateslice: SUCCESS (0.051s)
[303.755482] Closing watchdogs
Done.