[94.369343] Initializing watchdogs
[94.369536]   /dev/watchdog0
[94.409912] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.424915] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.432674] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.438818] [001/133] (960s left) fbdev (info)
[94.551742] Starting subtest: info
[94.554222] Subtest info: SUCCESS (0.000s)
[94.706401] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[94.914258] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[94.922184] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[95.058088] [003/133] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[95.271751] Starting subtest: yf-tiled-8bpp-rotate-180
[95.277064] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[95.436057] [004/133] (959s left) vgem_basic (unload)
[95.532547] Starting subtest: unload
[124.566900] Subtest unload: SUCCESS (29.016s)
[124.763803] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[124.769297] [005/133] (930s left) api_intel_bb (intel-bb-blit-none)
[124.878590] Starting subtest: intel-bb-blit-none
[128.587230] Subtest intel-bb-blit-none: SUCCESS (3.713s)
[128.751163] [006/133] (926s left) kms_psr (pr-dpms)
[128.948054] Subtest pr-dpms: SKIP (0.000s)
[129.055073] [007/133] (926s left) syncobj_timeline (etime-multi-wait-all-submitted)
[129.163706] Starting subtest: etime-multi-wait-all-submitted
[129.276528] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s)
[129.420200] [008/133] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[129.620644] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[129.625231] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[129.767397] [009/133] (925s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[129.962875] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[129.966747] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[130.115834] [010/133] (925s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[130.310212] Starting subtest: plane-primary-overlay-mutable-zpos
[131.389506] Subtest plane-primary-overlay-mutable-zpos: SKIP (1.072s)
[131.960489] [011/133] (923s left) sysfs_timeslice_duration (timeout)
[132.084142] Starting subtest: timeout
[132.085877] Starting dynamic subtest: vecs0
[132.927138] Dynamic subtest vecs0: SUCCESS (0.841s)
[132.957418] Starting dynamic subtest: vcs0
[133.760076] Dynamic subtest vcs0: SUCCESS (0.833s)
[133.782708] Starting dynamic subtest: bcs0
[134.603667] Dynamic subtest bcs0: SUCCESS (0.843s)
[134.621732] Starting dynamic subtest: rcs0
[135.463213] Dynamic subtest rcs0: SUCCESS (0.859s)
[135.465135] Subtest timeout: SUCCESS (3.383s)
[135.612499] [012/133] (920s left) gem_exec_reloc (basic-cpu-read-active)
[135.728123] Starting subtest: basic-cpu-read-active
[135.870275] Subtest basic-cpu-read-active: SUCCESS (0.141s)
[136.081887] [013/133] (919s left) gem_userptr_blits (huge-split)
[136.245042] Starting subtest: huge-split
[136.253764] Subtest huge-split: SUCCESS (0.011s)
[136.417961] [014/133] (919s left) gem_exec_schedule (submit-late-slice)
[136.556425] Starting subtest: submit-late-slice
[136.558462] Starting dynamic subtest: rcs0
[136.606843] Dynamic subtest rcs0: SUCCESS (0.053s)
[136.632717] Starting dynamic subtest: bcs0
[136.657457] Dynamic subtest bcs0: SUCCESS (0.049s)
[136.683798] Starting dynamic subtest: vcs0
[136.704451] Dynamic subtest vcs0: SUCCESS (0.045s)
[136.732578] Starting dynamic subtest: vecs0
[136.753875] Dynamic subtest vecs0: SUCCESS (0.045s)
[136.756352] Subtest submit-late-slice: SUCCESS (0.199s)
[137.152117] [015/133] (919s left) i915_drm_fdinfo (virtual-idle)
[137.260857] Starting subtest: virtual-idle
[139.294291] Subtest virtual-idle: SUCCESS (2.030s)
[139.468971] [016/133] (916s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[139.655497] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[142.161071] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.502s)
[142.465270] [017/133] (913s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[142.649164] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[142.758507] [018/133] (913s left) kms_psr (psr2-sprite-mmap-gtt)
[142.948784] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[143.059275] [019/133] (913s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[143.241099] Starting subtest: cursor-vs-flip-varying-size
[188.930909] Subtest cursor-vs-flip-varying-size: SUCCESS (45.689s)
[189.268923] [020/133] (867s left) gem_exec_async (concurrent-writes)
[189.397087] Starting subtest: concurrent-writes
[189.400761] Starting dynamic subtest: rcs0
[189.415167] Dynamic subtest rcs0: SUCCESS (0.018s)
[189.435953] Starting dynamic subtest: bcs0
[189.437661] Dynamic subtest bcs0: SUCCESS (0.019s)
[189.455897] Starting dynamic subtest: vcs0
[189.457790] Dynamic subtest vcs0: SUCCESS (0.015s)
[189.476115] Starting dynamic subtest: vecs0
[189.478172] Dynamic subtest vecs0: SUCCESS (0.019s)
[189.480685] Subtest concurrent-writes: SUCCESS (0.074s)
[189.752974] [021/133] (867s left) i915_drm_fdinfo (memory-info-resident)
[189.861084] Starting subtest: memory-info-resident
[189.863079] Starting dynamic subtest: smem0
[190.923046] Dynamic subtest smem0: SUCCESS (1.062s)
[190.924702] Subtest memory-info-resident: SUCCESS (1.063s)
[191.065518] [022/133] (865s left) kms_dsc (dsc-with-bpc)
[191.253654] Subtest dsc-with-bpc: SKIP (0.000s)
[191.355076] [023/133] (865s left) gem_ctx_exec (basic)
[191.464365] Starting subtest: basic
[191.469972] Subtest basic: SUCCESS (0.006s)
[191.617044] [024/133] (865s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[191.794065] Starting subtest: 2x-flip-vs-cursor-legacy
[192.590140] Subtest 2x-flip-vs-cursor-legacy: SUCCESS (0.793s)
[192.917860] [025/133] (864s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[193.105052] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[193.360189] Starting dynamic subtest: pipe-A-plane-0
[194.076140] Dynamic subtest pipe-A-plane-0: SUCCESS (0.715s)
[194.095417] Starting dynamic subtest: pipe-A-plane-1
[194.775374] Dynamic subtest pipe-A-plane-1: SUCCESS (0.699s)
[194.794529] Starting dynamic subtest: pipe-A-plane-2
[195.225759] Dynamic subtest pipe-A-plane-2: SUCCESS (0.449s)
[195.246764] Starting dynamic subtest: pipe-A-plane-3
[195.658182] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[196.062253] Starting dynamic subtest: pipe-B-plane-0
[196.696251] Dynamic subtest pipe-B-plane-0: SUCCESS (0.650s)
[196.719855] Starting dynamic subtest: pipe-B-plane-1
[197.396058] Dynamic subtest pipe-B-plane-1: SUCCESS (0.699s)
[197.415367] Starting dynamic subtest: pipe-B-plane-2
[197.846119] Dynamic subtest pipe-B-plane-2: SUCCESS (0.449s)
[197.865267] Starting dynamic subtest: pipe-B-plane-3
[198.294867] Dynamic subtest pipe-B-plane-3: SUCCESS (0.449s)
[198.519603] Subtest pixel-format-yf-tiled-modifier-source-clamping: SUCCESS (5.411s)
[198.850132] [026/133] (858s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[199.038872] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[199.042437] Starting dynamic subtest: pipe-A
[199.886956] Dynamic subtest pipe-A: SUCCESS (0.854s)
[199.915626] Starting dynamic subtest: pipe-B
[200.769155] Dynamic subtest pipe-B: SUCCESS (0.880s)
[200.802086] Starting dynamic subtest: pipe-C
[201.631204] Dynamic subtest pipe-C: SUCCESS (0.860s)
[201.632915] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.599s)
[202.187752] [027/133] (855s left) i915_suspend (debugfs-reader)
[202.291789] Starting subtest: debugfs-reader