[86.952202] Initializing watchdogs
[86.952421]   /dev/watchdog0
[86.989862] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.004847] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.012794] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.018616] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[87.226177] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[89.708787] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.483s)
[89.919277] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[90.101328] Starting subtest: bo-too-small-due-to-tiling
[90.102984] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[90.264727] [003/131] (957s left) gem_tiled_pread_pwrite
[91.340050] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[91.655750] Subtest fbc-pr-dpms: SKIP (0.000s)
[91.770837] [005/131] (956s left) gen9_exec_parse (batch-zero-length)
[91.901192] Starting subtest: batch-zero-length
[91.904679] Subtest batch-zero-length: SUCCESS (0.003s)
[92.185731] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[92.287796] Starting subtest: invalid-get-no-zeromap
[92.290693] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[92.454323] [007/131] (955s left) prime_vgem (sync)
[92.683651] Starting subtest: sync
[92.685169] Starting dynamic subtest: rcs0
[92.706787] Dynamic subtest rcs0: SUCCESS (0.022s)
[92.726055] Starting dynamic subtest: vcs0
[92.727674] Dynamic subtest vcs0: SUCCESS (0.019s)
[92.748136] Starting dynamic subtest: vecs0
[92.749780] Dynamic subtest vecs0: SUCCESS (0.011s)
[92.751298] Subtest sync: SUCCESS (0.056s)
[92.923172] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[92.928265] [008/131] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[93.123997] Starting subtest: psr-rgb565-draw-mmap-cpu
[93.127170] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[93.308295] [009/131] (954s left) gem_exec_schedule (timeslicing)
[93.436100] Starting subtest: timeslicing
[93.438458] Starting dynamic subtest: rcs0
[93.452302] Dynamic subtest rcs0: SUCCESS (0.014s)
[93.470164] Starting dynamic subtest: bcs0
[93.471861] Dynamic subtest bcs0: SUCCESS (0.014s)
[93.490752] Starting dynamic subtest: vcs0
[93.492393] Dynamic subtest vcs0: SUCCESS (0.015s)
[93.513270] Starting dynamic subtest: vecs0
[93.515332] Dynamic subtest vecs0: SUCCESS (0.012s)
[93.517748] Subtest timeslicing: SUCCESS (0.061s)
[93.910881] [010/131] (954s left) gem_exec_flush (basic-uc-pro-default)
[94.034849] Starting subtest: basic-uc-pro-default
[99.454694] Subtest basic-uc-pro-default: SUCCESS (5.419s)
[99.743129] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[99.843634] Starting subtest: fork-simple-once
[99.879078] Subtest fork-simple-once: SUCCESS (0.035s)
[100.047874] [012/131] (948s left) gem_spin_batch (resubmit-all)
[100.169188] Starting subtest: resubmit-all
[100.171049] Starting dynamic subtest: rcs0
[100.182479] Dynamic subtest rcs0: SUCCESS (0.013s)
[100.203383] Starting dynamic subtest: bcs0
[100.205315] Dynamic subtest bcs0: SUCCESS (0.011s)
[100.224551] Starting dynamic subtest: vcs0
[100.226761] Dynamic subtest vcs0: SUCCESS (0.009s)
[100.258280] Starting dynamic subtest: vecs0
[100.260323] Dynamic subtest vecs0: SUCCESS (0.009s)
[100.262057] Subtest resubmit-all: SUCCESS (0.046s)
[100.514714] [013/131] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[100.698852] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[100.789278] [014/131] (947s left) kms_content_protection (uevent)
[100.985741] Starting subtest: uevent
[101.033390] Subtest uevent: SKIP (0.042s)
[101.211771] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[101.324240] Subtest freq-suspend: SKIP (0.000s)
[101.453911] [016/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[101.639304] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[103.526640] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.889s)
[103.763200] [017/131] (945s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[103.959133] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[105.440917] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.480s)
[105.742190] [018/131] (943s left) sysfs_heartbeat_interval (nopreempt)
[105.851332] Starting subtest: nopreempt
[105.856489] Starting dynamic subtest: vecs0
[109.499097] Dynamic subtest vecs0: SUCCESS (3.645s)
[109.570339] Starting dynamic subtest: vcs0
[113.132133] Dynamic subtest vcs0: SUCCESS (3.632s)
[113.168974] Starting dynamic subtest: bcs0
[116.792672] Dynamic subtest bcs0: SUCCESS (3.659s)
[116.827897] Starting dynamic subtest: rcs0
[120.600967] Dynamic subtest rcs0: SUCCESS (3.805s)
[120.603078] Subtest nopreempt: SUCCESS (14.749s)
[120.777985] [019/131] (928s left) kms_lease (lease-revoke)
[120.970952] Starting subtest: lease-revoke
[120.974960] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.025820] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s)
[121.096323] Starting dynamic subtest: pipe-A-HDMI-A-2
[121.124058] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.090s)
[121.163068] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.212178] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.085s)
[121.269427] Starting dynamic subtest: pipe-B-HDMI-A-2
[121.301676] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.080s)
[121.347932] Starting dynamic subtest: pipe-C-HDMI-A-1
[121.369043] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.063s)
[121.424575] Starting dynamic subtest: pipe-C-HDMI-A-2
[121.451982] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.068s)
[121.453763] Subtest lease-revoke: SUCCESS (0.475s)
[121.629984] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[121.840118] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[121.844436] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[122.011791] [021/131] (927s left) perf_pmu (interrupts)
[122.118926] Starting subtest: interrupts
[123.232963] Subtest interrupts: SUCCESS (1.111s)
[123.418061] [022/131] (925s left) i915_drm_fdinfo (busy-check-all)
[123.522876] Starting subtest: busy-check-all
[123.528444] Starting dynamic subtest: rcs0
[124.051304] Dynamic subtest rcs0: SUCCESS (0.524s)
[124.072127] Starting dynamic subtest: bcs0
[124.578085] Dynamic subtest bcs0: SUCCESS (0.528s)
[124.598279] Starting dynamic subtest: vcs0
[125.107935] Dynamic subtest vcs0: SUCCESS (0.529s)
[125.129367] Starting dynamic subtest: vecs0
[125.639922] Dynamic subtest vecs0: SUCCESS (0.529s)
[125.641472] Subtest busy-check-all: SUCCESS (2.115s)
[125.815494] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[126.006495] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[126.009824] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.196584] [024/131] (923s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[126.304249] Starting subtest: multi-wait-all-for-submit-available-signaled
[126.307235] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.003s)
[126.482428] [025/131] (923s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[126.681241] Starting subtest: x-tiled-32bpp-rotate-270
[126.979514] Subtest x-tiled-32bpp-rotate-270: SKIP (0.298s)
[127.247363] [026/131] (922s left) i915_suspend (forcewake)
[127.346923] Starting subtest: forcewake