[87.868367] Initializing watchdogs
[87.868547]   /dev/watchdog0
[87.907375] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.922264] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.930231] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.936122] [001/131] (960s left) vgem_basic (busy-fence)
[88.131115] Starting subtest: busy-fence
[88.136110] Subtest busy-fence: SUCCESS (0.003s)
[88.274297] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[88.279362] [002/131] (960s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[90.235516] Starting subtest: gem-execbuf-stress-pc8
[90.304155] Subtest gem-execbuf-stress-pc8: SKIP (0.062s)
[90.677847] [003/131] (957s left) vgem_basic (dmabuf-mmap)
[90.801118] Starting subtest: dmabuf-mmap
[90.826973] Subtest dmabuf-mmap: SUCCESS (0.029s)
[90.949203] [004/131] (957s left) gem_exec_parallel (fds)
[91.076599] Starting subtest: fds
[91.079420] Starting dynamic subtest: rcs0
[98.479129] Dynamic subtest rcs0: SUCCESS (7.400s)
[98.498554] Starting dynamic subtest: bcs0
[107.826939] Dynamic subtest bcs0: SUCCESS (9.346s)
[107.844195] Starting dynamic subtest: vcs0
[112.695297] Dynamic subtest vcs0: SUCCESS (4.865s)
[112.714064] Starting dynamic subtest: vecs0
[128.668896] Dynamic subtest vecs0: SUCCESS (15.972s)
[128.671705] Subtest fds: SUCCESS (37.587s)
[128.943376] [005/131] (919s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[129.120118] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[129.124607] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[129.257352] [006/131] (919s left) drm_read (short-buffer-nonblock)
[129.745127] Starting subtest: short-buffer-nonblock
[129.746769] Subtest short-buffer-nonblock: SUCCESS (0.001s)
[130.024166] [007/131] (918s left) gem_userptr_blits (mmap-offset-banned)
[130.157952] Starting subtest: mmap-offset-banned
[130.160241] Starting dynamic subtest: gtt
[130.162111] Dynamic subtest gtt: SUCCESS (0.001s)
[130.187297] Starting dynamic subtest: wb
[130.189585] Dynamic subtest wb: SUCCESS (0.000s)
[130.208852] Starting dynamic subtest: wc
[130.211372] Dynamic subtest wc: SUCCESS (0.001s)
[130.231146] Starting dynamic subtest: uc
[130.233204] Dynamic subtest uc: SUCCESS (0.000s)
[130.234803] Subtest mmap-offset-banned: SUCCESS (0.005s)
[130.342351] [008/131] (918s left) gem_exec_whisper (basic-sync)
[130.466524] Starting subtest: basic-sync
[135.758384] Subtest basic-sync: SUCCESS (5.289s)
[136.039335] [009/131] (913s left) gem_create (create-ext-cpu-access-sanity-check)
[136.260467] Starting subtest: create-ext-cpu-access-sanity-check
[136.264636] Subtest create-ext-cpu-access-sanity-check: SKIP (0.002s)
[136.410926] [010/131] (912s left) kms_addfb_basic (no-handle)
[136.511976] Starting subtest: no-handle
[136.513994] Subtest no-handle: SUCCESS (0.000s)
[136.740780] [011/131] (912s left) gem_exec_fence (keep-in-fence)
[137.007175] Starting subtest: keep-in-fence
[137.009333] Starting dynamic subtest: rcs0
[137.040572] Dynamic subtest rcs0: SUCCESS (0.038s)
[137.062214] Starting dynamic subtest: bcs0
[137.169297] Dynamic subtest bcs0: SUCCESS (0.122s)
[137.189272] Starting dynamic subtest: vcs0
[137.204754] Dynamic subtest vcs0: SUCCESS (0.037s)
[137.223243] Starting dynamic subtest: vecs0
[137.236481] Dynamic subtest vecs0: SUCCESS (0.035s)
[137.238098] Subtest keep-in-fence: SUCCESS (0.235s)
[137.975054] [012/131] (911s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[138.112260] Starting subtest: map-fixed-invalidate-overlap
[138.113776] Starting dynamic subtest: gtt
[138.358701] Dynamic subtest gtt: SUCCESS (0.245s)
[138.379466] Starting dynamic subtest: wb
[138.519276] Dynamic subtest wb: SUCCESS (0.159s)
[138.540198] Starting dynamic subtest: wc
[138.678949] Dynamic subtest wc: SUCCESS (0.159s)
[138.699782] Starting dynamic subtest: uc
[138.837878] Dynamic subtest uc: SUCCESS (0.160s)
[138.840196] Subtest map-fixed-invalidate-overlap: SUCCESS (0.728s)
[139.028202] [013/131] (910s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[139.207083] Starting subtest: primary-4-tiled-reflect-x-0
[139.214193] Subtest primary-4-tiled-reflect-x-0: SKIP (0.003s)
[139.358913] [014/131] (910s left) kms_async_flips (test-time-stamp)
[139.561655] Starting subtest: test-time-stamp
[140.190345] Starting dynamic subtest: pipe-A-HDMI-A-1
[140.374196] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.181s)
[140.731759] Starting dynamic subtest: pipe-A-HDMI-A-2
[140.899199] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.186s)
[141.262202] Starting dynamic subtest: pipe-B-HDMI-A-1
[141.426296] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.180s)
[141.767124] Starting dynamic subtest: pipe-B-HDMI-A-2
[141.934428] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.186s)
[142.279038] Starting dynamic subtest: pipe-C-HDMI-A-1
[142.450844] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.191s)
[142.805284] Starting dynamic subtest: pipe-C-HDMI-A-2
[142.972836] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.190s)
[142.974390] Subtest test-time-stamp: SUCCESS (3.408s)
[143.582798] [015/131] (906s left) kms_cursor_legacy (single-bo)
[143.778080] Starting subtest: single-bo
[143.781053] Starting dynamic subtest: pipe-A
[149.186086] Dynamic subtest pipe-A: SUCCESS (5.404s)
[149.270736] Starting dynamic subtest: pipe-B
[154.587110] Dynamic subtest pipe-B: SUCCESS (5.400s)
[154.608124] Starting dynamic subtest: pipe-C
[159.983235] Dynamic subtest pipe-C: SUCCESS (5.397s)
[160.054301] Starting dynamic subtest: all-pipes
[165.379985] Dynamic subtest all-pipes: SUCCESS (5.399s)
[165.381654] Subtest single-bo: SUCCESS (21.606s)
[165.534214] [016/131] (884s left) gem_exec_schedule (in-order)
[165.670883] Starting subtest: in-order
[165.673411] Starting dynamic subtest: rcs0
[165.788620] Dynamic subtest rcs0: SUCCESS (0.115s)
[165.822210] Starting dynamic subtest: bcs0
[165.913614] Dynamic subtest bcs0: SUCCESS (0.125s)
[165.945279] Starting dynamic subtest: vcs0
[166.034572] Dynamic subtest vcs0: SUCCESS (0.115s)
[166.066116] Starting dynamic subtest: vecs0
[166.147193] Dynamic subtest vecs0: SUCCESS (0.118s)
[166.149780] Subtest in-order: SUCCESS (0.478s)
[166.548385] [017/131] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[166.750227] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[166.753993] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[166.899097] [018/131] (883s left) i915_suspend (fence-restore-tiled2untiled)
[167.004253] Starting subtest: fence-restore-tiled2untiled