[89.280585] Initializing watchdogs
[89.280805]   /dev/watchdog0
[89.318494] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.332911] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.341391] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.347183] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[89.556581] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[92.066394] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.510s)
[92.278149] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[92.463644] Starting subtest: bo-too-small-due-to-tiling
[92.465385] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[92.622924] [003/131] (957s left) gem_tiled_pread_pwrite
[93.693529] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[94.037780] Subtest fbc-pr-dpms: SKIP (0.000s)
[94.134986] [005/131] (956s left) gen9_exec_parse (batch-zero-length)
[94.268725] Starting subtest: batch-zero-length
[94.273233] Subtest batch-zero-length: SUCCESS (0.004s)
[94.558846] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[94.658691] Starting subtest: invalid-get-no-zeromap
[94.660375] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[94.825320] [007/131] (955s left) prime_vgem (sync)
[95.064739] Starting subtest: sync
[95.066826] Starting dynamic subtest: rcs0
[95.093676] Dynamic subtest rcs0: SUCCESS (0.028s)
[95.136175] Starting dynamic subtest: vcs0
[95.137778] Dynamic subtest vcs0: SUCCESS (0.039s)
[95.159058] Starting dynamic subtest: vecs0
[95.172386] Dynamic subtest vecs0: SUCCESS (0.042s)
[95.173924] Subtest sync: SUCCESS (0.112s)
[95.363632] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[95.368346] [008/131] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[95.559273] Starting subtest: psr-rgb565-draw-mmap-cpu
[95.562320] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[95.715882] [009/131] (954s left) gem_exec_schedule (timeslicing)
[95.847515] Starting subtest: timeslicing
[95.849049] Starting dynamic subtest: rcs0
[95.860831] Dynamic subtest rcs0: SUCCESS (0.011s)
[95.882159] Starting dynamic subtest: bcs0
[95.883972] Dynamic subtest bcs0: SUCCESS (0.013s)
[95.904429] Starting dynamic subtest: vcs0
[95.906265] Dynamic subtest vcs0: SUCCESS (0.011s)
[95.924695] Starting dynamic subtest: vecs0
[95.927220] Dynamic subtest vecs0: SUCCESS (0.011s)
[95.929689] Subtest timeslicing: SUCCESS (0.052s)
[96.321163] [010/131] (954s left) gem_exec_flush (basic-uc-pro-default)
[96.447378] Starting subtest: basic-uc-pro-default
[101.861076] Subtest basic-uc-pro-default: SUCCESS (5.412s)
[102.153995] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[102.257910] Starting subtest: fork-simple-once
[102.291619] Subtest fork-simple-once: SUCCESS (0.034s)
[102.470176] [012/131] (948s left) gem_spin_batch (resubmit-all)
[102.589297] Starting subtest: resubmit-all
[102.591068] Starting dynamic subtest: rcs0
[102.599828] Dynamic subtest rcs0: SUCCESS (0.011s)
[102.624962] Starting dynamic subtest: bcs0
[102.626563] Dynamic subtest bcs0: SUCCESS (0.006s)
[102.646314] Starting dynamic subtest: vcs0
[102.648401] Dynamic subtest vcs0: SUCCESS (0.006s)
[102.671329] Starting dynamic subtest: vecs0
[102.673361] Dynamic subtest vecs0: SUCCESS (0.005s)
[102.675244] Subtest resubmit-all: SUCCESS (0.031s)
[102.922158] [013/131] (947s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[103.121243] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[103.212856] [014/131] (947s left) kms_content_protection (uevent)
[103.412571] Starting subtest: uevent
[103.456345] Subtest uevent: SKIP (0.039s)
[103.635814] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[103.745890] Subtest freq-suspend: SKIP (0.000s)
[103.849108] [016/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[104.038301] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[105.952431] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.913s)
[106.190509] [017/131] (945s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[106.408244] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[107.917836] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.504s)
[108.201358] [018/131] (943s left) sysfs_heartbeat_interval (nopreempt)
[108.315280] Starting subtest: nopreempt
[108.316863] Starting dynamic subtest: vecs0
[111.958199] Dynamic subtest vecs0: SUCCESS (3.641s)
[111.993301] Starting dynamic subtest: vcs0
[115.593202] Dynamic subtest vcs0: SUCCESS (3.636s)
[115.629833] Starting dynamic subtest: bcs0
[119.230430] Dynamic subtest bcs0: SUCCESS (3.635s)
[119.267111] Starting dynamic subtest: rcs0
[123.014550] Dynamic subtest rcs0: SUCCESS (3.784s)
[123.016410] Subtest nopreempt: SUCCESS (14.702s)
[123.186844] [019/131] (928s left) kms_lease (lease-revoke)
[123.376611] Starting subtest: lease-revoke
[123.381562] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.435895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s)
[123.468903] Starting dynamic subtest: pipe-A-HDMI-A-2
[123.508609] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.065s)
[123.563362] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.585744] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.073s)
[123.644219] Starting dynamic subtest: pipe-B-HDMI-A-2
[123.669189] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.050s)
[123.720342] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.739173] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.065s)
[123.775741] Starting dynamic subtest: pipe-C-HDMI-A-2
[123.809559] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.047s)
[123.811927] Subtest lease-revoke: SUCCESS (0.431s)
[123.987691] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[124.189611] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[124.192731] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[124.370421] [021/131] (927s left) perf_pmu (interrupts)
[124.482593] Starting subtest: interrupts
[125.600649] Subtest interrupts: SUCCESS (1.114s)
[125.771235] [022/131] (925s left) i915_drm_fdinfo (busy-check-all)
[125.877488] Starting subtest: busy-check-all
[125.879423] Starting dynamic subtest: rcs0
[126.404050] Dynamic subtest rcs0: SUCCESS (0.527s)
[126.423872] Starting dynamic subtest: bcs0
[126.929789] Dynamic subtest bcs0: SUCCESS (0.524s)
[126.949439] Starting dynamic subtest: vcs0
[127.458869] Dynamic subtest vcs0: SUCCESS (0.529s)
[127.478761] Starting dynamic subtest: vecs0
[127.990093] Dynamic subtest vecs0: SUCCESS (0.530s)
[127.991711] Subtest busy-check-all: SUCCESS (2.113s)
[128.174823] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[128.363145] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[128.367276] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.536712] [024/131] (923s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[128.640269] Starting subtest: multi-wait-all-for-submit-available-signaled
[128.642369] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[128.806843] [025/131] (923s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[128.997479] Starting subtest: x-tiled-32bpp-rotate-270
[129.293605] Subtest x-tiled-32bpp-rotate-270: SKIP (0.295s)
[129.591608] [026/131] (922s left) i915_suspend (forcewake)
[129.695863] Starting subtest: forcewake