[89.928994] Initializing watchdogs
[89.929233]   /dev/watchdog0
[89.968530] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.983307] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.990222] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.995809] [001/133] (960s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[90.121132] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[90.214666] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[90.413666] Starting subtest: fbcpsr-2p-rte
[90.419150] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[90.570687] [003/133] (960s left) gem_eio (in-flight-internal-immediate)
[90.717625] Starting subtest: in-flight-internal-immediate
[90.795454] Subtest in-flight-internal-immediate: SUCCESS (0.088s)
[91.041595] [004/133] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[91.241430] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[91.245271] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[91.388547] [005/133] (959s left) gem_ctx_persistence (heartbeat-stop)
[91.503107] Starting subtest: heartbeat-stop
[91.643702] Subtest heartbeat-stop: SUCCESS (0.143s)
[91.773387] [006/133] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[91.956335] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[91.959123] Starting dynamic subtest: pipe-A
[92.325176] Dynamic subtest pipe-A: SUCCESS (0.370s)
[92.364661] Starting dynamic subtest: pipe-B
[92.735080] Dynamic subtest pipe-B: SUCCESS (0.412s)
[92.775467] Starting dynamic subtest: pipe-C
[92.823975] Dynamic subtest pipe-C: SUCCESS (0.087s)
[92.826376] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.871s)
[93.316610] [007/133] (957s left) dmabuf_sync_file (import-multiple-read-only)
[93.507298] Starting subtest: import-multiple-read-only
[93.517514] Subtest import-multiple-read-only: SUCCESS (0.015s)
[93.640552] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[93.645230] [008/133] (957s left) gem_busy (busy)
[93.780947] Starting subtest: busy
[93.783110] Starting dynamic subtest: all-engines
[93.854071] Dynamic subtest all-engines: SUCCESS (0.076s)
[93.877375] Starting dynamic subtest: rcs0
[93.880017] Dynamic subtest rcs0: SUCCESS (0.009s)
[93.900822] Starting dynamic subtest: bcs0
[93.902389] Dynamic subtest bcs0: SUCCESS (0.018s)
[93.921750] Starting dynamic subtest: vcs0
[93.924526] Dynamic subtest vcs0: SUCCESS (0.011s)
[93.943383] Starting dynamic subtest: vecs0
[93.945537] Dynamic subtest vecs0: SUCCESS (0.012s)
[93.948397] Subtest busy: SUCCESS (0.129s)
[94.312213] [009/133] (956s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[94.519289] Starting subtest: cursor-rapid-movement-128x42
[94.573211] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.522359] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.949s)
[95.639119] Starting dynamic subtest: pipe-C-HDMI-A-1
[96.195387] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.593s)
[96.196979] Subtest cursor-rapid-movement-128x42: SUCCESS (1.679s)
[96.532246] [010/133] (954s left) gem_spin_batch (resubmit-all)
[96.663712] Starting subtest: resubmit-all
[96.666840] Starting dynamic subtest: rcs0
[96.675148] Dynamic subtest rcs0: SUCCESS (0.012s)
[96.709818] Starting dynamic subtest: bcs0
[96.712550] Dynamic subtest bcs0: SUCCESS (0.007s)
[96.731322] Starting dynamic subtest: vcs0
[96.733187] Dynamic subtest vcs0: SUCCESS (0.006s)
[96.752275] Starting dynamic subtest: vecs0
[96.754423] Dynamic subtest vecs0: SUCCESS (0.006s)
[96.757284] Subtest resubmit-all: SUCCESS (0.034s)
[96.965275] [011/133] (954s left) kms_selftest (drm_plane_helper)
[97.068716] Starting subtest: drm_plane_helper
[97.087366] Starting dynamic subtest: drm_test_check_plane_state
[97.153225] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.067s)
[97.176066] Starting dynamic subtest: drm_test_check_invalid_plane_state
[97.196077] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.040s)
[97.198818] Subtest drm_plane_helper: SUCCESS (0.125s)
[97.366229] [012/133] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[97.571290] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[97.574584] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[97.713552] [013/133] (953s left) gem_mmap (bad-size)
[97.816209] Starting subtest: bad-size
[97.818993] Subtest bad-size: SUCCESS (0.002s)
[97.967152] [014/133] (953s left) kms_psr (fbc-psr2-dpms)
[98.143231] Subtest fbc-psr2-dpms: SKIP (0.000s)
[98.255307] [015/133] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[98.460168] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[98.463568] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.613661] [016/133] (953s left) syncobj_wait (single-wait-all-submitted)
[98.718328] Starting subtest: single-wait-all-submitted
[98.828314] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[98.967262] [017/133] (952s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[99.171108] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[99.176152] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[99.341289] [018/133] (952s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[99.530097] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[99.532110] Starting dynamic subtest: pipe-A-valid-mode
[100.094367] Dynamic subtest pipe-A-valid-mode: SKIP (0.559s)
[100.100467] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.562s)
[100.520790] [019/133] (951s left) gem_exec_whisper (basic-sync)
[100.652245] Starting subtest: basic-sync
[105.868651] Subtest basic-sync: SUCCESS (5.215s)
[106.125139] [020/133] (946s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[106.320439] Starting subtest: psr-modesetfrombusy
[106.323453] Subtest psr-modesetfrombusy: SKIP (0.000s)
[106.471177] [021/133] (945s left) kms_async_flips (invalid-async-flip-atomic)
[106.651712] Starting subtest: invalid-async-flip-atomic
[107.249436] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.500090] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.251s)
[107.819724] Starting dynamic subtest: pipe-A-HDMI-A-2
[108.041069] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.244s)
[108.341250] Starting dynamic subtest: pipe-B-HDMI-A-1
[108.577340] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.252s)
[108.886028] Starting dynamic subtest: pipe-B-HDMI-A-2
[109.107058] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.238s)
[109.424501] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.627411] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.237s)
[109.940085] Starting dynamic subtest: pipe-C-HDMI-A-2
[110.180692] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.273s)
[110.182488] Subtest invalid-async-flip-atomic: SUCCESS (3.523s)
[110.837767] [022/133] (941s left) gem_userptr_blits (unsync-unmap-cycles)
[110.978059] Subtest unsync-unmap-cycles: SKIP (0.000s)
[111.170249] [023/133] (941s left) gem_pxp (reject-modify-context-protection-off-2)
[113.811639] Starting subtest: reject-modify-context-protection-off-2
[113.815812] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[113.982929] [024/133] (938s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[114.176210] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[116.694993] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.518s)
[116.902414] [025/133] (935s left) i915_hangman (engine-error-state-capture)
[117.036825] Starting subtest: engine-error-state-capture
[117.039759] Starting dynamic subtest: rcs0
[121.492885] Dynamic subtest rcs0: SUCCESS (4.454s)
[121.515377] Starting dynamic subtest: bcs0
[125.446158] Dynamic subtest bcs0: SUCCESS (3.951s)
[125.470542] Starting dynamic subtest: vcs0
[129.474097] Dynamic subtest vcs0: SUCCESS (4.024s)
[129.496088] Starting dynamic subtest: vecs0
[133.446134] Dynamic subtest vecs0: SUCCESS (3.972s)
[133.447897] Subtest engine-error-state-capture: SUCCESS (16.409s)
[133.603290] [026/133] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[133.803229] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[136.375060] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.572s)
[136.670319] [027/133] (916s left) i915_query (engine-info-invalid)
[136.774187] Starting subtest: engine-info-invalid
[136.777094] Subtest engine-info-invalid: SUCCESS (0.000s)
[136.936703] [028/133] (916s left) gem_exec_balancer (full-pulse)
[137.062534] Starting subtest: full-pulse
[141.573791] Subtest full-pulse: SUCCESS (4.511s)
[141.887346] [029/133] (911s left) i915_pm_rpm (system-suspend)
[143.793466] Starting subtest: system-suspend