[58.110093] Initializing watchdogs
[58.110136]   /dev/watchdog0
[58.117683] [001/131] (960s left) gen9_exec_parse (bb-chained)
[58.231129] Subtest bb-chained: SKIP (0.000s)
[58.280690] [002/131] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[58.384318] Starting subtest: psr-2p-primscrn-cur-indfb-move
[58.388620] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[58.451636] [003/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[58.570870] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[58.575308] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[58.652576] [004/131] (960s left) kms_flip (flip-vs-expired-vblank-interruptible)
[58.748951] Starting subtest: flip-vs-expired-vblank-interruptible
[58.751414] Starting dynamic subtest: A-eDP1
[67.417136] Dynamic subtest A-eDP1: SUCCESS (8.613s)
[67.426134] Starting dynamic subtest: B-eDP1
[76.085109] Dynamic subtest B-eDP1: SUCCESS (8.650s)
[76.094740] Starting dynamic subtest: C-eDP1
[84.709808] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[84.717804] Starting dynamic subtest: D-eDP1
[93.333809] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[93.336560] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.508s)
[94.477088] [005/131] (924s left) gem_exec_balancer (parallel)
[94.729380] Starting subtest: parallel
[95.493662] Subtest parallel: SUCCESS (0.764s)
[95.931827] [006/131] (922s left) gem_ctx_isolation (clean)
[95.995966] Starting subtest: clean
[95.998278] Starting dynamic subtest: rcs0
[96.065607] Dynamic subtest rcs0: SUCCESS (0.069s)
[96.074151] Starting dynamic subtest: bcs0
[96.166670] Dynamic subtest bcs0: SUCCESS (0.101s)
[96.173221] Starting dynamic subtest: vcs0
[96.263566] Dynamic subtest vcs0: SUCCESS (0.096s)
[96.270103] Starting dynamic subtest: vcs1
[97.899762] Dynamic subtest vcs1: SUCCESS (1.636s)
[97.907136] Starting dynamic subtest: vecs0
[99.979565] Dynamic subtest vecs0: SUCCESS (2.079s)
[99.986353] Starting dynamic subtest: ccs0
[101.930112] Dynamic subtest ccs0: SUCCESS (1.950s)
[101.932693] Subtest clean: SUCCESS (5.933s)
[102.167855] [007/131] (916s left) vgem_basic (bad-flag)
[102.241279] Starting subtest: bad-flag
[102.243694] Subtest bad-flag: SUCCESS (0.000s)
[102.276293] [008/131] (916s left) gem_exec_alignment (many)
[102.353127] Starting subtest: many
[150.169433] Subtest many: SUCCESS (47.810s)
[152.089216] [009/131] (866s left) gem_exec_schedule (implicit-read-write)
[152.206436] Starting subtest: implicit-read-write
[152.208545] Starting dynamic subtest: rcs0
[152.384101] Dynamic subtest rcs0: SUCCESS (0.184s)
[152.394771] Starting dynamic subtest: vcs0
[152.475652] Dynamic subtest vcs0: SUCCESS (0.093s)
[152.487598] Starting dynamic subtest: vcs1
[152.578328] Dynamic subtest vcs1: SUCCESS (0.103s)
[152.587926] Starting dynamic subtest: vecs0
[152.674399] Dynamic subtest vecs0: SUCCESS (0.095s)
[152.684052] Starting dynamic subtest: ccs0
[152.786584] Dynamic subtest ccs0: SUCCESS (0.113s)
[152.789236] Subtest implicit-read-write: SUCCESS (0.588s)
[154.047961] [010/131] (864s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[154.186471] Starting subtest: cursorB-vs-flipB-toggle
[154.191234] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[154.273542] [011/131] (864s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[154.350720] Starting subtest: single-wait-all-for-submit-unsubmitted
[154.456608] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[154.510353] [012/131] (864s left) kms_vblank (ts-continuation-dpms-suspend)
[154.612094] Starting subtest: ts-continuation-dpms-suspend
[154.614580] Starting dynamic subtest: pipe-A-eDP-1
[171.296287] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[171.310587] Starting dynamic subtest: pipe-D-eDP-1
[189.022789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.146s)
[189.025123] Subtest ts-continuation-dpms-suspend: SUCCESS (4.038s)
[189.826238] [013/131] (859s left) gem_ctx_param (set-priority-range)
[189.880685] Starting subtest: set-priority-range
[189.897806] Subtest set-priority-range: SUCCESS (0.016s)
[190.004436] [014/131] (859s left) perf_pmu (busy-idle-check-all)
[190.046072] Starting subtest: busy-idle-check-all
[190.048572] Starting dynamic subtest: rcs0
[190.730395] Dynamic subtest rcs0: SUCCESS (0.670s)
[190.741786] Starting dynamic subtest: bcs0
[191.451774] Dynamic subtest bcs0: FAIL (0.639s)
[191.461607] Starting dynamic subtest: vcs0
[192.095762] Dynamic subtest vcs0: FAIL (0.625s)
[192.105399] Starting dynamic subtest: vcs1
[192.727513] Dynamic subtest vcs1: FAIL (0.620s)
[192.736899] Starting dynamic subtest: vecs0
[193.364312] Dynamic subtest vecs0: FAIL (0.622s)
[193.373984] Starting dynamic subtest: ccs0
[193.993788] Dynamic subtest ccs0: FAIL (0.622s)
[193.995821] Subtest busy-idle-check-all: FAIL (3.799s)
[194.016221] [015/131] (855s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[194.142718] Starting subtest: fbc-shrfb-scaledprimary
[198.212329] Subtest fbc-shrfb-scaledprimary: SUCCESS (4.034s)
[198.341862] [016/131] (851s left) gem_exec_schedule (u-fairslice-all)
[198.427407] Starting subtest: u-fairslice-all
[200.485731] Subtest u-fairslice-all: SUCCESS (2.054s)
[202.334337] [017/131] (847s left) drm_fdinfo (busy-idle)
[202.377629] Starting subtest: busy-idle
[202.379955] Starting dynamic subtest: rcs0
[202.396187] Dynamic subtest rcs0: SKIP (0.016s)
[202.404569] Starting dynamic subtest: bcs0
[202.415203] Dynamic subtest bcs0: SKIP (0.019s)
[202.423345] Starting dynamic subtest: vcs0
[202.427338] Dynamic subtest vcs0: SKIP (0.001s)
[202.438208] Starting dynamic subtest: vcs1
[202.442886] Dynamic subtest vcs1: SKIP (0.001s)
[202.451464] Starting dynamic subtest: vecs0
[202.455455] Dynamic subtest vecs0: SKIP (0.001s)
[202.462776] Starting dynamic subtest: ccs0
[202.466879] Dynamic subtest ccs0: SKIP (0.000s)
[202.470910] Subtest busy-idle: SKIP (0.038s)
[202.487063] [018/131] (847s left) gem_exec_fence (syncobj-export)
[202.956997] Starting subtest: syncobj-export
[202.964055] Subtest syncobj-export: SUCCESS (0.008s)
[204.297452] [019/131] (845s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[204.351687] Starting subtest: rel-constants-invalid-rel-gen5
[204.354156] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[204.429710] [020/131] (845s left) gem_mmap_offset (close-race)
[204.489061] Starting subtest: close-race
[224.624395] Subtest close-race: SUCCESS (20.103s)
[224.702343] [021/131] (824s left) i915_pm_rps (thresholds-idle-park)
[224.776452] Starting subtest: thresholds-idle-park
[224.781073] Subtest thresholds-idle-park: SKIP (0.001s)
[224.834992] [022/131] (824s left) gem_mmap_gtt (medium-copy-xy)
[224.912243] Subtest medium-copy-XY: SKIP (0.000s)
[224.963368] [023/131] (824s left) syncobj_basic (bad-destroy)
[225.029177] Starting subtest: bad-destroy
[225.031490] Subtest bad-destroy: SUCCESS (0.000s)
[225.121531] [024/131] (824s left) gem_ccs (ctrl-surf-copy-new-ctx)
[225.173267] Starting subtest: ctrl-surf-copy-new-ctx
[225.177886] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[225.260200] [025/131] (824s left) core_getclient
[225.420921] [026/131] (824s left) vgem_basic (mmap)
[225.460075] Starting subtest: mmap
[225.480236] Subtest mmap: SUCCESS (0.022s)
[225.524617] [027/131] (824s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[225.636219] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[225.638170] Starting dynamic subtest: pipe-A-default-mode
[226.796830] Dynamic subtest pipe-A-default-mode: SKIP (1.154s)
[226.801344] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.155s)
[226.938481] [028/131] (822s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[227.027102] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[227.029408] Starting dynamic subtest: pipe-A
[227.043859] Dynamic subtest pipe-A: SKIP (0.010s)
[227.052382] Starting dynamic subtest: pipe-B
[227.061574] Dynamic subtest pipe-B: SKIP (0.019s)
[227.070292] Starting dynamic subtest: pipe-C
[227.084279] Dynamic subtest pipe-C: SKIP (0.020s)
[227.093230] Starting dynamic subtest: pipe-D
[227.102299] Dynamic subtest pipe-D: SKIP (0.019s)
[227.106724] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.069s)
[227.192146] [029/131] (822s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[227.299251] Starting subtest: disable-crc-after-crtc
[227.301740] Starting dynamic subtest: pipe-A-eDP-1
[229.113720] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[229.124192] Starting dynamic subtest: pipe-B-eDP-1
[231.354106] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.244s)
[231.364552] Starting dynamic subtest: pipe-C-eDP-1
[233.584995] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[233.595535] Starting dynamic subtest: pipe-D-eDP-1
[235.832881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.247s)
[235.835056] Subtest disable-crc-after-crtc: SUCCESS (8.537s)
[236.654474] [030/131] (813s left) api_intel_allocator (fork-simple-once)
[236.714405] Starting subtest: fork-simple-once
[236.730984] Subtest fork-simple-once: SUCCESS (0.018s)
[236.848597] [031/131] (812s left) core_setmaster (master-drop-set-user)
[238.743642] Starting subtest: master-drop-set-user
[238.757728] Subtest master-drop-set-user: SUCCESS (0.015s)
[238.773391] [032/131] (811s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[238.880304] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[243.854888] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (4.980s)
[243.990787] [033/131] (805s left) kms_psr (fbc-psr2-no-drrs)
[244.092331] Starting subtest: fbc-psr2-no-drrs
[244.094611] Starting dynamic subtest: eDP-1
[244.098711] Dynamic subtest eDP-1: SKIP (0.000s)
[244.102940] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[244.145564] [034/131] (805s left) gem_exec_parallel (fds)
[244.212799] Starting subtest: fds
[244.215279] Starting dynamic subtest: rcs0
[246.634058] Dynamic subtest rcs0: SUCCESS (2.421s)
[246.644192] Starting dynamic subtest: bcs0
[249.800233] Dynamic subtest bcs0: SUCCESS (3.165s)
[249.809666] Starting dynamic subtest: vcs0
[253.498503] Dynamic subtest vcs0: SUCCESS (3.698s)
[253.508765] Starting dynamic subtest: vcs1
[257.472157] Dynamic subtest vcs1: SUCCESS (3.973s)
[257.484075] Starting dynamic subtest: vecs0
[261.438633] Dynamic subtest vecs0: SUCCESS (3.965s)
[261.446997] Starting dynamic subtest: ccs0
[264.720635] Dynamic subtest ccs0: SUCCESS (3.280s)
[264.723465] Subtest fds: SUCCESS (20.507s)
[264.890353] [035/131] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[264.992625] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[264.996973] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[265.050412] [036/131] (784s left) gem_workarounds (suspend-resume-fd)
[265.123058] Starting subtest: suspend-resume-fd
[280.762443] Subtest suspend-resume-fd: SUCCESS (1.174s)
[280.867093] [037/131] (783s left) kms_cursor_legacy (forked-move)
[280.996048] Starting subtest: forked-move
[280.998515] Starting dynamic subtest: pipe-A
[286.483535] Dynamic subtest pipe-A: SUCCESS (5.482s)
[286.495964] Starting dynamic subtest: pipe-B
[291.985999] Dynamic subtest pipe-B: SUCCESS (5.499s)
[291.999995] Starting dynamic subtest: pipe-C
[297.497969] Dynamic subtest pipe-C: SUCCESS (5.510s)
[297.511642] Starting dynamic subtest: pipe-D
[303.005852] Dynamic subtest pipe-D: SUCCESS (5.506s)
[303.020418] Starting dynamic subtest: all-pipes
[308.533808] Dynamic subtest all-pipes: SUCCESS (5.525s)
[308.536766] Subtest forked-move: SUCCESS (27.527s)
[308.618159] [038/131] (755s left) prime_mmap (test_forked)
[308.672658] Starting subtest: test_forked
[308.675010] Starting dynamic subtest: test_forked-smem
[308.715808] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[308.718578] Subtest test_forked: SUCCESS (0.043s)
[308.806235] [039/131] (755s left) kms_addfb_basic (invalid-set-prop-any)
[308.872699] Starting subtest: invalid-set-prop-any
[308.875131] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[309.003654] [040/131] (755s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[309.253238] Starting subtest: cursor-rapid-movement-512x512
[309.258495] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[309.382887] [041/131] (755s left) kms_prop_blob (basic)
[309.445186] Starting subtest: basic
[309.447830] Subtest basic: SUCCESS (0.000s)
[309.516087] [042/131] (755s left) i915_hangman (gt-engine-error)
[309.586634] Starting subtest: gt-engine-error
[309.589210] Starting dynamic subtest: rcs0
[310.649858] Dynamic subtest rcs0: SUCCESS (1.062s)
[310.659275] Starting dynamic subtest: bcs0
[312.697247] Dynamic subtest bcs0: SUCCESS (2.046s)
[312.709489] Starting dynamic subtest: vcs0
[314.682378] Dynamic subtest vcs0: SUCCESS (1.983s)
[314.695193] Starting dynamic subtest: vcs1
[316.665820] Dynamic subtest vcs1: SUCCESS (1.982s)
[316.678251] Starting dynamic subtest: vecs0
[318.651100] Dynamic subtest vecs0: SUCCESS (1.984s)
[318.663437] Starting dynamic subtest: ccs0
[320.698928] Dynamic subtest ccs0: SUCCESS (2.045s)
[320.701677] Subtest gt-engine-error: SUCCESS (11.108s)
[320.763895] [043/131] (743s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[320.879669] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[320.884668] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[320.975705] [044/131] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[321.080073] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[321.084710] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[321.167821] [045/131] (743s left) perf (unprivileged-single-ctx-counters)
[321.295467] Starting subtest: unprivileged-single-ctx-counters
[321.299998] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[321.320035] [046/131] (743s left) gem_mmap_gtt (basic)
[321.381045] Subtest basic: SKIP (0.000s)
[321.429801] [047/131] (743s left) kms_plane_cursor (viewport)
[321.527864] Starting subtest: viewport
[321.532926] Starting dynamic subtest: pipe-A-eDP-1-size-64
[324.227574] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.696s)
[324.287547] Starting dynamic subtest: pipe-A-eDP-1-size-128
[326.939555] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.660s)
[326.997155] Starting dynamic subtest: pipe-A-eDP-1-size-256
[329.652697] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.659s)
[330.004651] Starting dynamic subtest: pipe-B-eDP-1-size-64
[333.454936] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.463s)
[333.512988] Starting dynamic subtest: pipe-B-eDP-1-size-128
[336.189663] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.682s)
[336.246010] Starting dynamic subtest: pipe-B-eDP-1-size-256
[338.890227] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.649s)
[339.237004] Starting dynamic subtest: pipe-C-eDP-1-size-64
[342.198627] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.970s)
[342.236137] Starting dynamic subtest: pipe-C-eDP-1-size-128
[344.477080] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.246s)
[344.514973] Starting dynamic subtest: pipe-C-eDP-1-size-256
[346.744691] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.235s)
[347.073841] Starting dynamic subtest: pipe-D-eDP-1-size-64
[350.012465] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.948s)
[350.048905] Starting dynamic subtest: pipe-D-eDP-1-size-128
[352.321699] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.279s)
[352.360483] Starting dynamic subtest: pipe-D-eDP-1-size-256
[354.536570] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[354.852623] Subtest viewport: SUCCESS (33.313s)
[355.695888] [048/131] (708s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[355.801462] Starting subtest: psr-rgb565-draw-render
[360.758726] Subtest psr-rgb565-draw-render: SUCCESS (4.959s)
[360.874300] [049/131] (703s left) drm_fdinfo (virtual-busy-all)
[360.917737] Starting subtest: virtual-busy-all
[360.923838] Subtest virtual-busy-all: SKIP (0.000s)
[360.959995] [050/131] (703s left) gem_lmem_swapping (basic)
[361.005197] Subtest basic: SKIP (0.000s)
[361.025812] [051/131] (703s left) drm_read (short-buffer-block)
[361.192820] Starting subtest: short-buffer-block
[361.195652] Subtest short-buffer-block: SUCCESS (0.000s)
[361.309160] [052/131] (703s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[361.405088] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[361.410123] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[362.485994] [053/131] (702s left) gem_spin_batch (spin-each)
[362.558532] Starting subtest: spin-each
[365.928640] Subtest spin-each: SUCCESS (3.369s)
[367.768425] [054/131] (697s left) gem_mmap_gtt (flink-race)
[367.836738] Subtest flink-race: SKIP (0.000s)
[367.879276] [055/131] (696s left) gem_ctx_persistence (engines-queued)
[367.939528] Starting subtest: engines-queued
[367.941832] Starting dynamic subtest: rcs0
[368.054177] Dynamic subtest rcs0: SUCCESS (0.117s)
[368.066405] Starting dynamic subtest: bcs0
[368.135456] Dynamic subtest bcs0: SUCCESS (0.077s)
[368.146879] Starting dynamic subtest: vcs0
[369.659406] Dynamic subtest vcs0: SUCCESS (1.523s)
[369.671836] Starting dynamic subtest: vcs1
[371.643539] Dynamic subtest vcs1: SUCCESS (1.979s)
[371.656024] Starting dynamic subtest: vecs0
[373.689267] Dynamic subtest vecs0: SUCCESS (2.044s)
[373.699195] Starting dynamic subtest: ccs0
[373.858792] Dynamic subtest ccs0: SUCCESS (0.168s)
[373.861871] Subtest engines-queued: SUCCESS (5.919s)
[373.984292] [056/131] (690s left) prime_vgem (basic-blt)
[374.074172] Starting subtest: basic-blt
[374.119247] Subtest basic-blt: SUCCESS (0.044s)
[374.218089] [057/131] (690s left) kms_chamelium_color (ctm-green-to-red)
[374.315791] Subtest ctm-green-to-red: SKIP (0.000s)
[374.341190] [058/131] (690s left) gem_mmap_wc (fault-concurrent)
[374.399657] Subtest fault-concurrent: SKIP (0.000s)
[374.444300] [059/131] (690s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[374.535088] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[374.537842] Starting dynamic subtest: pipe-A
[374.888571] Dynamic subtest pipe-A: SUCCESS (0.353s)
[374.898429] Starting dynamic subtest: pipe-B
[376.316506] Dynamic subtest pipe-B: SUCCESS (1.427s)
[376.325298] Starting dynamic subtest: pipe-C
[377.745412] Dynamic subtest pipe-C: SUCCESS (1.428s)
[377.753732] Starting dynamic subtest: pipe-D
[379.172819] Dynamic subtest pipe-D: SUCCESS (1.426s)
[379.175512] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.637s)
[380.293688] [060/131] (684s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[380.397800] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[380.400647] Starting dynamic subtest: pipe-A-eDP-1
[380.427017] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[380.436826] Starting dynamic subtest: pipe-B-eDP-1
[380.462658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[380.471387] Starting dynamic subtest: pipe-C-eDP-1
[380.496717] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[380.505370] Starting dynamic subtest: pipe-D-eDP-1
[380.531765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[380.536678] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[382.529425] [061/131] (682s left) syncobj_timeline (wait-for-submit-delayed-submit)
[382.590730] Starting subtest: wait-for-submit-delayed-submit
[382.695020] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[382.750996] [062/131] (682s left) kms_flip (blocking-wf_vblank)
[382.856838] Starting subtest: blocking-wf_vblank
[382.859544] Starting dynamic subtest: A-eDP1
[391.792354] Dynamic subtest A-eDP1: SUCCESS (8.932s)
[391.808073] Starting dynamic subtest: B-eDP1
[400.712305] Dynamic subtest B-eDP1: SUCCESS (8.916s)
[400.721711] Starting dynamic subtest: C-eDP1
[409.624964] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[409.634647] Starting dynamic subtest: D-eDP1
[418.548717] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[418.551656] Subtest blocking-wf_vblank: SUCCESS (35.685s)
[419.743148] [063/131] (645s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[419.858515] Starting subtest: y-tiled-16bpp-rotate-90
[419.863816] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[419.947953] [064/131] (645s left) kms_psr (fbc-psr-sprite-blt)
[420.041452] Starting subtest: fbc-psr-sprite-blt
[420.043721] Starting dynamic subtest: eDP-1
[420.048116] Dynamic subtest eDP-1: SKIP (0.000s)
[420.052313] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[420.097715] [065/131] (644s left) gem_exec_reloc (basic-cpu-wc)
[420.151856] Subtest basic-cpu-wc: SKIP (0.000s)
[420.210579] [066/131] (644s left) kms_psr (psr-cursor-mmap-cpu)
[420.306460] Starting subtest: psr-cursor-mmap-cpu
[420.308850] Starting dynamic subtest: eDP-1
[422.049077] Dynamic subtest eDP-1: SUCCESS (1.740s)
[422.051822] Subtest psr-cursor-mmap-cpu: SUCCESS (1.741s)
[422.891185] [067/131] (642s left) kms_psr2_su (page_flip-p010)
[422.948671] Subtest page_flip-P010: SKIP (0.000s)
[422.981538] [068/131] (642s left) syncobj_timeline (signal)
[423.041689] Starting subtest: signal
[423.044379] Subtest signal: SUCCESS (0.000s)
[423.141158] [069/131] (641s left) syncobj_timeline (device-signal-unordered)
[423.200830] Starting subtest: device-signal-unordered
[423.203403] Subtest device-signal-unordered: SUCCESS (0.000s)
[423.288076] [070/131] (641s left) prime_self_import (basic-with_one_bo)
[423.326055] Starting subtest: basic-with_one_bo
[423.350815] Subtest basic-with_one_bo: SUCCESS (0.029s)
[423.432908] [071/131] (641s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[423.537407] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[423.539806] Starting dynamic subtest: pipe-A-eDP-1
[423.564299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.573617] Starting dynamic subtest: pipe-B-eDP-1
[423.599457] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[423.607807] Starting dynamic subtest: pipe-C-eDP-1
[423.633641] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[423.642468] Starting dynamic subtest: pipe-D-eDP-1
[423.669680] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[423.674667] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[425.640093] [072/131] (639s left) kms_big_fb (x-tiled-addfb-size-overflow)
[425.747552] Starting subtest: x-tiled-addfb-size-overflow
[425.749714] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[425.825464] [073/131] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[425.934714] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[425.939796] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[426.012293] [074/131] (639s left) i915_query (engine-info)
[426.070665] Starting subtest: engine-info
[426.073524] Subtest engine-info: SUCCESS (0.005s)
[426.188628] [075/131] (639s left) gem_pxp (protected-raw-src-copy-not-readible)
[426.309049] Starting subtest: protected-raw-src-copy-not-readible
[426.367202] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.060s)
[427.539959] [076/131] (637s left) kms_atomic (atomic-invalid-params)
[427.642044] Starting subtest: atomic-invalid-params
[427.644727] Starting dynamic subtest: pipe-A-eDP-1
[428.028884] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[428.031722] Subtest atomic-invalid-params: SUCCESS (0.386s)
[428.873312] [077/131] (636s left) gem_exec_schedule (preempt-queue-chain)
[428.957734] Subtest preempt-queue-chain: SKIP (0.000s)
[429.226331] [078/131] (636s left) prime_vgem (fence-write-hang)
[429.323818] Subtest fence-write-hang: SKIP (0.000s)
[429.416672] [079/131] (635s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[429.509603] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[429.512316] Starting dynamic subtest: pipe-A-eDP-1
[429.928242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[429.939103] Starting dynamic subtest: pipe-B-eDP-1
[431.282007] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[431.291757] Starting dynamic subtest: pipe-C-eDP-1
[432.691617] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[432.700824] Starting dynamic subtest: pipe-D-eDP-1
[434.024199] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[434.026818] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.478s)
[435.082270] [080/131] (630s left) kms_big_fb (linear-32bpp-rotate-0)
[435.192550] Starting subtest: linear-32bpp-rotate-0
[436.591445] Subtest linear-32bpp-rotate-0: SUCCESS (1.401s)
[436.729121] [081/131] (628s left) kms_cursor_crc (cursor-onscreen-64x21)
[436.896810] Starting subtest: cursor-onscreen-64x21
[436.933685] Subtest cursor-onscreen-64x21: SKIP (0.031s)
[437.133931] [082/131] (628s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[437.233736] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[437.958415] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.725s)
[438.122173] [083/131] (627s left) gen3_render_linear_blits
[438.217305] [084/131] (627s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[438.317481] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[438.319980] Starting dynamic subtest: pipe-A-default-mode
[438.605632] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[438.610645] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.285s)
[439.413223] [085/131] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[439.527431] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[444.660428] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.070s)
[444.766471] [086/131] (620s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[444.862460] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[444.864742] Starting dynamic subtest: pipe-A-default-mode
[445.154660] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[445.159949] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.285s)
[445.973939] [087/131] (619s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[446.027827] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[446.030763] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[446.125458] [088/131] (619s left) perf (invalid-oa-metric-set-id)
[446.220556] Starting subtest: invalid-oa-metric-set-id
[446.233772] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[446.255045] [089/131] (619s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[451.283855] Starting subtest: pr-plane-move-sf-dmg-area
[451.289663] Subtest pr-plane-move-sf-dmg-area: SKIP (0.004s)
[452.114034] [090/131] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[452.222826] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[452.227741] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[452.308599] [091/131] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[452.415717] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[452.421332] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.524569] [092/131] (613s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[452.633840] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[457.265673] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.620s)
[457.380140] [093/131] (608s left) gen7_exec_parse (batch-without-end)
[457.449686] Subtest batch-without-end: SKIP (0.000s)
[457.483187] [094/131] (608s left) gem_ctx_exec (basic)
[457.552687] Starting subtest: basic
[457.558519] Subtest basic: SUCCESS (0.006s)
[457.682211] [095/131] (608s left) syncobj_timeline (invalid-query-one-illegal-handle)
[457.747520] Starting subtest: invalid-query-one-illegal-handle
[457.749719] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[457.824514] [096/131] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[457.930469] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[457.935663] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[458.024533] [097/131] (607s left) kms_draw_crc (draw-method-render)
[458.134074] Starting subtest: draw-method-render
[458.136512] Starting dynamic subtest: xrgb8888-untiled
[458.398337] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[458.407180] Starting dynamic subtest: rgb565-untiled
[458.599235] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[458.608129] Starting dynamic subtest: xrgb2101010-untiled
[458.788247] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.189s)
[458.797601] Starting dynamic subtest: xrgb8888-xtiled
[458.910934] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[458.920233] Starting dynamic subtest: rgb565-xtiled
[459.011081] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s)
[459.020505] Starting dynamic subtest: xrgb2101010-xtiled
[459.111449] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[459.120533] Starting dynamic subtest: xrgb8888-4tiled
[459.222449] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[459.231242] Starting dynamic subtest: rgb565-4tiled
[459.322561] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s)
[459.331284] Starting dynamic subtest: xrgb2101010-4tiled
[459.434259] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[459.436613] Subtest draw-method-render: SUCCESS (1.301s)
[459.542658] [098/131] (606s left) gem_pxp (reject-modify-context-protection-off-3)
[459.611603] Starting subtest: reject-modify-context-protection-off-3
[459.613669] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[460.716206] [099/131] (605s left) gem_partial_pwrite_pread (reads-uncached)
[460.777046] Subtest reads-uncached: SKIP (0.000s)
[460.848520] [100/131] (605s left) kms_psr (fbc-psr-suspend)
[460.936564] Starting subtest: fbc-psr-suspend
[460.939234] Starting dynamic subtest: eDP-1
[460.944478] Dynamic subtest eDP-1: SKIP (0.000s)
[460.949252] Subtest fbc-psr-suspend: SKIP (0.001s)
[460.992969] [101/131] (604s left) kms_universal_plane (universal-plane-sanity)
[461.082356] Starting subtest: universal-plane-sanity
[461.084940] Starting dynamic subtest: pipe-A-eDP-1
[461.677651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.590s)
[461.687271] Starting dynamic subtest: pipe-B-eDP-1
[462.922733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[462.933579] Starting dynamic subtest: pipe-C-eDP-1
[464.143449] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[464.154845] Starting dynamic subtest: pipe-D-eDP-1
[465.369577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[465.371834] Subtest universal-plane-sanity: SUCCESS (4.280s)
[466.213923] [102/131] (599s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[466.340080] Starting subtest: invalid-modeset-force-ultra-joiner
[466.345725] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[466.383870] [103/131] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[466.485048] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[466.489732] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[466.560888] [104/131] (599s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[466.656154] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[469.475880] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.821s)
[469.580472] [105/131] (596s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[469.969325] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[470.739507] [106/131] (595s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[470.837376] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[470.842817] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[471.880560] [107/131] (594s left) kms_psr (psr-sprite-mmap-gtt)
[471.974619] Starting subtest: psr-sprite-mmap-gtt
[471.977518] Starting dynamic subtest: eDP-1
[473.426806] Dynamic subtest eDP-1: SKIP (1.448s)
[473.432221] Subtest psr-sprite-mmap-gtt: SKIP (1.450s)
[473.607329] [108/131] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[473.708434] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[473.713447] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[473.797291] [109/131] (592s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[473.857885] Starting subtest: etime-multi-wait-all-for-submit-submitted
[473.958856] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[474.020569] [110/131] (592s left) kms_flip (2x-flip-vs-panning-vs-hang)
[474.128812] Starting subtest: 2x-flip-vs-panning-vs-hang
[474.140483] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[474.221382] [111/131] (591s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[474.341638] Starting subtest: cursorB-vs-flipA-atomic
[474.347261] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[474.435477] [112/131] (591s left) kms_pm_backlight (bad-brightness)
[474.541443] Starting subtest: bad-brightness
[474.591281] Starting dynamic subtest: eDP-1
[474.899658] Dynamic subtest eDP-1: SUCCESS (0.306s)
[474.902408] Subtest bad-brightness: SUCCESS (0.360s)
[475.729755] [113/131] (590s left) kms_atomic_transition (modeset-transition-fencing)
[475.834119] Starting subtest: modeset-transition-fencing
[475.836898] Starting dynamic subtest: 1x-outputs
[486.254007] Dynamic subtest 1x-outputs: SUCCESS (10.422s)
[486.532628] Subtest modeset-transition-fencing: SUCCESS (10.697s)
[487.371283] [114/131] (578s left) gem_exec_balancer (waits)
[487.438703] Starting subtest: waits
[493.754616] Subtest waits: SUCCESS (6.313s)
[494.028125] [115/131] (572s left) kms_content_protection (lic-type-0)
[494.172600] Starting subtest: lic-type-0
[497.521291] Subtest lic-type-0: SKIP (3.346s)
[498.679328] [116/131] (567s left) perf (gen12-group-concurrent-oa-buffer-read)
[498.770817] Starting subtest: gen12-group-concurrent-oa-buffer-read
[508.808095] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.033s)
[508.837439] [117/131] (557s left) gem_mmap_gtt (basic-write-read-distinct)
[508.896831] Subtest basic-write-read-distinct: SKIP (0.000s)
[508.930231] [118/131] (557s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[510.860459] Starting subtest: dpms-mode-unset-non-lpsp
[512.024216] Subtest dpms-mode-unset-non-lpsp: SKIP (1.160s)
[512.367384] [119/131] (553s left) gem_exec_reloc (basic-cpu-read-active)
[512.428093] Subtest basic-cpu-read-active: SKIP (0.000s)
[512.499412] [120/131] (553s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[512.878395] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[513.659924] [121/131] (552s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[513.764839] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[516.239679] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.479s)
[516.345961] [122/131] (550s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[516.444646] Starting subtest: yf-tiled-8bpp-rotate-0
[516.449055] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[516.515063] [123/131] (549s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[516.637680] Starting subtest: 2x-long-cursor-vs-flip-legacy
[516.642597] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[516.727618] [124/131] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[516.834606] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[516.838720] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[516.924906] [125/131] (549s left) gem_ringfill (legacy-basic)
[522.719834] Starting subtest: legacy-basic
[522.722857] Starting dynamic subtest: default
[522.793224] Dynamic subtest default: SUCCESS (0.074s)
[522.804823] Starting dynamic subtest: render
[522.836072] Dynamic subtest render: SUCCESS (0.040s)
[522.846850] Starting dynamic subtest: bsd
[522.878939] Dynamic subtest bsd: SUCCESS (0.041s)
[522.890146] Starting dynamic subtest: bsd1
[522.923847] Dynamic subtest bsd1: SUCCESS (0.043s)
[522.935818] Starting dynamic subtest: bsd2
[522.964291] Dynamic subtest bsd2: SUCCESS (0.039s)
[522.974844] Starting dynamic subtest: blt
[523.011246] Dynamic subtest blt: SUCCESS (0.045s)
[523.022620] Starting dynamic subtest: vebox
[523.053725] Dynamic subtest vebox: SUCCESS (0.041s)
[523.056712] Subtest legacy-basic: SUCCESS (0.337s)
[523.115080] [126/131] (543s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[523.238666] Starting subtest: flip-vs-cursor-busy-crc-atomic
[524.040501] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.802s)
[524.824478] [127/131] (541s left) kms_flip (2x-flip-vs-panning-interruptible)
[524.924089] Starting subtest: 2x-flip-vs-panning-interruptible
[524.935763] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[524.995052] [128/131] (541s left) gem_exec_whisper (basic-normal-all)
[525.066790] Starting subtest: basic-normal-all
[527.282126] Subtest basic-normal-all: SUCCESS (2.212s)
[527.451233] [129/131] (539s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[527.562435] Starting subtest: short-flip-after-cursor-toggle
[528.492449] Subtest short-flip-after-cursor-toggle: SUCCESS (0.928s)
[529.348471] [130/131] (537s left) kms_getfb (getfb2-handle-closed)
[529.406726] Starting subtest: getfb2-handle-closed
[529.409445] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[529.490087] [131/131] (537s left) gem_ctx_persistence (processes)
[529.554864] Starting subtest: processes
[530.726172] Subtest processes: SUCCESS (1.171s)
[530.787155] Closing watchdogs
Done.