[94.524968] Initializing watchdogs
[94.525243]   /dev/watchdog0
[94.567431] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.582383] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.588672] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.597054] [001/133] (960s left) syncobj_timeline (etime-single-wait-all-submitted)
[94.731422] Starting subtest: etime-single-wait-all-submitted
[94.832686] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[94.983693] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[95.208620] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[97.349308] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.144s)
[97.597116] [003/133] (957s left) kms_vblank (ts-continuation-dpms-rpm)
[97.792572] Starting subtest: ts-continuation-dpms-rpm
[97.796060] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.076747] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.281s)
[100.121516] Starting dynamic subtest: pipe-A-HDMI-A-2
[101.199877] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.007s)
[101.395376] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.018935] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.811s)
[102.084511] Starting dynamic subtest: pipe-C-HDMI-A-2
[102.741777] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.821s)
[102.748348] Subtest ts-continuation-dpms-rpm: SUCCESS (4.946s)
[103.029890] [004/133] (952s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[103.229058] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[103.235016] Starting dynamic subtest: pipe-A
[104.001948] Dynamic subtest pipe-A: SUCCESS (0.773s)
[104.043393] Starting dynamic subtest: pipe-B
[104.885823] Dynamic subtest pipe-B: SUCCESS (0.882s)
[104.924621] Starting dynamic subtest: pipe-C
[105.723130] Dynamic subtest pipe-C: SUCCESS (0.831s)
[105.727758] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.488s)
[106.267266] [005/133] (949s left) kms_psr (fbc-pr-cursor-blt)
[106.466174] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[106.582317] [006/133] (948s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[106.807934] Starting subtest: 4-tiled-64bpp-rotate-270
[106.815630] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[106.937319] [007/133] (948s left) gem_exec_fence (syncobj-timeline-export)
[107.741175] Starting subtest: syncobj-timeline-export
[107.751865] Subtest syncobj-timeline-export: SUCCESS (0.009s)
[108.026197] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[108.033339] [008/133] (947s left) i915_pm_rc6_residency (rc6-fence)
[108.141822] Starting subtest: rc6-fence
[108.150810] Starting dynamic subtest: gt0
[123.396213] Dynamic subtest gt0: SUCCESS (15.244s)
[123.401543] Subtest rc6-fence: SUCCESS (15.257s)
[123.553524] [009/133] (932s left) gem_exec_schedule (fairslice-all)
[123.698519] Starting subtest: fairslice-all
[125.816806] Subtest fairslice-all: SUCCESS (2.119s)
[126.238719] [010/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[126.452175] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[128.956216] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.510s)
[129.153152] [011/133] (926s left) perf_pmu (gt-awake)
[129.277341] Starting subtest: gt-awake
[131.838938] Subtest gt-awake: SUCCESS (2.562s)
[131.984967] [012/133] (924s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[132.187419] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[132.194659] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[132.340655] [013/133] (923s left) syncobj_wait (wait-all-interrupted)
[132.459178] Starting subtest: wait-all-interrupted
[132.561594] Subtest wait-all-interrupted: SUCCESS (0.103s)
[132.703220] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[132.919444] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[135.420101] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.505s)
[135.769974] [015/133] (920s left) gem_exec_reloc (basic-write-cpu-active)
[135.896990] Starting subtest: basic-write-cpu-active
[136.040393] Subtest basic-write-cpu-active: SUCCESS (0.143s)
[136.276122] [016/133] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[136.498077] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[139.322599] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.831s)
[139.607867] [017/133] (917s left) api_intel_bb (reset-bb)
[139.718526] Starting subtest: reset-bb
[139.727234] Subtest reset-bb: SUCCESS (0.006s)
[139.889925] [018/133] (916s left) syncobj_timeline (multi-wait-submitted-signaled)
[140.004624] Starting subtest: multi-wait-submitted-signaled
[140.008591] Subtest multi-wait-submitted-signaled: SUCCESS (0.004s)
[140.156109] [019/133] (916s left) gem_exec_schedule (preempt-queue-contexts)
[140.306976] Starting subtest: preempt-queue-contexts
[140.311229] Starting dynamic subtest: rcs0
[141.073221] Dynamic subtest rcs0: SUCCESS (0.764s)
[141.149338] Starting dynamic subtest: bcs0
[141.849200] Dynamic subtest bcs0: SUCCESS (0.771s)
[141.915024] Starting dynamic subtest: vcs0
[142.598664] Dynamic subtest vcs0: SUCCESS (0.750s)
[142.637499] Starting dynamic subtest: vecs0
[143.320077] Dynamic subtest vecs0: SUCCESS (0.725s)
[143.323748] Subtest preempt-queue-contexts: SUCCESS (3.020s)
[143.725784] [020/133] (913s left) i915_suspend (fence-restore-tiled2untiled)
[143.836274] Starting subtest: fence-restore-tiled2untiled