[40.334652] Initializing watchdogs
[40.334886]   /dev/watchdog0
[40.351731] [001/142] (960s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_mc_ccs)
[41.067192] Subtest pipe-D-random-ccs-data-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[41.385723] [002/142] (959s left) gem_ctx_persistence (legacy-engines-mixed)
[41.613659] Starting subtest: legacy-engines-mixed
[41.621935] Starting dynamic subtest: render
[41.692530] Dynamic subtest render: SUCCESS (0.073s)
[41.706624] Starting dynamic subtest: bsd
[41.740737] Dynamic subtest bsd: SUCCESS (0.047s)
[41.755324] Starting dynamic subtest: blt
[41.791662] Dynamic subtest blt: SUCCESS (0.051s)
[41.804883] Starting dynamic subtest: vebox
[41.840516] Dynamic subtest vebox: SUCCESS (0.047s)
[41.843760] Subtest legacy-engines-mixed: SUCCESS (0.227s)
[41.937811] [003/142] (958s left) gem_ctx_param (invalid-ctx-get)
[42.141377] Starting subtest: invalid-ctx-get
[42.142991] Subtest invalid-ctx-get: SUCCESS (0.000s)
[42.217412] [004/142] (958s left) gem_userptr_blits (set-cache-level)
[42.432170] Starting subtest: set-cache-level
[42.433473] Subtest set-cache-level: SUCCESS (0.001s)
[42.587119] [005/142] (958s left) kms_flip (2x-modeset-vs-vblank-race)
[42.882175] Starting subtest: 2x-modeset-vs-vblank-race
[42.884872] Subtest 2x-modeset-vs-vblank-race: SKIP (0.003s)
[42.985342] [006/142] (958s left) gem_exec_reloc (basic-write-cpu-active)
[43.199993] Starting subtest: basic-write-cpu-active
[43.342277] Subtest basic-write-cpu-active: SUCCESS (0.141s)
[43.534643] [007/142] (957s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_mc_ccs)
[44.107496] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs
[44.110207] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[44.518356] [008/142] (956s left) kms_content_protection (dp-mst-lic-type-1)
[44.858106] Starting subtest: dp-mst-lic-type-1
[44.861129] Subtest dp-mst-lic-type-1: SKIP (0.001s)
[44.967458] [009/142] (956s left) kms_invalid_mode (bad-vsync-end)
[45.274202] Starting subtest: bad-vsync-end
[45.275676] Starting dynamic subtest: DP-1-pipe-A
[45.374760] Dynamic subtest DP-1-pipe-A: SUCCESS (0.103s)
[45.388781] Starting dynamic subtest: DP-1-pipe-B
[45.390211] Dynamic subtest DP-1-pipe-B: SUCCESS (0.014s)
[45.408208] Starting dynamic subtest: DP-1-pipe-C
[45.409579] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[45.410888] Subtest bad-vsync-end: SUCCESS (0.137s)
[45.736674] [010/142] (955s left) kms_flip (2x-plain-flip-interruptible)
[46.039469] Starting subtest: 2x-plain-flip-interruptible
[46.043616] Subtest 2x-plain-flip-interruptible: SKIP (0.003s)
[46.136951] [011/142] (955s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[46.449864] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[46.452726] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[46.536310] [012/142] (954s left) kms_cursor_crc (cursor-onscreen-512x512)
[46.851660] Starting subtest: cursor-onscreen-512x512
[46.856019] Subtest cursor-onscreen-512x512: SKIP (0.003s)
[46.953435] [013/142] (954s left) gem_exec_schedule (submit-early-slice)
[47.189506] Starting subtest: submit-early-slice
[47.190951] Starting dynamic subtest: rcs0
[47.254785] Dynamic subtest rcs0: SUCCESS (0.065s)
[47.270419] Starting dynamic subtest: bcs0
[47.316648] Dynamic subtest bcs0: SUCCESS (0.062s)
[47.331299] Starting dynamic subtest: vcs0
[47.377493] Dynamic subtest vcs0: SUCCESS (0.059s)
[47.396470] Starting dynamic subtest: vecs0
[47.439413] Dynamic subtest vecs0: SUCCESS (0.062s)
[47.440885] Subtest submit-early-slice: SUCCESS (0.250s)
[47.787323] [014/142] (953s left) kms_vrr (flip-suspend)
[48.095979] Starting subtest: flip-suspend
[48.098466] Subtest flip-suspend: SKIP (0.000s)
[48.169910] [015/142] (953s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[48.503980] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[48.537636] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.032s)
[48.653431] [016/142] (952s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[48.859960] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[48.861798] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[48.936593] [017/142] (952s left) kms_universal_plane (universal-plane-pipe-b-sanity)
[49.239093] Starting subtest: universal-plane-pipe-B-sanity
[50.054990] Subtest universal-plane-pipe-B-sanity: SUCCESS (0.816s)
[50.367955] [018/142] (951s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm)
[50.669388] Starting subtest: pipe-C-ts-continuation-dpms-rpm
[53.167779] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.494s)
[53.633269] [019/142] (947s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[54.117594] Starting subtest: pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[54.120446] Subtest pipe-B-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[54.606326] [020/142] (946s left) gem_exec_params (dr4-dirt)
[54.816627] Starting subtest: DR4-dirt
[54.818492] Subtest DR4-dirt: SUCCESS (0.001s)
[54.922521] [021/142] (946s left) syncobj_wait (invalid-wait-illegal-handle)
[55.123649] Starting subtest: invalid-wait-illegal-handle
[55.125380] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[55.205945] [022/142] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[55.517713] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[55.520178] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[55.606138] [023/142] (945s left) kms_addfb_basic (legacy-format)
[55.808180] Starting subtest: legacy-format
[55.946581] Subtest legacy-format: SUCCESS (0.119s)
[56.264496] [024/142] (945s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[56.595686] Starting subtest: yf-tiled-16bpp-rotate-180
[60.854302] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (4.259s)
[61.658820] [025/142] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[61.981976] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[61.988728] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.076275] [026/142] (939s left) vc4/vc4_tiling (get-bad-flags)
[62.339433] Subtest get-bad-flags: SKIP (0.000s)
[62.406786] [027/142] (939s left) kms_busy (basic)
[62.727444] Starting subtest: basic
[62.728877] Starting dynamic subtest: flip
[63.453703] Dynamic subtest flip: SUCCESS (0.725s)
[63.468534] Starting dynamic subtest: modeset
[65.012507] Dynamic subtest modeset: SUCCESS (1.555s)
[65.014626] Subtest basic: SUCCESS (2.285s)
[65.371272] [028/142] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[65.683986] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[65.686768] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[65.787592] [029/142] (936s left) i915_pm_rpm (drm-resources-equal)
[67.581349] Starting subtest: drm-resources-equal
[69.181014] Subtest drm-resources-equal: SUCCESS (1.600s)
[69.402675] [030/142] (932s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[69.712898] Starting subtest: basic-flip-before-cursor-varying-size
[70.800472] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.087s)
[71.134814] [031/142] (930s left) gem_readwrite (read-write)
[71.337072] Starting subtest: read-write
[71.342600] Subtest read-write: SUCCESS (0.001s)
[71.433682] [032/142] (930s left) kms_cursor_legacy (forked-bo)
[71.734564] Starting subtest: forked-bo
[71.735955] Starting dynamic subtest: pipe-A
[77.190418] Dynamic subtest pipe-A: SUCCESS (5.456s)
[77.205253] Starting dynamic subtest: pipe-B
[82.655093] Dynamic subtest pipe-B: SUCCESS (5.465s)
[82.670187] Starting dynamic subtest: pipe-C
[88.128700] Dynamic subtest pipe-C: SUCCESS (5.468s)
[88.143883] Starting dynamic subtest: all-pipes
[93.595680] Dynamic subtest all-pipes: SUCCESS (5.467s)
[93.597382] Subtest forked-bo: SUCCESS (21.864s)
[93.687760] [033/142] (908s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_mc_ccs)
[94.319390] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs
[94.326252] Subtest pipe-C-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[94.677775] [034/142] (907s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[94.981685] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[94.983043] Starting dynamic subtest: pipe-A-DP-1
[95.015361] Dynamic subtest pipe-A-DP-1: SKIP (0.031s)
[95.031464] Starting dynamic subtest: pipe-B-DP-1
[95.100866] Dynamic subtest pipe-B-DP-1: SKIP (0.081s)
[95.116358] Starting dynamic subtest: pipe-C-DP-1
[95.185485] Dynamic subtest pipe-C-DP-1: SKIP (0.080s)
[95.188262] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.204s)
[95.296285] [035/142] (906s left) kms_concurrent (pipe-b)
[95.590869] Starting subtest: pipe-B
[95.592467] Starting dynamic subtest: DP-1
[96.471046] Dynamic subtest DP-1: SUCCESS (0.879s)
[96.472318] Subtest pipe-B: SUCCESS (0.883s)
[96.794678] [036/142] (905s left) gem_exec_basic (basic)
[97.016202] Starting subtest: basic
[97.019739] Starting dynamic subtest: rcs0-smem
[97.023675] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[97.040431] Starting dynamic subtest: bcs0-smem
[97.041697] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[97.056159] Starting dynamic subtest: vcs0-smem
[97.057362] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[97.071722] Starting dynamic subtest: vecs0-smem
[97.072971] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[97.074235] Subtest basic: SUCCESS (0.016s)
[97.244574] [037/142] (904s left) gem_workarounds (basic-read-fd)
[97.478401] Starting subtest: basic-read-fd
[97.503890] Subtest basic-read-fd: SUCCESS (0.025s)
[97.610694] [038/142] (904s left) kms_draw_crc (draw-method-mmap-wc)
[97.911708] Starting subtest: draw-method-mmap-wc
[97.913181] Starting dynamic subtest: xrgb8888-untiled
[98.222969] Dynamic subtest xrgb8888-untiled: SUCCESS (0.310s)
[98.239294] Starting dynamic subtest: rgb565-untiled
[98.505980] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[98.524955] Starting dynamic subtest: xrgb2101010-untiled
[98.822768] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[98.839461] Starting dynamic subtest: xrgb8888-xtiled
[99.039388] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.215s)
[99.057820] Starting dynamic subtest: rgb565-xtiled
[99.240739] Dynamic subtest rgb565-xtiled: SUCCESS (0.198s)
[99.257564] Starting dynamic subtest: xrgb2101010-xtiled
[99.456592] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.215s)
[99.473089] Starting dynamic subtest: xrgb8888-ytiled
[99.674600] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.216s)
[99.692860] Starting dynamic subtest: rgb565-ytiled
[99.873865] Dynamic subtest rgb565-ytiled: SUCCESS (0.196s)
[99.890277] Starting dynamic subtest: xrgb2101010-ytiled
[100.090652] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.216s)
[100.092418] Subtest draw-method-mmap-wc: SUCCESS (2.181s)
[100.193891] [039/142] (901s left) kms_atomic_transition (plane-all-transition-fencing)
[100.502701] Starting subtest: plane-all-transition-fencing
[100.506637] Starting dynamic subtest: pipe-A-DP-1
[104.422829] Dynamic subtest pipe-A-DP-1: SUCCESS (3.918s)
[104.550983] Starting dynamic subtest: pipe-B-DP-1
[109.041730] Dynamic subtest pipe-B-DP-1: SUCCESS (4.511s)
[109.145667] Subtest plane-all-transition-fencing: SUCCESS (8.641s)
[109.461406] [040/142] (892s left) device_reset (unbind-cold-reset-rebind)
[109.704145] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[109.777122] [041/142] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[110.084433] Starting subtest: fbcpsr-1p-rte
[110.086887] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[110.177897] [042/142] (892s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[110.492458] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[110.495386] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[110.578192] [043/142] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[110.889832] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[110.892813] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[110.994786] [044/142] (891s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[111.678510] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[111.991907] [045/142] (890s left) syncobj_wait (single-wait-all-for-submit-signaled)
[112.198378] Starting subtest: single-wait-all-for-submit-signaled
[112.200029] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[112.292795] [046/142] (890s left) kms_plane_scaling (plane-downscale-with-rotation-factor-0-25)
[112.589266] Starting subtest: plane-downscale-with-rotation-factor-0-25
[112.590531] Starting dynamic subtest: pipe-A-DP-1
[112.636458] Dynamic subtest pipe-A-DP-1: SKIP (0.046s)
[112.654220] Starting dynamic subtest: pipe-B-DP-1
[112.738687] Dynamic subtest pipe-B-DP-1: SKIP (0.095s)
[112.756430] Starting dynamic subtest: pipe-C-DP-1
[112.838829] Dynamic subtest pipe-C-DP-1: SKIP (0.096s)
[112.841443] Subtest plane-downscale-with-rotation-factor-0-25: SKIP (0.252s)
[112.942338] [047/142] (889s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[113.248059] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[113.249872] Starting dynamic subtest: pipe-A-valid-mode
[113.370751] Dynamic subtest pipe-A-valid-mode: SKIP (0.121s)
[113.373373] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.126s)
[113.702690] [048/142] (888s left) kms_ccs (pipe-a-random-ccs-data-yf_tiled_ccs)
[114.127884] Starting subtest: pipe-A-random-ccs-data-yf_tiled_ccs
[114.571338] Subtest pipe-A-random-ccs-data-yf_tiled_ccs: SUCCESS (0.443s)
[115.235185] [049/142] (887s left) gem_exec_schedule (deep)
[115.597438] Starting subtest: deep
[115.601869] Starting dynamic subtest: rcs0
[129.986685] Dynamic subtest rcs0: SUCCESS (14.381s)
[130.007262] Starting dynamic subtest: bcs0
[145.222109] Dynamic subtest bcs0: SUCCESS (15.238s)
[145.248080] Starting dynamic subtest: vcs0
[158.991893] Dynamic subtest vcs0: SUCCESS (13.760s)
[159.020656] Starting dynamic subtest: vecs0
[173.692968] Dynamic subtest vecs0: SUCCESS (14.690s)
[173.694713] Subtest deep: SUCCESS (58.096s)
[175.104259] [050/142] (827s left) gem_fenced_exec_thrash (no-spare-fences)
[175.320309] Starting subtest: no-spare-fences
[177.481818] Subtest no-spare-fences: SUCCESS (2.162s)
[177.818792] [051/142] (824s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[178.442052] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[178.444615] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[178.836589] [052/142] (823s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[179.147121] Starting subtest: psr-shrfb-scaledprimary
[179.149891] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[179.253178] [053/142] (823s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[179.650303] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[179.941945] [054/142] (822s left) gem_exec_fair (basic-none-vip)
[180.172658] Starting subtest: basic-none-vip
[180.174258] Starting dynamic subtest: rcs0
[185.907776] Dynamic subtest rcs0: SUCCESS (5.733s)
[185.909655] Subtest basic-none-vip: SUCCESS (5.736s)
[186.120225] [055/142] (816s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[186.423409] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[186.424668] Starting dynamic subtest: pipe-A-valid-mode
[186.517838] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[186.520457] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.097s)
[186.827720] [056/142] (815s left) dmabuf_sync_file (import-basic)
[187.042110] Starting subtest: import-basic
[187.046129] Subtest import-basic: SUCCESS (0.007s)
[187.127443] [057/142] (815s left) gem_ctx_shared (q-independent)
[187.355571] Starting subtest: Q-independent
[187.359891] Starting dynamic subtest: rcs0
[187.430689] Dynamic subtest rcs0: SUCCESS (0.073s)
[187.455694] Starting dynamic subtest: bcs0
[187.516245] Dynamic subtest bcs0: SUCCESS (0.082s)
[187.542212] Starting dynamic subtest: vcs0
[187.580516] Dynamic subtest vcs0: SUCCESS (0.062s)
[187.603760] Starting dynamic subtest: vecs0
[187.646694] Dynamic subtest vecs0: SUCCESS (0.062s)
[187.649597] Subtest Q-independent: SUCCESS (0.291s)
[187.878205] [058/142] (814s left) kms_vblank (pipe-b-wait-forked-hang)
[188.185922] Starting subtest: pipe-B-wait-forked-hang
[196.049278] Subtest pipe-B-wait-forked-hang: SUCCESS (7.865s)
[196.368158] [059/142] (806s left) gem_wait (write-wait)
[196.609072] Starting subtest: write-wait
[196.610804] Starting dynamic subtest: all-engines
[197.649883] Dynamic subtest all-engines: SUCCESS (1.039s)
[197.670376] Starting dynamic subtest: rcs0
[198.686548] Dynamic subtest rcs0: SUCCESS (1.034s)
[198.707181] Starting dynamic subtest: bcs0
[199.728661] Dynamic subtest bcs0: SUCCESS (1.039s)
[199.750694] Starting dynamic subtest: vcs0
[200.766587] Dynamic subtest vcs0: SUCCESS (1.035s)
[200.788460] Starting dynamic subtest: vecs0
[201.800512] Dynamic subtest vecs0: SUCCESS (1.030s)
[201.802165] Subtest write-wait: SUCCESS (5.193s)
[202.051992] [060/142] (800s left) v3d/v3d_get_bo_offset (create-get-offsets)
[202.313176] Subtest create-get-offsets: SKIP (0.000s)
[202.382375] [061/142] (800s left) kms_getfb (getfb2-handle-not-fb)
[202.587155] Starting subtest: getfb2-handle-not-fb
[202.683052] Subtest getfb2-handle-not-fb: SUCCESS (0.092s)
[202.783542] [062/142] (800s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[203.094981] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[203.098035] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[203.200712] [063/142] (799s left) kms_addfb_basic (bad-pitch-256)
[203.403209] Starting subtest: bad-pitch-256
[203.404606] Subtest bad-pitch-256: SUCCESS (0.000s)
[203.600087] [064/142] (799s left) gem_flink_race (flink_name)
[203.797958] Starting subtest: flink_name
[209.175793] Subtest flink_name: SUCCESS (5.376s)
[209.282489] [065/142] (793s left) kms_legacy_colorkey (invalid-plane)
[209.577936] Starting subtest: invalid-plane
[209.579293] Starting dynamic subtest: zero-id
[209.580494] Dynamic subtest zero-id: SUCCESS (0.000s)
[209.596913] Starting dynamic subtest: outrange-id
[209.598193] Dynamic subtest outrange-id: SUCCESS (0.000s)
[209.599354] Subtest invalid-plane: SUCCESS (0.005s)
[209.666664] [066/142] (793s left) gem_exec_params (secure-non-master)
[209.875704] Starting subtest: secure-non-master
[209.878649] Subtest secure-non-master: SKIP (0.000s)
[209.983289] [067/142] (793s left) vc4/vc4_mmap (mmap-bo)
[210.246700] Subtest mmap-bo: SKIP (0.000s)
[210.315465] [068/142] (792s left) kms_sysfs_edid_timing
[211.816499] [069/142] (791s left) i915_pm_rpm (modeset-lpsp-stress)
[213.623910] Starting subtest: modeset-lpsp-stress
[214.026374] Subtest modeset-lpsp-stress: SKIP (0.400s)
[214.526561] [070/142] (788s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[214.960198] Starting subtest: plane-primary-overlay-mutable-zpos
[214.964338] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.000s)
[215.389219] [071/142] (787s left) gem_pwrite (basic-self)
[215.592350] Starting subtest: basic-self
[215.843927] Subtest basic-self: SUCCESS (0.254s)
[215.954356] [072/142] (787s left) v3d/v3d_submit_csd (bad-in-sync)
[216.216747] Subtest bad-in-sync: SKIP (0.000s)
[216.287617] [073/142] (787s left) kms_ccs (pipe-c-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[216.912493] Starting subtest: pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[216.915398] Subtest pipe-C-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[217.280756] [074/142] (786s left) perf_pmu (init-busy)
[217.492745] Starting subtest: init-busy
[217.494716] Starting dynamic subtest: rcs0
[217.496424] Dynamic subtest rcs0: SUCCESS (0.002s)
[217.519102] Starting dynamic subtest: bcs0
[217.520487] Dynamic subtest bcs0: SUCCESS (0.001s)
[217.538640] Starting dynamic subtest: vcs0
[217.540308] Dynamic subtest vcs0: SUCCESS (0.001s)
[217.556477] Starting dynamic subtest: vecs0
[217.557744] Dynamic subtest vecs0: SUCCESS (0.002s)
[217.558992] Subtest init-busy: SUCCESS (0.018s)
[217.597382] [075/142] (785s left) kms_cursor_crc (cursor-random-max-size)
[217.924245] Starting subtest: cursor-random-max-size
[217.928939] Subtest cursor-random-max-size: SKIP (0.000s)
[218.030609] [076/142] (785s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[218.349575] Starting subtest: y-tiled-64bpp-rotate-270
[218.435078] Subtest y-tiled-64bpp-rotate-270: SKIP (0.081s)
[218.547510] [077/142] (785s left) gem_exec_gttfill (basic)
[218.775795] Starting subtest: basic
[247.078462] Subtest basic: SUCCESS (28.302s)
[247.282713] [078/142] (756s left) i915_hangman (engine-error-state-capture)
[247.636307] Starting subtest: engine-error-state-capture
[247.637812] Starting dynamic subtest: rcs0
[251.813156] Dynamic subtest rcs0: SUCCESS (4.176s)
[251.835065] Starting dynamic subtest: bcs0
[255.776039] Dynamic subtest bcs0: SUCCESS (3.960s)
[255.797802] Starting dynamic subtest: vcs0
[259.809578] Dynamic subtest vcs0: SUCCESS (4.030s)
[259.831827] Starting dynamic subtest: vecs0
[263.776450] Dynamic subtest vecs0: SUCCESS (3.963s)
[263.778662] Subtest engine-error-state-capture: SUCCESS (16.143s)
[263.901463] [079/142] (739s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[264.217701] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[264.220446] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[264.315898] [080/142] (739s left) gem_render_copy (linear)
[264.538830] Starting subtest: linear
[264.543614] Starting dynamic subtest: smem
[264.798794] Dynamic subtest smem: SUCCESS (0.257s)
[264.800306] Subtest linear: SUCCESS (0.260s)
[264.999995] [081/142] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[265.306381] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[265.309485] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[265.399899] [082/142] (738s left) perf (per-context-mode-unprivileged)
[265.747345] Starting subtest: per-context-mode-unprivileged
[265.750393] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[265.798531] [083/142] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[266.111472] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[266.114661] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[266.216145] [084/142] (737s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc)
[266.713630] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc
[266.716369] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_rc_ccs_cc: SKIP (0.001s)
[267.194297] [085/142] (736s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc)
[267.654888] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc
[267.661292] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.005s)
[268.181980] [086/142] (735s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[268.498610] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[268.501358] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[268.599212] [087/142] (735s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[268.803531] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[268.805393] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[268.898474] [088/142] (735s left) gem_exec_whisper (basic-queues-all)
[269.128276] Starting subtest: basic-queues-all
[280.658825] Subtest basic-queues-all: SUCCESS (11.528s)
[280.867856] [089/142] (723s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[281.196068] Starting subtest: x-tiled-16bpp-rotate-180
[285.457952] Subtest x-tiled-16bpp-rotate-180: SUCCESS (4.260s)
[285.803641] [090/142] (718s left) kms_ccs (pipe-a-bad-pixel-format-4_tiled_mtl_mc_ccs)
[286.105243] Starting subtest: pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs
[286.107880] Subtest pipe-A-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[286.793901] [091/142] (717s left) syncobj_timeline (signal-array)
[286.998721] Starting subtest: signal-array
[287.000449] Subtest signal-array: SUCCESS (0.001s)
[287.093296] [092/142] (717s left) api_intel_allocator (open-vm)
[287.295965] Starting subtest: open-vm
[287.297858] Subtest open-vm: SUCCESS (0.004s)
[287.393962] [093/142] (716s left) kms_psr2_su (page_flip-xrgb8888)
[287.599327] Subtest page_flip-XRGB8888: SKIP (0.000s)
[287.659712] [094/142] (716s left) kms_vblank (invalid)
[287.957860] Starting subtest: invalid
[288.199990] Subtest invalid: SUCCESS (0.243s)
[288.544208] [095/142] (715s left) kms_plane (invalid-pixel-format-settings)
[288.847164] Starting subtest: invalid-pixel-format-settings
[288.852751] Subtest invalid-pixel-format-settings: SUCCESS (0.009s)
[288.944165] [096/142] (715s left) kms_pipe_crc_basic (bad-source)
[289.252206] Starting subtest: bad-source
[289.253736] Subtest bad-source: SUCCESS (0.001s)
[289.344828] [097/142] (715s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[289.555576] Starting subtest: writes-after-reads
[293.230454] Subtest writes-after-reads: SUCCESS (3.675s)
[293.359244] [098/142] (711s left) kms_color (ctm-blue-to-red)
[293.673188] Starting subtest: ctm-blue-to-red
[293.674700] Starting dynamic subtest: pipe-A
[294.202786] Dynamic subtest pipe-A: SUCCESS (0.533s)
[294.238498] Starting dynamic subtest: pipe-B
[295.026659] Dynamic subtest pipe-B: SUCCESS (0.818s)
[295.052114] Starting dynamic subtest: pipe-C
[295.968375] Dynamic subtest pipe-C: SUCCESS (0.940s)
[295.969926] Subtest ctm-blue-to-red: SUCCESS (2.299s)
[296.305350] [099/142] (708s left) syncobj_timeline (wait-for-submit-complex)
[296.514632] Starting subtest: wait-for-submit-complex
[296.579181] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[296.671404] [100/142] (707s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[297.081892] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[297.084881] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[297.657196] [101/142] (706s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[297.964371] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[297.967730] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[298.074116] [102/142] (706s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[298.277326] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[298.279257] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[298.373995] [103/142] (706s left) gem_bad_reloc (negative-reloc)
[298.584778] Starting subtest: negative-reloc
[298.589172] Subtest negative-reloc: SUCCESS (0.002s)
[298.690391] [104/142] (706s left) i915_hangman (gt-error-state-capture)
[298.910741] Starting subtest: gt-error-state-capture
[298.912295] Starting dynamic subtest: rcs0
[308.295305] Dynamic subtest rcs0: SUCCESS (9.382s)
[308.316758] Starting dynamic subtest: bcs0
[318.318035] Dynamic subtest bcs0: SUCCESS (10.021s)
[318.342021] Starting dynamic subtest: vcs0
[328.298258] Dynamic subtest vcs0: SUCCESS (9.977s)
[328.322517] Starting dynamic subtest: vecs0
[338.285122] Dynamic subtest vecs0: SUCCESS (9.984s)
[338.286915] Subtest gt-error-state-capture: SUCCESS (39.376s)
[338.407538] [105/142] (666s left) api_intel_bb (blit-reloc-purge-cache)
[338.612787] Starting subtest: blit-reloc-purge-cache
[338.633510] Subtest blit-reloc-purge-cache: SUCCESS (0.020s)
[338.756902] [106/142] (666s left) kms_frontbuffer_tracking (fbc-badstride)
[339.075270] Starting subtest: fbc-badstride
[346.996216] Subtest fbc-badstride: SUCCESS (7.924s)
[347.138173] [107/142] (657s left) kms_addfb_basic (tile-pitch-mismatch)
[347.342525] Starting subtest: tile-pitch-mismatch
[347.343825] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[347.542522] [108/142] (657s left) gem_mmap (bad-offset)
[347.742290] Starting subtest: bad-offset
[347.743942] Subtest bad-offset: SUCCESS (0.001s)
[347.857317] [109/142] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[348.168273] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[348.171144] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[348.258105] [110/142] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[348.562027] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[348.564785] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[348.658168] [111/142] (656s left) kms_flip (bo-too-big-interruptible)
[348.962692] Starting subtest: bo-too-big-interruptible
[348.967737] Starting dynamic subtest: A-DP1
[351.946915] Dynamic subtest A-DP1: SUCCESS (2.979s)
[351.973868] Starting dynamic subtest: B-DP1
[354.902781] Dynamic subtest B-DP1: SUCCESS (2.952s)
[354.929791] Starting dynamic subtest: C-DP1
[357.851485] Dynamic subtest C-DP1: SUCCESS (2.943s)
[357.856131] Subtest bo-too-big-interruptible: SUCCESS (8.891s)
[358.527617] [112/142] (646s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[358.828167] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[358.834776] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.005s)
[358.942814] [113/142] (646s left) gem_softpin (allocator-basic)
[359.160260] Starting subtest: allocator-basic
[359.404547] Subtest allocator-basic: SUCCESS (0.244s)
[359.524959] [114/142] (645s left) kms_psr (psr2_sprite_mmap_cpu)
[359.726483] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[359.790244] [115/142] (645s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[360.097197] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[360.101853] Starting dynamic subtest: pipe-A-DP-1
[360.746125] Dynamic subtest pipe-A-DP-1: SUCCESS (0.647s)
[360.772412] Starting dynamic subtest: pipe-B-DP-1
[361.717346] Dynamic subtest pipe-B-DP-1: SUCCESS (0.966s)
[361.743689] Starting dynamic subtest: pipe-C-DP-1
[362.080470] Dynamic subtest pipe-C-DP-1: SUCCESS (0.358s)
[362.082302] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (1.987s)
[362.490410] [116/142] (642s left) gem_mmap_offset (close-race)
[362.690739] Starting subtest: close-race
[385.009703] Subtest close-race: SUCCESS (22.319s)
[385.123235] [117/142] (620s left) kms_chamelium_color (ctm-0-75)
[385.430561] Subtest ctm-0-75: SKIP (0.000s)
[385.489331] [118/142] (619s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[385.790630] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[400.397621] Subtest flip-vs-cursor-atomic-transitions-varying-size: FAIL (14.283s)
[400.430192] [119/142] (604s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[400.651982] Starting subtest: yf-tiled-ccs-to-x-tiled
[400.653732] Starting dynamic subtest: smem
[400.966448] Dynamic subtest smem: SUCCESS (0.313s)
[400.968111] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.316s)
[401.174788] [120/142] (604s left) gem_lmem_swapping (basic)
[401.385506] Subtest basic: SKIP (0.000s)
[401.439160] [121/142] (604s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[401.641669] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[401.746630] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[401.839902] [122/142] (603s left) gem_mmap_gtt (medium-copy-odd)
[402.041923] Starting subtest: medium-copy-odd
[408.065094] Subtest medium-copy-odd: SUCCESS (6.021s)
[408.173676] [123/142] (597s left) v3d/v3d_submit_csd (multisync-out-syncs)
[408.565782] Subtest multisync-out-syncs: SKIP (0.000s)
[408.639226] [124/142] (596s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_mc_ccs)
[409.163453] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs
[409.167485] Subtest pipe-B-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[409.638302] [125/142] (595s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_mc_ccs)
[410.316705] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[410.640213] [126/142] (595s left) gem_create (create-clear)
[410.843879] Starting subtest: create-clear
[410.845700] Starting dynamic subtest: smem0
[444.174188] Dynamic subtest smem0: SUCCESS (33.325s)
[444.175648] Subtest create-clear: SUCCESS (33.328s)
[444.440130] [127/142] (561s left) gem_ctx_isolation (nonpriv)
[444.667501] Starting subtest: nonpriv
[444.669541] Starting dynamic subtest: rcs0
[447.064898] Dynamic subtest rcs0: SUCCESS (2.395s)
[447.087090] Starting dynamic subtest: bcs0
[450.086852] Dynamic subtest bcs0: SUCCESS (3.020s)
[450.108315] Starting dynamic subtest: vcs0
[452.322644] Dynamic subtest vcs0: SUCCESS (2.233s)
[452.344328] Starting dynamic subtest: vecs0
[454.593734] Dynamic subtest vecs0: SUCCESS (2.268s)
[454.595417] Subtest nonpriv: SUCCESS (9.927s)
[454.807303] [128/142] (550s left) syncobj_timeline (invalid-signal-bad-pad)
[455.012415] Starting subtest: invalid-signal-bad-pad
[455.014354] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[455.107741] [129/142] (550s left) gem_exec_fence (syncobj-signal)
[455.785362] Starting subtest: syncobj-signal
[455.789926] Subtest syncobj-signal: SUCCESS (0.007s)
[456.158168] [130/142] (549s left) kms_getfb (getfb-handle-zero)
[456.360314] Starting subtest: getfb-handle-zero
[456.361873] Subtest getfb-handle-zero: SUCCESS (0.000s)
[456.472979] [131/142] (549s left) gem_exec_reloc (basic-gtt-read-noreloc)
[456.682962] Starting subtest: basic-gtt-read-noreloc
[456.693435] Subtest basic-gtt-read-noreloc: SUCCESS (0.010s)
[456.890131] [132/142] (549s left) gem_exec_schedule (noreorder-corked)
[457.256200] Starting subtest: noreorder-corked
[457.257662] Starting dynamic subtest: rcs0
[458.399121] Dynamic subtest rcs0: SUCCESS (1.141s)
[458.423470] Starting dynamic subtest: bcs0
[459.532866] Dynamic subtest bcs0: SUCCESS (1.130s)
[459.557627] Starting dynamic subtest: vcs0
[460.668242] Dynamic subtest vcs0: SUCCESS (1.131s)
[460.697703] Starting dynamic subtest: vecs0
[461.796920] Dynamic subtest vecs0: SUCCESS (1.124s)
[461.799237] Subtest noreorder-corked: SUCCESS (4.542s)
[462.008466] [133/142] (543s left) gem_workarounds (suspend-resume)
[462.246461] Starting subtest: suspend-resume
[478.553247] Subtest suspend-resume: SUCCESS (1.489s)
[484.622888] [134/142] (541s left) gem_userptr_blits (sync-unmap)
[484.872387] Starting subtest: sync-unmap
[484.923595] Subtest sync-unmap: SUCCESS (0.050s)
[485.068167] [135/142] (541s left) perf_pmu (busy-double-start)
[485.277070] Starting subtest: busy-double-start
[485.278682] Starting dynamic subtest: rcs0
[488.826683] Dynamic subtest rcs0: SUCCESS (3.548s)
[488.855216] Starting dynamic subtest: bcs0
[492.384309] Dynamic subtest bcs0: SUCCESS (3.553s)
[492.412626] Starting dynamic subtest: vcs0
[495.936215] Dynamic subtest vcs0: SUCCESS (3.548s)
[495.964923] Starting dynamic subtest: vecs0
[499.487694] Dynamic subtest vecs0: SUCCESS (3.548s)
[499.489536] Subtest busy-double-start: SUCCESS (14.212s)
[499.583472] [136/142] (526s left) kms_big_fb (linear-8bpp-rotate-270)
[499.899971] Starting subtest: linear-8bpp-rotate-270
[499.979168] Subtest linear-8bpp-rotate-270: SKIP (0.075s)
[500.100771] [137/142] (526s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[500.415222] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[500.418581] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[500.533985] [138/142] (526s left) i915_pm_rpm (universal-planes)
[502.565960] Starting subtest: universal-planes
[502.568831] Starting dynamic subtest: plane-31
[505.585607] Dynamic subtest plane-31: SUCCESS (3.018s)
[505.612667] Starting dynamic subtest: plane-39
[508.683257] Dynamic subtest plane-39: SUCCESS (3.094s)
[508.710387] Starting dynamic subtest: plane-47
[511.516267] Dynamic subtest plane-47: SUCCESS (2.830s)
[511.544116] Starting dynamic subtest: plane-55
[514.230492] Dynamic subtest plane-55: SUCCESS (2.712s)
[514.232719] Subtest universal-planes: SUCCESS (11.666s)
[514.691247] [139/142] (511s left) gem_exec_async (concurrent-writes)
[514.922810] Starting subtest: concurrent-writes
[514.926832] Starting dynamic subtest: rcs0
[514.943380] Dynamic subtest rcs0: SUCCESS (0.018s)
[514.974566] Starting dynamic subtest: bcs0
[514.975847] Dynamic subtest bcs0: SUCCESS (0.015s)
[515.002793] Starting dynamic subtest: vcs0
[515.004096] Dynamic subtest vcs0: SUCCESS (0.014s)
[515.029189] Starting dynamic subtest: vecs0
[515.030548] Dynamic subtest vecs0: SUCCESS (0.015s)
[515.031794] Subtest concurrent-writes: SUCCESS (0.073s)
[515.240320] [140/142] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[515.545302] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[515.548145] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[515.656358] [141/142] (511s left) kms_psr (sprite_mmap_cpu)
[515.859982] Subtest sprite_mmap_cpu: SKIP (0.000s)
[515.921243] [142/142] (510s left) prime_busy (hang-wait)
[516.126774] Starting subtest: hang-wait
[516.128772] Starting dynamic subtest: rcs0
[523.289503] Dynamic subtest rcs0: SUCCESS (7.156s)
[523.315796] Starting dynamic subtest: bcs0
[530.327080] Dynamic subtest bcs0: SUCCESS (7.036s)
[530.352443] Starting dynamic subtest: vcs0
[537.304923] Dynamic subtest vcs0: SUCCESS (6.976s)
[537.331211] Starting dynamic subtest: vecs0
[544.280134] Dynamic subtest vecs0: SUCCESS (6.972s)
[544.281640] Subtest hang-wait: SUCCESS (28.153s)
[544.384206] Closing watchdogs
Done.