[55.845082] Initializing watchdogs
[55.845185]   /dev/watchdog0
[55.853202] [001/131] (960s left) gem_partial_pwrite_pread (write-snoop)
[55.919659] Subtest write-snoop: SKIP (0.000s)
[55.981915] [002/131] (960s left) kms_flip (2x-flip-vs-wf_vblank)
[56.088163] Starting subtest: 2x-flip-vs-wf_vblank
[56.099338] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[56.201072] [003/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[56.316791] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[56.320466] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[56.404920] [004/131] (960s left) kms_invalid_mode (zero-clock)
[56.496495] Starting subtest: zero-clock
[56.498527] Starting dynamic subtest: pipe-A-eDP-1
[56.782930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[56.790119] Starting dynamic subtest: pipe-B-eDP-1
[56.792236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[56.797850] Starting dynamic subtest: pipe-C-eDP-1
[56.800031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[56.805909] Starting dynamic subtest: pipe-D-eDP-1
[56.807766] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[56.809670] Subtest zero-clock: SUCCESS (0.292s)
[57.606235] [005/131] (958s left) kms_flip (2x-flip-vs-expired-vblank)
[57.709202] Starting subtest: 2x-flip-vs-expired-vblank
[57.720462] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[57.782230] [006/131] (958s left) i915_pm_rpm (gem-execbuf-stress)
[60.131805] Starting subtest: gem-execbuf-stress
[60.134698] Starting dynamic subtest: smem0
[73.074723] Dynamic subtest smem0: SUCCESS (12.932s)
[73.083235] Starting dynamic subtest: extra-wait-smem0
[134.926113] Dynamic subtest extra-wait-smem0: SUCCESS (61.843s)
[134.929077] Subtest gem-execbuf-stress: SUCCESS (74.776s)
[135.254308] [007/131] (881s left) gem_softpin (invalid)
[135.322804] Starting subtest: invalid
[135.329579] Subtest invalid: SUCCESS (0.007s)
[135.434924] [008/131] (881s left) syncobj_timeline (invalid-wait-illegal-handle)
[135.500106] Starting subtest: invalid-wait-illegal-handle
[135.502313] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[135.591808] [009/131] (880s left) dumb_buffer (create-valid-dumb)
[135.634705] Starting subtest: create-valid-dumb
[135.636673] Subtest create-valid-dumb: SUCCESS (0.000s)
[135.706620] [010/131] (880s left) debugfs_test (read_all_entries_display_off)
[135.806914] Starting subtest: read_all_entries_display_off
[136.814671] Subtest read_all_entries_display_off: SUCCESS (1.005s)
[137.098613] [011/131] (879s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[142.062107] Starting subtest: pr-overlay-plane-move-continuous-sf
[142.066884] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s)
[142.894973] [012/131] (873s left) kms_getfb (getfb-handle-valid)
[142.957190] Starting subtest: getfb-handle-valid
[142.959249] Subtest getfb-handle-valid: SUCCESS (0.000s)
[143.037652] [013/131] (873s left) gem_exec_reloc (basic-wc-read)
[143.098732] Subtest basic-wc-read: SKIP (0.000s)
[143.160055] [014/131] (873s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[143.261965] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[143.264432] Starting dynamic subtest: pipe-A-eDP-1
[143.417497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[143.424987] Starting dynamic subtest: pipe-B-eDP-1
[143.443851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[143.450441] Starting dynamic subtest: pipe-C-eDP-1
[143.469350] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[143.475257] Starting dynamic subtest: pipe-D-eDP-1
[143.493304] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[143.495151] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[145.648733] [015/131] (870s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[150.599715] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[150.604661] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[151.440343] [016/131] (865s left) gem_exec_gttfill (basic)
[151.504334] Starting subtest: basic
[153.974105] Subtest basic: SUCCESS (2.469s)
[154.139780] [017/131] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[154.291482] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[154.295800] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[154.390445] [018/131] (862s left) kms_properties (get_properties-sanity-non-atomic)
[154.493547] Starting subtest: get_properties-sanity-non-atomic
[154.495959] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[154.548753] [019/131] (862s left) gem_exec_reloc (basic-gtt-read)
[154.618161] Subtest basic-gtt-read: SKIP (0.000s)
[154.671908] [020/131] (862s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[154.772215] Starting subtest: psr-farfromfence-mmap-gtt
[154.776237] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[154.863877] [021/131] (861s left) kms_cursor_crc (cursor-random-256x256)
[155.091931] Starting subtest: cursor-random-256x256
[155.094201] Starting dynamic subtest: pipe-A-eDP-1
[158.424477] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[158.449309] Starting dynamic subtest: pipe-D-eDP-1
[162.439666] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s)
[162.442193] Subtest cursor-random-256x256: SUCCESS (7.349s)
[163.294816] [022/131] (853s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[163.394115] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[163.396639] Starting dynamic subtest: pipe-A-eDP-1
[163.420373] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[163.428401] Starting dynamic subtest: pipe-B-eDP-1
[163.450877] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[163.458198] Starting dynamic subtest: pipe-C-eDP-1
[163.481745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[163.488858] Starting dynamic subtest: pipe-D-eDP-1
[163.511540] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[163.515751] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[165.560071] [023/131] (851s left) kms_setmode (clone-exclusive-crtc)
[165.619929] Starting subtest: clone-exclusive-crtc
[165.626653] Subtest clone-exclusive-crtc: SKIP (0.000s)
[165.709246] [024/131] (851s left) kms_pm_rpm (modeset-lpsp)
[167.242040] Starting subtest: modeset-lpsp
[168.687549] Subtest modeset-lpsp: SUCCESS (1.445s)
[168.752868] [025/131] (848s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[168.860648] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[168.862895] Starting dynamic subtest: pipe-A
[168.881872] Dynamic subtest pipe-A: SKIP (0.014s)
[168.889388] Starting dynamic subtest: pipe-B
[168.907069] Dynamic subtest pipe-B: SKIP (0.026s)
[168.913799] Starting dynamic subtest: pipe-C
[168.936579] Dynamic subtest pipe-C: SKIP (0.028s)
[168.944653] Starting dynamic subtest: pipe-D
[168.965249] Dynamic subtest pipe-D: SKIP (0.029s)
[168.969524] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.098s)
[169.060179] [026/131] (847s left) kms_psr (psr-sprite-plane-onoff)
[169.166505] Starting subtest: psr-sprite-plane-onoff
[169.168710] Starting dynamic subtest: eDP-1
[170.869248] Dynamic subtest eDP-1: SUCCESS (1.701s)
[170.871710] Subtest psr-sprite-plane-onoff: SUCCESS (1.702s)
[171.669886] [027/131] (845s left) gem_exec_balancer (parallel)
[171.916197] Starting subtest: parallel
[172.718762] Subtest parallel: SUCCESS (0.803s)
[173.949314] [028/131] (842s left) gem_mmap (bad-size)
[174.003689] Subtest bad-size: SKIP (0.000s)
[174.040653] [029/131] (842s left) kms_scaling_modes (scaling-mode-full)
[174.136845] Starting subtest: scaling-mode-full
[174.139204] Starting dynamic subtest: pipe-A-eDP-1
[174.231290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[174.239765] Starting dynamic subtest: pipe-B-eDP-1
[175.411330] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.179s)
[175.419491] Starting dynamic subtest: pipe-C-eDP-1
[176.517292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[176.525096] Starting dynamic subtest: pipe-D-eDP-1
[177.638163] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[177.640484] Subtest scaling-mode-full: SUCCESS (3.501s)
[178.770632] [030/131] (838s left) perf_pmu (gt-awake)
[178.817838] Starting subtest: gt-awake
[187.947709] Subtest gt-awake: SUCCESS (9.129s)
[188.050689] [031/131] (828s left) gem_mmap_offset (pf-nonblock)
[188.107340] Starting subtest: pf-nonblock
[188.112555] Subtest pf-nonblock: SUCCESS (0.005s)
[188.206818] [032/131] (828s left) gem_lmem_swapping (heavy-verify-multi)
[188.255774] Subtest heavy-verify-multi: SKIP (0.000s)
[188.275943] [033/131] (828s left) kms_psr (fbc-pr-cursor-render)
[188.394108] Starting subtest: fbc-pr-cursor-render
[188.398740] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[188.448940] [034/131] (828s left) gem_exec_suspend (basic-s3-devices)
[188.521410] Starting subtest: basic-S3-devices
[188.523842] Starting dynamic subtest: smem
[198.954100] Dynamic subtest smem: SUCCESS (10.430s)
[198.956896] Subtest basic-S3-devices: SUCCESS (10.431s)
[199.116358] [035/131] (817s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[199.236632] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[199.241309] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[199.339728] [036/131] (817s left) gem_exec_parallel (engines)
[199.411378] Starting subtest: engines
[199.413681] Starting dynamic subtest: basic
[200.903618] Dynamic subtest basic: SUCCESS (1.492s)
[200.912419] Starting dynamic subtest: contexts
[205.157241] Dynamic subtest contexts: SUCCESS (4.251s)
[205.170910] Starting dynamic subtest: fds
[208.962361] Dynamic subtest fds: SUCCESS (3.804s)
[208.973592] Starting dynamic subtest: userptr
[210.921682] Dynamic subtest userptr: SUCCESS (1.959s)
[210.924329] Subtest engines: SUCCESS (11.508s)
[211.091233] [037/131] (805s left) kms_psr (pr-basic)
[211.186992] Starting subtest: pr-basic
[211.191356] Subtest pr-basic: SKIP (0.000s)
[211.240192] [038/131] (805s left) prime_vgem (basic-fence-flip)
[211.406365] Starting subtest: basic-fence-flip
[211.716244] Subtest basic-fence-flip: SUCCESS (0.310s)
[211.824914] [039/131] (805s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[211.936662] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[211.940699] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[212.009432] [040/131] (805s left) i915_selftest (perf)
[216.060909] Starting subtest: perf
[216.063588] Starting dynamic subtest: engine_cs
[220.477347] Dynamic subtest engine_cs: SUCCESS (4.415s)
[220.486846] Starting dynamic subtest: request
[227.798814] Dynamic subtest request: SUCCESS (7.321s)
[227.807479] Starting dynamic subtest: migrate
[232.152860] Dynamic subtest migrate: SUCCESS (4.352s)
[232.162567] Starting dynamic subtest: region
[238.695261] Dynamic subtest region: SUCCESS (6.542s)
[238.698430] Subtest perf: SUCCESS (22.633s)
[238.712905] [041/131] (778s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[240.323315] Starting subtest: yf-tiled-32bpp-rotate-180
[240.327463] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[240.383902] [042/131] (776s left) kms_async_flips (test-cursor-atomic)
[240.477082] Starting subtest: test-cursor-atomic
[240.481298] Subtest test-cursor-atomic: SKIP (0.000s)
[241.609154] [043/131] (775s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[241.857098] Starting subtest: cursor-rapid-movement-512x512
[241.861597] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[242.026157] [044/131] (775s left) api_intel_bb (render)
[242.083215] Starting subtest: render
[242.085526] Starting dynamic subtest: render-none-512
[242.183257] Dynamic subtest render-none-512: SUCCESS (0.101s)
[242.193570] Starting dynamic subtest: render-none-1024
[242.567693] Dynamic subtest render-none-1024: SUCCESS (0.383s)
[242.578458] Starting dynamic subtest: render-x-512
[242.651351] Dynamic subtest render-x-512: SUCCESS (0.085s)
[242.662039] Starting dynamic subtest: render-x-1024
[242.991514] Dynamic subtest render-x-1024: SUCCESS (0.338s)
[243.001592] Starting dynamic subtest: render-y-512
[243.076681] Dynamic subtest render-y-512: SUCCESS (0.086s)
[243.086881] Starting dynamic subtest: render-y-1024
[243.418498] Dynamic subtest render-y-1024: SUCCESS (0.340s)
[243.421326] Subtest render: SUCCESS (1.335s)
[243.543627] [045/131] (773s left) gem_exec_reloc (basic-write-wc)
[243.613819] Subtest basic-write-wc: SKIP (0.000s)
[243.682044] [046/131] (773s left) kms_lease (lease-unleased-connector)
[243.793180] Starting subtest: lease-unleased-connector
[243.795424] Starting dynamic subtest: pipe-A-eDP-1
[243.807561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.012s)
[243.816199] Starting dynamic subtest: pipe-B-eDP-1
[243.818447] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[243.827200] Starting dynamic subtest: pipe-C-eDP-1
[243.832194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[243.840798] Starting dynamic subtest: pipe-D-eDP-1
[243.843132] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[243.845323] Subtest lease-unleased-connector: SUCCESS (0.049s)
[243.946564] [047/131] (773s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[244.053672] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[244.058538] Starting dynamic subtest: pipe-A-default-mode
[244.347396] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[244.352064] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.288s)
[245.126319] [048/131] (772s left) i915_pm_freq_api (freq-reset)
[245.195827] Starting subtest: freq-reset
[245.198235] Starting dynamic subtest: gt0
[245.359979] Dynamic subtest gt0: SUCCESS (0.162s)
[245.367893] Starting dynamic subtest: gt1
[245.497994] Dynamic subtest gt1: SUCCESS (0.138s)
[245.500516] Subtest freq-reset: SUCCESS (0.301s)
[245.552929] [049/131] (771s left) gem_exec_alignment (pi)
[245.619465] Starting subtest: pi
[296.160401] Subtest pi: SUCCESS (50.538s)
[297.007313] [050/131] (720s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[297.154809] Starting subtest: fbcpsr-rgb565-draw-blt
[302.013035] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (4.862s)
[302.151513] [051/131] (715s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[302.222519] Starting subtest: wait-all-for-submit-delayed-submit
[302.328089] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[302.384914] [052/131] (714s left) api_intel_bb (delta-check)
[302.449761] Starting subtest: delta-check
[302.452077] Subtest delta-check: SUCCESS (0.006s)
[302.521042] [053/131] (714s left) syncobj_eventfd (binary-wait)
[302.581273] Starting subtest: binary-wait
[302.590068] Subtest binary-wait: SUCCESS (0.010s)
[302.643910] [054/131] (714s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[302.757094] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[302.759301] Starting dynamic subtest: pipe-A-eDP-1
[319.364179] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.405s)
[319.375760] Starting dynamic subtest: pipe-B-eDP-1
[336.263842] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.339s)
[336.273595] Starting dynamic subtest: pipe-C-eDP-1
[353.239726] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.302s)
[353.248511] Starting dynamic subtest: pipe-D-eDP-1
[370.239069] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[370.244225] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.288s)
[371.440911] [055/131] (705s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[371.533847] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[371.536259] Starting dynamic subtest: pipe-A-eDP-1
[371.565149] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.576059] Starting dynamic subtest: pipe-B-eDP-1
[371.603980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.613239] Starting dynamic subtest: pipe-C-eDP-1
[371.643618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.654205] Starting dynamic subtest: pipe-D-eDP-1
[371.681158] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.685976] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[373.698822] [056/131] (702s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[373.818474] Starting subtest: 4-tiled-64bpp-rotate-270
[373.839345] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[373.943935] [057/131] (702s left) kms_content_protection (dp-mst-lic-type-1)
[374.116826] Starting subtest: dp-mst-lic-type-1
[374.122391] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[374.228972] [058/131] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[374.344871] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[379.452555] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.101s)
[379.559949] [059/131] (697s left) gem_bad_reloc (negative-reloc-lut)
[379.621211] Subtest negative-reloc-lut: SKIP (0.000s)
[379.689847] [060/131] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[379.796204] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[379.801202] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[379.892722] [061/131] (696s left) kms_addfb_basic (size-max)
[379.994316] Starting subtest: size-max
[379.996975] Subtest size-max: SUCCESS (0.000s)
[380.074705] [062/131] (696s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[380.140129] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[380.188777] [063/131] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[380.281024] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[380.285178] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[380.367037] [064/131] (696s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[380.471590] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[380.475851] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[380.569109] [065/131] (696s left) syncobj_wait (wait-delayed-signal)
[380.624052] Starting subtest: wait-delayed-signal
[380.726771] Subtest wait-delayed-signal: SUCCESS (0.102s)
[380.785838] [066/131] (696s left) kms_chamelium_frames (hdmi-crc-fast)
[381.182253] Subtest hdmi-crc-fast: SKIP (0.000s)
[381.940684] [067/131] (694s left) perf_pmu (rc6)
[381.982966] Starting subtest: rc6
[381.985185] Starting dynamic subtest: gt0
[388.349837] Dynamic subtest gt0: SUCCESS (6.359s)
[388.361455] Starting dynamic subtest: runtime-pm-gt0
[396.075373] Dynamic subtest runtime-pm-gt0: SUCCESS (7.719s)
[396.087210] Starting dynamic subtest: runtime-pm-long-gt0
[408.510836] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.434s)
[408.523153] Starting dynamic subtest: other-idle-gt0
[414.855585] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[414.868166] Starting dynamic subtest: gt1
[421.200287] Dynamic subtest gt1: SUCCESS (6.341s)
[421.211869] Starting dynamic subtest: runtime-pm-gt1
[428.638796] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[428.649603] Starting dynamic subtest: runtime-pm-long-gt1
[441.078494] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.434s)
[441.090536] Starting dynamic subtest: other-idle-gt1
[447.422874] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[447.426142] Subtest rc6: SUCCESS (65.421s)
[448.679638] [068/131] (628s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[448.784808] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[448.796066] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[448.831834] [069/131] (628s left) syncobj_wait (reset-multiple-signaled)
[448.885115] Starting subtest: reset-multiple-signaled
[448.887383] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[448.943828] [070/131] (627s left) device_reset (unbind-cold-reset-rebind)
[448.990641] Starting subtest: unbind-cold-reset-rebind
[448.994547] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[449.017716] [071/131] (627s left) gen9_exec_parse (basic-rejected)
[449.081185] Subtest basic-rejected: SKIP (0.000s)
[449.139326] [072/131] (627s left) perf_pmu (semaphore-busy)
[449.180918] Starting subtest: semaphore-busy
[449.182952] Starting dynamic subtest: rcs0
[450.842723] Dynamic subtest rcs0: SUCCESS (1.658s)
[450.852938] Starting dynamic subtest: bcs0
[452.479356] Dynamic subtest bcs0: SUCCESS (1.633s)
[452.491003] Starting dynamic subtest: vcs0
[456.624616] Dynamic subtest vcs0: SUCCESS (4.088s)
[456.637133] Starting dynamic subtest: vcs1
[462.586242] Dynamic subtest vcs1: SUCCESS (6.011s)
[462.596492] Starting dynamic subtest: vecs0
[468.601849] Dynamic subtest vecs0: SUCCESS (6.013s)
[468.611927] Starting dynamic subtest: ccs0
[471.676039] Dynamic subtest ccs0: SUCCESS (3.073s)
[471.678980] Subtest semaphore-busy: SUCCESS (22.490s)
[471.771820] [073/131] (605s left) kms_flip (2x-flip-vs-suspend-interruptible)
[471.884753] Starting subtest: 2x-flip-vs-suspend-interruptible
[471.895159] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[471.931056] [074/131] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[472.051395] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[472.056846] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[472.117949] [075/131] (604s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[472.224122] Starting subtest: fbcpsr-tiling-4
[477.020476] Subtest fbcpsr-tiling-4: SUCCESS (4.801s)
[477.136662] [076/131] (599s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[477.251925] Starting subtest: fbc-psr-sprite-mmap-gtt
[477.254516] Starting dynamic subtest: eDP-1
[477.259949] Dynamic subtest eDP-1: SKIP (0.000s)
[477.264951] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[477.282996] [077/131] (599s left) gem_workarounds (basic-read)
[477.350810] Starting subtest: basic-read
[477.363182] Subtest basic-read: SUCCESS (0.012s)
[477.457742] [078/131] (599s left) gem_ctx_engines (independent)
[477.520267] Starting subtest: independent
[477.523214] Starting dynamic subtest: rcs0
[477.643234] Dynamic subtest rcs0: SUCCESS (0.121s)
[477.652468] Starting dynamic subtest: bcs0
[477.745695] Dynamic subtest bcs0: SUCCESS (0.103s)
[477.754734] Starting dynamic subtest: vcs0
[477.839752] Dynamic subtest vcs0: SUCCESS (0.093s)
[477.852016] Starting dynamic subtest: vcs1
[477.943548] Dynamic subtest vcs1: SUCCESS (0.103s)
[477.953270] Starting dynamic subtest: vecs0
[478.042868] Dynamic subtest vecs0: SUCCESS (0.099s)
[478.051675] Starting dynamic subtest: ccs0
[478.152367] Dynamic subtest ccs0: SUCCESS (0.109s)
[478.163352] Starting dynamic subtest: all-engines
[478.552863] Dynamic subtest all-engines: SUCCESS (0.399s)
[478.555590] Subtest independent: SUCCESS (1.032s)
[479.210153] [079/131] (597s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[479.318387] Starting subtest: x-tiled-64bpp-rotate-180
[480.905497] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.588s)
[481.074207] [080/131] (596s left) gem_exec_schedule (u-semaphore-resolve)
[481.145073] Starting subtest: u-semaphore-resolve
[481.176550] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[481.468393] [081/131] (595s left) gem_ctx_persistence (engines-cleanup)
[481.527208] Starting subtest: engines-cleanup
[481.530286] Starting dynamic subtest: rcs0
[481.600865] Dynamic subtest rcs0: SUCCESS (0.073s)
[481.613816] Starting dynamic subtest: bcs0
[481.661371] Dynamic subtest bcs0: SUCCESS (0.059s)
[481.672287] Starting dynamic subtest: vcs0
[481.717188] Dynamic subtest vcs0: SUCCESS (0.053s)
[481.728364] Starting dynamic subtest: vcs1
[481.773563] Dynamic subtest vcs1: SUCCESS (0.055s)
[481.785028] Starting dynamic subtest: vecs0
[481.839522] Dynamic subtest vecs0: SUCCESS (0.064s)
[481.851068] Starting dynamic subtest: ccs0
[481.901174] Dynamic subtest ccs0: SUCCESS (0.060s)
[481.903700] Subtest engines-cleanup: SUCCESS (0.375s)
[481.937702] [082/131] (595s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[482.037361] Starting subtest: psr-2p-primscrn-cur-indfb-move
[482.042273] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[482.092806] [083/131] (595s left) vgem_basic (busy-fence)
[482.209333] Starting subtest: busy-fence
[482.212113] Subtest busy-fence: SUCCESS (0.001s)
[482.230525] [084/131] (594s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[482.332498] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[482.337919] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[482.383390] [085/131] (594s left) kms_frontbuffer_tracking (psr-slowdraw)
[482.488844] Starting subtest: psr-slowdraw
[505.411843] Subtest psr-slowdraw: SUCCESS (22.925s)
[505.525463] [086/131] (571s left) kms_chamelium_color (ctm-blue-to-red)
[505.630476] Subtest ctm-blue-to-red: SKIP (0.000s)
[505.661437] [087/131] (571s left) sw_sync (alloc_fence_invalid_timeline)
[505.701971] Starting subtest: alloc_fence_invalid_timeline
[505.704216] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[505.722914] [088/131] (571s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[505.837264] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[505.842418] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[505.909423] [089/131] (571s left) gem_exec_schedule (out-order)
[505.995661] Starting subtest: out-order
[505.997966] Starting dynamic subtest: rcs0
[506.086395] Dynamic subtest rcs0: SUCCESS (0.099s)
[506.099121] Starting dynamic subtest: vcs0
[506.167487] Dynamic subtest vcs0: SUCCESS (0.081s)
[506.176879] Starting dynamic subtest: vcs1
[506.244988] Dynamic subtest vcs1: SUCCESS (0.077s)
[506.256092] Starting dynamic subtest: vecs0
[506.323634] Dynamic subtest vecs0: SUCCESS (0.077s)
[506.335623] Starting dynamic subtest: ccs0
[506.405983] Dynamic subtest ccs0: SUCCESS (0.082s)
[506.408873] Subtest out-order: SUCCESS (0.420s)
[508.100910] [090/131] (569s left) gem_exec_fence (submit-chain)
[508.288366] Starting subtest: submit-chain
[508.306116] Subtest submit-chain: SUCCESS (0.018s)
[510.139384] [091/131] (567s left) kms_dp_aux_dev
[510.456456] [092/131] (566s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[510.558113] Starting subtest: x-tiled-16bpp-rotate-90
[510.578196] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[510.673750] [093/131] (566s left) kms_color (deep-color)
[510.775467] Starting subtest: deep-color
[511.814204] Starting dynamic subtest: pipe-A-eDP-1-gamma
[512.494961] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.680s)
[512.507187] Starting dynamic subtest: pipe-A-eDP-1-degamma
[513.878392] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.382s)
[513.888952] Starting dynamic subtest: pipe-A-eDP-1-ctm
[515.268866] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.390s)
[516.009954] Starting dynamic subtest: pipe-B-eDP-1-gamma
[516.695218] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.692s)
[516.704772] Starting dynamic subtest: pipe-B-eDP-1-degamma
[518.045940] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.346s)
[518.055693] Starting dynamic subtest: pipe-B-eDP-1-ctm
[519.485997] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.442s)
[520.291615] Starting dynamic subtest: pipe-C-eDP-1-gamma
[520.935203] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.648s)
[520.945917] Starting dynamic subtest: pipe-C-eDP-1-degamma
[522.304147] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.370s)
[522.314337] Starting dynamic subtest: pipe-C-eDP-1-ctm
[523.614055] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.307s)
[524.372394] Starting dynamic subtest: pipe-D-eDP-1-gamma
[525.027619] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.660s)
[525.037179] Starting dynamic subtest: pipe-D-eDP-1-degamma
[526.401134] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.372s)
[526.411464] Starting dynamic subtest: pipe-D-eDP-1-ctm
[527.960008] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.560s)
[527.962722] Subtest deep-color: SUCCESS (17.180s)
[528.782541] [094/131] (548s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[528.882812] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[528.887508] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[528.936100] [095/131] (548s left) gem_close (many-handles-one-vma)
[528.987217] Starting subtest: many-handles-one-vma
[529.012340] Subtest many-handles-one-vma: SUCCESS (0.025s)
[529.056619] [096/131] (548s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[529.174905] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[530.299780] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (0.494s)
[530.318345] [097/131] (547s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[530.383319] Starting subtest: yf-tiled-to-vebox-x-tiled
[530.388339] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[530.525713] [098/131] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[530.631346] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[530.636219] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[530.691800] [099/131] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[530.796668] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[534.966789] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (4.172s)
[535.048722] [100/131] (542s left) gem_exec_create (forked)
[535.111094] Starting subtest: forked
[535.113764] Starting dynamic subtest: smem
[557.119496] Dynamic subtest smem: SUCCESS (22.001s)
[557.122617] Subtest forked: SUCCESS (22.002s)
[557.263554] [101/131] (520s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[557.330230] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[557.336129] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[557.475011] [102/131] (520s left) gem_exec_reloc (basic-write-read)
[557.545688] Subtest basic-write-read: SKIP (0.000s)
[557.613853] [103/131] (520s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[557.665000] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[557.667875] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[557.717759] [104/131] (519s left) kms_plane_scaling (invalid-parameters)
[557.824101] Starting subtest: invalid-parameters
[557.826744] Starting dynamic subtest: less-than-1-height-src
[557.844387] Dynamic subtest less-than-1-height-src: SUCCESS (0.022s)
[557.854007] Starting dynamic subtest: less-than-1-width-src
[557.856496] Dynamic subtest less-than-1-width-src: SUCCESS (0.010s)
[557.859195] Subtest invalid-parameters: SUCCESS (0.034s)
[557.915179] [105/131] (519s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[558.018075] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[558.023150] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[558.090601] [106/131] (519s left) kms_pm_dc (dc6-dpms)
[559.206011] Starting subtest: dc6-dpms
[566.261121] Subtest dc6-dpms: FAIL (6.641s)
[566.281714] [107/131] (511s left) kms_psr (psr2-primary-blt)
[566.377780] Starting subtest: psr2-primary-blt
[566.380139] Starting dynamic subtest: eDP-1
[568.142627] Dynamic subtest eDP-1: SUCCESS (1.762s)
[568.145068] Subtest psr2-primary-blt: SUCCESS (1.762s)
[568.972250] [108/131] (508s left) gem_pxp (hw-rejects-pxp-buffer)
[569.100421] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[570.192056] [109/131] (507s left) gem_mmap_wc (write-gtt-read-wc)
[570.263847] Subtest write-gtt-read-wc: SKIP (0.000s)
[570.316087] [110/131] (507s left) kms_vblank (ts-continuation-modeset)
[570.414940] Starting subtest: ts-continuation-modeset
[570.417544] Starting dynamic subtest: pipe-A-eDP-1
[571.876818] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.459s)
[571.892893] Starting dynamic subtest: pipe-D-eDP-1
[574.018983] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.139s)
[574.021208] Subtest ts-continuation-modeset: SUCCESS (3.601s)
[574.778107] [111/131] (503s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[574.886287] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[574.891372] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[574.949399] [112/131] (502s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[575.013076] Starting subtest: etime-single-wait-for-submit-unsubmitted
[575.115639] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[575.150610] [113/131] (502s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[575.260503] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[575.265574] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[575.324646] [114/131] (502s left) gem_eio (wait-wedge-1us)
[575.574961] Starting subtest: wait-wedge-1us
[577.168389] Subtest wait-wedge-1us: SUCCESS (1.592s)
[577.277889] [115/131] (500s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[577.401477] Starting subtest: cursorA-vs-flipA-atomic
[588.530253] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[589.298826] [116/131] (488s left) kms_cursor_edge_walk (128x128-top-edge)
[589.401408] Starting subtest: 128x128-top-edge
[589.404184] Starting dynamic subtest: pipe-A-eDP-1
[592.904070] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s)
[592.914688] Starting dynamic subtest: pipe-D-eDP-1
[595.996607] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.093s)
[595.999173] Subtest 128x128-top-edge: SUCCESS (6.593s)
[596.782906] [117/131] (481s left) gem_ctx_persistence (many-contexts)
[596.842291] Starting subtest: many-contexts
[634.582713] Subtest many-contexts: SUCCESS (37.746s)
[634.620664] [118/131] (443s left) gem_userptr_blits (mmap-offset-banned)
[634.690206] Starting subtest: mmap-offset-banned
[634.692616] Starting dynamic subtest: wb
[634.694542] Dynamic subtest wb: SUCCESS (0.000s)
[634.704086] Starting dynamic subtest: wc
[634.706393] Dynamic subtest wc: SUCCESS (0.000s)
[634.716254] Starting dynamic subtest: uc
[634.719144] Dynamic subtest uc: SUCCESS (0.000s)
[634.721951] Subtest mmap-offset-banned: SUCCESS (0.002s)
[634.763280] [119/131] (443s left) gem_exec_capture (capture-invisible)
[634.817117] Starting subtest: capture-invisible
[634.820249] Starting dynamic subtest: smem0
[634.825110] Dynamic subtest smem0: SKIP (0.000s)
[634.829088] Subtest capture-invisible: SKIP (0.001s)
[634.882069] [120/131] (443s left) gem_exec_store (pages)
[634.952478] Starting subtest: pages
[634.955250] Starting dynamic subtest: rcs0
[635.084986] Dynamic subtest rcs0: SUCCESS (0.134s)
[635.097347] Starting dynamic subtest: bcs0
[635.181627] Dynamic subtest bcs0: SUCCESS (0.095s)
[635.194400] Starting dynamic subtest: vcs0
[635.251012] Dynamic subtest vcs0: SUCCESS (0.068s)
[635.262850] Starting dynamic subtest: vcs1
[635.328667] Dynamic subtest vcs1: SUCCESS (0.075s)
[635.341038] Starting dynamic subtest: vecs0
[635.397658] Dynamic subtest vecs0: SUCCESS (0.068s)
[635.410202] Starting dynamic subtest: ccs0
[635.484968] Dynamic subtest ccs0: SUCCESS (0.087s)
[635.488026] Subtest pages: SUCCESS (0.534s)
[635.625749] [121/131] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[635.742575] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[640.830619] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.095s)
[640.892267] [122/131] (437s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[640.988971] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[640.993794] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[642.053212] [123/131] (436s left) gen7_exec_parse (batch-without-end)
[642.135041] Subtest batch-without-end: SKIP (0.000s)
[642.192549] [124/131] (435s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[642.309000] Starting subtest: primary-y-tiled-reflect-x-90
[642.314157] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[642.343187] [125/131] (435s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[642.468127] Starting subtest: 2x-long-cursor-vs-flip-atomic
[642.473751] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[642.569487] [126/131] (435s left) gem_wait (invalid-buf)
[642.634243] Starting subtest: invalid-buf
[642.636773] Subtest invalid-buf: SUCCESS (0.000s)
[642.794844] [127/131] (435s left) kms_plane_alpha_blend (coverage-7efc)
[642.899045] Starting subtest: coverage-7efc
[643.171991] Starting dynamic subtest: pipe-A-eDP-1
[643.701029] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.527s)
[643.724772] Starting dynamic subtest: pipe-D-eDP-1
[644.995290] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[644.997932] Subtest coverage-7efc: SUCCESS (2.095s)
[645.801333] [128/131] (432s left) kms_writeback (writeback-fb-id-xrgb2101010)
[645.897556] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[645.927587] [129/131] (432s left) kms_psr (fbc-pr-primary-page-flip)
[646.034295] Starting subtest: fbc-pr-primary-page-flip
[646.039346] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[646.065823] [130/131] (432s left) gem_eio (in-flight-suspend)
[646.269949] Starting subtest: in-flight-suspend
[689.431294] Subtest in-flight-suspend: SUCCESS (13.942s)
[689.539222] [131/131] (417s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[689.600015] Starting subtest: etime-single-wait-all-available-unsubmitted
[689.705323] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.105s)
[689.736264] Closing watchdogs
Done.