[54.809323] Initializing watchdogs
[54.809682]   /dev/watchdog0
[54.825900] [001/141] (960s left) prime_busy (before-wait)
[55.078525] Starting subtest: before-wait
[55.094170] Starting dynamic subtest: rcs0
[55.122202] Dynamic subtest rcs0: SUCCESS (0.027s)
[55.135742] Starting dynamic subtest: bcs0
[55.148205] Dynamic subtest bcs0: SUCCESS (0.024s)
[55.161170] Starting dynamic subtest: vcs0
[55.168302] Dynamic subtest vcs0: SUCCESS (0.020s)
[55.181498] Starting dynamic subtest: vecs0
[55.190857] Dynamic subtest vecs0: SUCCESS (0.022s)
[55.306545] Subtest before-wait: SUCCESS (0.228s)
[55.396421] [002/141] (959s left) drm_read (short-buffer-wakeup)
[56.117051] Starting subtest: short-buffer-wakeup
[88.334377] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[88.446156] [003/141] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[88.769875] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[88.772802] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[88.861342] [004/141] (926s left) kms_flip (wf_vblank-ts-check)
[89.155130] Starting subtest: wf_vblank-ts-check
[89.156824] Starting dynamic subtest: A-DP1
[99.990115] Dynamic subtest A-DP1: SUCCESS (10.836s)
[100.004448] Starting dynamic subtest: B-DP1
[110.758929] Dynamic subtest B-DP1: SUCCESS (10.768s)
[110.775168] Starting dynamic subtest: C-DP1
[121.512862] Dynamic subtest C-DP1: SUCCESS (10.752s)
[121.516210] Subtest wf_vblank-ts-check: SUCCESS (32.366s)
[121.939696] [005/141] (893s left) kms_color (degamma)
[122.255107] Starting subtest: degamma
[122.256497] Starting dynamic subtest: pipe-A
[122.818721] Dynamic subtest pipe-A: SUCCESS (0.565s)
[122.835844] Starting dynamic subtest: pipe-B
[123.687193] Dynamic subtest pipe-B: SUCCESS (0.868s)
[123.712406] Starting dynamic subtest: pipe-C
[124.661857] Dynamic subtest pipe-C: SUCCESS (0.974s)
[124.663191] Subtest degamma: SUCCESS (2.408s)
[124.998479] [006/141] (890s left) kms_plane (pixel-format-source-clamping)
[125.303633] Starting subtest: pixel-format-source-clamping
[125.304988] Starting dynamic subtest: pipe-A-planes
[131.929427] Dynamic subtest pipe-A-planes: SUCCESS (6.624s)
[131.959304] Starting dynamic subtest: pipe-B-planes
[138.932550] Dynamic subtest pipe-B-planes: SUCCESS (7.000s)
[138.933886] Subtest pixel-format-source-clamping: SUCCESS (13.631s)
[139.273140] [007/141] (876s left) gem_exec_reloc (basic-gtt-read-noreloc)
[139.488593] Starting subtest: basic-gtt-read-noreloc
[139.500198] Subtest basic-gtt-read-noreloc: SUCCESS (0.011s)
[139.672649] [008/141] (875s left) gem_madvise (dontneed-before-exec)
[139.871205] Starting subtest: dontneed-before-exec
[139.880919] Subtest dontneed-before-exec: SUCCESS (0.008s)
[139.989301] [009/141] (875s left) gem_ctx_persistence (engines-persistence)
[140.205456] Starting subtest: engines-persistence
[140.206970] Starting dynamic subtest: rcs0
[140.973525] Dynamic subtest rcs0: SUCCESS (0.768s)
[140.988573] Starting dynamic subtest: bcs0
[141.740461] Dynamic subtest bcs0: SUCCESS (0.767s)
[141.756021] Starting dynamic subtest: vcs0
[142.509214] Dynamic subtest vcs0: SUCCESS (0.768s)
[142.524105] Starting dynamic subtest: vecs0
[143.282791] Dynamic subtest vecs0: SUCCESS (0.773s)
[143.285205] Subtest engines-persistence: SUCCESS (3.078s)
[143.371629] [010/141] (872s left) gen3_render_mixed_blits
[143.622537] [011/141] (872s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[143.828229] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[143.870887] [012/141] (871s left) kms_lease (lease_invalid_plane)
[144.182171] Starting subtest: lease_invalid_plane
[144.183636] Starting dynamic subtest: pipe-A-DP-1
[144.185785] Dynamic subtest pipe-A-DP-1: SUCCESS (0.000s)
[144.200161] Starting dynamic subtest: pipe-B-DP-1
[144.201490] Dynamic subtest pipe-B-DP-1: SUCCESS (0.000s)
[144.216279] Starting dynamic subtest: pipe-C-DP-1
[144.217479] Dynamic subtest pipe-C-DP-1: SUCCESS (0.000s)
[144.218929] Subtest lease_invalid_plane: SUCCESS (0.007s)
[144.272960] [013/141] (871s left) kms_vblank (pipe-d-wait-forked-busy)
[144.591428] Subtest pipe-D-wait-forked-busy: SKIP (0.000s)
[144.673420] [014/141] (871s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[145.011731] Starting subtest: x-tiled-8bpp-rotate-90
[145.097628] Subtest x-tiled-8bpp-rotate-90: SKIP (0.085s)
[145.206606] [015/141] (870s left) gem_exec_fence (syncobj-invalid-wait)
[145.963605] Starting subtest: syncobj-invalid-wait
[145.965164] Subtest syncobj-invalid-wait: SUCCESS (0.002s)
[146.306296] [016/141] (869s left) i915_pm_rps (reset)
[146.521642] Starting subtest: reset
[150.099199] Subtest reset: SUCCESS (3.577s)
[150.193250] [017/141] (865s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[150.457297] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[150.522904] [018/141] (865s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[150.728994] Starting subtest: single-wait-all-for-submit-available-submitted
[150.730722] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[150.806457] [019/141] (865s left) template (a)
[151.012769] Starting subtest: A
[151.014222] Subtest A: SUCCESS (0.000s)
[151.089208] [020/141] (864s left) syncobj_timeline (wait-for-submit-snapshot)
[151.298634] Starting subtest: wait-for-submit-snapshot
[151.384273] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[151.456835] [021/141] (864s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[151.767388] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[151.770435] Starting dynamic subtest: pipe-A-valid-mode
[152.500820] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.735s)
[152.502454] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.737s)
[152.847459] [022/141] (863s left) kms_atomic_interruptible (legacy-pageflip)
[153.154647] Starting subtest: legacy-pageflip
[153.157669] Starting dynamic subtest: DP-1-pipe-A
[159.724948] Dynamic subtest DP-1-pipe-A: SUCCESS (6.566s)
[159.726315] Subtest legacy-pageflip: SUCCESS (6.570s)
[160.075734] [023/141] (856s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[160.284020] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[160.340535] [024/141] (855s left) kms_psr (psr2_cursor_mmap_cpu)
[160.548989] Subtest psr2_cursor_mmap_cpu: SKIP (0.000s)
[160.608597] [025/141] (855s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[160.905566] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[160.906861] Starting dynamic subtest: pipe-A-valid-mode
[161.616042] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.711s)
[161.619843] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (0.713s)
[161.984722] [026/141] (854s left) gem_ppgtt (blt-vs-render-ctxn)
[162.202749] Starting subtest: blt-vs-render-ctxN
[195.906716] Subtest blt-vs-render-ctxN: SUCCESS (33.701s)
[196.022595] [027/141] (820s left) gem_exec_schedule (reorder-wide)
[196.535039] Starting subtest: reorder-wide
[196.536515] Starting dynamic subtest: rcs0
[196.715312] Dynamic subtest rcs0: SUCCESS (0.179s)
[196.739212] Starting dynamic subtest: bcs0
[197.072912] Dynamic subtest bcs0: SUCCESS (0.357s)
[197.093223] Starting dynamic subtest: vcs0
[197.248094] Dynamic subtest vcs0: SUCCESS (0.173s)
[197.267232] Starting dynamic subtest: vecs0
[197.411302] Dynamic subtest vecs0: SUCCESS (0.164s)
[197.412767] Subtest reorder-wide: SUCCESS (0.876s)
[197.635749] [028/141] (818s left) gem_exec_whisper (basic-sync-all)
[197.870318] Starting subtest: basic-sync-all
[207.777286] Subtest basic-sync-all: SUCCESS (9.906s)
[207.973573] [029/141] (808s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs)
[208.566654] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs
[208.569191] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[208.983350] [030/141] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[209.295846] Starting subtest: fbcpsr-2p-rte
[209.298449] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[209.400210] [031/141] (806s left) syncobj_basic (create-signaled)
[209.607724] Starting subtest: create-signaled
[209.609119] Subtest create-signaled: SUCCESS (0.000s)
[209.700259] [032/141] (806s left) core_auth (basic-auth)
[209.909131] Starting subtest: basic-auth
[209.910876] Subtest basic-auth: SUCCESS (0.001s)
[209.999612] [033/141] (806s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[210.312091] Starting subtest: psr-2p-pri-indfb-multidraw
[210.314680] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[210.416978] [034/141] (806s left) v3d/v3d_perfmon (get-values-invalid-pointer)
[210.678903] Subtest get-values-invalid-pointer: SKIP (0.000s)
[210.751950] [035/141] (805s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[211.089085] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[211.114091] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.022s)
[211.232227] [036/141] (805s left) gem_exec_reloc (basic-gtt-wc)
[211.446889] Starting subtest: basic-gtt-wc
[211.469395] Subtest basic-gtt-wc: SUCCESS (0.022s)
[211.650072] [037/141] (804s left) gem_exec_balancer (parallel)
[215.681796] Subtest parallel: SKIP (0.000s)
[215.768329] [038/141] (800s left) gen9_exec_parse (unaligned-jump)
[215.999152] Starting subtest: unaligned-jump
[216.250541] Subtest unaligned-jump: SUCCESS (0.251s)
[216.466256] [039/141] (800s left) kms_lease (master-vs-lease)
[216.780681] Starting subtest: master-vs-lease
[216.782651] Subtest master-vs-lease: SUCCESS (0.003s)
[216.867738] [040/141] (799s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[217.359022] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[217.362355] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[217.856112] [041/141] (798s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[218.205494] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[218.210162] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.004s)
[218.307167] [042/141] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[218.618605] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[218.621235] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[218.722699] [043/141] (798s left) kms_rotation_crc (sprite-rotation-270)
[219.031513] Starting subtest: sprite-rotation-270
[225.178635] Subtest sprite-rotation-270: SUCCESS (6.150s)
[225.610783] [044/141] (791s left) kms_cursor_legacy (torture-bo)
[225.918889] Starting subtest: torture-bo
[225.920271] Starting dynamic subtest: pipe-A
[232.816343] Dynamic subtest pipe-A: SUCCESS (6.899s)
[232.835466] Starting dynamic subtest: pipe-B
[238.497508] Dynamic subtest pipe-B: SUCCESS (5.681s)
[238.515307] Starting dynamic subtest: pipe-C
[244.101285] Dynamic subtest pipe-C: SUCCESS (5.599s)
[244.119900] Starting dynamic subtest: all-pipes
[249.702835] Dynamic subtest all-pipes: SUCCESS (5.602s)
[249.704173] Subtest torture-bo: SUCCESS (23.785s)
[249.793155] [045/141] (767s left) syncobj_timeline (invalid-transfer-non-existent-point)
[250.001510] Starting subtest: invalid-transfer-non-existent-point
[250.003317] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[250.092273] [046/141] (766s left) gem_mmap_gtt (big-copy-odd)
[250.296192] Starting subtest: big-copy-odd
[261.810345] Subtest big-copy-odd: SUCCESS (11.514s)
[261.958042] [047/141] (755s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[262.301354] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[262.302892] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[262.392440] [048/141] (754s left) gem_spin_batch (legacy-resubmit-new)
[262.624832] Starting subtest: legacy-resubmit-new
[262.626260] Starting dynamic subtest: default
[262.633839] Dynamic subtest default: SUCCESS (0.009s)
[262.657839] Starting dynamic subtest: render
[262.659314] Dynamic subtest render: SUCCESS (0.008s)
[262.679442] Starting dynamic subtest: bsd
[262.682200] Dynamic subtest bsd: SUCCESS (0.008s)
[262.700563] Starting dynamic subtest: bsd1
[262.701899] Dynamic subtest bsd1: SUCCESS (0.007s)
[262.720445] Starting dynamic subtest: blt
[262.721825] Dynamic subtest blt: SUCCESS (0.009s)
[262.740218] Starting dynamic subtest: vebox
[262.741707] Dynamic subtest vebox: SUCCESS (0.009s)
[262.743134] Subtest legacy-resubmit-new: SUCCESS (0.057s)
[262.910888] [049/141] (754s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[263.243420] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[263.246021] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.344355] [050/141] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[263.651512] Starting subtest: fbcpsr-rgb101010-draw-render
[263.654178] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[263.744338] [051/141] (753s left) i915_suspend (fence-restore-tiled2untiled)
[263.947463] Starting subtest: fence-restore-tiled2untiled
[283.350416] Subtest fence-restore-tiled2untiled: SUCCESS (4.401s)
[285.486417] [052/141] (748s left) gem_mmap_offset (ptrace)
[285.691955] Starting subtest: ptrace
[285.696103] Starting dynamic subtest: smem0-gtt
[285.782133] Dynamic subtest smem0-gtt: SUCCESS (0.083s)
[285.803611] Starting dynamic subtest: smem0-wb
[285.856163] Dynamic subtest smem0-wb: SUCCESS (0.075s)
[285.878158] Starting dynamic subtest: smem0-wc
[285.936066] Dynamic subtest smem0-wc: SUCCESS (0.078s)
[285.957827] Starting dynamic subtest: smem0-uc
[286.014520] Dynamic subtest smem0-uc: SUCCESS (0.077s)
[286.015997] Subtest ptrace: SUCCESS (0.324s)
[286.128064] [053/141] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[286.445424] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[286.447994] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[286.545349] [054/141] (747s left) gem_mmap_gtt (hang)
[286.750450] Starting subtest: hang
[292.236718] Subtest hang: SUCCESS (5.485s)
[292.447711] [055/141] (741s left) kms_addfb_basic (bad-pitch-65536)
[292.653534] Starting subtest: bad-pitch-65536
[292.655406] Subtest bad-pitch-65536: SUCCESS (0.001s)
[292.867296] [056/141] (741s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[293.073835] Starting subtest: cpuset-medium-copy-odd
[304.702622] Subtest cpuset-medium-copy-odd: SUCCESS (11.628s)
[304.848681] [057/141] (729s left) perf (low-oa-exponent-permissions)
[305.333156] Starting subtest: low-oa-exponent-permissions
[305.493442] Subtest low-oa-exponent-permissions: SUCCESS (0.161s)
[305.544869] [058/141] (728s left) prime_vgem (fence-wait)
[305.768087] Starting subtest: fence-wait
[305.769767] Starting dynamic subtest: rcs0
[306.814534] Dynamic subtest rcs0: SUCCESS (1.044s)
[306.837191] Starting dynamic subtest: vcs0
[307.857947] Dynamic subtest vcs0: SUCCESS (1.042s)
[307.880580] Starting dynamic subtest: vecs0
[308.895132] Dynamic subtest vecs0: SUCCESS (1.035s)
[308.896748] Subtest fence-wait: SUCCESS (3.127s)
[309.012893] [059/141] (725s left) kms_universal_plane (disable-primary-vs-flip-pipe-d)
[309.324689] Subtest disable-primary-vs-flip-pipe-D: SKIP (0.000s)
[309.412942] [060/141] (725s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[310.082928] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[310.088243] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s)
[310.420405] [061/141] (724s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_dg2_rc_ccs)
[310.817429] Starting subtest: pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs
[310.820176] Subtest pipe-A-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[311.410278] [062/141] (723s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[312.086067] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[312.400746] [063/141] (722s left) kms_ccs (pipe-a-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc)
[312.829431] Starting subtest: pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc
[312.832171] Subtest pipe-A-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[313.385636] [064/141] (721s left) gem_exec_reloc (basic-write-cpu-noreloc)
[313.601264] Starting subtest: basic-write-cpu-noreloc
[313.613287] Subtest basic-write-cpu-noreloc: SUCCESS (0.012s)
[313.801069] [065/141] (720s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[314.013230] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[314.014720] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[314.100189] [066/141] (720s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[314.408758] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[317.339510] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.932s)
[317.484050] [067/141] (717s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[317.791937] Starting subtest: psr-rgb565-draw-render
[317.794590] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[317.901626] [068/141] (717s left) kms_vblank (pipe-d-query-idle-hang)
[318.211077] Subtest pipe-D-query-idle-hang: SKIP (0.000s)
[318.300480] [069/141] (716s left) gem_exec_schedule (preemptive-hang)
[318.652628] Starting subtest: preemptive-hang
[318.654115] Starting dynamic subtest: rcs0
[325.325201] Dynamic subtest rcs0: SUCCESS (6.669s)
[325.355833] Starting dynamic subtest: bcs0
[331.345479] Dynamic subtest bcs0: SUCCESS (6.019s)
[331.372272] Starting dynamic subtest: vcs0
[337.352188] Dynamic subtest vcs0: SUCCESS (6.006s)
[337.379415] Starting dynamic subtest: vecs0
[343.369675] Dynamic subtest vecs0: SUCCESS (6.015s)
[343.371139] Subtest preemptive-hang: SUCCESS (24.716s)
[343.585352] [070/141] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[343.901110] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[343.903810] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[344.000817] [071/141] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[344.307519] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[344.310183] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[344.417552] [072/141] (690s left) perf (rc6-disable)
[344.726120] Starting subtest: rc6-disable
[344.957143] Subtest rc6-disable: SUCCESS (0.229s)
[345.016932] [073/141] (690s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[345.405866] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[345.698306] [074/141] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[346.014277] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[346.016974] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[346.127459] [075/141] (689s left) sw_sync (alloc_fence_invalid_timeline)
[346.332394] Starting subtest: alloc_fence_invalid_timeline
[346.333884] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[346.410421] [076/141] (688s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[346.906762] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs
[346.909330] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.001s)
[347.392795] [077/141] (687s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[347.726615] Starting subtest: yf-tiled-8bpp-rotate-180
[347.729782] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[347.842548] [078/141] (687s left) v3d/v3d_submit_cl (simple-flush-cache)
[348.098901] Subtest simple-flush-cache: SKIP (0.000s)
[348.177167] [079/141] (687s left) kms_frontbuffer_tracking (fbc-badstride)
[348.482934] Starting subtest: fbc-badstride
[356.379709] Subtest fbc-badstride: SUCCESS (7.899s)
[356.509095] [080/141] (678s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling)
[356.810418] Starting subtest: plane-scaler-with-pixel-format-unity-scaling
[356.811814] Starting dynamic subtest: pipe-A-DP-1
[359.199350] Dynamic subtest pipe-A-DP-1: SUCCESS (2.389s)
[359.232334] Starting dynamic subtest: pipe-B-DP-1
[361.857296] Dynamic subtest pipe-B-DP-1: SUCCESS (2.653s)
[361.887267] Starting dynamic subtest: pipe-C-DP-1
[362.235684] Dynamic subtest pipe-C-DP-1: SUCCESS (0.374s)
[362.237096] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (5.430s)
[362.640418] [081/141] (672s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[363.263531] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[363.267771] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[363.642750] [082/141] (671s left) i915_pm_rpm (dpms-mode-unset-lpsp)
[365.649116] Starting subtest: dpms-mode-unset-lpsp
[366.035849] Subtest dpms-mode-unset-lpsp: SKIP (0.385s)
[366.534621] [083/141] (669s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[367.232779] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[367.573387] [084/141] (668s left) kms_cursor_crc (cursor-sliding-256x256)
[367.891870] Starting subtest: cursor-sliding-256x256
[367.904654] Starting dynamic subtest: pipe-A-DP-1
[371.577968] Dynamic subtest pipe-A-DP-1: SUCCESS (3.671s)
[371.666969] Starting dynamic subtest: pipe-C-DP-1
[375.654921] Dynamic subtest pipe-C-DP-1: SUCCESS (4.010s)
[375.656323] Subtest cursor-sliding-256x256: SUCCESS (7.761s)
[376.029247] [085/141] (659s left) gem_reg_read (timestamp-moving)
[376.232909] Starting subtest: timestamp-moving
[377.235789] Subtest timestamp-moving: SUCCESS (1.001s)
[377.324301] [086/141] (658s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[377.650705] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[377.653801] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[377.758790] [087/141] (657s left) kms_vblank (pipe-b-wait-busy)
[378.067096] Starting subtest: pipe-B-wait-busy
[380.925355] Subtest pipe-B-wait-busy: SUCCESS (2.860s)
[381.269636] [088/141] (654s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[381.673795] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[382.137297] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SUCCESS (0.460s)
[382.818805] [089/141] (653s left) sw_sync (timeline_closed)
[383.023145] Starting subtest: timeline_closed
[383.024770] Subtest timeline_closed: SUCCESS (0.000s)
[383.099419] [090/141] (652s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[383.396880] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[383.398441] Starting dynamic subtest: pipe-A-DP-1
[383.486328] Dynamic subtest pipe-A-DP-1: SUCCESS (0.090s)
[383.553598] Starting dynamic subtest: pipe-B-DP-1
[383.878641] Dynamic subtest pipe-B-DP-1: SUCCESS (0.387s)
[383.945805] Starting dynamic subtest: pipe-C-DP-1
[383.982054] Dynamic subtest pipe-C-DP-1: SKIP (0.095s)
[383.983474] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.588s)
[384.395180] [091/141] (651s left) gem_ctx_exec (basic-norecovery)
[384.604722] Starting subtest: basic-norecovery
[384.639510] Subtest basic-norecovery: SUCCESS (0.033s)
[384.762615] [092/141] (651s left) gem_exec_gttfill (all-engines)
[384.996025] Starting subtest: all-engines
[426.185641] Subtest all-engines: SUCCESS (41.188s)
[426.398541] [093/141] (609s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_mc_ccs)
[427.024314] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs
[427.027399] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[427.548428] [094/141] (608s left) prime_vgem (basic-write)
[427.795325] Starting subtest: basic-write
[427.857854] Subtest basic-write: SUCCESS (0.063s)
[427.964768] [095/141] (608s left) perf_pmu (busy)
[428.178088] Starting subtest: busy
[428.179862] Starting dynamic subtest: rcs0
[428.715034] Dynamic subtest rcs0: SUCCESS (0.536s)
[428.744412] Starting dynamic subtest: bcs0
[429.252961] Dynamic subtest bcs0: SUCCESS (0.536s)
[429.278732] Starting dynamic subtest: vcs0
[429.796661] Dynamic subtest vcs0: SUCCESS (0.542s)
[429.825084] Starting dynamic subtest: vecs0
[430.333704] Dynamic subtest vecs0: SUCCESS (0.535s)
[430.335468] Subtest busy: SUCCESS (2.157s)
[430.430963] [096/141] (605s left) kms_atomic (plane-overlay-legacy)
[431.084753] Starting subtest: plane-overlay-legacy
[431.218592] Subtest plane-overlay-legacy: SUCCESS (0.133s)
[431.656936] [097/141] (604s left) kms_frontbuffer_tracking (fbc-stridechange)
[431.980827] Starting subtest: fbc-stridechange
[433.592660] Subtest fbc-stridechange: SUCCESS (1.613s)
[433.737724] [098/141] (602s left) gem_softpin (evict-prime-sanity-check)
[433.952937] Starting subtest: evict-prime-sanity-check
[433.955262] Starting dynamic subtest: rcs0
[435.067044] Dynamic subtest rcs0: SUCCESS (1.112s)
[435.094894] Starting dynamic subtest: bcs0
[436.176691] Dynamic subtest bcs0: SUCCESS (1.106s)
[436.205275] Starting dynamic subtest: vcs0
[437.287286] Dynamic subtest vcs0: SUCCESS (1.107s)
[437.323364] Starting dynamic subtest: vecs0
[438.395469] Dynamic subtest vecs0: SUCCESS (1.105s)
[438.425239] Starting dynamic subtest: all
[439.501512] Dynamic subtest all: SUCCESS (1.104s)
[439.503615] Subtest evict-prime-sanity-check: SUCCESS (5.550s)
[439.604476] [099/141] (596s left) gem_exec_store (pages)
[439.833070] Starting subtest: pages
[439.834508] Starting dynamic subtest: rcs0
[439.926728] Dynamic subtest rcs0: SUCCESS (0.092s)
[439.954876] Starting dynamic subtest: bcs0
[440.023975] Dynamic subtest bcs0: SUCCESS (0.094s)
[440.052690] Starting dynamic subtest: vcs0
[440.121493] Dynamic subtest vcs0: SUCCESS (0.093s)
[440.149490] Starting dynamic subtest: vecs0
[440.215958] Dynamic subtest vecs0: SUCCESS (0.091s)
[440.217752] Subtest pages: SUCCESS (0.384s)
[440.421384] [100/141] (595s left) kms_ccs (pipe-c-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc)
[441.086417] Starting subtest: pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc
[441.089163] Subtest pipe-C-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[441.448575] [101/141] (594s left) gem_flink_basic (basic)
[441.654468] Starting subtest: basic
[441.656860] Subtest basic: SUCCESS (0.000s)
[441.765541] [102/141] (594s left) gem_exec_fair (basic-none)
[442.010705] Starting subtest: basic-none
[442.012465] Starting dynamic subtest: rcs0
[447.682365] Dynamic subtest rcs0: SUCCESS (5.667s)
[447.710161] Starting dynamic subtest: bcs0
[447.712815] Dynamic subtest bcs0: SKIP (0.008s)
[447.737505] Starting dynamic subtest: vcs0
[453.729204] Dynamic subtest vcs0: SUCCESS (6.034s)
[453.756192] Starting dynamic subtest: vecs0
[459.866769] Dynamic subtest vecs0: SUCCESS (6.135s)
[459.868757] Subtest basic-none: SUCCESS (17.855s)
[460.081289] [103/141] (576s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[460.421210] Starting subtest: x-tiled-32bpp-rotate-0
[465.701933] Subtest x-tiled-32bpp-rotate-0: SUCCESS (5.282s)
[466.232634] [104/141] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[466.553648] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[466.556747] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[466.666253] [105/141] (569s left) gem_exec_balancer (bonded-pair)
[466.906696] Starting subtest: bonded-pair
[470.699750] Subtest bonded-pair: SUCCESS (3.791s)
[474.598864] [106/141] (562s left) gem_busy (extended)
[474.963373] Starting subtest: extended
[474.965109] Starting dynamic subtest: rcs0
[474.988892] Dynamic subtest rcs0: SUCCESS (0.025s)
[475.020450] Starting dynamic subtest: bcs0
[475.021870] Dynamic subtest bcs0: SUCCESS (0.017s)
[475.046141] Starting dynamic subtest: vcs0
[475.047477] Dynamic subtest vcs0: SUCCESS (0.018s)
[475.072634] Starting dynamic subtest: vecs0
[475.074153] Dynamic subtest vecs0: SUCCESS (0.019s)
[475.075588] Subtest extended: SUCCESS (0.089s)
[475.297676] [107/141] (561s left) gem_caching (read-writes)
[475.510150] Starting subtest: read-writes
[501.439368] Subtest read-writes: SUCCESS (25.929s)
[501.600194] [108/141] (535s left) kms_chamelium_color (ctm-negative)
[501.906066] Subtest ctm-negative: SKIP (0.000s)
[501.964754] [109/141] (534s left) kms_vblank (pipe-b-query-idle-hang)
[502.261036] Starting subtest: pipe-B-query-idle-hang
[509.967433] Subtest pipe-B-query-idle-hang: SUCCESS (7.708s)
[510.312407] [110/141] (526s left) vc4/vc4_mmap (mmap-bad-handle)
[510.565766] Subtest mmap-bad-handle: SKIP (0.000s)
[510.644868] [111/141] (526s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[510.959250] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[510.962204] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[511.062906] [112/141] (525s left) api_intel_bb (intel-bb-blit-none)
[511.267500] Starting subtest: intel-bb-blit-none
[514.913829] Subtest intel-bb-blit-none: SUCCESS (3.644s)
[515.029836] [113/141] (521s left) i915_pm_dc (dc5-dpms-negative)
[516.351717] Starting subtest: dc5-dpms-negative
[520.673707] Subtest dc5-dpms-negative: SUCCESS (4.322s)
[520.879348] [114/141] (516s left) gem_fenced_exec_thrash (no-spare-fences)
[521.093823] Starting subtest: no-spare-fences
[523.257209] Subtest no-spare-fences: SUCCESS (2.160s)
[523.531697] [115/141] (513s left) vgem_basic (second-client)
[523.750755] Starting subtest: second-client
[523.784178] Subtest second-client: SUCCESS (0.032s)
[523.861078] [116/141] (513s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[524.068923] Starting subtest: no-spare-fences-busy
[526.247692] Subtest no-spare-fences-busy: SUCCESS (2.179s)
[526.427788] [117/141] (510s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[526.650786] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[526.652474] Starting dynamic subtest: smem
[526.985135] Dynamic subtest smem: SUCCESS (0.332s)
[526.986716] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.334s)
[527.197264] [118/141] (509s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[527.514923] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[527.518706] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[527.628641] [119/141] (509s left) gem_ctx_sseu (engines)
[527.839419] Subtest engines: SKIP (0.000s)
[527.893966] [120/141] (509s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[528.208767] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[528.211574] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[528.312550] [121/141] (508s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_mc_ccs)
[528.985868] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[529.314913] [122/141] (508s left) gem_flink_race (flink_name)
[529.512053] Starting subtest: flink_name
[534.892789] Subtest flink_name: SUCCESS (5.374s)
[534.998302] [123/141] (502s left) core_auth (getclient-simple)
[535.196904] Starting subtest: getclient-simple
[535.204177] Subtest getclient-simple: SUCCESS (0.005s)
[535.297650] [124/141] (502s left) gem_mmap_wc (write-gtt-read-wc)
[535.502384] Starting subtest: write-gtt-read-wc
[536.007764] Subtest write-gtt-read-wc: SUCCESS (0.502s)
[536.112426] [125/141] (501s left) kms_vblank (pipe-b-query-forked)
[536.411273] Starting subtest: pipe-B-query-forked
[539.181800] Subtest pipe-B-query-forked: SUCCESS (2.773s)
[539.533433] [126/141] (498s left) perf (mi-rpc)
[539.860423] Starting subtest: mi-rpc
[539.912575] Subtest mi-rpc: SUCCESS (0.052s)
[539.966039] [127/141] (497s left) kms_cursor_crc (cursor-offscreen-256x256)
[540.291047] Starting subtest: cursor-offscreen-256x256
[540.303064] Starting dynamic subtest: pipe-A-DP-1
[542.802974] Dynamic subtest pipe-A-DP-1: SUCCESS (2.498s)
[542.888848] Starting dynamic subtest: pipe-C-DP-1
[545.676526] Dynamic subtest pipe-C-DP-1: SUCCESS (2.810s)
[545.678600] Subtest cursor-offscreen-256x256: SUCCESS (5.385s)
[546.027400] [128/141] (491s left) kms_cursor_crc (cursor-onscreen-256x256)
[546.337043] Starting subtest: cursor-onscreen-256x256
[546.347286] Starting dynamic subtest: pipe-A-DP-1
[548.674341] Dynamic subtest pipe-A-DP-1: SUCCESS (2.325s)
[548.767927] Starting dynamic subtest: pipe-C-DP-1
[551.442990] Dynamic subtest pipe-C-DP-1: SUCCESS (2.704s)
[551.444727] Subtest cursor-onscreen-256x256: SUCCESS (5.108s)
[551.812408] [129/141] (485s left) fbdev (unaligned-write)
[552.030445] Starting subtest: unaligned-write
[552.217482] Subtest unaligned-write: SUCCESS (0.186s)
[552.293651] [130/141] (485s left) gen7_exec_parse (basic-allowed)
[552.507159] Subtest basic-allowed: SKIP (0.000s)
[552.575870] [131/141] (485s left) kms_rmfb (rmfb-ioctl)
[552.877300] Starting subtest: rmfb-ioctl
[552.878786] Starting dynamic subtest: pipe-A-DP-1
[552.998123] Dynamic subtest pipe-A-DP-1: SUCCESS (0.119s)
[553.026297] Starting dynamic subtest: pipe-B-DP-1
[553.454425] Dynamic subtest pipe-B-DP-1: SUCCESS (0.454s)
[553.496235] Starting dynamic subtest: pipe-C-DP-1
[553.882317] Dynamic subtest pipe-C-DP-1: SUCCESS (0.425s)
[553.883770] Subtest rmfb-ioctl: SUCCESS (1.011s)
[554.289707] [132/141] (483s left) i915_pm_rpm (gem-execbuf-stress)
[556.091271] Starting subtest: gem-execbuf-stress
[556.093911] Starting dynamic subtest: smem0
[558.276391] Dynamic subtest smem0: SUCCESS (2.185s)
[558.305749] Starting dynamic subtest: extra-wait-smem0
[610.637298] Dynamic subtest extra-wait-smem0: SUCCESS (52.356s)
[610.640048] Subtest gem-execbuf-stress: SUCCESS (54.548s)
[611.081412] [133/141] (426s left) kms_getfb (getfb2-handle-closed)
[611.291589] Starting subtest: getfb2-handle-closed
[611.293183] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[611.413242] [134/141] (426s left) gem_pxp (hw-rejects-pxp-buffer)
[614.143735] Starting subtest: hw-rejects-pxp-buffer
[614.146083] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[614.263569] [135/141] (423s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_dg2_mc_ccs)
[614.566885] Starting subtest: pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs
[614.569693] Subtest pipe-A-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[615.264897] [136/141] (422s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[615.570575] Starting subtest: cursorA-vs-flipA-atomic
[626.636854] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.060s)
[626.980841] [137/141] (411s left) kms_draw_crc (draw-method-blt)
[627.299752] Starting subtest: draw-method-blt
[627.301086] Starting dynamic subtest: xrgb8888-untiled
[627.594845] Dynamic subtest xrgb8888-untiled: SUCCESS (0.297s)
[627.629725] Starting dynamic subtest: rgb565-untiled
[627.894716] Dynamic subtest rgb565-untiled: SUCCESS (0.298s)
[627.922496] Starting dynamic subtest: xrgb2101010-untiled
[628.211421] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[628.241079] Starting dynamic subtest: xrgb8888-xtiled
[628.394979] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[628.429569] Starting dynamic subtest: rgb565-xtiled
[628.578150] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[628.607864] Starting dynamic subtest: xrgb2101010-xtiled
[628.761439] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.181s)
[628.788348] Starting dynamic subtest: xrgb8888-ytiled
[628.962585] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.197s)
[628.993204] Starting dynamic subtest: rgb565-ytiled
[629.131116] Dynamic subtest rgb565-ytiled: SUCCESS (0.163s)
[629.157353] Starting dynamic subtest: xrgb2101010-ytiled
[629.311454] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.181s)
[629.312898] Subtest draw-method-blt: SUCCESS (2.016s)
[629.444043] [138/141] (408s left) syncobj_wait (wait-any-complex)
[629.655124] Starting subtest: wait-any-complex
[629.720657] Subtest wait-any-complex: SUCCESS (0.065s)
[629.810316] [139/141] (408s left) kms_psr2_sf (cursor-plane-update-sf)
[630.022122] Subtest cursor-plane-update-sf: SKIP (0.000s)
[630.090859] [140/141] (408s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[630.618715] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[630.623654] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[631.089719] [141/141] (407s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[631.429361] Starting subtest: y-tiled-64bpp-rotate-90
[631.518695] Subtest y-tiled-64bpp-rotate-90: SKIP (0.090s)
[631.634654] Closing watchdogs
Done.