[94.690222] Initializing watchdogs
[94.690418]   /dev/watchdog0
[94.731575] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.747138] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.754426] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.761190] [001/133] (960s left) syncobj_timeline (etime-single-wait-all-submitted)
[94.885979] Starting subtest: etime-single-wait-all-submitted
[94.990160] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[95.140169] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[95.344228] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[97.441451] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.096s)
[97.664953] [003/133] (957s left) kms_vblank (ts-continuation-dpms-rpm)
[97.859994] Starting subtest: ts-continuation-dpms-rpm
[97.861620] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.221835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.357s)
[100.263142] Starting dynamic subtest: pipe-A-HDMI-A-2
[101.218759] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.989s)
[101.249784] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.219267] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.989s)
[102.251317] Starting dynamic subtest: pipe-C-HDMI-A-2
[103.098378] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.874s)
[103.100492] Subtest ts-continuation-dpms-rpm: SUCCESS (5.239s)
[103.445894] [004/133] (952s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[103.630466] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[103.634249] Starting dynamic subtest: pipe-A
[104.442072] Dynamic subtest pipe-A: SUCCESS (0.811s)
[104.465653] Starting dynamic subtest: pipe-B
[105.324053] Dynamic subtest pipe-B: SUCCESS (0.881s)
[105.363522] Starting dynamic subtest: pipe-C
[106.222373] Dynamic subtest pipe-C: SUCCESS (0.897s)
[106.224102] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.593s)
[106.796284] [005/133] (948s left) kms_psr (fbc-pr-cursor-blt)
[106.999480] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[107.101810] [006/133] (948s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[107.323080] Starting subtest: 4-tiled-64bpp-rotate-270
[107.326486] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[107.461092] [007/133] (948s left) gem_exec_fence (syncobj-timeline-export)
[108.253284] Starting subtest: syncobj-timeline-export
[108.260293] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[108.535701] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[108.541401] [008/133] (947s left) i915_pm_rc6_residency (rc6-fence)
[108.650120] Starting subtest: rc6-fence
[108.663560] Starting dynamic subtest: gt0
[123.918480] Dynamic subtest gt0: SUCCESS (15.256s)
[123.920212] Subtest rc6-fence: SUCCESS (15.272s)
[124.072459] [009/133] (931s left) gem_exec_schedule (fairslice-all)
[124.211202] Starting subtest: fairslice-all
[126.329736] Subtest fairslice-all: SUCCESS (2.121s)
[126.772230] [010/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[126.973764] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[129.397062] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.425s)
[129.590365] [011/133] (926s left) perf_pmu (gt-awake)
[129.709902] Starting subtest: gt-awake
[132.274982] Subtest gt-awake: SUCCESS (2.566s)
[132.424563] [012/133] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[132.627316] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[132.630956] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[132.770844] [013/133] (923s left) syncobj_wait (wait-all-interrupted)
[132.877279] Starting subtest: wait-all-interrupted
[132.982997] Subtest wait-all-interrupted: SUCCESS (0.103s)
[133.158257] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[133.351203] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[135.827623] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.473s)
[136.121489] [015/133] (920s left) gem_exec_reloc (basic-write-cpu-active)
[136.243347] Starting subtest: basic-write-cpu-active
[136.388349] Subtest basic-write-cpu-active: SUCCESS (0.144s)
[136.624411] [016/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[136.820937] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[139.643325] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.820s)
[139.925284] [017/133] (916s left) api_intel_bb (reset-bb)
[140.033980] Starting subtest: reset-bb
[140.038473] Subtest reset-bb: SUCCESS (0.007s)
[140.190600] [018/133] (916s left) syncobj_timeline (multi-wait-submitted-signaled)
[140.299311] Starting subtest: multi-wait-submitted-signaled
[140.303327] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[140.441397] [019/133] (916s left) gem_exec_schedule (preempt-queue-contexts)
[140.583238] Starting subtest: preempt-queue-contexts
[140.587440] Starting dynamic subtest: rcs0
[141.355455] Dynamic subtest rcs0: SUCCESS (0.766s)
[141.414948] Starting dynamic subtest: bcs0
[142.088609] Dynamic subtest bcs0: SUCCESS (0.736s)
[142.158595] Starting dynamic subtest: vcs0
[142.831908] Dynamic subtest vcs0: SUCCESS (0.744s)
[142.872847] Starting dynamic subtest: vecs0
[143.563123] Dynamic subtest vecs0: SUCCESS (0.730s)
[143.567705] Subtest preempt-queue-contexts: SUCCESS (2.981s)
[143.957248] [020/133] (913s left) i915_suspend (fence-restore-tiled2untiled)
[144.059098] Starting subtest: fence-restore-tiled2untiled