[87.329790] Initializing watchdogs
[87.329959]   /dev/watchdog0
[87.381805] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.397119] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.404272] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.413583] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[87.638366] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[90.075254] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.440s)
[90.287950] [002/131] (957s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[90.464875] Starting subtest: bo-too-small-due-to-tiling
[90.468391] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[90.638833] [003/131] (957s left) gem_tiled_pread_pwrite
[91.709884] [004/131] (956s left) kms_psr (fbc-pr-dpms)
[92.056376] Subtest fbc-pr-dpms: SKIP (0.000s)
[92.151292] [005/131] (956s left) gen9_exec_parse (batch-zero-length)
[92.282807] Starting subtest: batch-zero-length
[92.286491] Subtest batch-zero-length: SUCCESS (0.003s)
[92.575094] [006/131] (955s left) gem_ctx_param (invalid-get-no-zeromap)
[92.680490] Starting subtest: invalid-get-no-zeromap
[92.684129] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[92.865729] [007/131] (955s left) prime_vgem (sync)
[93.083657] Starting subtest: sync
[93.087566] Starting dynamic subtest: rcs0
[93.110760] Dynamic subtest rcs0: SUCCESS (0.023s)
[93.137264] Starting dynamic subtest: vcs0
[93.140883] Dynamic subtest vcs0: SUCCESS (0.019s)
[93.164144] Starting dynamic subtest: vecs0
[93.167424] Dynamic subtest vecs0: SUCCESS (0.023s)
[93.171225] Subtest sync: SUCCESS (0.070s)
[93.341222] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[93.347515] [008/131] (955s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[93.552160] Starting subtest: psr-rgb565-draw-mmap-cpu
[93.558722] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[93.728983] [009/131] (954s left) gem_exec_schedule (timeslicing)
[93.863363] Starting subtest: timeslicing
[93.867376] Starting dynamic subtest: rcs0
[93.871499] Dynamic subtest rcs0: SUCCESS (0.009s)
[93.895303] Starting dynamic subtest: bcs0
[93.899681] Dynamic subtest bcs0: SUCCESS (0.012s)
[93.920272] Starting dynamic subtest: vcs0
[93.924228] Dynamic subtest vcs0: SUCCESS (0.010s)
[93.943598] Starting dynamic subtest: vecs0
[93.947598] Dynamic subtest vecs0: SUCCESS (0.020s)
[93.951454] Subtest timeslicing: SUCCESS (0.053s)
[94.328705] [010/131] (954s left) gem_exec_flush (basic-uc-pro-default)
[94.449207] Starting subtest: basic-uc-pro-default
[99.860885] Subtest basic-uc-pro-default: SUCCESS (5.412s)
[100.163934] [011/131] (948s left) api_intel_allocator (fork-simple-once)
[100.272542] Starting subtest: fork-simple-once
[100.300276] Subtest fork-simple-once: SUCCESS (0.033s)
[100.503891] [012/131] (948s left) gem_spin_batch (resubmit-all)
[100.628348] Starting subtest: resubmit-all
[100.632637] Starting dynamic subtest: rcs0
[100.641694] Dynamic subtest rcs0: SUCCESS (0.012s)
[100.662402] Starting dynamic subtest: bcs0
[100.665591] Dynamic subtest bcs0: SUCCESS (0.007s)
[100.684923] Starting dynamic subtest: vcs0
[100.688912] Dynamic subtest vcs0: SUCCESS (0.005s)
[100.708480] Starting dynamic subtest: vecs0
[100.712445] Dynamic subtest vecs0: SUCCESS (0.005s)
[100.716526] Subtest resubmit-all: SUCCESS (0.031s)
[100.966895] [013/131] (948s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[101.197097] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[101.292379] [014/131] (947s left) kms_content_protection (uevent)
[101.508619] Starting subtest: uevent
[101.544128] Subtest uevent: SKIP (0.035s)
[101.728427] [015/131] (947s left) i915_pm_freq_api (freq-suspend)
[101.839764] Subtest freq-suspend: SKIP (0.000s)
[101.957979] [016/131] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[102.157884] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[104.092310] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.936s)
[104.328709] [017/131] (945s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[104.530886] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[106.071615] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.542s)
[106.362138] [018/131] (943s left) sysfs_heartbeat_interval (nopreempt)
[106.473621] Starting subtest: nopreempt
[106.477577] Starting dynamic subtest: vecs0
[110.106597] Dynamic subtest vecs0: SUCCESS (3.628s)
[110.142234] Starting dynamic subtest: vcs0
[113.720696] Dynamic subtest vcs0: SUCCESS (3.614s)
[113.790040] Starting dynamic subtest: bcs0
[117.336936] Dynamic subtest bcs0: SUCCESS (3.616s)
[117.376667] Starting dynamic subtest: rcs0
[121.085441] Dynamic subtest rcs0: SUCCESS (3.747s)
[121.088831] Subtest nopreempt: SUCCESS (14.609s)
[121.265488] [019/131] (928s left) kms_lease (lease-revoke)
[121.445021] Starting subtest: lease-revoke
[121.448368] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.500941] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.041s)
[121.533319] Starting dynamic subtest: pipe-A-HDMI-A-2
[121.558216] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.070s)
[121.598418] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.614457] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.047s)
[121.650322] Starting dynamic subtest: pipe-B-HDMI-A-2
[121.669976] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.053s)
[121.711068] Starting dynamic subtest: pipe-C-HDMI-A-1
[121.726147] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.049s)
[121.768939] Starting dynamic subtest: pipe-C-HDMI-A-2
[121.786321] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.045s)
[121.791284] Subtest lease-revoke: SUCCESS (0.340s)
[121.967112] [020/131] (927s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[122.173969] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[122.180917] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[122.350211] [021/131] (927s left) perf_pmu (interrupts)
[122.463774] Starting subtest: interrupts
[123.561608] Subtest interrupts: SUCCESS (1.099s)
[123.750132] [022/131] (926s left) i915_drm_fdinfo (busy-check-all)
[123.860676] Starting subtest: busy-check-all
[123.864290] Starting dynamic subtest: rcs0
[124.389705] Dynamic subtest rcs0: SUCCESS (0.528s)
[124.411231] Starting dynamic subtest: bcs0
[124.917652] Dynamic subtest bcs0: SUCCESS (0.526s)
[124.939175] Starting dynamic subtest: vcs0
[125.442586] Dynamic subtest vcs0: SUCCESS (0.524s)
[125.464049] Starting dynamic subtest: vecs0
[125.970503] Dynamic subtest vecs0: SUCCESS (0.528s)
[125.974253] Subtest busy-check-all: SUCCESS (2.110s)
[126.149198] [023/131] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[126.345678] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[126.352678] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[126.530759] [024/131] (923s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[126.639514] Starting subtest: multi-wait-all-for-submit-available-signaled
[126.643231] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s)
[126.813932] [025/131] (923s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[127.012057] Starting subtest: x-tiled-32bpp-rotate-270
[127.297526] Subtest x-tiled-32bpp-rotate-270: SKIP (0.283s)
[127.567564] [026/131] (922s left) i915_suspend (forcewake)
[127.676330] Starting subtest: forcewake