[110.761361] Initializing watchdogs
[110.761570]   /dev/watchdog0
[110.803638] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[110.818302] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[110.824670] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[110.834080] [001/133] (960s left) syncobj_timeline (etime-single-wait-all-submitted)
[110.982560] Starting subtest: etime-single-wait-all-submitted
[111.092345] Subtest etime-single-wait-all-submitted: SUCCESS (0.109s)
[111.242377] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[111.453582] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[113.543370] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.099s)
[113.760114] [003/133] (957s left) kms_vblank (ts-continuation-dpms-rpm)
[113.950490] Starting subtest: ts-continuation-dpms-rpm
[113.954494] Starting dynamic subtest: pipe-A-HDMI-A-1
[116.247244] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.290s)
[116.288630] Starting dynamic subtest: pipe-A-HDMI-A-2
[117.262638] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.010s)
[117.301849] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.136645] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.861s)
[118.170062] Starting dynamic subtest: pipe-C-HDMI-A-2
[118.988780] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.851s)
[118.992821] Subtest ts-continuation-dpms-rpm: SUCCESS (5.038s)
[119.304917] [004/133] (952s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[119.502622] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[119.506893] Starting dynamic subtest: pipe-A
[120.259076] Dynamic subtest pipe-A: SUCCESS (0.756s)
[120.298808] Starting dynamic subtest: pipe-B
[121.107193] Dynamic subtest pipe-B: SUCCESS (0.848s)
[121.149443] Starting dynamic subtest: pipe-C
[121.989083] Dynamic subtest pipe-C: SUCCESS (0.881s)
[121.992152] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.487s)
[122.567122] [005/133] (949s left) kms_psr (fbc-pr-cursor-blt)
[122.769059] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[122.883470] [006/133] (948s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[123.109813] Starting subtest: 4-tiled-64bpp-rotate-270
[123.116216] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[123.245351] [007/133] (948s left) gem_exec_fence (syncobj-timeline-export)
[124.039640] Starting subtest: syncobj-timeline-export
[124.048498] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[124.343397] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[124.350269] [008/133] (947s left) i915_pm_rc6_residency (rc6-fence)
[124.455634] Starting subtest: rc6-fence
[124.472137] Starting dynamic subtest: gt0
[139.718919] Dynamic subtest gt0: SUCCESS (15.249s)
[139.724130] Subtest rc6-fence: SUCCESS (15.264s)
[139.894202] [009/133] (932s left) gem_exec_schedule (fairslice-all)
[140.036396] Starting subtest: fairslice-all
[142.156362] Subtest fairslice-all: SUCCESS (2.124s)
[142.576995] [010/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[142.786338] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[145.252052] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.470s)
[145.447192] [011/133] (926s left) perf_pmu (gt-awake)
[145.569908] Starting subtest: gt-awake
[148.140090] Subtest gt-awake: SUCCESS (2.570s)
[148.296774] [012/133] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[148.507533] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[148.514689] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[148.667396] [013/133] (923s left) syncobj_wait (wait-all-interrupted)
[148.785973] Starting subtest: wait-all-interrupted
[148.888081] Subtest wait-all-interrupted: SUCCESS (0.103s)
[149.079977] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[149.288540] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[151.887465] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.509s)
[152.215877] [015/133] (920s left) gem_exec_reloc (basic-write-cpu-active)
[152.367109] Starting subtest: basic-write-cpu-active
[152.507458] Subtest basic-write-cpu-active: SUCCESS (0.146s)
[152.735260] [016/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[152.951508] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[155.746200] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.802s)
[156.015218] [017/133] (916s left) api_intel_bb (reset-bb)
[156.124426] Starting subtest: reset-bb
[156.135251] Subtest reset-bb: SUCCESS (0.006s)
[156.279948] [018/133] (916s left) syncobj_timeline (multi-wait-submitted-signaled)
[156.392349] Starting subtest: multi-wait-submitted-signaled
[156.397512] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s)
[156.548381] [019/133] (916s left) gem_exec_schedule (preempt-queue-contexts)
[156.696202] Starting subtest: preempt-queue-contexts
[156.700134] Starting dynamic subtest: rcs0
[157.531555] Dynamic subtest rcs0: SUCCESS (0.832s)
[157.601233] Starting dynamic subtest: bcs0
[158.327337] Dynamic subtest bcs0: SUCCESS (0.793s)
[158.355838] Starting dynamic subtest: vcs0
[159.134481] Dynamic subtest vcs0: SUCCESS (0.807s)
[159.198482] Starting dynamic subtest: vecs0
[159.925266] Dynamic subtest vecs0: SUCCESS (0.793s)
[159.928995] Subtest preempt-queue-contexts: SUCCESS (3.228s)
[160.316187] [020/133] (912s left) i915_suspend (fence-restore-tiled2untiled)
[160.431701] Starting subtest: fence-restore-tiled2untiled