[87.463196] Initializing watchdogs
[87.463366]   /dev/watchdog0
[87.503532] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.516886] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.523513] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.528799] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[87.726328] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[90.400930] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.673s)
[90.643449] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[90.813123] Starting subtest: bo-too-small-due-to-tiling
[90.814498] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[90.983711] [003/131] (957s left) gem_tiled_pread_pwrite
[92.089983] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[92.376896] Subtest fbc-pr-dpms: SKIP (0.000s)
[92.464597] [005/131] (955s left) gen9_exec_parse (batch-zero-length)
[92.580641] Starting subtest: batch-zero-length
[92.582399] Subtest batch-zero-length: SUCCESS (0.003s)
[92.871690] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[92.961332] Starting subtest: invalid-get-no-zeromap
[92.962297] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[93.112758] [007/131] (955s left) prime_vgem (sync)
[93.310041] Starting subtest: sync
[93.311545] Starting dynamic subtest: rcs0
[93.340172] Dynamic subtest rcs0: SUCCESS (0.029s)
[93.357468] Starting dynamic subtest: vcs0
[93.361075] Dynamic subtest vcs0: SUCCESS (0.021s)
[93.377755] Starting dynamic subtest: vecs0
[93.386927] Dynamic subtest vecs0: SUCCESS (0.025s)
[93.387978] Subtest sync: SUCCESS (0.078s)
[93.600247] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[93.605137] [008/131] (954s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[93.781484] Starting subtest: psr-rgb565-draw-mmap-cpu
[93.783471] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[93.960987] [009/131] (954s left) gem_exec_schedule (timeslicing)
[94.076673] Starting subtest: timeslicing
[94.077683] Starting dynamic subtest: rcs0
[94.085548] Dynamic subtest rcs0: SUCCESS (0.008s)
[94.107513] Starting dynamic subtest: bcs0
[94.108711] Dynamic subtest bcs0: SUCCESS (0.009s)
[94.125927] Starting dynamic subtest: vcs0
[94.127148] Dynamic subtest vcs0: SUCCESS (0.008s)
[94.142398] Starting dynamic subtest: vecs0
[94.143849] Dynamic subtest vecs0: SUCCESS (0.005s)
[94.145347] Subtest timeslicing: SUCCESS (0.033s)
[94.537193] [010/131] (954s left) gem_exec_flush (basic-uc-pro-default)
[94.648245] Starting subtest: basic-uc-pro-default
[100.092274] Subtest basic-uc-pro-default: SUCCESS (5.442s)
[100.376052] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[100.463796] Starting subtest: fork-simple-once
[100.495378] Subtest fork-simple-once: SUCCESS (0.032s)
[100.672574] [012/131] (948s left) gem_spin_batch (resubmit-all)
[100.782594] Starting subtest: resubmit-all
[100.783479] Starting dynamic subtest: rcs0
[100.791569] Dynamic subtest rcs0: SUCCESS (0.010s)
[100.811773] Starting dynamic subtest: bcs0
[100.813904] Dynamic subtest bcs0: SUCCESS (0.006s)
[100.830731] Starting dynamic subtest: vcs0
[100.832134] Dynamic subtest vcs0: SUCCESS (0.006s)
[100.849191] Starting dynamic subtest: vecs0
[100.850486] Dynamic subtest vecs0: SUCCESS (0.005s)
[100.851863] Subtest resubmit-all: SUCCESS (0.030s)
[101.126290] [013/131] (947s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[101.299726] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[101.392674] [014/131] (947s left) kms_content_protection (uevent)
[101.589442] Starting subtest: uevent
[101.622729] Subtest uevent: SKIP (0.026s)
[101.780873] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[101.878647] Subtest freq-suspend: SKIP (0.000s)
[101.978973] [016/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[102.151576] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[104.107274] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.955s)
[104.359708] [017/131] (945s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[104.549299] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[106.088512] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.538s)
[106.383590] [018/131] (943s left) sysfs_heartbeat_interval (nopreempt)
[106.484468] Starting subtest: nopreempt
[106.486674] Starting dynamic subtest: vecs0
[110.172646] Dynamic subtest vecs0: SUCCESS (3.686s)
[110.190444] Starting dynamic subtest: vcs0
[113.892502] Dynamic subtest vcs0: SUCCESS (3.717s)
[113.908698] Starting dynamic subtest: bcs0
[117.546189] Dynamic subtest bcs0: SUCCESS (3.652s)
[117.563020] Starting dynamic subtest: rcs0
[121.433167] Dynamic subtest rcs0: SUCCESS (3.886s)
[121.434183] Subtest nopreempt: SUCCESS (14.947s)
[121.585498] [019/131] (927s left) kms_lease (lease-revoke)
[121.751850] Starting subtest: lease-revoke
[121.752971] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.806100] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s)
[121.824970] Starting dynamic subtest: pipe-A-HDMI-A-2
[121.856886] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.050s)
[121.885012] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.908355] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.050s)
[121.928179] Starting dynamic subtest: pipe-B-HDMI-A-2
[121.961060] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.052s)
[121.994242] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.024089] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.055s)
[122.040839] Starting dynamic subtest: pipe-C-HDMI-A-2
[122.078038] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.051s)
[122.079521] Subtest lease-revoke: SUCCESS (0.328s)
[122.252796] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[122.431588] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[122.433431] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[122.601924] [021/131] (927s left) perf_pmu (interrupts)
[122.699937] Starting subtest: interrupts
[123.827199] Subtest interrupts: SUCCESS (1.127s)
[124.019343] [022/131] (925s left) i915_drm_fdinfo (busy-check-all)
[124.116555] Starting subtest: busy-check-all
[124.117492] Starting dynamic subtest: rcs0
[124.649452] Dynamic subtest rcs0: SUCCESS (0.533s)
[124.667635] Starting dynamic subtest: bcs0
[125.184167] Dynamic subtest bcs0: SUCCESS (0.534s)
[125.202174] Starting dynamic subtest: vcs0
[125.717320] Dynamic subtest vcs0: SUCCESS (0.532s)
[125.735166] Starting dynamic subtest: vecs0
[126.247535] Dynamic subtest vecs0: SUCCESS (0.529s)
[126.249267] Subtest busy-check-all: SUCCESS (2.132s)
[126.416968] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[126.590783] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[126.592784] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.770440] [024/131] (923s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[126.861589] Starting subtest: multi-wait-all-for-submit-available-signaled
[126.863849] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[127.028849] [025/131] (923s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[127.207521] Starting subtest: x-tiled-32bpp-rotate-270
[127.489224] Subtest x-tiled-32bpp-rotate-270: SKIP (0.280s)
[127.755371] [026/131] (922s left) i915_suspend (forcewake)
[127.844988] Starting subtest: forcewake