[50.947365] Initializing watchdogs
[50.947819]   /dev/watchdog0
[50.978712] [001/142] (960s left) kms_vblank (pipe-d-wait-idle)
[51.484927] Starting subtest: pipe-D-wait-idle
[54.538781] Subtest pipe-D-wait-idle: SUCCESS (3.049s)
[55.501325] [002/142] (956s left) gem_mmap_gtt (ptrace)
[55.826220] Subtest ptrace: SKIP (0.000s)
[55.915796] [003/142] (955s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[56.286502] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[56.290295] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.004s)
[56.414566] [004/142] (955s left) kms_psr (sprite_render)
[56.904872] Starting subtest: sprite_render
[60.154359] Subtest sprite_render: SUCCESS (3.248s)
[61.086198] [005/142] (950s left) gem_exec_schedule (u-lateslice)
[61.535109] Starting subtest: u-lateslice
[61.538263] Starting dynamic subtest: rcs0
[61.590427] Dynamic subtest rcs0: SUCCESS (0.059s)
[61.623176] Starting dynamic subtest: bcs0
[61.635443] Dynamic subtest bcs0: SUCCESS (0.043s)
[61.667389] Starting dynamic subtest: vcs0
[61.684411] Dynamic subtest vcs0: SUCCESS (0.047s)
[61.715578] Starting dynamic subtest: vcs1
[61.725365] Dynamic subtest vcs1: SUCCESS (0.036s)
[61.759493] Starting dynamic subtest: vecs0
[61.763645] Dynamic subtest vecs0: SUCCESS (0.038s)
[61.798959] Starting dynamic subtest: ccs0
[61.803336] Dynamic subtest ccs0: SUCCESS (0.038s)
[61.807080] Subtest u-lateslice: SUCCESS (0.265s)
[63.643494] [006/142] (948s left) kms_rotation_crc (bad-tiling)
[64.138241] Starting subtest: bad-tiling
[64.149077] Subtest bad-tiling: SKIP (0.007s)
[64.270646] [007/142] (947s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[64.673394] Starting subtest: yf-tiled-to-vebox-yf-tiled
[64.679236] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[64.925697] [008/142] (947s left) gem_mmap_gtt (basic-small-bo-tiledy)
[65.305230] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[65.404152] [009/142] (946s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[65.767884] Starting subtest: single-wait-for-submit-available-signaled
[65.771448] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[65.883769] [010/142] (946s left) syncobj_timeline (invalid-single-wait-available-unsubmitted)
[66.255453] Starting subtest: invalid-single-wait-available-unsubmitted
[66.259654] Subtest invalid-single-wait-available-unsubmitted: SUCCESS (0.002s)
[66.383144] [011/142] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[66.906880] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[66.914244] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[67.044187] [012/142] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[67.553589] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[67.560121] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.710644] [013/142] (944s left) v3d/v3d_submit_csd (bad-in-sync)
[68.179299] Subtest bad-in-sync: SKIP (0.000s)
[68.296083] [014/142] (944s left) i915_query (hwconfig_table)
[68.660947] Starting subtest: hwconfig_table
[69.068286] Subtest hwconfig_table: SUCCESS (0.007s)
[69.112929] [015/142] (943s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[72.020093] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[72.169724] [016/142] (940s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[72.658942] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[72.666156] Starting dynamic subtest: pipe-A-default-mode
[73.073412] Dynamic subtest pipe-A-default-mode: SKIP (0.399s)
[73.080520] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.409s)
[73.995953] [017/142] (938s left) kms_addfb_basic (no-handle)
[74.363880] Starting subtest: no-handle
[74.367569] Subtest no-handle: SUCCESS (0.000s)
[74.624067] [018/142] (938s left) perf_pmu (busy-idle)
[75.008324] Starting subtest: busy-idle
[75.011914] Starting dynamic subtest: rcs0
[75.725859] Dynamic subtest rcs0: SUCCESS (0.717s)
[75.758116] Starting dynamic subtest: bcs0
[76.414829] Dynamic subtest bcs0: SUCCESS (0.688s)
[76.446830] Starting dynamic subtest: vcs0
[77.491528] Dynamic subtest vcs0: SUCCESS (1.074s)
[77.524811] Starting dynamic subtest: vcs1
[79.539608] Dynamic subtest vcs1: SUCCESS (2.047s)
[79.572956] Starting dynamic subtest: vecs0
[81.523149] Dynamic subtest vecs0: SUCCESS (1.983s)
[81.556515] Starting dynamic subtest: ccs0
[82.220309] Dynamic subtest ccs0: SUCCESS (0.698s)
[82.223890] Subtest busy-idle: SUCCESS (7.212s)
[82.387784] [019/142] (930s left) i915_pm_rpm (legacy-planes)
[88.730423] Starting subtest: legacy-planes
[88.734524] Starting dynamic subtest: plane-40
[117.462773] Dynamic subtest plane-40: SUCCESS (28.732s)
[117.496387] Starting dynamic subtest: plane-49
[146.208507] Dynamic subtest plane-49: SUCCESS (28.745s)
[146.243546] Starting dynamic subtest: plane-58
[171.173310] Dynamic subtest plane-58: SUCCESS (24.965s)
[171.210547] Starting dynamic subtest: plane-67
[196.115179] Dynamic subtest plane-67: SUCCESS (24.940s)
[196.118532] Subtest legacy-planes: SUCCESS (107.386s)
[197.030250] [020/142] (815s left) api_intel_bb (object-reloc-keep-cache)
[197.395323] Starting subtest: object-reloc-keep-cache
[197.409200] Subtest object-reloc-keep-cache: SKIP (0.010s)
[197.565607] [021/142] (815s left) kms_addfb_basic (basic-x-tiled-legacy)
[197.936478] Starting subtest: basic-x-tiled-legacy
[197.943104] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[198.207385] [022/142] (814s left) kms_color (ctm-0-25)
[198.689891] Starting subtest: ctm-0-25
[198.692920] Starting dynamic subtest: pipe-A
[203.731920] Dynamic subtest pipe-A: SUCCESS (5.041s)
[203.760938] Starting dynamic subtest: pipe-B
[209.493288] Dynamic subtest pipe-B: SUCCESS (5.761s)
[209.522508] Starting dynamic subtest: pipe-C
[215.354327] Dynamic subtest pipe-C: SUCCESS (5.860s)
[215.388937] Starting dynamic subtest: pipe-D
[221.250890] Dynamic subtest pipe-D: SUCCESS (5.889s)
[221.253947] Subtest ctm-0-25: SUCCESS (22.559s)
[222.169695] [023/142] (790s left) gem_ctx_param (basic)
[222.545623] Starting subtest: basic
[222.549473] Subtest basic: SUCCESS (0.002s)
[222.672273] [024/142] (790s left) kms_mmap_write_crc (main)
[223.175489] Starting subtest: main
[223.184093] Starting dynamic subtest: pipe-A-eDP-1
[233.011063] Dynamic subtest pipe-A-eDP-1: SUCCESS (9.826s)
[233.014538] Subtest main: SUCCESS (9.835s)
[233.972753] [025/142] (779s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[234.351362] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[234.458217] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[234.597977] [026/142] (778s left) gen7_exec_parse (batch-without-end)
[234.988235] Subtest batch-without-end: SKIP (0.000s)
[235.103261] [027/142] (778s left) syncobj_wait (reset-multiple-signaled)
[235.478775] Starting subtest: reset-multiple-signaled
[235.482366] Subtest reset-multiple-signaled: SUCCESS (0.002s)
[235.615937] [028/142] (777s left) perf (disabled-read-error)
[236.540513] Starting subtest: disabled-read-error
[236.617302] Subtest disabled-read-error: SUCCESS (0.077s)
[236.721393] [029/142] (776s left) gem_userptr_blits (stress-mm)
[237.178705] Starting subtest: stress-mm
[242.552166] Subtest stress-mm: SUCCESS (5.371s)
[242.735726] [030/142] (770s left) gem_eio (in-flight-internal-10ms)
[244.408869] Starting subtest: in-flight-internal-10ms
[247.067854] Subtest in-flight-internal-10ms: SUCCESS (2.660s)
[248.653413] [031/142] (764s left) v3d/v3d_perfmon (get-values-invalid-pad)
[249.117333] Subtest get-values-invalid-pad: SKIP (0.000s)
[249.235118] [032/142] (764s left) gem_exec_async (forked-writes)
[249.654954] Starting subtest: forked-writes
[249.659198] Starting dynamic subtest: rcs0
[249.849838] Dynamic subtest rcs0: SUCCESS (0.192s)
[249.899998] Starting dynamic subtest: bcs0
[250.046218] Dynamic subtest bcs0: SUCCESS (0.194s)
[250.084631] Starting dynamic subtest: vcs0
[250.233851] Dynamic subtest vcs0: SUCCESS (0.181s)
[250.278867] Starting dynamic subtest: vcs1
[250.418635] Dynamic subtest vcs1: SUCCESS (0.183s)
[250.458949] Starting dynamic subtest: vecs0
[250.518202] Dynamic subtest vecs0: SUCCESS (0.096s)
[250.559677] Starting dynamic subtest: ccs0
[250.714900] Dynamic subtest ccs0: SUCCESS (0.192s)
[250.718784] Subtest forked-writes: SUCCESS (1.060s)
[251.649658] [033/142] (762s left) gem_exec_reloc (basic-write-cpu)
[252.057679] Subtest basic-write-cpu: SKIP (0.000s)
[252.206211] [034/142] (761s left) kms_sequence (get-idle)
[252.698743] Starting subtest: get-idle
[252.702349] Starting dynamic subtest: eDP-1-pipe-A
[254.847201] Dynamic subtest eDP-1-pipe-A: SUCCESS (2.145s)
[254.897220] Starting dynamic subtest: eDP-1-pipe-B
[257.731850] Dynamic subtest eDP-1-pipe-B: SUCCESS (2.873s)
[257.771905] Starting dynamic subtest: eDP-1-pipe-C
[260.845799] Dynamic subtest eDP-1-pipe-C: SUCCESS (3.108s)
[260.890445] Starting dynamic subtest: eDP-1-pipe-D
[264.222802] Dynamic subtest eDP-1-pipe-D: SUCCESS (3.369s)
[264.225931] Subtest get-idle: SUCCESS (11.528s)
[265.121359] [035/142] (748s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[266.457372] Starting subtest: pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[266.464140] Subtest pipe-C-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[267.484513] [036/142] (746s left) kms_ccs (pipe-c-crc-primary-rotation-180-yf_tiled_ccs)
[268.889301] Starting subtest: pipe-C-crc-primary-rotation-180-yf_tiled_ccs
[268.896112] Subtest pipe-C-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.002s)
[269.842439] [037/142] (744s left) feature_discovery (display-3x)
[270.353144] Starting subtest: display-3x
[270.360219] Subtest display-3x: SKIP (0.000s)
[270.496224] [038/142] (743s left) gem_lmem_swapping (heavy-verify-random)
[270.897684] Subtest heavy-verify-random: SKIP (0.000s)
[271.007426] [039/142] (743s left) kms_cursor_legacy (torture-move)
[271.590047] Starting subtest: torture-move
[271.593577] Starting dynamic subtest: pipe-A
[277.891063] Dynamic subtest pipe-A: SUCCESS (6.294s)
[277.930718] Starting dynamic subtest: pipe-B
[284.667529] Dynamic subtest pipe-B: SUCCESS (6.775s)
[284.703670] Starting dynamic subtest: pipe-C
[291.005394] Dynamic subtest pipe-C: SUCCESS (6.333s)
[291.043827] Starting dynamic subtest: pipe-D
[297.416801] Dynamic subtest pipe-D: SUCCESS (6.407s)
[297.457771] Starting dynamic subtest: all-pipes
[304.282316] Dynamic subtest all-pipes: SUCCESS (6.859s)
[304.285942] Subtest torture-move: SUCCESS (32.691s)
[304.682622] [040/142] (709s left) perf_pmu (most-busy-check-all)
[305.081629] Starting subtest: most-busy-check-all
[305.085378] Starting dynamic subtest: rcs0
[306.546843] Dynamic subtest rcs0: SUCCESS (1.468s)
[306.589848] Starting dynamic subtest: bcs0
[308.530469] Dynamic subtest bcs0: SUCCESS (1.980s)
[308.571142] Starting dynamic subtest: vcs0
[310.514901] Dynamic subtest vcs0: SUCCESS (1.979s)
[310.553260] Starting dynamic subtest: vcs1
[312.498951] Dynamic subtest vcs1: SUCCESS (1.980s)
[312.537866] Starting dynamic subtest: vecs0
[314.546253] Dynamic subtest vecs0: SUCCESS (2.043s)
[314.588704] Starting dynamic subtest: ccs0
[316.530953] Dynamic subtest ccs0: SUCCESS (1.980s)
[316.535770] Subtest most-busy-check-all: SUCCESS (11.459s)
[316.712266] [041/142] (697s left) vc4/vc4_tiling (set-bad-flags)
[317.176640] Subtest set-bad-flags: SKIP (0.000s)
[317.311581] [042/142] (697s left) gem_flink_race (flink_close)
[317.674820] Starting subtest: flink_close
[322.753916] Subtest flink_close: SUCCESS (5.080s)
[322.921916] [043/142] (691s left) kms_chamelium_frames (dp-crc-fast)
[323.799684] Subtest dp-crc-fast: SKIP (0.000s)
[324.666892] [044/142] (690s left) i915_pm_dc (dc5-dpms)
[326.149307] Starting subtest: dc5-dpms
[328.372650] Subtest dc5-dpms: SUCCESS (2.223s)
[328.522208] [045/142] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[329.031245] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[329.038229] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[329.202476] [046/142] (685s left) v3d/v3d_create_bo (create-bo-zeroed)
[329.661340] Subtest create-bo-zeroed: SKIP (0.000s)
[329.778206] [047/142] (685s left) gem_ctx_shared (q-out-order)
[330.201079] Starting subtest: Q-out-order
[330.204538] Starting dynamic subtest: rcs0
[330.635796] Dynamic subtest rcs0: SUCCESS (0.431s)
[330.689228] Starting dynamic subtest: bcs0
[330.878430] Dynamic subtest bcs0: SUCCESS (0.239s)
[330.934474] Starting dynamic subtest: vcs0
[331.129190] Dynamic subtest vcs0: SUCCESS (0.247s)
[331.184199] Starting dynamic subtest: vcs1
[331.373458] Dynamic subtest vcs1: SUCCESS (0.241s)
[331.430952] Starting dynamic subtest: vecs0
[331.603722] Dynamic subtest vecs0: SUCCESS (0.227s)
[331.659691] Starting dynamic subtest: ccs0
[331.858562] Dynamic subtest ccs0: SUCCESS (0.249s)
[331.861849] Subtest Q-out-order: SUCCESS (1.658s)
[332.782507] [048/142] (682s left) kms_cursor_edge_walk (64x64-top-edge)
[333.273993] Starting subtest: 64x64-top-edge
[333.284135] Starting dynamic subtest: pipe-A-eDP-1
[337.195952] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.912s)
[337.242697] Starting dynamic subtest: pipe-D-eDP-1
[340.659670] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.451s)
[340.663512] Subtest 64x64-top-edge: SUCCESS (7.384s)
[341.601559] [049/142] (673s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_gen12_mc_ccs)
[342.590756] Starting subtest: pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs
[342.600158] Subtest pipe-A-random-ccs-data-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[344.027334] [050/142] (671s left) v3d/v3d_submit_csd (multi-and-single-sync)
[344.510607] Subtest multi-and-single-sync: SKIP (0.000s)
[344.639863] [051/142] (670s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-render)
[345.153485] Starting subtest: fbc-1p-offscren-pri-indfb-draw-render
[355.307926] Subtest fbc-1p-offscren-pri-indfb-draw-render: SUCCESS (10.164s)
[355.510952] [052/142] (659s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[355.748921] Subtest untiled-to-tiled: SKIP (0.000s)
[355.831456] [053/142] (659s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_dg2_rc_ccs)
[356.684412] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs
[356.689724] Subtest pipe-D-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[357.366614] [054/142] (658s left) kms_flip (flip-vs-expired-vblank)
[357.776531] Starting subtest: flip-vs-expired-vblank
[357.801250] Starting dynamic subtest: A-eDP1
[367.077980] Dynamic subtest A-eDP1: SUCCESS (9.278s)
[367.115064] Starting dynamic subtest: B-eDP1
[376.143765] Dynamic subtest B-eDP1: SUCCESS (9.062s)
[376.162030] Starting dynamic subtest: C-eDP1
[385.006139] Dynamic subtest C-eDP1: SUCCESS (8.858s)
[385.047180] Starting dynamic subtest: D-eDP1
[394.077285] Dynamic subtest D-eDP1: SUCCESS (9.066s)
[394.099596] Subtest flip-vs-expired-vblank: SUCCESS (36.328s)
[395.704215] [055/142] (619s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-submitted-sign
[396.084652] Starting subtest: invalid-multi-wait-all-available-unsubmitted-submitted-signaled
[396.088128] Subtest invalid-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[396.235499] [056/142] (619s left) gem_softpin (full)
[396.637666] Starting subtest: full
[396.690140] Subtest full: SUCCESS (0.053s)
[396.866225] [057/142] (618s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[397.961233] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[397.967794] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.002s)
[399.171477] [058/142] (616s left) debugfs_test (read_all_entries)
[399.563133] Starting subtest: read_all_entries
[401.997340] Subtest read_all_entries: SUCCESS (2.433s)
[402.250453] [059/142] (613s left) gem_exec_schedule (preempt-user)
[402.690118] Starting subtest: preempt-user
[402.693787] Starting dynamic subtest: rcs0
[402.834570] Dynamic subtest rcs0: SUCCESS (0.141s)
[402.878424] Starting dynamic subtest: bcs0
[402.971568] Dynamic subtest bcs0: SUCCESS (0.133s)
[403.022134] Starting dynamic subtest: vcs0
[403.112147] Dynamic subtest vcs0: SUCCESS (0.135s)
[403.169700] Starting dynamic subtest: vcs1
[403.253211] Dynamic subtest vcs1: SUCCESS (0.136s)
[403.300519] Starting dynamic subtest: vecs0
[403.386633] Dynamic subtest vecs0: SUCCESS (0.130s)
[403.434619] Starting dynamic subtest: ccs0
[403.522917] Dynamic subtest ccs0: SUCCESS (0.131s)
[403.526810] Subtest preempt-user: SUCCESS (0.835s)
[404.676522] [060/142] (611s left) sw_sync (alloc_fence)
[405.047665] Starting subtest: alloc_fence
[405.051315] Subtest alloc_fence: SUCCESS (0.001s)
[405.174833] [061/142] (610s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[405.550390] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[405.554577] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[405.726514] [062/142] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[406.248814] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[406.255433] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[406.416402] [063/142] (609s left) gem_workarounds (suspend-resume-context)
[406.875499] Starting subtest: suspend-resume-context
[423.617892] Subtest suspend-resume-context: SUCCESS (16.742s)
[423.832817] [064/142] (592s left) gem_ctx_isolation (preservation)
[424.269324] Starting subtest: preservation
[424.272304] Starting dynamic subtest: rcs0
[424.784868] Dynamic subtest rcs0: SUCCESS (0.512s)
[424.835769] Starting dynamic subtest: bcs0
[425.374079] Dynamic subtest bcs0: SUCCESS (0.586s)
[425.421943] Starting dynamic subtest: vcs0
[425.971489] Dynamic subtest vcs0: SUCCESS (0.593s)
[426.019643] Starting dynamic subtest: vcs1
[427.079874] Dynamic subtest vcs1: SUCCESS (1.104s)
[427.130190] Starting dynamic subtest: vecs0
[429.017872] Dynamic subtest vecs0: SUCCESS (1.934s)
[429.066983] Starting dynamic subtest: ccs0
[431.053060] Dynamic subtest ccs0: SUCCESS (2.030s)
[431.056687] Subtest preservation: SUCCESS (6.784s)
[431.407724] [065/142] (585s left) kms_cursor_crc (cursor-offscreen-128x42)
[432.404877] Starting subtest: cursor-offscreen-128x42
[432.433197] Starting dynamic subtest: pipe-A-eDP-1
[435.223583] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.790s)
[435.426223] Starting dynamic subtest: pipe-D-eDP-1
[438.992246] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.608s)
[438.996996] Subtest cursor-offscreen-128x42: SUCCESS (6.588s)
[439.939506] [066/142] (576s left) kms_atomic (plane-primary-legacy)
[440.761266] Starting subtest: plane-primary-legacy
[441.056774] Subtest plane-primary-legacy: SUCCESS (0.303s)
[442.405408] [067/142] (574s left) gem_exec_fence (submit-chain)
[442.995469] Starting subtest: submit-chain
[443.070451] Subtest submit-chain: SUCCESS (0.076s)
[444.825886] [068/142] (571s left) kms_content_protection (dp-mst-type-1)
[445.522650] Starting subtest: dp-mst-type-1
[445.528696] Subtest dp-mst-type-1: SKIP (0.001s)
[445.710287] [069/142] (571s left) sw_sync (sync_busy_fork)
[446.081767] Starting subtest: sync_busy_fork
[447.148993] Subtest sync_busy_fork: SUCCESS (1.066s)
[447.293544] [070/142] (569s left) gem_close_race (basic-process)
[447.734692] Starting subtest: basic-process
[447.834844] Subtest basic-process: SUCCESS (0.099s)
[448.113235] [071/142] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[448.638639] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[460.444469] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (11.808s)
[460.744287] [072/142] (556s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[461.286299] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[465.107848] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (3.820s)
[465.667440] [073/142] (551s left) vc4/vc4_perfmon (destroy-invalid-perfmon)
[466.095467] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[466.197152] [074/142] (551s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[466.768461] Starting subtest: y-tiled-8bpp-rotate-90
[466.775702] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[466.953528] [075/142] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[467.470779] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[467.477786] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[467.649479] [076/142] (549s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[469.170862] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[469.174573] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SUCCESS (0.003s)
[470.072649] [077/142] (547s left) gem_exec_reloc (basic-wc-cpu-active)
[470.473839] Subtest basic-wc-cpu-active: SKIP (0.000s)
[470.618593] [078/142] (546s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs)
[472.099296] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs
[473.285184] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs: SUCCESS (1.186s)
[474.626879] [079/142] (543s left) kms_psr (psr2_primary_mmap_gtt)
[475.104382] Starting subtest: psr2_primary_mmap_gtt
[477.932600] Subtest psr2_primary_mmap_gtt: SKIP (2.824s)
[478.292504] [080/142] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[478.809987] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[484.523311] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (5.723s)
[484.805973] [081/142] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[485.208393] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[498.522370] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (13.321s)
[498.818108] [082/142] (519s left) gem_exec_balancer (parallel-keep-submit-fence)
[500.050431] Starting subtest: parallel-keep-submit-fence
[508.299477] Subtest parallel-keep-submit-fence: SUCCESS (8.250s)
[508.509821] [083/142] (509s left) api_intel_allocator (fork-simple-stress-signal)
[508.889241] Starting subtest: fork-simple-stress-signal
[514.555331] Subtest fork-simple-stress-signal: SUCCESS (5.668s)
[514.745597] [084/142] (503s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[515.249856] Starting subtest: plane-all-transition-nonblocking-fencing
[515.259641] Starting dynamic subtest: pipe-A-eDP-1
[520.025519] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.765s)
[520.478129] Starting dynamic subtest: pipe-B-eDP-1
[525.766940] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.331s)
[526.187446] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (10.935s)
[527.145718] [085/142] (491s left) template (a)
[527.525654] Starting subtest: A
[527.529346] Subtest A: SUCCESS (0.000s)
[527.685395] [086/142] (490s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-sf)
[534.850208] Starting subtest: overlay-plane-move-continuous-exceed-sf
[534.858880] Starting dynamic subtest: pipe-A-eDP-1
[547.680371] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.819s)
[547.736256] Starting dynamic subtest: pipe-B-eDP-1
[560.515954] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.825s)
[560.520201] Subtest overlay-plane-move-continuous-exceed-sf: SUCCESS (25.665s)
[561.470194] [087/142] (456s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[563.303770] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[566.423252] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (3.119s)
[567.765767] [088/142] (450s left) gem_exec_reloc (basic-active)
[568.165949] Subtest basic-active: SKIP (0.000s)
[568.305286] [089/142] (450s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[568.673602] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[568.797905] [090/142] (449s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_mtl_rc_ccs)
[569.966446] Starting subtest: pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs
[571.267572] Subtest pipe-B-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.301s)
[572.888052] [091/142] (445s left) drm_read (invalid-buffer)
[573.718167] Starting subtest: invalid-buffer
[573.721914] Subtest invalid-buffer: SUCCESS (0.000s)
[573.934618] [092/142] (444s left) drm_fdinfo (virtual-busy-idle)
[574.330675] Starting subtest: virtual-busy-idle
[574.337596] Subtest virtual-busy-idle: SKIP (0.001s)
[574.489780] [093/142] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[574.999422] Starting subtest: fbcpsr-1p-rte
[582.458188] Subtest fbcpsr-1p-rte: SUCCESS (7.464s)
[582.777480] [094/142] (436s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[583.295252] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[583.301810] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[583.474464] [095/142] (435s left) prime_mmap (test_errors)
[583.849244] Starting subtest: test_errors
[583.852323] Starting dynamic subtest: test_errors-smem
[585.399431] Dynamic subtest test_errors-smem: SUCCESS (1.553s)
[585.402931] Subtest test_errors: SUCCESS (1.557s)
[585.579878] [096/142] (433s left) gem_create (create-massive)
[585.958661] Starting subtest: create-massive
[585.962348] Subtest create-massive: SUCCESS (0.000s)
[586.266305] [097/142] (433s left) gem_exec_store (pages)
[586.692656] Starting subtest: pages
[586.696368] Starting dynamic subtest: rcs0
[586.933894] Dynamic subtest rcs0: SUCCESS (0.239s)
[586.989133] Starting dynamic subtest: bcs0
[587.168733] Dynamic subtest bcs0: SUCCESS (0.229s)
[587.228443] Starting dynamic subtest: vcs0
[588.532058] Dynamic subtest vcs0: SUCCESS (1.356s)
[588.586640] Starting dynamic subtest: vcs1
[590.515202] Dynamic subtest vcs1: SUCCESS (1.979s)
[590.565887] Starting dynamic subtest: vecs0
[592.499694] Dynamic subtest vecs0: SUCCESS (1.980s)
[592.550269] Starting dynamic subtest: ccs0
[592.722110] Dynamic subtest ccs0: SUCCESS (0.220s)
[592.725720] Subtest pages: SUCCESS (6.031s)
[593.035506] [098/142] (426s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[593.621435] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[593.633353] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.008s)
[593.977097] [099/142] (425s left) kms_plane (pixel-format)
[594.455124] Starting subtest: pixel-format
[594.464447] Starting dynamic subtest: pipe-A-planes
[615.023651] Dynamic subtest pipe-A-planes: SUCCESS (20.558s)
[615.082360] Starting dynamic subtest: pipe-B-planes
[640.100381] Dynamic subtest pipe-B-planes: FAIL (24.267s)
[640.103939] Subtest pixel-format: FAIL (45.435s)
[640.580809] [100/142] (379s left) gem_exec_fence (invalid-timeline-fence-array)
[642.531837] Starting subtest: invalid-timeline-fence-array
[642.552743] Subtest invalid-timeline-fence-array: SUCCESS (0.021s)
[642.834355] [101/142] (376s left) gem_shrink (reclaim)
[643.231217] Starting subtest: reclaim
[645.768901] Subtest reclaim: SUCCESS (2.537s)
[645.980383] [102/142] (373s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[646.509987] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[646.516216] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[646.688585] [103/142] (373s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[647.231382] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[647.237345] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[647.415119] [104/142] (372s left) kms_big_fb (linear-64bpp-rotate-270)
[647.961567] Starting subtest: linear-64bpp-rotate-270
[648.020763] Subtest linear-64bpp-rotate-270: SKIP (0.056s)
[648.209300] [105/142] (371s left) gen9_exec_parse (valid-registers)
[648.606564] Subtest valid-registers: SKIP (0.000s)
[648.729990] [106/142] (371s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[649.807800] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[649.823712] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SKIP (0.013s)
[651.125947] [107/142] (369s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[651.549718] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[651.578106] Starting dynamic subtest: A-eDP1
[661.068903] Dynamic subtest A-eDP1: SUCCESS (9.491s)
[661.120601] Starting dynamic subtest: B-eDP1
[670.382191] Dynamic subtest B-eDP1: SUCCESS (9.308s)
[670.440119] Starting dynamic subtest: C-eDP1
[679.691528] Dynamic subtest C-eDP1: SUCCESS (9.301s)
[679.743887] Starting dynamic subtest: D-eDP1
[689.002319] Dynamic subtest D-eDP1: SUCCESS (9.305s)
[689.028462] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (37.483s)
[690.571221] [108/142] (329s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[691.120569] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[695.049839] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (3.928s)
[695.682458] [109/142] (324s left) gem_userptr_blits (set-cache-level)
[696.087671] Starting subtest: set-cache-level
[696.093872] Subtest set-cache-level: SKIP (0.000s)
[696.362496] [110/142] (324s left) kms_ccs (pipe-b-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[697.599247] Starting subtest: pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[697.605883] Subtest pipe-B-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[698.771489] [111/142] (321s left) kms_flip (bo-too-big-interruptible)
[699.192184] Starting subtest: bo-too-big-interruptible
[699.220255] Starting dynamic subtest: A-eDP1
[701.757942] Dynamic subtest A-eDP1: SUCCESS (2.537s)
[701.805735] Starting dynamic subtest: B-eDP1
[704.046563] Dynamic subtest B-eDP1: SUCCESS (2.283s)
[704.094823] Starting dynamic subtest: C-eDP1
[706.318251] Dynamic subtest C-eDP1: SUCCESS (2.266s)
[706.366364] Starting dynamic subtest: D-eDP1
[708.559274] Dynamic subtest D-eDP1: SUCCESS (2.236s)
[708.581214] Subtest bo-too-big-interruptible: SUCCESS (9.394s)
[710.211085] [112/142] (310s left) gem_userptr_blits (relocations)
[710.609839] Starting subtest: relocations
[710.616293] Subtest relocations: SKIP (0.003s)
[710.895137] [113/142] (309s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[711.389828] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[711.396637] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[711.563744] [114/142] (309s left) kms_chamelium_color (gamma)
[712.054152] Subtest gamma: SKIP (0.000s)
[712.172852] [115/142] (308s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[712.680591] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[712.687517] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[712.850881] [116/142] (308s left) kms_cursor_crc (cursor-random-512x170)
[714.080170] Starting subtest: cursor-random-512x170
[714.093059] Subtest cursor-random-512x170: SKIP (0.007s)
[714.420853] [117/142] (306s left) kms_plane_alpha_blend (alpha-transparent-fb)
[714.904603] Starting subtest: alpha-transparent-fb
[716.645278] Starting dynamic subtest: pipe-A-eDP-1
[717.942543] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.297s)
[718.002369] Starting dynamic subtest: pipe-D-eDP-1
[720.070674] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.116s)
[720.074958] Subtest alpha-transparent-fb: SUCCESS (5.169s)
[721.037450] [118/142] (300s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[721.570690] Starting subtest: yf-tiled-32bpp-rotate-90
[721.577624] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[721.760676] [119/142] (299s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[722.278462] Starting subtest: psr-rgb565-draw-mmap-gtt
[722.285519] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[722.453713] [120/142] (299s left) kms_hdr (static-toggle)
[722.914364] Starting subtest: static-toggle
[722.920977] Subtest static-toggle: SKIP (0.001s)
[723.064618] [121/142] (298s left) gem_mmap_gtt (medium-copy-xy)
[723.447677] Subtest medium-copy-XY: SKIP (0.000s)
[723.565558] [122/142] (298s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[724.079794] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[724.087214] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[724.249315] [123/142] (297s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[724.800229] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[724.807226] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[724.973565] [124/142] (296s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[725.475086] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[740.392714] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (14.925s)
[740.679536] [125/142] (281s left) i915_pm_rpm (dpms-non-lpsp)
[746.779322] Starting subtest: dpms-non-lpsp
[746.786670] Subtest dpms-non-lpsp: SKIP (0.002s)
[747.755485] [126/142] (274s left) kms_ccs (pipe-d-bad-rotation-90-y_tiled_ccs)
[749.388650] Starting subtest: pipe-D-bad-rotation-90-y_tiled_ccs
[749.394759] Subtest pipe-D-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[750.212576] [127/142] (271s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[750.717371] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[750.723898] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[750.885518] [128/142] (271s left) kms_selftest (framebuffer)
[751.245571] Starting subtest: framebuffer
[751.259382] Subtest framebuffer: SKIP (0.010s)
[751.407669] [129/142] (270s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[751.912873] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[751.920743] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[752.098191] [130/142] (270s left) kms_atomic_interruptible (universal-setplane-primary)
[752.581385] Starting subtest: universal-setplane-primary
[752.589320] Starting dynamic subtest: eDP-1-pipe-A
[760.402758] Dynamic subtest eDP-1-pipe-A: SUCCESS (7.809s)
[760.406392] Subtest universal-setplane-primary: SUCCESS (7.820s)
[761.371680] [131/142] (261s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[761.858524] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[761.862610] Starting dynamic subtest: pipe-A-eDP-1
[762.083808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.221s)
[762.144490] Starting dynamic subtest: pipe-B-eDP-1
[763.596844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[763.658296] Starting dynamic subtest: pipe-C-eDP-1
[765.121558] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.514s)
[765.183601] Starting dynamic subtest: pipe-D-eDP-1
[766.659233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[766.663249] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (4.806s)
[768.197774] [132/142] (254s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[768.589835] Starting subtest: invalid-bsd1-flag-on-vebox
[768.593865] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[768.767183] [133/142] (253s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_rc_ccs)
[769.651285] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs
[769.658153] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[771.148676] [134/142] (251s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[771.635261] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[771.645119] Starting dynamic subtest: pipe-A-default-mode
[775.063369] Dynamic subtest pipe-A-default-mode: SUCCESS (3.418s)
[775.067359] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (3.432s)
[776.026514] [135/142] (246s left) kms_pwrite_crc
[778.979829] [136/142] (244s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[779.943481] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[781.321512] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.378s)
[783.160530] [137/142] (239s left) gem_ctx_persistence (heartbeat-many)
[783.570708] Starting subtest: heartbeat-many
[783.577530] Subtest heartbeat-many: SKIP (0.001s)
[783.729931] [138/142] (239s left) gem_userptr_blits (forbidden-operations)
[784.115560] Starting subtest: forbidden-operations
[784.123243] Subtest forbidden-operations: SKIP (0.000s)
[784.384127] [139/142] (238s left) kms_vblank (pipe-c-wait-busy-hang)
[784.865333] Starting subtest: pipe-C-wait-busy-hang
[800.836325] Subtest pipe-C-wait-busy-hang: SUCCESS (15.972s)
[801.788260] [140/142] (221s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[802.301115] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[818.418308] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (16.121s)
[818.692747] [141/142] (204s left) core_hotunplug (unbind-rebind)
[819.141495] Starting subtest: unbind-rebind
[824.665702] Subtest unbind-rebind: SUCCESS (5.524s)
[824.767136] [142/142] (198s left) gem_render_linear_blits (basic)
[826.514780] Starting subtest: basic
[826.663817] Subtest basic: SUCCESS (0.149s)
[826.834509] Closing watchdogs
Done.