[90.602515] Initializing watchdogs
[90.602706]   /dev/watchdog0
[90.646297] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.661069] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.669089] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.675070] [001/133] (960s left) gem_exec_whisper (basic-queues-priority-all)
[90.825508] Starting subtest: basic-queues-priority-all
[101.437672] Subtest basic-queues-priority-all: SUCCESS (10.615s)
[101.711060] [002/133] (949s left) kms_plane (plane-position-hole)
[101.903069] Starting subtest: plane-position-hole
[102.718164] Starting dynamic subtest: pipe-A-plane-1
[103.279052] Dynamic subtest pipe-A-plane-1: SUCCESS (0.563s)
[103.313066] Starting dynamic subtest: pipe-A-plane-2
[103.828381] Dynamic subtest pipe-A-plane-2: SUCCESS (0.547s)
[103.854050] Starting dynamic subtest: pipe-A-plane-3
[104.392170] Dynamic subtest pipe-A-plane-3: SUCCESS (0.560s)
[104.417558] Starting dynamic subtest: pipe-A-plane-4
[104.426611] Dynamic subtest pipe-A-plane-4: SUCCESS (0.008s)
[104.896258] Starting dynamic subtest: pipe-B-plane-1
[105.420299] Dynamic subtest pipe-B-plane-1: SUCCESS (0.558s)
[105.448368] Starting dynamic subtest: pipe-B-plane-2
[105.996187] Dynamic subtest pipe-B-plane-2: SUCCESS (0.576s)
[106.032102] Starting dynamic subtest: pipe-B-plane-3
[106.525202] Dynamic subtest pipe-B-plane-3: SUCCESS (0.528s)
[106.550677] Starting dynamic subtest: pipe-B-plane-4
[106.557142] Dynamic subtest pipe-B-plane-4: SUCCESS (0.010s)
[106.562416] Subtest plane-position-hole: SUCCESS (4.636s)
[106.889325] [003/133] (944s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[107.104083] Starting subtest: x-tiled-32bpp-rotate-0
[111.061105] Subtest x-tiled-32bpp-rotate-0: SUCCESS (3.952s)
[111.477309] [004/133] (939s left) gem_tiled_fence_blits (normal)
[112.333149] Starting subtest: normal
[114.685044] Subtest normal: SUCCESS (2.352s)
[114.834426] [005/133] (936s left) kms_psr (fbc-psr2-primary-page-flip)
[115.170688] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[115.267124] [006/133] (936s left) kms_getfb (getfb2-handle-zero)
[115.450976] Starting subtest: getfb2-handle-zero
[115.452681] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[115.592872] [007/133] (936s left) kms_flip (flip-vs-expired-vblank)
[115.786066] Starting subtest: flip-vs-expired-vblank
[115.791091] Starting dynamic subtest: A-HDMI-A1
[121.512849] Dynamic subtest A-HDMI-A1: SUCCESS (5.725s)
[121.533889] Starting dynamic subtest: B-HDMI-A1
[126.902174] Dynamic subtest B-HDMI-A1: SUCCESS (5.387s)
[126.926195] Starting dynamic subtest: C-HDMI-A1
[132.319166] Dynamic subtest C-HDMI-A1: SUCCESS (5.417s)
[132.341037] Starting dynamic subtest: A-HDMI-A2
[137.763276] Dynamic subtest A-HDMI-A2: SUCCESS (5.443s)
[137.783691] Starting dynamic subtest: B-HDMI-A2
[143.141430] Dynamic subtest B-HDMI-A2: SUCCESS (5.373s)
[143.161912] Starting dynamic subtest: C-HDMI-A2
[148.537243] Dynamic subtest C-HDMI-A2: SUCCESS (5.387s)
[148.542196] Subtest flip-vs-expired-vblank: SUCCESS (32.749s)
[149.064686] [008/133] (902s left) core_auth (getclient-master-drop)
[149.165073] Starting subtest: getclient-master-drop
[149.177692] Subtest getclient-master-drop: SUCCESS (0.010s)
[149.345641] [009/133] (902s left) kms_invalid_mode (uint-max-clock)
[149.534129] Starting subtest: uint-max-clock
[149.537404] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.984254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.454s)
[150.017165] Starting dynamic subtest: pipe-A-HDMI-A-2
[150.019432] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.004s)
[150.045249] Starting dynamic subtest: pipe-B-HDMI-A-1
[150.048458] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[150.094632] Starting dynamic subtest: pipe-B-HDMI-A-2
[150.097382] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[150.140403] Starting dynamic subtest: pipe-C-HDMI-A-1
[150.143593] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[150.184466] Starting dynamic subtest: pipe-C-HDMI-A-2
[150.187615] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s)
[150.191347] Subtest uint-max-clock: SUCCESS (0.496s)
[150.398918] [010/133] (901s left) prime_mmap (test_map_unmap)
[150.505912] Starting subtest: test_map_unmap
[150.507438] Starting dynamic subtest: test_map_unmap-smem
[150.514951] Dynamic subtest test_map_unmap-smem: SUCCESS (0.009s)
[150.518139] Subtest test_map_unmap: SUCCESS (0.010s)
[150.662174] [011/133] (901s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[150.844552] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[150.848411] Starting dynamic subtest: pipe-A-valid-mode
[151.834131] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.994s)
[151.835792] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.998s)
[152.135811] [012/133] (899s left) gem_mmap_wc (bad-offset)
[152.248885] Starting subtest: bad-offset
[152.253226] Subtest bad-offset: SUCCESS (0.002s)
[152.387654] [013/133] (899s left) gem_exec_schedule (lateslice)
[152.536839] Starting subtest: lateslice
[152.540224] Starting dynamic subtest: rcs0
[152.569116] Dynamic subtest rcs0: SUCCESS (0.032s)
[152.597141] Starting dynamic subtest: bcs0
[152.605870] Dynamic subtest bcs0: SUCCESS (0.032s)
[152.629654] Starting dynamic subtest: vcs0
[152.635154] Dynamic subtest vcs0: SUCCESS (0.030s)
[152.655885] Starting dynamic subtest: vecs0
[152.662576] Dynamic subtest vecs0: SUCCESS (0.031s)
[152.664726] Subtest lateslice: SUCCESS (0.129s)
[153.056360] [014/133] (899s left) kms_cursor_crc (cursor-offscreen-512x170)
[153.251066] Starting subtest: cursor-offscreen-512x170
[153.257148] Subtest cursor-offscreen-512x170: SKIP (0.003s)
[153.389321] [015/133] (898s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[153.581312] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[153.585233] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[153.751858] [016/133] (898s left) i915_drm_fdinfo (busy-idle-check-all)
[153.871811] Starting subtest: busy-idle-check-all
[153.874153] Starting dynamic subtest: rcs0
[154.499395] Dynamic subtest rcs0: SUCCESS (0.630s)
[154.522983] Starting dynamic subtest: bcs0
[155.128373] Dynamic subtest bcs0: SUCCESS (0.627s)
[155.150205] Starting dynamic subtest: vcs0
[155.753333] Dynamic subtest vcs0: SUCCESS (0.628s)
[155.773983] Starting dynamic subtest: vecs0
[156.380683] Dynamic subtest vecs0: SUCCESS (0.626s)
[156.382660] Subtest busy-idle-check-all: SUCCESS (2.514s)
[156.508233] [017/133] (896s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[157.276318] Starting subtest: syncobj-timeline-multiple-ext-nodes
[157.282352] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[157.546605] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[157.552466] [018/133] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[157.764244] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[157.767901] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.916356] [019/133] (894s left) kms_flip (flip-vs-expired-vblank-interruptible)
[158.114076] Starting subtest: flip-vs-expired-vblank-interruptible
[158.119176] Starting dynamic subtest: A-HDMI-A1
[163.777261] Dynamic subtest A-HDMI-A1: SUCCESS (5.654s)
[163.802096] Starting dynamic subtest: B-HDMI-A1
[165.802563] Dynamic subtest B-HDMI-A1: FAIL (1.685s)
[165.829122] Starting dynamic subtest: C-HDMI-A1
[170.839114] Dynamic subtest C-HDMI-A1: SUCCESS (5.372s)
[170.864205] Starting dynamic subtest: A-HDMI-A2
[176.250733] Dynamic subtest A-HDMI-A2: SUCCESS (5.408s)
[176.274089] Starting dynamic subtest: B-HDMI-A2
[181.609681] Dynamic subtest B-HDMI-A2: SUCCESS (5.356s)
[181.633200] Starting dynamic subtest: C-HDMI-A2
[187.006272] Dynamic subtest C-HDMI-A2: SUCCESS (5.392s)
[187.007926] Subtest flip-vs-expired-vblank-interruptible: FAIL (28.890s)
[187.498945] [020/133] (865s left) perf_pmu (rc6-all-gts)
[187.622164] Starting subtest: rc6-all-gts
[187.625750] Subtest rc6-all-gts: SKIP (0.000s)
[187.782412] [021/133] (865s left) gem_exec_balancer (persistence)
[188.040983] Starting subtest: persistence
[192.393258] Subtest persistence: SUCCESS (4.352s)
[192.534384] [022/133] (860s left) perf (oa-formats)
[192.807092] Starting subtest: oa-formats
[192.808741] Starting dynamic subtest: 0-rcs0
[192.898239] Dynamic subtest 0-rcs0: SUCCESS (0.088s)
[192.901282] Subtest oa-formats: SUCCESS (0.090s)
[193.015356] [023/133] (860s left) kms_atomic_interruptible (legacy-cursor)
[193.198706] Starting subtest: legacy-cursor
[193.201072] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.077152] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.875s)
[200.079115] Subtest legacy-cursor: SUCCESS (6.880s)
[200.410051] [024/133] (852s left) kms_psr (psr-dpms)
[200.605164] Subtest psr-dpms: SKIP (0.000s)
[200.716144] [025/133] (852s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[200.895725] Starting subtest: primary-y-tiled-reflect-x-0
[200.906501] Subtest primary-y-tiled-reflect-x-0: SKIP (0.004s)
[201.043246] [026/133] (852s left) kms_chamelium_color (ctm-blue-to-red)
[201.232094] Subtest ctm-blue-to-red: SKIP (0.000s)
[201.349916] [027/133] (852s left) gem_userptr_blits (invalid-null-pointer)
[201.471219] Starting subtest: invalid-null-pointer
[201.474142] Subtest invalid-null-pointer: SUCCESS (0.004s)
[201.678113] [028/133] (851s left) vgem_basic (second-client)
[201.789883] Starting subtest: second-client
[201.822142] Subtest second-client: SUCCESS (0.034s)
[201.957488] [029/133] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[202.160792] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[202.165432] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[202.308875] [030/133] (851s left) sriov_basic (bind-unbind-vf)
[202.421066] Subtest bind-unbind-vf: SKIP (0.000s)
[202.534629] [031/133] (851s left) syncobj_wait (wait-for-submit-delayed-submit)
[202.642800] Starting subtest: wait-for-submit-delayed-submit
[202.751128] Subtest wait-for-submit-delayed-submit: SUCCESS (0.106s)
[202.928468] [032/133] (851s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[203.126115] Starting subtest: basic-flip-after-cursor-varying-size
[204.465313] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.343s)
[204.777298] [033/133] (849s left) gem_exec_flush (basic-wb-ro-before-default)
[204.917109] Starting subtest: basic-wb-ro-before-default
[210.334802] Subtest basic-wb-ro-before-default: SUCCESS (5.421s)
[210.598517] [034/133] (843s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[210.792085] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[210.797086] Starting dynamic subtest: A-HDMI-A1
[212.301023] Dynamic subtest A-HDMI-A1: SUCCESS (1.504s)
[212.327144] Starting dynamic subtest: B-HDMI-A1
[213.304653] Dynamic subtest B-HDMI-A1: SUCCESS (0.997s)
[213.329111] Starting dynamic subtest: C-HDMI-A1
[214.315060] Dynamic subtest C-HDMI-A1: SUCCESS (1.009s)
[214.359185] Starting dynamic subtest: A-HDMI-A2
[215.369330] Dynamic subtest A-HDMI-A2: SUCCESS (1.049s)
[215.397292] Starting dynamic subtest: B-HDMI-A2
[216.353094] Dynamic subtest B-HDMI-A2: SUCCESS (0.983s)
[216.392186] Starting dynamic subtest: C-HDMI-A2
[217.373841] Dynamic subtest C-HDMI-A2: SUCCESS (1.012s)
[217.377121] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.579s)
[217.732443] [035/133] (836s left) i915_suspend (forcewake)
[217.851109] Starting subtest: forcewake