[39.892770] Initializing watchdogs
[39.892815]   /dev/watchdog0
[39.900502] [001/133] (960s left) kms_fbcon_fbt (fbc-suspend)
[39.987529] Starting subtest: fbc-suspend
[88.421661] Subtest fbc-suspend: SUCCESS (17.897s)
[88.488005] [002/133] (942s left) kms_selftest (drm_plane_helper)
[88.554312] Starting subtest: drm_plane_helper
[88.563149] Starting dynamic subtest: drm_test_check_plane_state
[88.565692] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.003s)
[88.574482] Starting dynamic subtest: drm_test_check_invalid_plane_state
[88.576751] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.000s)
[88.579033] Subtest drm_plane_helper: SUCCESS (0.014s)
[88.679884] [003/133] (942s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[88.763563] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[91.835572] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.077s)
[91.941415] [004/133] (939s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[92.083830] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[99.387717] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (7.300s)
[100.300375] [005/133] (930s left) kms_flip (flip-vs-blocking-wf-vblank)
[100.385532] Starting subtest: flip-vs-blocking-wf-vblank
[100.388363] Starting dynamic subtest: A-eDP1
[109.373799] Dynamic subtest A-eDP1: SUCCESS (8.991s)
[109.387309] Starting dynamic subtest: B-eDP1
[118.397438] Dynamic subtest B-eDP1: SUCCESS (9.023s)
[118.413516] Starting dynamic subtest: C-eDP1
[127.402610] Dynamic subtest C-eDP1: SUCCESS (9.003s)
[127.416802] Starting dynamic subtest: D-eDP1
[136.436127] Dynamic subtest D-eDP1: SUCCESS (9.032s)
[136.441526] Subtest flip-vs-blocking-wf-vblank: SUCCESS (36.061s)
[137.686485] [006/133] (893s left) kms_atomic_transition (modeset-transition-nonblocking)
[137.767550] Starting subtest: modeset-transition-nonblocking
[137.769915] Starting dynamic subtest: 1x-outputs
[149.985548] Dynamic subtest 1x-outputs: SUCCESS (12.219s)
[150.278619] Subtest modeset-transition-nonblocking: SUCCESS (12.506s)
[151.175648] [007/133] (879s left) kms_pipe_crc_basic (nonblocking-crc)
[151.261491] Starting subtest: nonblocking-crc
[151.263926] Starting dynamic subtest: pipe-A-eDP-1
[152.071068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[152.085028] Starting dynamic subtest: pipe-B-eDP-1
[153.636514] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.563s)
[153.652398] Starting dynamic subtest: pipe-C-eDP-1
[155.147942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[155.163263] Starting dynamic subtest: pipe-D-eDP-1
[156.630859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[156.633389] Subtest nonblocking-crc: SUCCESS (5.368s)
[157.505690] [008/133] (873s left) gem_mmap_gtt (hang-user)
[157.574349] Subtest hang-user: SKIP (0.000s)
[157.621668] [009/133] (873s left) gem_pread (display)
[157.696694] Subtest display: SKIP (0.000s)
[157.744743] [010/133] (873s left) sw_sync (sync_busy_fork_unixsocket)
[157.806566] Starting subtest: sync_busy_fork_unixsocket
[157.825444] Subtest sync_busy_fork_unixsocket: SUCCESS (0.020s)
[157.882756] [011/133] (873s left) v3d/v3d_mmap (mmap-bad-flags)
[157.976351] Subtest mmap-bad-flags: SKIP (0.000s)
[158.024953] [012/133] (873s left) gem_exec_fence (long-history)
[158.523069] Starting subtest: long-history
[165.644970] Subtest long-history: SUCCESS (7.124s)
[166.280895] [013/133] (864s left) perf (oa-formats)
[166.412948] Starting subtest: oa-formats
[166.415257] Starting dynamic subtest: 0-rcs0
[166.431657] Dynamic subtest 0-rcs0: SUCCESS (0.019s)
[166.439116] Starting dynamic subtest: 1-vcs1
[166.472323] Dynamic subtest 1-vcs1: SUCCESS (0.040s)
[166.474813] Subtest oa-formats: SUCCESS (0.060s)
[166.511842] [014/133] (864s left) kms_psr (fbc-psr2-sprite-render)
[166.598375] Starting subtest: fbc-psr2-sprite-render
[166.600788] Starting dynamic subtest: eDP-1
[166.605388] Dynamic subtest eDP-1: SKIP (0.000s)
[166.610020] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[166.662853] [015/133] (864s left) gem_userptr_blits (access-control)
[166.754571] Starting subtest: access-control
[166.759401] Subtest access-control: SKIP (0.000s)
[166.851945] [016/133] (864s left) syncobj_basic (illegal-fd-to-handle)
[166.930624] Starting subtest: illegal-fd-to-handle
[166.933270] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[167.001870] [017/133] (864s left) kms_psr (psr2-cursor-mmap-cpu)
[167.072283] Starting subtest: psr2-cursor-mmap-cpu
[167.074686] Starting dynamic subtest: eDP-1
[168.892436] Dynamic subtest eDP-1: SUCCESS (1.819s)
[168.895115] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.820s)
[169.776364] [018/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[169.848939] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[169.851724] Starting dynamic subtest: pipe-A-default-mode
[170.138987] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[170.143951] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.287s)
[171.020244] [019/133] (860s left) kms_atomic_transition (plane-all-transition)
[171.128681] Starting subtest: plane-all-transition
[171.131803] Starting dynamic subtest: pipe-A-eDP-1
[173.626410] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.502s)
[173.943128] Starting dynamic subtest: pipe-B-eDP-1
[177.279521] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.353s)
[177.592267] Subtest plane-all-transition: SUCCESS (6.468s)
[178.504712] [020/133] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[178.607249] Starting subtest: psr-2p-primscrn-cur-indfb-move
[178.611638] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[178.700455] [021/133] (852s left) syncobj_wait (wait-all-snapshot)
[178.773648] Starting subtest: wait-all-snapshot
[178.856848] Subtest wait-all-snapshot: SUCCESS (0.083s)
[178.928168] [022/133] (852s left) kms_frontbuffer_tracking (psr-2p-rte)
[179.024128] Starting subtest: psr-2p-rte
[179.028084] Subtest psr-2p-rte: SKIP (0.000s)
[179.099995] [023/133] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[179.212729] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[184.419201] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.213s)
[184.514460] [024/133] (847s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[184.617573] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[184.619851] Starting dynamic subtest: A-eDP1
[188.476061] Dynamic subtest A-eDP1: SUCCESS (3.854s)
[188.492527] Starting dynamic subtest: B-eDP1
[192.000249] Dynamic subtest B-eDP1: SUCCESS (3.522s)
[192.016803] Starting dynamic subtest: C-eDP1
[195.449997] Dynamic subtest C-eDP1: SUCCESS (3.451s)
[195.469753] Starting dynamic subtest: D-eDP1
[198.908693] Dynamic subtest D-eDP1: SUCCESS (3.457s)
[198.917575] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.298s)
[199.816288] [025/133] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[199.902241] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[199.906940] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[199.969348] [026/133] (831s left) kms_invalid_mode (zero-vdisplay)
[200.072035] Starting subtest: zero-vdisplay
[200.074472] Starting dynamic subtest: pipe-A-eDP-1
[200.355408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[200.371441] Starting dynamic subtest: pipe-B-eDP-1
[200.373727] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[200.388215] Starting dynamic subtest: pipe-C-eDP-1
[200.390950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[200.404157] Starting dynamic subtest: pipe-D-eDP-1
[200.406836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[200.409585] Subtest zero-vdisplay: SUCCESS (0.297s)
[201.282584] [027/133] (830s left) gem_lmem_swapping (verify)
[201.346218] Subtest verify: SKIP (0.000s)
[201.373881] [028/133] (830s left) kms_psr (fbc-pr-cursor-plane-move)
[201.476971] Starting subtest: fbc-pr-cursor-plane-move
[201.480784] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[201.540210] [029/133] (830s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[201.643023] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[201.646965] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[201.715330] [030/133] (830s left) gem_exec_flush (basic-wb-set-default)
[201.805359] Starting subtest: basic-wb-set-default
[207.282088] Subtest basic-wb-set-default: SUCCESS (5.476s)
[207.468446] [031/133] (824s left) vc4/vc4_wait_bo (used-bo)
[207.582993] Subtest used-bo: SKIP (0.000s)
[207.633807] [032/133] (824s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[209.156855] Starting subtest: modeset-non-lpsp-stress-no-wait
[209.873702] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.715s)
[210.203157] [033/133] (821s left) gem_close (many-handles-one-vma)
[210.269075] Starting subtest: many-handles-one-vma
[210.290016] Subtest many-handles-one-vma: SUCCESS (0.021s)
[210.391484] [034/133] (821s left) kms_vblank (query-forked-busy-hang)
[210.463822] Starting subtest: query-forked-busy-hang
[210.466318] Starting dynamic subtest: pipe-A-eDP-1
[224.810409] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.342s)
[224.826337] Starting dynamic subtest: pipe-D-eDP-1
[249.818411] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.004s)
[249.821025] Subtest query-forked-busy-hang: SUCCESS (39.356s)
[250.762570] [035/133] (781s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[250.862237] Starting subtest: 4-tiled-8bpp-rotate-180
[252.049115] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.191s)
[252.177351] [036/133] (779s left) kms_plane_multiple (tiling-yf)
[252.262637] Starting subtest: tiling-yf
[252.266540] Subtest tiling-yf: SKIP (0.000s)
[252.328174] [037/133] (779s left) gem_exec_schedule (preempt-other)
[252.416831] Starting subtest: preempt-other
[252.418967] Starting dynamic subtest: rcs0
[252.519389] Dynamic subtest rcs0: SUCCESS (0.103s)
[252.535291] Starting dynamic subtest: bcs0
[252.634482] Dynamic subtest bcs0: SUCCESS (0.114s)
[252.643901] Starting dynamic subtest: vcs0
[252.737471] Dynamic subtest vcs0: SUCCESS (0.102s)
[252.752852] Starting dynamic subtest: vcs1
[252.854816] Dynamic subtest vcs1: SUCCESS (0.117s)
[252.871220] Starting dynamic subtest: vecs0
[252.943584] Dynamic subtest vecs0: SUCCESS (0.088s)
[252.950221] Starting dynamic subtest: ccs0
[253.058569] Dynamic subtest ccs0: SUCCESS (0.115s)
[253.061086] Subtest preempt-other: SUCCESS (0.642s)
[254.113076] [038/133] (777s left) gem_exec_alignment (single)
[254.184016] Starting subtest: single
[254.187084] Subtest single: SUCCESS (0.003s)
[254.285112] [039/133] (777s left) kms_psr (pr-primary-mmap-gtt)
[254.361565] Starting subtest: pr-primary-mmap-gtt
[254.366715] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[254.428957] [040/133] (777s left) core_setmaster (master-drop-set-shared-fd)
[255.069396] Starting subtest: master-drop-set-shared-fd
[255.093464] Subtest master-drop-set-shared-fd: SUCCESS (0.023s)
[255.110244] [041/133] (776s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[255.210307] Starting subtest: yf-tiled-8bpp-rotate-270
[255.214696] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[255.287169] [042/133] (776s left) kms_draw_crc (fill-fb)
[255.405379] Starting subtest: fill-fb
[255.923840] Subtest fill-fb: SUCCESS (0.522s)
[256.012447] [043/133] (776s left) i915_query (query-topology-unsupported)
[256.094913] Starting subtest: query-topology-unsupported
[256.098889] Subtest query-topology-unsupported: SKIP (0.000s)
[256.179669] [044/133] (775s left) gem_partial_pwrite_pread (reads-display)
[256.245389] Subtest reads-display: SKIP (0.000s)
[256.287909] [045/133] (775s left) gem_softpin (evict-prime)
[256.356504] Starting subtest: evict-prime
[256.359159] Starting dynamic subtest: rcs0
[257.500598] Dynamic subtest rcs0: SUCCESS (1.143s)
[257.515590] Starting dynamic subtest: bcs0
[258.613578] Dynamic subtest bcs0: SUCCESS (1.111s)
[258.625861] Starting dynamic subtest: vcs0
[259.970234] Dynamic subtest vcs0: SUCCESS (1.354s)
[259.990750] Starting dynamic subtest: vcs1
[262.018219] Dynamic subtest vcs1: SUCCESS (2.046s)
[262.035562] Starting dynamic subtest: vecs0
[264.002101] Dynamic subtest vecs0: SUCCESS (1.983s)
[264.018987] Starting dynamic subtest: ccs0
[265.117806] Dynamic subtest ccs0: SUCCESS (1.116s)
[265.131767] Starting dynamic subtest: all
[266.952955] Dynamic subtest all: SUCCESS (1.832s)
[266.956140] Subtest evict-prime: SUCCESS (10.595s)
[267.029330] [046/133] (765s left) kms_psr (psr-no-drrs)
[267.134686] Starting subtest: psr-no-drrs
[267.137212] Starting dynamic subtest: eDP-1
[268.863539] Dynamic subtest eDP-1: SUCCESS (1.728s)
[268.866190] Subtest psr-no-drrs: SUCCESS (1.730s)
[269.770982] [047/133] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[269.879965] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[269.884705] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[269.971116] [048/133] (762s left) kms_addfb_basic (unused-offsets)
[270.034834] Starting subtest: unused-offsets
[270.037351] Subtest unused-offsets: SUCCESS (0.000s)
[270.127666] [049/133] (762s left) gem_ppgtt (shrink-vs-evict-any)
[270.202963] Starting subtest: shrink-vs-evict-any
[278.079330] Subtest shrink-vs-evict-any: SUCCESS (7.823s)
[278.105624] [050/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[278.186866] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[282.772271] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.595s)
[282.891389] [051/133] (749s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[282.970616] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[282.975225] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[283.058522] [052/133] (749s left) drm_fdinfo (most-busy-check-all)
[283.100898] Starting subtest: most-busy-check-all
[283.102884] Starting dynamic subtest: rcs0
[283.107476] Dynamic subtest rcs0: SKIP (0.004s)
[283.114397] Starting dynamic subtest: bcs0
[283.118340] Dynamic subtest bcs0: SKIP (0.000s)
[283.124421] Starting dynamic subtest: vcs0
[283.128563] Dynamic subtest vcs0: SKIP (0.000s)
[283.134596] Starting dynamic subtest: vcs1
[283.138529] Dynamic subtest vcs1: SKIP (0.000s)
[283.144196] Starting dynamic subtest: vecs0
[283.148445] Dynamic subtest vecs0: SKIP (0.000s)
[283.154134] Starting dynamic subtest: ccs0
[283.158298] Dynamic subtest ccs0: SKIP (0.000s)
[283.162411] Subtest most-busy-check-all: SKIP (0.008s)
[283.178597] [053/133] (749s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[283.282799] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[283.295400] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.013s)
[283.371134] [054/133] (749s left) perf (gen12-unprivileged-single-ctx-counters)
[283.505347] Starting subtest: gen12-unprivileged-single-ctx-counters
[283.507831] Starting dynamic subtest: rcs0
[283.554392] Dynamic subtest rcs0: SUCCESS (0.047s)
[283.556786] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.049s)
[283.594747] [055/133] (748s left) i915_query (query-topology-kernel-writes)
[283.682043] Starting subtest: query-topology-kernel-writes
[283.684489] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[283.772343] [056/133] (748s left) kms_atomic_interruptible (universal-setplane-cursor)
[283.847935] Starting subtest: universal-setplane-cursor
[283.849872] Starting dynamic subtest: pipe-A-eDP-1
[291.384563] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.535s)
[291.387703] Subtest universal-setplane-cursor: SUCCESS (7.536s)
[292.300297] [057/133] (740s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[292.366504] Starting subtest: multi-wait-all-for-submit-signaled
[292.368978] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[292.446325] [058/133] (740s left) kms_cursor_crc (cursor-onscreen-max-size)
[292.730468] Starting subtest: cursor-onscreen-max-size
[292.737687] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[292.831671] [059/133] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[292.919618] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[292.923582] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[293.000974] [060/133] (739s left) gem_pxp (verify-pxp-stale-buf-execution)
[295.644834] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[295.677836] [061/133] (736s left) i915_module_load (reload)
[295.736748] Starting subtest: reload
[298.480924] Subtest reload: SUCCESS (2.747s)
[298.503344] [062/133] (734s left) gem_userptr_blits (map-fixed-invalidate)
[299.984462] Starting subtest: map-fixed-invalidate
[299.988985] Subtest map-fixed-invalidate: SKIP (0.000s)
[300.099664] [063/133] (732s left) kms_cursor_crc (cursor-onscreen-32x10)
[300.225031] Starting subtest: cursor-onscreen-32x10
[300.259399] Subtest cursor-onscreen-32x10: SKIP (0.027s)
[300.487018] [064/133] (732s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[300.573594] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[300.621520] [065/133] (732s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[300.709952] Starting subtest: multi-wait-all-available-submitted-signaled
[300.712669] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[300.796397] [066/133] (731s left) kms_ccs (crc-primary-rotation-180-4-tiled-xe2-ccs)
[300.876432] Starting subtest: crc-primary-rotation-180-4-tiled-xe2-ccs
[300.881060] Subtest crc-primary-rotation-180-4-tiled-xe2-ccs: SKIP (0.000s)
[300.944334] [067/133] (731s left) drm_fdinfo (memory-info-active)
[301.012762] Starting subtest: memory-info-active
[301.015230] Starting dynamic subtest: smem0
[303.582515] Dynamic subtest smem0: SUCCESS (2.572s)
[303.584993] Subtest memory-info-active: SUCCESS (2.573s)
[303.639555] [068/133] (729s left) gem_ctx_persistence (legacy-engines-mixed-process)
[303.719153] Starting subtest: legacy-engines-mixed-process
[303.721252] Starting dynamic subtest: render
[304.980181] Dynamic subtest render: SUCCESS (1.260s)
[304.995829] Starting dynamic subtest: bsd1
[307.003461] Dynamic subtest bsd1: SUCCESS (2.020s)
[307.018938] Starting dynamic subtest: bsd2
[309.011422] Dynamic subtest bsd2: SUCCESS (2.007s)
[309.030634] Starting dynamic subtest: blt
[310.983011] Dynamic subtest blt: SUCCESS (1.970s)
[310.999122] Starting dynamic subtest: vebox
[313.033667] Dynamic subtest vebox: SUCCESS (2.048s)
[313.037097] Subtest legacy-engines-mixed-process: SUCCESS (9.314s)
[313.111465] [069/133] (719s left) perf (i915-ref-count)
[313.205321] Starting subtest: i915-ref-count
[313.245578] Subtest i915-ref-count: SUCCESS (0.041s)
[313.282429] [070/133] (719s left) syncobj_timeline (device-submit-unordered)
[313.325881] Starting subtest: device-submit-unordered
[313.327889] Subtest device-submit-unordered: SUCCESS (0.000s)
[313.400911] [071/133] (719s left) gem_exec_basic (basic)
[313.491144] Starting subtest: basic
[313.494376] Starting dynamic subtest: rcs0-smem
[313.500905] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[313.508266] Starting dynamic subtest: bcs0-smem
[313.511005] Dynamic subtest bcs0-smem: SUCCESS (0.004s)
[313.517713] Starting dynamic subtest: vcs0-smem
[313.520262] Dynamic subtest vcs0-smem: SUCCESS (0.006s)
[313.527201] Starting dynamic subtest: vcs1-smem
[313.529152] Dynamic subtest vcs1-smem: SUCCESS (0.005s)
[313.535337] Starting dynamic subtest: vecs0-smem
[313.537290] Dynamic subtest vecs0-smem: SUCCESS (0.005s)
[313.543283] Starting dynamic subtest: ccs0-smem
[313.545242] Dynamic subtest ccs0-smem: SUCCESS (0.005s)
[313.547145] Subtest basic: SUCCESS (0.035s)
[315.056490] [072/133] (717s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[315.150212] Starting subtest: y-tiled-to-vebox-y-tiled
[315.155118] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[315.335621] [073/133] (717s left) gem_exec_parallel (userptr)
[315.406922] Starting subtest: userptr
[315.409408] Starting dynamic subtest: rcs0
[317.806508] Dynamic subtest rcs0: SUCCESS (2.377s)
[317.822837] Starting dynamic subtest: bcs0
[319.706856] Dynamic subtest bcs0: SUCCESS (1.921s)
[319.721935] Starting dynamic subtest: vcs0
[323.021189] Dynamic subtest vcs0: SUCCESS (3.311s)
[323.037389] Starting dynamic subtest: vcs1
[324.984087] Dynamic subtest vcs1: SUCCESS (1.962s)
[324.997725] Starting dynamic subtest: vecs0
[327.044903] Dynamic subtest vecs0: SUCCESS (2.059s)
[327.061112] Starting dynamic subtest: ccs0
[328.936053] Dynamic subtest ccs0: SUCCESS (1.890s)
[328.939097] Subtest userptr: SUCCESS (13.529s)
[329.123200] [074/133] (703s left) gem_ctx_engines (independent)
[329.177712] Starting subtest: independent
[329.180069] Starting dynamic subtest: rcs0
[329.538815] Dynamic subtest rcs0: SUCCESS (0.359s)
[329.555432] Starting dynamic subtest: bcs0
[329.913653] Dynamic subtest bcs0: SUCCESS (0.375s)
[329.923893] Starting dynamic subtest: vcs0
[330.270090] Dynamic subtest vcs0: SUCCESS (0.355s)
[330.287485] Starting dynamic subtest: vcs1
[330.629547] Dynamic subtest vcs1: SUCCESS (0.359s)
[330.645837] Starting dynamic subtest: vecs0
[331.284831] Dynamic subtest vecs0: SUCCESS (0.655s)
[331.301048] Starting dynamic subtest: ccs0
[331.687176] Dynamic subtest ccs0: SUCCESS (0.400s)
[331.703028] Starting dynamic subtest: all-engines
[333.679156] Dynamic subtest all-engines: SUCCESS (1.992s)
[333.681215] Subtest independent: SUCCESS (4.500s)
[334.168964] [075/133] (698s left) gen7_exec_parse (batch-without-end)
[334.240038] Subtest batch-without-end: SKIP (0.000s)
[334.290374] [076/133] (698s left) kms_ccs (bad-rotation-90-4-tiled-xe2-ccs)
[334.375839] Starting subtest: bad-rotation-90-4-tiled-xe2-ccs
[334.380506] Subtest bad-rotation-90-4-tiled-xe2-ccs: SKIP (0.000s)
[334.439864] [077/133] (698s left) gem_ctx_shared (q-smoketest-all)
[334.547446] Starting subtest: Q-smoketest-all
[366.957807] Subtest Q-smoketest-all: SUCCESS (32.359s)
[368.114334] [078/133] (664s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[368.209603] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[368.212006] Starting dynamic subtest: pipe-A-eDP-1
[373.512892] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.304s)
[373.523390] Starting dynamic subtest: pipe-B-eDP-1
[379.694615] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.179s)
[379.712200] Starting dynamic subtest: pipe-C-eDP-1
[385.845967] Dynamic subtest pipe-C-eDP-1: SUCCESS (6.150s)
[385.860016] Starting dynamic subtest: pipe-D-eDP-1
[391.936036] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.086s)
[391.938333] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (23.726s)
[394.259473] [079/133] (638s left) i915_query (engine-info)
[394.320912] Starting subtest: engine-info
[394.329292] Subtest engine-info: SUCCESS (0.010s)
[394.430990] [080/133] (638s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[394.542099] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[395.489007] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.948s)
[395.639303] [081/133] (637s left) kms_flip (flip-vs-rmfb)
[395.715390] Starting subtest: flip-vs-rmfb
[395.722275] Starting dynamic subtest: A-eDP1
[404.477422] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[404.495492] Starting dynamic subtest: B-eDP1
[413.247323] Dynamic subtest B-eDP1: SUCCESS (8.768s)
[413.268840] Starting dynamic subtest: C-eDP1
[422.000985] Dynamic subtest C-eDP1: SUCCESS (8.752s)
[422.019401] Starting dynamic subtest: D-eDP1
[430.771033] Dynamic subtest D-eDP1: SUCCESS (8.768s)
[430.778750] Subtest flip-vs-rmfb: SUCCESS (35.065s)
[432.023973] [082/133] (601s left) kms_psr2_sf (cursor-plane-update-sf)
[437.301579] Starting subtest: cursor-plane-update-sf
[437.304317] Starting dynamic subtest: psr2-pipe-A-eDP-1
[438.704066] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (1.401s)
[438.723992] Starting dynamic subtest: psr2-pipe-B-eDP-1
[440.063557] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (1.356s)
[440.066257] Subtest cursor-plane-update-sf: SUCCESS (2.764s)
[440.968844] [083/133] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[441.081403] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[441.085731] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[441.184808] [084/133] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[441.264222] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[441.267010] Starting dynamic subtest: pipe-A-eDP-1
[441.758425] Dynamic subtest pipe-A-eDP-1: SKIP (0.492s)
[441.775910] Starting dynamic subtest: pipe-B-eDP-1
[443.291013] Dynamic subtest pipe-B-eDP-1: SKIP (1.531s)
[443.299409] Starting dynamic subtest: pipe-C-eDP-1
[444.707270] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.419s)
[444.730049] Starting dynamic subtest: pipe-D-eDP-1
[446.128315] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s)
[446.130736] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.867s)
[447.385989] [085/133] (585s left) kms_chamelium_audio (dp-audio-edid)
[447.765452] Subtest dp-audio-edid: SKIP (0.000s)
[448.627652] [086/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[448.738351] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[448.743181] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[448.834068] [087/133] (584s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[448.933028] Starting subtest: bad-pixel-format-yf-tiled-ccs
[448.935483] Starting dynamic subtest: pipe-A-eDP-1
[448.940245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.958545] Starting dynamic subtest: pipe-B-eDP-1
[448.963719] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.977537] Starting dynamic subtest: pipe-C-eDP-1
[448.982172] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.998061] Starting dynamic subtest: pipe-D-eDP-1
[449.002440] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[449.006697] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.010s)
[449.029074] [088/133] (584s left) kms_cursor_edge_walk (128x128-right-edge)
[449.103603] Starting subtest: 128x128-right-edge
[449.105974] Starting dynamic subtest: pipe-A-eDP-1
[452.688364] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.583s)
[452.705008] Starting dynamic subtest: pipe-D-eDP-1
[455.929209] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.240s)
[455.931965] Subtest 128x128-right-edge: SUCCESS (6.827s)
[456.842630] [089/133] (576s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[456.905667] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[457.008100] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[457.084063] [090/133] (576s left) syncobj_wait (multi-wait-all-signaled)
[457.153804] Starting subtest: multi-wait-all-signaled
[457.156417] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[457.239505] [091/133] (576s left) gem_exec_schedule (u-semaphore-user)
[457.315954] Starting subtest: u-semaphore-user
[457.331454] Subtest u-semaphore-user: SUCCESS (0.028s)
[459.059184] [092/133] (574s left) gem_close_race (multigpu-basic-threads)
[459.139860] Starting subtest: multigpu-basic-threads
[459.144605] Subtest multigpu-basic-threads: SKIP (0.000s)
[459.355003] [093/133] (574s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[459.437569] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[459.440046] Starting dynamic subtest: pipe-A-default-mode
[459.725652] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[459.730868] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.287s)
[460.622230] [094/133] (572s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[460.676129] Starting subtest: invalid-single-wait-all-unsubmitted
[460.678708] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[460.767291] [095/133] (572s left) i915_pm_rpm (gem-idle)
[462.269043] Starting subtest: gem-idle
[471.154419] Subtest gem-idle: SUCCESS (8.886s)
[471.688291] [096/133] (561s left) kms_addfb_basic (unused-modifier)
[473.006466] Starting subtest: unused-modifier
[473.008997] Subtest unused-modifier: SUCCESS (0.000s)
[473.136173] [097/133] (560s left) kms_flip (2x-flip-vs-dpms)
[473.220417] Starting subtest: 2x-flip-vs-dpms
[473.231468] Subtest 2x-flip-vs-dpms: SKIP (0.013s)
[473.308186] [098/133] (560s left) kms_chamelium_frames (dp-crc-single)
[473.738936] Subtest dp-crc-single: SKIP (0.000s)
[474.610231] [099/133] (559s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[474.696496] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[474.744257] [100/133] (559s left) syncobj_wait (invalid-wait-zero-handles)
[474.818563] Starting subtest: invalid-wait-zero-handles
[474.869563] Subtest invalid-wait-zero-handles: FAIL (0.024s)
[474.912546] [101/133] (558s left) api_intel_bb (blit-noreloc-keep-cache)
[474.977101] Starting subtest: blit-noreloc-keep-cache
[474.988955] Subtest blit-noreloc-keep-cache: SUCCESS (0.014s)
[475.076875] [102/133] (558s left) gem_vm_create (invalid-create)
[475.167917] Starting subtest: invalid-create
[475.170445] Subtest invalid-create: SUCCESS (0.002s)
[475.264927] [103/133] (558s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[475.380067] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[476.646874] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.266s)
[476.780422] [104/133] (557s left) kms_feature_discovery (display-3x)
[476.854489] Starting subtest: display-3x
[476.861290] Subtest display-3x: SKIP (0.000s)
[476.916443] [105/133] (556s left) gem_ctx_param (invalid-set-no-zeromap)
[476.982986] Starting subtest: invalid-set-no-zeromap
[476.985260] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[477.054591] [106/133] (556s left) kms_flip (2x-plain-flip)
[477.133989] Starting subtest: 2x-plain-flip
[477.146036] Subtest 2x-plain-flip: SKIP (0.014s)
[477.214949] [107/133] (556s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[477.287697] Starting subtest: fbc-rgb565-draw-render
[480.373503] Subtest fbc-rgb565-draw-render: SUCCESS (3.087s)
[480.504283] [108/133] (553s left) kms_force_connector_basic (prune-stale-modes)
[480.579079] Starting subtest: prune-stale-modes
[480.820119] Subtest prune-stale-modes: SKIP (0.241s)
[480.927661] [109/133] (553s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[481.039978] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[481.043416] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[481.123043] [110/133] (552s left) v3d/v3d_submit_csd (valid-submission)
[481.197767] Subtest valid-submission: SKIP (0.000s)
[481.251594] [111/133] (552s left) sysfs_preempt_timeout (invalid)
[481.328041] Starting subtest: invalid
[481.330379] Starting dynamic subtest: vecs0
[481.332647] Dynamic subtest vecs0: SUCCESS (0.000s)
[481.349739] Starting dynamic subtest: ccs0
[481.351968] Dynamic subtest ccs0: SUCCESS (0.000s)
[481.364653] Starting dynamic subtest: vcs0
[481.366702] Dynamic subtest vcs0: SUCCESS (0.000s)
[481.382897] Starting dynamic subtest: bcs0
[481.384806] Dynamic subtest bcs0: SUCCESS (0.000s)
[481.395652] Starting dynamic subtest: rcs0
[481.397460] Dynamic subtest rcs0: SUCCESS (0.000s)
[481.405677] Starting dynamic subtest: vcs1
[481.407541] Dynamic subtest vcs1: SUCCESS (0.000s)
[481.409427] Subtest invalid: SUCCESS (0.009s)
[481.425219] [112/133] (552s left) kms_pm_backlight (fade)
[481.495191] Starting subtest: fade
[481.554230] Starting dynamic subtest: eDP-1
[484.210528] Dynamic subtest eDP-1: SUCCESS (2.657s)
[484.213401] Subtest fade: SUCCESS (2.715s)
[485.132648] [113/133] (548s left) v3d/v3d_submit_cl (multisync-out-syncs)
[485.238017] Subtest multisync-out-syncs: SKIP (0.000s)
[485.292486] [114/133] (548s left) prime_vgem (basic-blt)
[485.368064] Starting subtest: basic-blt
[485.395353] Subtest basic-blt: SUCCESS (0.028s)
[485.496998] [115/133] (548s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[485.573750] Starting subtest: psr-dirtyfb-ioctl
[485.576199] Starting dynamic subtest: A-eDP-1
[487.283491] Dynamic subtest A-eDP-1: SUCCESS (1.710s)
[487.286148] Subtest psr-dirtyfb-ioctl: SUCCESS (1.712s)
[488.206507] [116/133] (545s left) kms_flip (2x-dpms-vs-vblank-race)
[488.303324] Starting subtest: 2x-dpms-vs-vblank-race
[488.315498] Subtest 2x-dpms-vs-vblank-race: SKIP (0.013s)
[488.393491] [117/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[488.518278] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[488.522304] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.611370] [118/133] (545s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[488.705480] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[488.707987] Starting dynamic subtest: pipe-A-eDP-1
[488.716802] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[488.735351] Starting dynamic subtest: pipe-B-eDP-1
[488.741182] Dynamic subtest pipe-B-eDP-1: SKIP (0.015s)
[488.755550] Starting dynamic subtest: pipe-C-eDP-1
[488.760998] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s)
[488.772865] Starting dynamic subtest: pipe-D-eDP-1
[488.777466] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s)
[488.781840] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.057s)
[488.852033] [119/133] (545s left) kms_color (legacy-gamma-reset)
[488.948731] Starting subtest: legacy-gamma-reset
[488.951192] Starting dynamic subtest: pipe-A
[489.321667] Dynamic subtest pipe-A: SUCCESS (0.376s)
[489.340427] Starting dynamic subtest: pipe-B
[489.342847] Dynamic subtest pipe-B: SUCCESS (0.009s)
[489.354778] Starting dynamic subtest: pipe-C
[489.357051] Dynamic subtest pipe-C: SUCCESS (0.013s)
[489.365448] Starting dynamic subtest: pipe-D
[489.367799] Dynamic subtest pipe-D: SUCCESS (0.011s)
[489.370175] Subtest legacy-gamma-reset: SUCCESS (0.411s)
[490.189412] [120/133] (544s left) gem_exec_balancer (full-late-pulse)
[490.262300] Starting subtest: full-late-pulse
[494.598193] Subtest full-late-pulse: SUCCESS (4.335s)
[494.875523] [121/133] (539s left) gem_exec_schedule (noreorder-corked)
[495.078010] Starting subtest: noreorder-corked
[495.080918] Starting dynamic subtest: rcs0
[496.229393] Dynamic subtest rcs0: SUCCESS (1.152s)
[496.249009] Starting dynamic subtest: vcs0
[497.991247] Dynamic subtest vcs0: SUCCESS (1.759s)
[498.010346] Starting dynamic subtest: vcs1
[499.972765] Dynamic subtest vcs1: SUCCESS (1.980s)
[499.992667] Starting dynamic subtest: vecs0
[502.016077] Dynamic subtest vecs0: SUCCESS (2.042s)
[502.035468] Starting dynamic subtest: ccs0
[503.171063] Dynamic subtest ccs0: SUCCESS (1.155s)
[503.174059] Subtest noreorder-corked: SUCCESS (8.095s)
[503.362877] [122/133] (531s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[503.472710] Starting subtest: psr-rgb101010-draw-mmap-gtt
[503.476930] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[503.560874] [123/133] (530s left) kms_psr (fbc-psr2-primary-page-flip)
[503.677853] Starting subtest: fbc-psr2-primary-page-flip
[503.680514] Starting dynamic subtest: eDP-1
[503.685260] Dynamic subtest eDP-1: SKIP (0.000s)
[503.689997] Subtest fbc-psr2-primary-page-flip: SKIP (0.002s)
[503.752153] [124/133] (530s left) kms_chamelium_hpd (dp-hpd-fast)
[504.121237] Subtest dp-hpd-fast: SKIP (0.000s)
[505.007847] [125/133] (529s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[505.074688] Starting subtest: invalid-smem-bo-on-discrete
[505.079284] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[505.176829] [126/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[505.266070] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[526.001878] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (20.741s)
[526.125064] [127/133] (508s left) gem_basic (create-fd-close)
[526.192962] Starting subtest: create-fd-close
[526.197045] Subtest create-fd-close: SUCCESS (0.000s)
[526.271484] [128/133] (508s left) gem_exec_whisper (basic-fds-priority-all)
[526.360568] Starting subtest: basic-fds-priority-all
[565.821659] Subtest basic-fds-priority-all: SUCCESS (39.456s)
[566.008018] [129/133] (468s left) syncobj_timeline (invalid-signal-illegal-point)
[566.085194] Starting subtest: invalid-signal-illegal-point
[566.087655] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[566.176945] [130/133] (468s left) prime_self_import (basic-with_fd_dup)
[566.236990] Starting subtest: basic-with_fd_dup
[566.252633] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[566.350829] [131/133] (468s left) syncobj_timeline (reset-signaled)
[566.428230] Starting subtest: reset-signaled
[566.430871] Subtest reset-signaled: SUCCESS (0.001s)
[566.504626] [132/133] (468s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[566.578915] Starting subtest: fbcpsr-tiling-y
[566.582698] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[566.665939] [133/133] (468s left) perf_pmu (busy-no-semaphores)
[566.706902] Starting subtest: busy-no-semaphores
[566.709102] Starting dynamic subtest: rcs0
[567.254091] Dynamic subtest rcs0: SUCCESS (0.548s)
[567.273816] Starting dynamic subtest: bcs0
[567.808884] Dynamic subtest bcs0: SUCCESS (0.554s)
[567.829255] Starting dynamic subtest: vcs0
[568.364577] Dynamic subtest vcs0: SUCCESS (0.554s)
[568.384568] Starting dynamic subtest: vcs1
[569.489398] Dynamic subtest vcs1: SUCCESS (1.124s)
[569.509678] Starting dynamic subtest: vecs0
[571.541877] Dynamic subtest vecs0: SUCCESS (2.050s)
[571.562120] Starting dynamic subtest: ccs0
[573.525490] Dynamic subtest ccs0: SUCCESS (1.982s)
[573.528423] Subtest busy-no-semaphores: SUCCESS (6.820s)
[573.632944] Closing watchdogs
Done.