[89.304577] Initializing watchdogs
[89.304747]   /dev/watchdog0
[89.344262] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.358865] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.365971] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.375341] [001/132] (960s left) gem_lmem_swapping (heavy-verify-multi)
[89.528179] Subtest heavy-verify-multi: SKIP (0.000s)
[89.626234] [002/132] (960s left) i915_drm_fdinfo (virtual-busy-hang-all)
[89.740844] Starting subtest: virtual-busy-hang-all
[89.744452] Subtest virtual-busy-hang-all: SUCCESS (0.001s)
[89.898117] [003/132] (960s left) gem_exec_reloc (basic-gtt)
[90.016688] Starting subtest: basic-gtt
[90.039469] Subtest basic-gtt: SUCCESS (0.021s)
[90.252437] [004/132] (959s left) kms_dp_aux_dev (basic)
[90.364146] Starting subtest: basic
[90.372186] Subtest basic: SKIP (0.001s)
[90.532616] [005/132] (959s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[90.654699] Starting subtest: tiled-to-untiled
[90.774119] Subtest tiled-to-untiled: SUCCESS (0.115s)
[90.916223] [006/132] (959s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[91.055723] Starting subtest: map-fixed-invalidate-overlap-busy
[91.061319] Starting dynamic subtest: gtt
[94.922090] Dynamic subtest gtt: SUCCESS (3.868s)
[94.943215] Starting dynamic subtest: wb
[98.696062] Dynamic subtest wb: SUCCESS (3.772s)
[98.716325] Starting dynamic subtest: wc
[102.475096] Dynamic subtest wc: SUCCESS (3.780s)
[102.496457] Starting dynamic subtest: uc
[106.256319] Dynamic subtest uc: SUCCESS (3.779s)
[106.259858] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (15.203s)
[106.420636] [007/132] (943s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[106.633479] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[106.640065] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[106.767988] [008/132] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[106.985632] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[106.992659] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.136083] [009/132] (943s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[107.337312] Starting subtest: psr-shrfb-scaledprimary
[107.345274] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[107.514804] [010/132] (943s left) gem_pxp (create-regular-buffer)
[110.165717] Starting subtest: create-regular-buffer
[110.172560] Subtest create-regular-buffer: SKIP (0.000s)
[110.331303] [011/132] (940s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[110.527794] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[110.626756] [012/132] (940s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[110.843385] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[114.581936] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.674s)
[115.106087] [013/132] (936s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[115.431049] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[115.438209] Starting dynamic subtest: pipe-A-HDMI-A-1
[115.611123] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[115.632272] Starting dynamic subtest: pipe-A-HDMI-A-2
[115.769686] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s)
[115.789055] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.962396] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s)
[115.998442] Starting dynamic subtest: pipe-B-HDMI-A-2
[116.148702] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s)
[116.167845] Starting dynamic subtest: pipe-C-HDMI-A-1
[116.306256] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[116.338144] Starting dynamic subtest: pipe-C-HDMI-A-2
[116.470630] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[116.478957] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.081s)
[116.586079] [014/132] (934s left) gem_exec_balancer (bonded-chain)
[116.721219] Starting subtest: bonded-chain
[121.057249] Subtest bonded-chain: SUCCESS (4.336s)
[121.318842] [015/132] (930s left) kms_flip (2x-flip-vs-expired-vblank)
[121.510130] Starting subtest: 2x-flip-vs-expired-vblank
[121.515372] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[132.319354] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.806s)
[132.356967] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[136.405116] Dynamic subtest AC-HDMI-A1-HDMI-A2: FAIL (3.711s)
[136.424924] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[146.761085] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.723s)
[146.767538] Subtest 2x-flip-vs-expired-vblank: FAIL (25.253s)
[147.400190] [016/132] (904s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[147.612037] Starting subtest: cursor-rapid-movement-256x256
[147.662102] Starting dynamic subtest: pipe-A-HDMI-A-1
[148.576074] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.912s)
[148.669539] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.206140] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.577s)
[149.210220] Subtest cursor-rapid-movement-256x256: SUCCESS (1.597s)
[149.536636] [017/132] (902s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[149.731109] Starting subtest: stress-xrgb8888-4tiled
[149.739136] Subtest stress-xrgb8888-4tiled: SKIP (0.000s)
[149.842541] [018/132] (901s left) gem_exec_create (madvise)
[149.981268] Starting subtest: madvise
[149.987110] Starting dynamic subtest: smem
[170.106815] Dynamic subtest smem: SUCCESS (20.127s)
[170.117069] Subtest madvise: SUCCESS (20.128s)
[171.515415] [019/132] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[171.724091] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[174.192556] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.474s)
[174.481535] [020/132] (877s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[174.674073] Starting subtest: 2x-long-flip-vs-cursor-atomic
[180.253954] Subtest 2x-long-flip-vs-cursor-atomic: SUCCESS (5.581s)
[180.577373] [021/132] (871s left) gem_ringfill (basic-all)
[181.039470] Starting subtest: basic-all
[182.250686] Subtest basic-all: SUCCESS (1.211s)
[182.414535] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[182.421343] [022/132] (869s left) kms_pm_dc (dc9-dpms)
[183.616841] Starting subtest: dc9-dpms
[183.627322] Subtest dc9-dpms: SKIP (0.000s)
[183.769098] [023/132] (868s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[183.963041] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[184.093072] [024/132] (868s left) prime_vgem (fence-wait)
[184.227545] Starting subtest: fence-wait
[184.231366] Starting dynamic subtest: rcs0
[185.251827] Dynamic subtest rcs0: SUCCESS (1.027s)
[185.273993] Starting dynamic subtest: vcs0
[186.274530] Dynamic subtest vcs0: SUCCESS (1.024s)
[186.297355] Starting dynamic subtest: vecs0
[187.297594] Dynamic subtest vecs0: SUCCESS (1.020s)
[187.303424] Subtest fence-wait: SUCCESS (3.076s)
[187.482486] [025/132] (865s left) gem_bad_reloc (negative-reloc)
[187.600829] Starting subtest: negative-reloc
[187.613400] Subtest negative-reloc: SUCCESS (0.002s)
[187.753333] [026/132] (864s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[187.962492] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[189.003689] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.041s)
[189.302485] [027/132] (863s left) gem_exec_fence (syncobj-timeline-chain-engines)
[189.982073] Starting subtest: syncobj-timeline-chain-engines
[190.103573] Subtest syncobj-timeline-chain-engines: SUCCESS (0.120s)
[190.387269] [028/132] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[190.590595] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[190.598853] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[190.753250] [029/132] (862s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[190.965437] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[193.411390] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (2.448s)
[193.633880] [030/132] (859s left) kms_addfb_basic (basic)
[193.746567] Starting subtest: basic
[193.750219] Subtest basic: SUCCESS (0.000s)
[193.970995] [031/132] (859s left) kms_content_protection (legacy-hdcp14)
[194.163233] Starting subtest: legacy-hdcp14
[194.178595] Subtest legacy-hdcp14: SKIP (0.010s)
[194.322800] [032/132] (858s left) kms_flip (2x-flip-vs-wf_vblank)
[194.510424] Starting subtest: 2x-flip-vs-wf_vblank
[194.514087] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[196.247664] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.734s)
[196.270157] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[197.940126] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.690s)
[197.963409] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[199.635060] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.685s)
[199.640057] Subtest 2x-flip-vs-wf_vblank: SUCCESS (5.123s)
[200.231623] [033/132] (853s left) kms_flip (flip-vs-suspend)
[200.418134] Starting subtest: flip-vs-suspend
[200.422126] Starting dynamic subtest: A-HDMI-A1