[88.723705] Initializing watchdogs
[88.723891]   /dev/watchdog0
[88.763769] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.778292] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.785432] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.793262] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[89.019728] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[91.513316] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.499s)
[91.730289] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[91.923573] Starting subtest: bo-too-small-due-to-tiling
[91.927872] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[92.097688] [003/131] (957s left) gem_tiled_pread_pwrite
[93.194743] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[93.554446] Subtest fbc-pr-dpms: SKIP (0.000s)
[93.659888] [005/131] (956s left) gen9_exec_parse (batch-zero-length)
[93.804865] Starting subtest: batch-zero-length
[93.809351] Subtest batch-zero-length: SUCCESS (0.004s)
[94.098075] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[94.209317] Starting subtest: invalid-get-no-zeromap
[94.212433] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[94.376869] [007/131] (955s left) prime_vgem (sync)
[94.626657] Starting subtest: sync
[94.631060] Starting dynamic subtest: rcs0
[94.655802] Dynamic subtest rcs0: SUCCESS (0.026s)
[94.676803] Starting dynamic subtest: vcs0
[94.683341] Dynamic subtest vcs0: SUCCESS (0.019s)
[94.703338] Starting dynamic subtest: vecs0
[94.707170] Dynamic subtest vecs0: SUCCESS (0.030s)
[94.710925] Subtest sync: SUCCESS (0.076s)
[94.897906] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[94.904678] [008/131] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[95.104674] Starting subtest: psr-rgb565-draw-mmap-cpu
[95.111357] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[95.288172] [009/131] (954s left) gem_exec_schedule (timeslicing)
[95.434427] Starting subtest: timeslicing
[95.439769] Starting dynamic subtest: rcs0
[95.444986] Dynamic subtest rcs0: SUCCESS (0.008s)
[95.466211] Starting dynamic subtest: bcs0
[95.469723] Dynamic subtest bcs0: SUCCESS (0.022s)
[95.490531] Starting dynamic subtest: vcs0
[95.494686] Dynamic subtest vcs0: SUCCESS (0.011s)
[95.524536] Starting dynamic subtest: vecs0
[95.528550] Dynamic subtest vecs0: SUCCESS (0.011s)
[95.532627] Subtest timeslicing: SUCCESS (0.058s)
[95.892294] [010/131] (954s left) gem_exec_flush (basic-uc-pro-default)
[96.023116] Starting subtest: basic-uc-pro-default
[101.439125] Subtest basic-uc-pro-default: SUCCESS (5.417s)
[101.722767] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[101.836614] Starting subtest: fork-simple-once
[101.871060] Subtest fork-simple-once: SUCCESS (0.039s)
[102.056124] [012/131] (948s left) gem_spin_batch (resubmit-all)
[102.184234] Starting subtest: resubmit-all
[102.188144] Starting dynamic subtest: rcs0
[102.198276] Dynamic subtest rcs0: SUCCESS (0.013s)
[102.218235] Starting dynamic subtest: bcs0
[102.222068] Dynamic subtest bcs0: SUCCESS (0.010s)
[102.241584] Starting dynamic subtest: vcs0
[102.245543] Dynamic subtest vcs0: SUCCESS (0.012s)
[102.264819] Starting dynamic subtest: vecs0
[102.268663] Dynamic subtest vecs0: SUCCESS (0.008s)
[102.272636] Subtest resubmit-all: SUCCESS (0.047s)
[102.539299] [013/131] (947s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[102.750329] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[102.864949] [014/131] (947s left) kms_content_protection (uevent)
[103.072622] Starting subtest: uevent
[103.114163] Subtest uevent: SKIP (0.032s)
[103.290548] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[103.414192] Subtest freq-suspend: SKIP (0.000s)
[103.531227] [016/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[103.749705] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[105.698239] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.956s)
[105.938170] [017/131] (944s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[106.157099] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[107.678747] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.521s)
[107.988391] [018/131] (942s left) sysfs_heartbeat_interval (nopreempt)
[108.109288] Starting subtest: nopreempt
[108.113114] Starting dynamic subtest: vecs0
[111.764978] Dynamic subtest vecs0: SUCCESS (3.651s)
[111.802652] Starting dynamic subtest: vcs0
[115.421718] Dynamic subtest vcs0: SUCCESS (3.654s)
[115.441921] Starting dynamic subtest: bcs0
[119.104888] Dynamic subtest bcs0: SUCCESS (3.683s)
[119.146026] Starting dynamic subtest: rcs0
[122.955291] Dynamic subtest rcs0: SUCCESS (3.848s)
[122.958713] Subtest nopreempt: SUCCESS (14.843s)
[123.125552] [019/131] (927s left) kms_lease (lease-revoke)
[123.314766] Starting subtest: lease-revoke
[123.318324] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.360212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.043s)
[123.404933] Starting dynamic subtest: pipe-A-HDMI-A-2
[123.446216] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.071s)
[123.465414] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.510469] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.065s)
[123.543834] Starting dynamic subtest: pipe-B-HDMI-A-2
[123.598311] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.056s)
[123.649433] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.654110] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.041s)
[123.675661] Starting dynamic subtest: pipe-C-HDMI-A-2
[123.678876] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.040s)
[123.681879] Subtest lease-revoke: SUCCESS (0.341s)
[123.857627] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[124.059124] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[124.065689] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[124.240414] [021/131] (927s left) perf_pmu (interrupts)
[124.360499] Starting subtest: interrupts
[125.482481] Subtest interrupts: SUCCESS (1.120s)
[125.658667] [022/131] (925s left) i915_drm_fdinfo (busy-check-all)
[125.782651] Starting subtest: busy-check-all
[125.788342] Starting dynamic subtest: rcs0
[126.312695] Dynamic subtest rcs0: SUCCESS (0.528s)
[126.334914] Starting dynamic subtest: bcs0
[126.842949] Dynamic subtest bcs0: SUCCESS (0.529s)
[126.865582] Starting dynamic subtest: vcs0
[127.366610] Dynamic subtest vcs0: SUCCESS (0.523s)
[127.388717] Starting dynamic subtest: vecs0
[127.890767] Dynamic subtest vecs0: SUCCESS (0.527s)
[127.895416] Subtest busy-check-all: SUCCESS (2.110s)
[128.056948] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[128.258843] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[128.265602] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.441865] [024/131] (923s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[128.557862] Starting subtest: multi-wait-all-for-submit-available-signaled
[128.561922] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[128.739414] [025/131] (922s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[128.941654] Starting subtest: x-tiled-32bpp-rotate-270
[129.241047] Subtest x-tiled-32bpp-rotate-270: SKIP (0.296s)
[129.525617] [026/131] (922s left) i915_suspend (forcewake)
[129.638501] Starting subtest: forcewake