[91.263864] Initializing watchdogs
[91.264110]   /dev/watchdog0
[91.311092] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.325817] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.333818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.342235] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[91.579202] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[94.105943] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.530s)
[94.320047] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[94.505738] Starting subtest: bo-too-small-due-to-tiling
[94.509039] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[94.672374] [003/131] (957s left) gem_tiled_pread_pwrite
[95.952916] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[96.344879] Subtest fbc-pr-dpms: SKIP (0.000s)
[96.461150] [005/131] (955s left) gen9_exec_parse (batch-zero-length)
[96.606723] Starting subtest: batch-zero-length
[96.610563] Subtest batch-zero-length: SUCCESS (0.003s)
[96.903069] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[97.011527] Starting subtest: invalid-get-no-zeromap
[97.014667] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[97.173218] [007/131] (955s left) prime_vgem (sync)
[97.421538] Starting subtest: sync
[97.425050] Starting dynamic subtest: rcs0
[97.445685] Dynamic subtest rcs0: SUCCESS (0.025s)
[97.468892] Starting dynamic subtest: vcs0
[97.472466] Dynamic subtest vcs0: SUCCESS (0.018s)
[97.493099] Starting dynamic subtest: vecs0
[97.496423] Dynamic subtest vecs0: SUCCESS (0.017s)
[97.500071] Subtest sync: SUCCESS (0.067s)
[97.690656] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[97.697163] [008/131] (954s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[97.902731] Starting subtest: psr-rgb565-draw-mmap-cpu
[97.909411] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[98.078341] [009/131] (954s left) gem_exec_schedule (timeslicing)
[98.225175] Starting subtest: timeslicing
[98.231216] Starting dynamic subtest: rcs0
[98.234273] Dynamic subtest rcs0: SUCCESS (0.010s)
[98.257536] Starting dynamic subtest: bcs0
[98.260544] Dynamic subtest bcs0: SUCCESS (0.014s)
[98.281705] Starting dynamic subtest: vcs0
[98.285431] Dynamic subtest vcs0: SUCCESS (0.013s)
[98.312517] Starting dynamic subtest: vecs0
[98.316767] Dynamic subtest vecs0: SUCCESS (0.012s)
[98.320963] Subtest timeslicing: SUCCESS (0.055s)
[98.702225] [010/131] (953s left) gem_exec_flush (basic-uc-pro-default)
[98.827882] Starting subtest: basic-uc-pro-default
[104.245102] Subtest basic-uc-pro-default: SUCCESS (5.421s)
[104.529606] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[104.637437] Starting subtest: fork-simple-once
[104.672062] Subtest fork-simple-once: SUCCESS (0.034s)
[104.847699] [012/131] (948s left) gem_spin_batch (resubmit-all)
[104.974181] Starting subtest: resubmit-all
[104.977966] Starting dynamic subtest: rcs0
[104.986574] Dynamic subtest rcs0: SUCCESS (0.011s)
[105.007529] Starting dynamic subtest: bcs0
[105.011299] Dynamic subtest bcs0: SUCCESS (0.006s)
[105.030478] Starting dynamic subtest: vcs0
[105.034929] Dynamic subtest vcs0: SUCCESS (0.006s)
[105.054558] Starting dynamic subtest: vecs0
[105.058600] Dynamic subtest vecs0: SUCCESS (0.005s)
[105.062584] Subtest resubmit-all: SUCCESS (0.035s)
[105.314962] [013/131] (947s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[105.549075] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.648660] [014/131] (947s left) kms_content_protection (uevent)
[105.858039] Starting subtest: uevent
[105.897672] Subtest uevent: SKIP (0.031s)
[106.081686] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[106.203355] Subtest freq-suspend: SKIP (0.000s)
[106.307915] [016/131] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[106.516476] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[108.456345] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.945s)
[108.698353] [017/131] (944s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[108.910326] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[110.434011] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.525s)
[110.746183] [018/131] (942s left) sysfs_heartbeat_interval (nopreempt)
[110.860115] Starting subtest: nopreempt
[110.864122] Starting dynamic subtest: vecs0
[114.539375] Dynamic subtest vecs0: SUCCESS (3.676s)
[114.577387] Starting dynamic subtest: vcs0
[118.204338] Dynamic subtest vcs0: SUCCESS (3.664s)
[118.243639] Starting dynamic subtest: bcs0
[121.888141] Dynamic subtest bcs0: SUCCESS (3.681s)
[121.927388] Starting dynamic subtest: rcs0
[125.766571] Dynamic subtest rcs0: SUCCESS (3.878s)
[125.771036] Subtest nopreempt: SUCCESS (14.905s)
[125.975401] [019/131] (927s left) kms_lease (lease-revoke)
[126.160544] Starting subtest: lease-revoke
[126.164958] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.211364] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[126.252955] Starting dynamic subtest: pipe-A-HDMI-A-2
[126.289952] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.068s)
[126.329363] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.346338] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.050s)
[126.387323] Starting dynamic subtest: pipe-B-HDMI-A-2
[126.410200] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.057s)
[126.445348] Starting dynamic subtest: pipe-C-HDMI-A-1
[126.462825] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.046s)
[126.501456] Starting dynamic subtest: pipe-C-HDMI-A-2
[126.522137] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.048s)
[126.525408] Subtest lease-revoke: SUCCESS (0.359s)
[126.715857] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[126.930137] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[126.936810] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[127.116216] [021/131] (926s left) perf_pmu (interrupts)
[127.232207] Starting subtest: interrupts
[128.359717] Subtest interrupts: SUCCESS (1.126s)
[128.548694] [022/131] (925s left) i915_drm_fdinfo (busy-check-all)
[128.663719] Starting subtest: busy-check-all
[128.667396] Starting dynamic subtest: rcs0
[129.193041] Dynamic subtest rcs0: SUCCESS (0.532s)
[129.214326] Starting dynamic subtest: bcs0
[129.731061] Dynamic subtest bcs0: SUCCESS (0.538s)
[129.752772] Starting dynamic subtest: vcs0
[130.261264] Dynamic subtest vcs0: SUCCESS (0.527s)
[130.283176] Starting dynamic subtest: vecs0
[130.790382] Dynamic subtest vecs0: SUCCESS (0.527s)
[130.794167] Subtest busy-check-all: SUCCESS (2.128s)
[130.974319] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[131.174283] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[131.180654] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[131.363222] [024/131] (922s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[131.473545] Starting subtest: multi-wait-all-for-submit-available-signaled
[131.477322] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[131.647794] [025/131] (922s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[131.856086] Starting subtest: x-tiled-32bpp-rotate-270
[132.154616] Subtest x-tiled-32bpp-rotate-270: SKIP (0.297s)
[132.436994] [026/131] (921s left) i915_suspend (forcewake)
[132.545837] Starting subtest: forcewake