[57.842505] Initializing watchdogs
[57.842571]   /dev/watchdog0
[57.856299] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[57.861171] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.863460] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.865769] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[58.034823] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[58.036321] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[58.146198] [002/130] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[58.244236] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[58.245649] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[58.374151] [003/130] (960s left) perf (oa-exponents)
[58.473977] Starting subtest: oa-exponents
[58.475061] Starting dynamic subtest: 0-rcs0
[62.040535] Dynamic subtest 0-rcs0: SUCCESS (3.550s)
[62.041293] Subtest oa-exponents: SUCCESS (3.550s)
[62.076547] [004/130] (956s left) gem_exec_basic (basic)
[62.138160] Starting subtest: basic
[62.138886] Starting dynamic subtest: rcs0-smem
[62.139614] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[62.144888] Starting dynamic subtest: bcs0-smem
[62.145594] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[62.150078] Starting dynamic subtest: vcs0-smem
[62.150807] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[62.155821] Starting dynamic subtest: vcs1-smem
[62.156552] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[62.160743] Starting dynamic subtest: vecs0-smem
[62.161431] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[62.162116] Subtest basic: SUCCESS (0.004s)
[62.351161] [005/130] (956s left) kms_pm_backlight (fade-with-dpms)
[62.441251] Subtest fade-with-dpms: SKIP (0.000s)
[62.484679] [006/130] (956s left) kms_fb_coherency (memset-crc)
[62.570833] Starting subtest: memset-crc
[62.571567] Starting dynamic subtest: mmap-gtt
[63.068163] Dynamic subtest mmap-gtt: SUCCESS (0.496s)
[63.123336] Starting dynamic subtest: mmap-offset-wc
[63.494382] Dynamic subtest mmap-offset-wc: SUCCESS (0.376s)
[63.547165] Starting dynamic subtest: mmap-offset-uc
[64.279313] Dynamic subtest mmap-offset-uc: SUCCESS (0.736s)
[64.334437] Starting dynamic subtest: mmap-legacy-wc
[64.701791] Dynamic subtest mmap-legacy-wc: SUCCESS (0.371s)
[64.749433] Subtest memset-crc: SUCCESS (2.175s)
[64.918286] [007/130] (953s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[64.955658] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[64.956406] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[65.052384] [008/130] (953s left) kms_cursor_crc (cursor-onscreen-128x42)
[65.142899] Starting subtest: cursor-onscreen-128x42
[65.147642] Starting dynamic subtest: pipe-A-HDMI-A-1
[66.767134] Dynamic subtest pipe-A-HDMI-A-1: FAIL (1.440s)
[66.771908] Starting dynamic subtest: pipe-D-HDMI-A-1
[69.196634] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.565s)
[69.197473] Subtest cursor-onscreen-128x42: FAIL (4.043s)
[69.367652] [009/130] (949s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[69.462078] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[69.463487] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[69.576430] [010/130] (949s left) gem_exec_fence (syncobj-wait)
[69.928973] Starting subtest: syncobj-wait
[69.992443] Subtest syncobj-wait: SUCCESS (0.063s)
[70.352954] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[70.355594] [011/130] (948s left) i915_pm_rps (reset)
[70.396384] Starting subtest: reset
[73.954997] Subtest reset: SUCCESS (3.527s)
[74.058513] [012/130] (944s left) kms_psr (psr2-sprite-mmap-cpu)
[74.148321] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[74.192486] [013/130] (944s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[74.294780] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[74.389941] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.095s)
[74.533735] [014/130] (944s left) gem_ctx_exec (basic-invalid-context)
[74.569944] Starting subtest: basic-invalid-context
[74.572180] Subtest basic-invalid-context: SUCCESS (0.002s)
[74.704073] [015/130] (944s left) kms_addfb_basic (small-bo)
[74.789622] Starting subtest: small-bo
[74.790331] Subtest small-bo: SUCCESS (0.000s)
[74.912827] [016/130] (944s left) gem_spin_batch (legacy-resubmit)
[74.956643] Starting subtest: legacy-resubmit
[74.957429] Starting dynamic subtest: default
[74.958978] Dynamic subtest default: SUCCESS (0.001s)
[74.964615] Starting dynamic subtest: render
[74.965437] Dynamic subtest render: SUCCESS (0.001s)
[74.970561] Starting dynamic subtest: bsd
[74.971290] Dynamic subtest bsd: SUCCESS (0.001s)
[74.976224] Starting dynamic subtest: bsd1
[74.976925] Dynamic subtest bsd1: SUCCESS (0.001s)
[74.981374] Starting dynamic subtest: bsd2
[74.982082] Dynamic subtest bsd2: SUCCESS (0.001s)
[74.986703] Starting dynamic subtest: blt
[74.987387] Dynamic subtest blt: SUCCESS (0.001s)
[74.991977] Starting dynamic subtest: vebox
[74.992705] Dynamic subtest vebox: SUCCESS (0.001s)
[74.993377] Subtest legacy-resubmit: SUCCESS (0.011s)
[75.179709] [017/130] (943s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[75.216037] Starting subtest: multi-wait-available-unsubmitted-signaled
[75.216803] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[75.310877] [018/130] (943s left) kms_draw_crc (draw-method-mmap-gtt)
[75.398316] Starting subtest: draw-method-mmap-gtt
[75.399074] Starting dynamic subtest: xrgb8888-untiled
[75.722461] Dynamic subtest xrgb8888-untiled: SUCCESS (0.324s)
[75.732863] Starting dynamic subtest: rgb565-untiled
[76.026288] Dynamic subtest rgb565-untiled: SUCCESS (0.303s)
[76.034235] Starting dynamic subtest: xrgb2101010-untiled
[76.329886] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.303s)
[76.336330] Starting dynamic subtest: xbgr16161616f-untiled
[76.633803] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.303s)
[76.642684] Starting dynamic subtest: xrgb8888-xtiled
[76.804135] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.170s)
[76.816909] Starting dynamic subtest: rgb565-xtiled
[76.975504] Dynamic subtest rgb565-xtiled: SUCCESS (0.171s)
[76.988115] Starting dynamic subtest: xrgb2101010-xtiled
[77.126821] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.151s)
[77.139488] Starting dynamic subtest: xbgr16161616f-xtiled
[77.278597] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.151s)
[77.291227] Starting dynamic subtest: xrgb8888-ytiled
[77.449516] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.170s)
[77.462457] Starting dynamic subtest: rgb565-ytiled
[77.620320] Dynamic subtest rgb565-ytiled: SUCCESS (0.170s)
[77.633157] Starting dynamic subtest: xrgb2101010-ytiled
[77.772170] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.151s)
[77.786523] Starting dynamic subtest: xbgr16161616f-ytiled
[77.961549] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.189s)
[77.962572] Subtest draw-method-mmap-gtt: SUCCESS (2.562s)
[78.082426] [019/130] (940s left) syncobj_wait (signal)
[78.119524] Starting subtest: signal
[78.120299] Subtest signal: SUCCESS (0.000s)
[78.214894] [020/130] (940s left) gem_exec_reloc (basic-write-gtt-active)
[78.253311] Starting subtest: basic-write-gtt-active
[78.379823] Subtest basic-write-gtt-active: SUCCESS (0.118s)
[78.538725] [021/130] (940s left) gem_exec_reloc (basic-wc-noreloc)
[78.579255] Starting subtest: basic-wc-noreloc
[78.582662] Subtest basic-wc-noreloc: SUCCESS (0.003s)
[78.725356] [022/130] (940s left) prime_busy (after-wait)
[78.763151] Starting subtest: after-wait
[78.768780] Starting dynamic subtest: rcs0
[78.788389] Dynamic subtest rcs0: SUCCESS (0.019s)
[78.796166] Starting dynamic subtest: bcs0
[78.805063] Dynamic subtest bcs0: SUCCESS (0.016s)
[78.814029] Starting dynamic subtest: vcs0
[78.819999] Dynamic subtest vcs0: SUCCESS (0.015s)
[78.827853] Starting dynamic subtest: vcs1
[78.836349] Dynamic subtest vcs1: SUCCESS (0.016s)
[78.843580] Starting dynamic subtest: vecs0
[78.855232] Dynamic subtest vecs0: SUCCESS (0.019s)
[78.974193] Subtest after-wait: SUCCESS (0.200s)
[79.069766] [023/130] (940s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[80.469923] Starting subtest: modeset-lpsp-stress-no-wait
[81.395727] Subtest modeset-lpsp-stress-no-wait: SUCCESS (0.926s)
[81.536092] [024/130] (937s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[81.623794] Starting subtest: primary-4-tiled-reflect-x-180
[81.738356] Subtest primary-4-tiled-reflect-x-180: SKIP (0.114s)
[81.848856] [025/130] (937s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[81.944104] Starting subtest: yf-tiled-8bpp-rotate-270
[81.945686] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[82.066982] [026/130] (937s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[82.158704] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[84.091532] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (1.933s)
[84.267248] [027/130] (935s left) kms_atomic (plane-immutable-zpos)
[84.364509] Starting subtest: plane-immutable-zpos
[84.365224] Starting dynamic subtest: pipe-A-HDMI-A-1
[84.934081] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.577s)
[84.934871] Subtest plane-immutable-zpos: SUCCESS (0.578s)
[85.108436] [028/130] (934s left) prime_mmap (test_refcounting)
[85.143687] Starting subtest: test_refcounting
[85.144460] Starting dynamic subtest: test_refcounting-smem
[85.145190] Dynamic subtest test_refcounting-smem: SUCCESS (0.001s)
[85.145950] Subtest test_refcounting: SUCCESS (0.002s)
[85.258736] [029/130] (934s left) kms_lease (lease-uevent)
[85.346961] Starting subtest: lease-uevent
[86.369996] Subtest lease-uevent: SUCCESS (1.015s)
[86.453375] [030/130] (933s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[86.545550] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[86.546935] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[86.684680] [031/130] (932s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[86.728170] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[86.728908] Starting dynamic subtest: smem
[86.803281] Dynamic subtest smem: SUCCESS (0.075s)
[86.804031] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.075s)
[87.004637] [032/130] (932s left) gem_ctx_shared (q-in-order)
[87.050726] Starting subtest: Q-in-order
[87.051500] Starting dynamic subtest: rcs0
[87.096505] Dynamic subtest rcs0: SUCCESS (0.045s)
[87.105490] Starting dynamic subtest: bcs0
[87.144777] Dynamic subtest bcs0: SUCCESS (0.048s)
[87.153549] Starting dynamic subtest: vcs0
[87.194090] Dynamic subtest vcs0: SUCCESS (0.049s)
[87.202514] Starting dynamic subtest: vcs1
[87.241516] Dynamic subtest vcs1: SUCCESS (0.047s)
[87.250514] Starting dynamic subtest: vecs0
[87.289606] Dynamic subtest vecs0: SUCCESS (0.048s)
[87.290739] Subtest Q-in-order: SUCCESS (0.239s)
[87.494843] [033/130] (932s left) kms_content_protection (dp-mst-lic-type-1)
[87.593744] Starting subtest: dp-mst-lic-type-1
[87.595124] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[87.729411] [034/130] (931s left) syncobj_wait (wait-zero-handles)
[87.765276] Starting subtest: wait-zero-handles
[87.765986] Subtest wait-zero-handles: SUCCESS (0.000s)
[87.861459] [035/130] (931s left) kms_prime (basic-modeset-hybrid)
[90.349187] Subtest basic-modeset-hybrid: SKIP (0.000s)
[90.452619] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.amdgpu: true
[90.453354] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.xe: true
[90.455201] [036/130] (929s left) kms_psr (fbc-psr-primary-page-flip)
[90.543449] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[90.598410] [037/130] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[90.689439] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[90.690794] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[90.820793] [038/130] (928s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[90.912480] Starting subtest: psr-indfb-scaledprimary
[90.913906] Subtest psr-indfb-scaledprimary: SKIP (0.000s)
[91.049045] [039/130] (928s left) api_intel_bb (intel-bb-blit-x)
[91.085199] Starting subtest: intel-bb-blit-x
[94.268630] Subtest intel-bb-blit-x: SUCCESS (3.149s)
[94.362712] [040/130] (925s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[94.449776] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[94.450502] Starting dynamic subtest: pipe-A-HDMI-A-1
[94.626518] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.174s)
[94.631885] Starting dynamic subtest: pipe-B-HDMI-A-1
[94.718397] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.091s)
[94.723561] Starting dynamic subtest: pipe-C-HDMI-A-1
[94.809680] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.090s)
[94.814837] Starting dynamic subtest: pipe-D-HDMI-A-1
[94.894795] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.084s)
[94.895468] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.443s)
[95.153656] [041/130] (924s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[95.192702] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[95.296642] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[95.387978] [042/130] (924s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[95.473775] Starting subtest: flip-vs-cursor-varying-size
[105.776586] Subtest flip-vs-cursor-varying-size: SUCCESS (10.268s)
[105.903467] [043/130] (914s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[105.998075] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[106.040424] [044/130] (913s left) syncobj_eventfd (timeline-wait)
[106.077327] Starting subtest: timeline-wait
[106.087153] Subtest timeline-wait: SUCCESS (0.010s)
[106.191415] [045/130] (913s left) gem_mmap_offset (isolation)
[106.227731] Starting subtest: isolation
[106.234382] Subtest isolation: SUCCESS (0.005s)
[106.361808] [046/130] (913s left) gem_mmap (basic)
[106.398635] Starting subtest: basic
[106.402511] Subtest basic: SUCCESS (0.000s)
[106.513771] [047/130] (913s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[106.607816] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[106.609217] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[106.737961] [048/130] (913s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[106.824882] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[106.825634] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.833405] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[106.841035] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.848786] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[106.855936] Starting dynamic subtest: pipe-C-HDMI-A-1
[106.863604] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[106.869856] Starting dynamic subtest: pipe-D-HDMI-A-1
[106.877868] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[106.879224] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[107.076989] [049/130] (913s left) gem_busy (busy)
[107.124589] Starting subtest: busy
[107.125329] Starting dynamic subtest: all-engines
[107.161580] Dynamic subtest all-engines: SUCCESS (0.037s)
[107.167525] Starting dynamic subtest: rcs0
[107.176827] Dynamic subtest rcs0: SUCCESS (0.015s)
[107.181985] Starting dynamic subtest: bcs0
[107.191412] Dynamic subtest bcs0: SUCCESS (0.014s)
[107.197820] Starting dynamic subtest: vcs0
[107.213662] Dynamic subtest vcs0: SUCCESS (0.022s)
[107.223324] Starting dynamic subtest: vcs1
[107.228387] Dynamic subtest vcs1: SUCCESS (0.015s)
[107.235891] Starting dynamic subtest: vecs0
[107.247049] Dynamic subtest vecs0: SUCCESS (0.018s)
[107.248058] Subtest busy: SUCCESS (0.123s)
[107.611481] [050/130] (912s left) syncobj_timeline (invalid-query-one-illegal-handle)
[107.649069] Starting subtest: invalid-query-one-illegal-handle
[107.649787] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[107.740878] [051/130] (912s left) vgem_basic (busy-fence)
[107.792516] Starting subtest: busy-fence
[107.793334] Subtest busy-fence: SUCCESS (0.000s)
[107.868458] [052/130] (912s left) fbdev (unaligned-read)
[107.925903] Starting subtest: unaligned-read
[107.935153] Subtest unaligned-read: SUCCESS (0.009s)
[108.003799] [053/130] (912s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[108.092617] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[108.093328] Starting dynamic subtest: pipe-A-valid-mode
[109.031016] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.938s)
[109.031776] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.939s)
[109.224323] [054/130] (911s left) perf_pmu (invalid-init)
[109.265192] Starting subtest: invalid-init
[109.282824] Subtest invalid-init: FAIL (0.008s)
[109.396784] [055/130] (911s left) kms_busy (extended-modeset-hang-newfb)
[109.490879] Starting subtest: extended-modeset-hang-newfb
[109.491619] Starting dynamic subtest: pipe-A
[133.862701] Dynamic subtest pipe-A: SUCCESS (24.371s)
[133.870098] Starting dynamic subtest: pipe-D
[157.913997] Dynamic subtest pipe-D: SUCCESS (24.047s)
[157.914788] Subtest extended-modeset-hang-newfb: SUCCESS (48.422s)
[158.057801] [056/130] (862s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[158.147698] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[158.148393] Starting dynamic subtest: pipe-A-HDMI-A-1
[158.151084] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[158.156501] Starting dynamic subtest: pipe-B-HDMI-A-1
[158.159269] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[158.164545] Starting dynamic subtest: pipe-C-HDMI-A-1
[158.167290] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[158.172567] Starting dynamic subtest: pipe-D-HDMI-A-1
[158.175305] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[158.176682] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[158.394524] [057/130] (862s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[158.526576] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[158.604446] [058/130] (861s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[158.692840] Starting subtest: 2x-cursor-vs-flip-legacy
[158.695790] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[158.791997] [059/130] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[158.885806] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[158.887221] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[159.014086] [060/130] (861s left) kms_cursor_legacy (single-bo)
[159.101860] Starting subtest: single-bo
[159.102597] Starting dynamic subtest: pipe-A
[164.517322] Dynamic subtest pipe-A: SUCCESS (5.381s)
[164.522776] Starting dynamic subtest: pipe-B
[169.899469] Dynamic subtest pipe-B: SUCCESS (5.381s)
[169.904893] Starting dynamic subtest: pipe-C
[175.258214] Dynamic subtest pipe-C: SUCCESS (5.381s)
[175.263624] Starting dynamic subtest: pipe-D
[180.662962] Dynamic subtest pipe-D: SUCCESS (5.381s)
[180.668436] Starting dynamic subtest: all-pipes
[186.045961] Dynamic subtest all-pipes: SUCCESS (5.381s)
[186.046882] Subtest single-bo: SUCCESS (26.908s)
[186.111871] [061/130] (834s left) gen9_exec_parse (bb-start-cmd)
[186.150075] Subtest bb-start-cmd: SKIP (0.000s)
[186.193380] [062/130] (834s left) prime_vgem (basic-fence-mmap)
[186.260376] Starting subtest: basic-fence-mmap
[186.283580] Subtest basic-fence-mmap: SUCCESS (0.023s)
[186.400823] [063/130] (834s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[186.492694] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[186.493464] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.499884] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[186.505530] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.511853] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[186.517402] Starting dynamic subtest: pipe-C-HDMI-A-1
[186.523562] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[186.528979] Starting dynamic subtest: pipe-D-HDMI-A-1
[186.534958] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[186.535655] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.010s)
[186.755170] [064/130] (834s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[186.852284] Starting subtest: x-tiled-64bpp-rotate-0
[189.537716] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.685s)
[189.758880] [065/130] (831s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[189.804092] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[189.804835] Starting dynamic subtest: smem
[189.931193] Dynamic subtest smem: SUCCESS (0.118s)
[189.931949] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.119s)
[190.103368] [066/130] (830s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[190.197170] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[190.252518] [067/130] (830s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[190.349139] Starting subtest: 4-tiled-64bpp-rotate-180
[190.350527] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[190.474936] [068/130] (830s left) gem_exec_balancer (noheartbeat)
[190.642274] Starting subtest: noheartbeat
[191.675547] Subtest noheartbeat: SUCCESS (1.029s)
[191.762222] [069/130] (829s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[191.856006] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[191.857422] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[191.974825] [070/130] (829s left) gem_mmap_gtt (medium-copy)
[192.011414] Starting subtest: medium-copy
[195.498859] Subtest medium-copy: SUCCESS (3.487s)
[195.598252] [071/130] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[195.748119] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[195.749590] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[195.864217] [072/130] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[195.972423] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[195.973813] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[196.092171] [073/130] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[196.182937] Starting subtest: psr-1p-primscrn-spr-indfb-move
[196.184390] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[196.320026] [074/130] (824s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[196.415077] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[196.416436] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[196.527345] [075/130] (824s left) prime_mmap_kms (buffer-sharing)
[196.616101] Starting subtest: buffer-sharing
[196.886852] Subtest buffer-sharing: SUCCESS (0.271s)
[197.060784] [076/130] (824s left) gem_exec_schedule (u-submit-early-slice)
[197.118236] Starting subtest: u-submit-early-slice
[197.118984] Starting dynamic subtest: rcs0
[197.145820] Dynamic subtest rcs0: SUCCESS (0.027s)
[197.151951] Starting dynamic subtest: bcs0
[197.170772] Dynamic subtest bcs0: SUCCESS (0.024s)
[197.176872] Starting dynamic subtest: vcs0
[197.196696] Dynamic subtest vcs0: SUCCESS (0.025s)
[197.202720] Starting dynamic subtest: vcs1
[197.223743] Dynamic subtest vcs1: SUCCESS (0.026s)
[197.229724] Starting dynamic subtest: vecs0
[197.250136] Dynamic subtest vecs0: SUCCESS (0.026s)
[197.250883] Subtest u-submit-early-slice: SUCCESS (0.132s)
[197.575596] [077/130] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[197.666853] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[197.668323] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[197.783921] [078/130] (823s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[197.872882] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[197.873585] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.880489] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[197.886614] Starting dynamic subtest: pipe-B-HDMI-A-1
[197.893758] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[197.899601] Starting dynamic subtest: pipe-C-HDMI-A-1
[197.906719] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[197.912396] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.919414] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[197.920817] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.007s)
[198.098361] [079/130] (823s left) gen7_exec_parse (oacontrol-tracking)
[198.139384] Subtest oacontrol-tracking: SKIP (0.000s)
[198.197252] [080/130] (823s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[198.290005] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[198.291446] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[198.401843] [081/130] (823s left) i915_module_load (resize-bar)
[198.436899] Starting subtest: resize-bar
[198.442857] Subtest resize-bar: SKIP (0.005s)
[198.503173] [082/130] (823s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[198.597968] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[199.968992] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.371s)
[200.142540] [083/130] (821s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[200.179548] Starting subtest: single-wait-all-for-submit-signaled
[200.180271] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[200.280478] [084/130] (821s left) gem_reg_read (bad-register)
[200.316899] Starting subtest: bad-register
[200.317636] Subtest bad-register: SUCCESS (0.000s)
[200.412807] [085/130] (821s left) gem_exec_params (cliprects_ptr-dirt)
[200.453555] Starting subtest: cliprects_ptr-dirt
[200.454281] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[200.565979] [086/130] (821s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[200.655731] Starting subtest: flip-vs-cursor-atomic
[209.713416] Subtest flip-vs-cursor-atomic: SUCCESS (9.048s)
[209.874546] [087/130] (811s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[209.967808] Starting subtest: fbcpsr-modesetfrombusy
[209.969313] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[210.084559] [088/130] (811s left) kms_joiner (basic-big-joiner)
[210.176327] Starting subtest: basic-big-joiner
[210.177755] Subtest basic-big-joiner: SKIP (0.000s)
[210.272818] [089/130] (811s left) gem_exec_params (rsvd2-dirt)
[210.311553] Starting subtest: rsvd2-dirt
[210.312953] Subtest rsvd2-dirt: SKIP (0.000s)
[210.425507] [090/130] (811s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[210.515946] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[210.517339] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[210.633493] [091/130] (811s left) gem_tiled_swapping (non-threaded)
[223.105665] Starting subtest: non-threaded
[225.568982] Subtest non-threaded: FAIL (2.434s)
[227.880139] [092/130] (794s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[228.032522] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[228.071924] [093/130] (793s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[228.165035] Starting subtest: fbcpsr-tiling-y
[228.166472] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[228.300992] [094/130] (793s left) kms_vblank (ts-continuation-modeset-hang)
[228.387949] Starting subtest: ts-continuation-modeset-hang
[228.388692] Starting dynamic subtest: pipe-A-HDMI-A-1
[242.855265] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.466s)
[242.865308] Starting dynamic subtest: pipe-D-HDMI-A-1
[256.665101] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.805s)
[256.665879] Subtest ts-continuation-modeset-hang: SUCCESS (28.278s)
[256.845755] [095/130] (765s left) gem_ctx_param (invalid-ctx-set)
[256.884204] Starting subtest: invalid-ctx-set
[256.884926] Subtest invalid-ctx-set: SUCCESS (0.000s)
[256.980114] [096/130] (765s left) kms_psr (fbc-psr2-dpms)
[257.068823] Subtest fbc-psr2-dpms: SKIP (0.000s)
[257.112912] [097/130] (764s left) api_intel_allocator (default-alignment)
[257.151362] Starting subtest: default-alignment
[257.153272] Subtest default-alignment: SUCCESS (0.002s)
[257.300851] [098/130] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[257.397570] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[257.398947] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[257.551391] [099/130] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[257.645889] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[257.647302] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[257.757549] [100/130] (764s left) i915_selftest (perf)
[258.937425] Starting subtest: perf
[258.938455] Starting dynamic subtest: engine_cs
[260.327192] Dynamic subtest engine_cs: SUCCESS (1.381s)
[260.335837] Starting dynamic subtest: request
[264.669274] Dynamic subtest request: SUCCESS (4.341s)
[264.677850] Starting dynamic subtest: migrate
[266.101282] Dynamic subtest migrate: SUCCESS (1.431s)
[266.110134] Starting dynamic subtest: region
[268.445363] Dynamic subtest region: SUCCESS (2.343s)
[268.446372] Subtest perf: SUCCESS (9.500s)
[268.468356] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[268.469425] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[268.472294] [101/130] (753s left) kms_psr (psr-sprite-blt)
[269.490917] Subtest psr-sprite-blt: SKIP (0.000s)
[269.576635] [FACT kms_psr (psr-sprite-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[269.578648] [FACT kms_psr (psr-sprite-blt)] new: kernel.kmod_is_loaded.i915: true
[269.580929] [102/130] (752s left) debugfs_test (read_all_entries_display_off)
[269.676057] Starting subtest: read_all_entries_display_off
[269.850478] Subtest read_all_entries_display_off: SUCCESS (0.175s)
[269.979855] [103/130] (752s left) gem_exec_fence (basic-busy-all)
[270.029221] Starting subtest: basic-busy-all
[270.083688] Subtest basic-busy-all: SUCCESS (0.054s)
[270.685730] [104/130] (751s left) kms_vrr (flipline)
[270.778854] Starting subtest: flipline
[270.780957] Subtest flipline: SKIP (0.000s)
[270.871496] [105/130] (751s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[270.969781] Starting subtest: cursor-rapid-movement-32x10
[271.026860] Subtest cursor-rapid-movement-32x10: SKIP (0.056s)
[271.158872] [106/130] (751s left) gem_userptr_blits (sync-overlap)
[271.211945] Starting subtest: sync-overlap
[271.212655] Subtest sync-overlap: SUCCESS (0.000s)
[271.347975] [107/130] (751s left) api_intel_bb (reset-bb)
[271.383861] Starting subtest: reset-bb
[271.386684] Subtest reset-bb: SUCCESS (0.003s)
[271.523815] [108/130] (751s left) gem_ctx_param (invalid-get-no-zeromap)
[271.560786] Starting subtest: invalid-get-no-zeromap
[271.561762] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[271.648950] [109/130] (750s left) gem_exec_schedule (pi-distinct-iova)
[271.825837] Starting subtest: pi-distinct-iova
[271.826804] Starting dynamic subtest: rcs0
[271.849096] Dynamic subtest rcs0: SUCCESS (0.023s)
[271.857668] Starting dynamic subtest: bcs0
[271.871906] Dynamic subtest bcs0: SUCCESS (0.021s)
[271.880884] Starting dynamic subtest: vcs0
[271.890116] Dynamic subtest vcs0: SUCCESS (0.018s)
[271.900347] Starting dynamic subtest: vcs1
[271.913709] Dynamic subtest vcs1: SUCCESS (0.023s)
[271.923198] Starting dynamic subtest: vecs0
[271.935658] Dynamic subtest vecs0: SUCCESS (0.021s)
[271.936413] Subtest pi-distinct-iova: SUCCESS (0.110s)
[272.145602] [110/130] (750s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[272.298916] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[272.379232] [111/130] (750s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[272.473086] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[274.892893] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.420s)
[275.069622] [112/130] (747s left) gem_exec_flush (basic-wb-rw-before-default)
[275.118344] Starting subtest: basic-wb-rw-before-default
[280.563717] Subtest basic-wb-rw-before-default: SUCCESS (5.445s)
[280.800092] [113/130] (741s left) gem_exec_schedule (in-order)
[280.851772] Starting subtest: in-order
[280.852468] Starting dynamic subtest: rcs0
[280.905993] Dynamic subtest rcs0: SUCCESS (0.054s)
[280.917266] Starting dynamic subtest: bcs0
[280.964604] Dynamic subtest bcs0: SUCCESS (0.057s)
[280.976334] Starting dynamic subtest: vcs0
[281.024397] Dynamic subtest vcs0: SUCCESS (0.058s)
[281.035841] Starting dynamic subtest: vcs1
[281.083740] Dynamic subtest vcs1: SUCCESS (0.058s)
[281.094822] Starting dynamic subtest: vecs0
[281.141863] Dynamic subtest vecs0: SUCCESS (0.057s)
[281.142945] Subtest in-order: SUCCESS (0.291s)
[281.466111] [114/130] (741s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[281.559941] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[281.560727] Starting dynamic subtest: pipe-A
[281.754525] Dynamic subtest pipe-A: SUCCESS (0.194s)
[281.767331] Starting dynamic subtest: pipe-B
[281.931759] Dynamic subtest pipe-B: SUCCESS (0.176s)
[281.946357] Starting dynamic subtest: pipe-C
[282.090936] Dynamic subtest pipe-C: SUCCESS (0.158s)
[282.108610] Starting dynamic subtest: pipe-D
[282.249532] Dynamic subtest pipe-D: SUCCESS (0.157s)
[282.250428] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.690s)
[282.435326] [115/130] (740s left) gem_lmem_swapping (massive)
[282.477401] Subtest massive: SKIP (0.000s)
[282.533092] [116/130] (740s left) kms_plane_scaling (intel-max-src-size)
[282.621969] Starting subtest: intel-max-src-size
[282.632883] Subtest intel-max-src-size: SKIP (0.009s)
[282.777962] [117/130] (740s left) perf (invalid-oa-format-id)
[282.894019] Starting subtest: invalid-oa-format-id
[282.911049] Subtest invalid-oa-format-id: SUCCESS (0.017s)
[282.951201] [118/130] (740s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[283.046575] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[283.055898] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.009s)
[283.154974] [119/130] (739s left) drm_fdinfo (all-busy-check-all)
[283.194100] Starting subtest: all-busy-check-all
[283.715177] Subtest all-busy-check-all: SUCCESS (0.521s)
[283.813768] [120/130] (739s left) kms_plane_alpha_blend (alpha-opaque-fb)
[283.905234] Starting subtest: alpha-opaque-fb
[284.002014] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.518783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.516s)
[284.526791] Starting dynamic subtest: pipe-D-HDMI-A-1
[285.043442] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.523s)
[285.044147] Subtest alpha-opaque-fb: SUCCESS (1.139s)
[285.225331] [121/130] (737s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[285.316854] Starting subtest: cursorA-vs-flipA-atomic
[296.176423] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.849s)
[296.347827] [122/130] (726s left) gem_set_tiling_vs_gtt
[296.846644] [123/130] (726s left) kms_flip (2x-wf_vblank-ts-check)
[296.936991] Starting subtest: 2x-wf_vblank-ts-check
[296.945302] Subtest 2x-wf_vblank-ts-check: SKIP (0.009s)
[297.058495] [124/130] (726s left) gem_mmap_wc (coherency)
[297.096934] Starting subtest: coherency
[297.172419] Subtest coherency: SUCCESS (0.076s)
[297.297947] [125/130] (725s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[297.335634] Starting subtest: cpuset-medium-copy-XY
[309.151522] Subtest cpuset-medium-copy-XY: SUCCESS (11.816s)
[309.316352] [126/130] (713s left) perf_pmu (busy-accuracy-2)
[309.405845] Starting subtest: busy-accuracy-2
[309.406609] Starting dynamic subtest: rcs0
[312.441315] Dynamic subtest rcs0: SUCCESS (3.033s)
[312.451713] Starting dynamic subtest: bcs0
[315.473251] Dynamic subtest bcs0: SUCCESS (3.030s)
[315.482378] Starting dynamic subtest: vcs0
[318.506043] Dynamic subtest vcs0: SUCCESS (3.033s)
[318.515492] Starting dynamic subtest: vcs1
[321.538995] Dynamic subtest vcs1: SUCCESS (3.032s)
[321.548078] Starting dynamic subtest: vecs0
[324.571696] Dynamic subtest vecs0: SUCCESS (3.031s)
[324.572398] Subtest busy-accuracy-2: SUCCESS (15.164s)
[324.662425] [127/130] (698s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[324.773727] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[326.744952] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (1.971s)
[326.963107] [128/130] (696s left) gem_exec_balancer (busy)
[327.008659] Starting subtest: busy
[327.557253] Subtest busy: SUCCESS (0.549s)
[327.783672] [129/130] (695s left) kms_chamelium_hpd (vga-hpd-fast)
[327.926230] Subtest vga-hpd-fast: SKIP (0.000s)
[328.009551] [130/130] (695s left) gem_exec_whisper (basic-sync)
[328.060431] Starting subtest: basic-sync
[330.494516] Subtest basic-sync: SUCCESS (2.435s)
[330.696284] Closing watchdogs
Done.