[95.943198] Initializing watchdogs
[95.943389]   /dev/watchdog0
[95.985401] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[96.000393] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.006747] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.014557] [001/133] (960s left) syncobj_timeline (etime-single-wait-all-submitted)
[96.150822] Starting subtest: etime-single-wait-all-submitted
[96.257371] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[96.420546] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[96.638109] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[98.910382] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.284s)
[99.162336] [003/133] (957s left) kms_vblank (ts-continuation-dpms-rpm)
[99.382513] Starting subtest: ts-continuation-dpms-rpm
[99.386207] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.630295] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.241s)
[101.655785] Starting dynamic subtest: pipe-A-HDMI-A-2
[102.638247] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.001s)
[102.668341] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.466086] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.818s)
[103.506081] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.347865] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.872s)
[104.353091] Subtest ts-continuation-dpms-rpm: SUCCESS (4.958s)
[104.631792] [004/133] (952s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[104.829243] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[104.834363] Starting dynamic subtest: pipe-A
[105.584113] Dynamic subtest pipe-A: SUCCESS (0.761s)
[105.625937] Starting dynamic subtest: pipe-B
[106.461494] Dynamic subtest pipe-B: SUCCESS (0.875s)
[106.505079] Starting dynamic subtest: pipe-C
[107.293575] Dynamic subtest pipe-C: SUCCESS (0.830s)
[107.297934] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.470s)
[107.831368] [005/133] (949s left) kms_psr (fbc-pr-cursor-blt)
[108.035071] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[108.138743] [006/133] (948s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[108.356721] Starting subtest: 4-tiled-64bpp-rotate-270
[108.363859] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[108.511262] [007/133] (948s left) gem_exec_fence (syncobj-timeline-export)
[109.303148] Starting subtest: syncobj-timeline-export
[109.310595] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[109.584851] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[109.592292] [008/133] (947s left) i915_pm_rc6_residency (rc6-fence)
[109.703554] Starting subtest: rc6-fence
[109.713628] Starting dynamic subtest: gt0
[124.951091] Dynamic subtest gt0: SUCCESS (15.240s)
[124.954481] Subtest rc6-fence: SUCCESS (15.254s)
[125.094659] [009/133] (932s left) gem_exec_schedule (fairslice-all)
[125.232900] Starting subtest: fairslice-all
[127.349589] Subtest fairslice-all: SUCCESS (2.119s)
[127.774139] [010/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[127.985647] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[130.447623] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.465s)
[130.645975] [011/133] (926s left) perf_pmu (gt-awake)
[130.771581] Starting subtest: gt-awake
[133.337104] Subtest gt-awake: SUCCESS (2.563s)
[133.494219] [012/133] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[133.700113] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[133.706102] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[133.866219] [013/133] (923s left) syncobj_wait (wait-all-interrupted)
[133.980751] Starting subtest: wait-all-interrupted
[134.089304] Subtest wait-all-interrupted: SUCCESS (0.107s)
[134.244657] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[134.458516] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[136.943788] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.493s)
[137.248246] [015/133] (920s left) gem_exec_reloc (basic-write-cpu-active)
[137.369775] Starting subtest: basic-write-cpu-active
[137.516486] Subtest basic-write-cpu-active: SUCCESS (0.145s)
[137.765406] [016/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[137.964197] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[140.781058] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.817s)
[141.076717] [017/133] (917s left) api_intel_bb (reset-bb)
[141.187801] Starting subtest: reset-bb
[141.192712] Subtest reset-bb: SUCCESS (0.007s)
[141.362277] [018/133] (916s left) syncobj_timeline (multi-wait-submitted-signaled)
[141.476297] Starting subtest: multi-wait-submitted-signaled
[141.481659] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[141.630883] [019/133] (916s left) gem_exec_schedule (preempt-queue-contexts)
[141.777265] Starting subtest: preempt-queue-contexts
[141.780546] Starting dynamic subtest: rcs0
[142.558547] Dynamic subtest rcs0: SUCCESS (0.779s)
[142.589443] Starting dynamic subtest: bcs0
[143.420415] Dynamic subtest bcs0: SUCCESS (0.862s)
[143.447715] Starting dynamic subtest: vcs0
[144.176449] Dynamic subtest vcs0: SUCCESS (0.756s)
[144.212958] Starting dynamic subtest: vecs0
[144.998604] Dynamic subtest vecs0: SUCCESS (0.824s)
[145.002251] Subtest preempt-queue-contexts: SUCCESS (3.226s)
[145.433438] [020/133] (913s left) i915_suspend (fence-restore-tiled2untiled)
[145.548922] Starting subtest: fence-restore-tiled2untiled