[117.085138] Initializing watchdogs
[117.085330]   /dev/watchdog0
[117.128291] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[117.143282] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[117.150585] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[117.158894] [001/155] (960s left) gem_exec_fence (submit)
[117.463175] Starting subtest: submit
[117.467968] Starting dynamic subtest: rcs0
[117.494430] Dynamic subtest rcs0: SUCCESS (0.038s)
[117.525794] Starting dynamic subtest: bcs0
[117.531968] Dynamic subtest bcs0: SUCCESS (0.034s)
[117.563578] Starting dynamic subtest: vcs0
[117.567254] Dynamic subtest vcs0: SUCCESS (0.029s)
[117.593528] Starting dynamic subtest: vecs0
[117.597404] Dynamic subtest vecs0: SUCCESS (0.026s)
[117.601632] Subtest submit: SUCCESS (0.131s)
[118.412058] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[118.419609] [002/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[118.643721] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[118.651543] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[118.804711] [003/155] (959s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[118.998555] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[119.002703] Starting dynamic subtest: pipe-A-valid-mode
[120.052266] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.053s)
[120.058484] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.055s)
[120.421692] [004/155] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[120.651588] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[120.658818] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[120.801832] [005/155] (957s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[121.036418] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[121.042794] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[121.180934] [006/155] (957s left) kms_psr (pr-cursor-mmap-gtt)
[121.381525] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[121.495486] [007/155] (956s left) kms_invalid_mode (bad-hsync-start)
[121.698591] Starting subtest: bad-hsync-start
[121.703308] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.171866] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.474s)
[122.208241] Starting dynamic subtest: pipe-A-HDMI-A-2
[122.213383] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[122.256522] Starting dynamic subtest: pipe-B-HDMI-A-1
[122.264685] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[122.310189] Starting dynamic subtest: pipe-B-HDMI-A-2
[122.315141] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[122.358377] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.364348] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.005s)
[122.404089] Starting dynamic subtest: pipe-C-HDMI-A-2
[122.407562] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[122.410994] Subtest bad-hsync-start: SUCCESS (0.509s)
[122.622441] [008/155] (955s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[122.853778] Starting subtest: x-tiled-32bpp-rotate-270
[123.212924] Subtest x-tiled-32bpp-rotate-270: SKIP (0.357s)
[123.512651] [009/155] (955s left) kms_properties (colorop-properties-legacy)
[123.703191] Starting subtest: colorop-properties-legacy
[123.707088] Starting dynamic subtest: pipe-A-HDMI-A-1
[124.226168] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.516s)
[124.249468] Starting dynamic subtest: pipe-A-HDMI-A-2
[124.595997] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.365s)
[124.621508] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.948420] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.355s)
[124.974351] Starting dynamic subtest: pipe-B-HDMI-A-2
[125.322237] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.364s)
[125.345431] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.690641] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.364s)
[125.714197] Starting dynamic subtest: pipe-C-HDMI-A-2
[126.054661] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.363s)
[126.058711] Subtest colorop-properties-legacy: SUCCESS (2.351s)
[126.479465] [010/155] (952s left) gem_exec_reloc (basic-gtt-wc)
[126.611334] Starting subtest: basic-gtt-wc
[126.637908] Subtest basic-gtt-wc: SUCCESS (0.024s)
[126.905110] [011/155] (951s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render)
[127.134088] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render
[127.140577] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[127.284816] [012/155] (951s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[127.416805] Starting subtest: tiled-to-tiled
[127.560164] Subtest tiled-to-tiled: SUCCESS (0.142s)
[127.730862] [013/155] (951s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[127.947670] Starting subtest: 4-tiled-8bpp-rotate-180
[127.954677] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[128.115277] [014/155] (950s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-pwrite)
[128.328359] Starting subtest: hdr-rgb101010-draw-pwrite
[128.337067] Subtest hdr-rgb101010-draw-pwrite: SKIP (0.000s)
[128.484995] [015/155] (950s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[128.702562] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[128.710657] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[128.852673] [016/155] (950s left) syncobj_basic (bad-create-flags)
[128.967216] Starting subtest: bad-create-flags
[128.970624] Subtest bad-create-flags: SUCCESS (0.000s)
[129.113385] [017/155] (950s left) kms_addfb_basic (too-wide)
[129.312848] Starting subtest: too-wide
[129.316676] Subtest too-wide: SUCCESS (0.000s)
[129.482964] [018/155] (950s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[129.683400] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[129.693502] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[130.498340] [019/155] (949s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-plflip-blt)
[130.713406] Starting subtest: psrhdr-2p-primscrn-indfb-plflip-blt
[130.720394] Subtest psrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[130.868222] [020/155] (948s left) syncobj_wait (invalid-reset-bad-pad)
[130.989110] Starting subtest: invalid-reset-bad-pad
[130.992920] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[131.148720] [021/155] (948s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[131.351124] Starting subtest: cursor-rapid-movement-256x85
[131.403924] Starting dynamic subtest: pipe-A-HDMI-A-1
[132.301464] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.893s)
[132.410184] Starting dynamic subtest: pipe-C-HDMI-A-1
[133.111574] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.620s)
[133.183568] Subtest cursor-rapid-movement-256x85: SUCCESS (1.635s)
[133.810700] [022/155] (946s left) dumb_buffer (create-clear)
[134.292198] Starting subtest: create-clear
[168.209702] Subtest create-clear: SUCCESS (34.146s)
[168.354417] [023/155] (912s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[168.581531] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[168.587854] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[168.743363] [024/155] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[168.966714] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[171.954508] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (2.995s)
[172.273484] [025/155] (908s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[172.498930] Starting subtest: yf-tiled-16bpp-rotate-0
[176.386517] Subtest yf-tiled-16bpp-rotate-0: SUCCESS (3.892s)
[176.756712] [026/155] (903s left) gem_userptr_blits (probe)
[176.926093] Starting subtest: probe
[177.313995] Subtest probe: SUCCESS (0.386s)
[177.501641] [027/155] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[177.716453] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[179.734558] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.028s)
[179.987397] [028/155] (900s left) gem_flink_basic (double-flink)
[180.107121] Starting subtest: double-flink
[180.111651] Subtest double-flink: SUCCESS (0.000s)
[180.285115] [029/155] (900s left) syncobj_wait (single-wait-submitted)
[180.402265] Starting subtest: single-wait-submitted
[180.507281] Subtest single-wait-submitted: SUCCESS (0.105s)
[180.652277] [030/155] (900s left) gem_exec_schedule (preemptive-hang)
[180.910619] Starting subtest: preemptive-hang
[180.916618] Starting dynamic subtest: rcs0
[187.095134] Dynamic subtest rcs0: SUCCESS (6.177s)
[187.130343] Starting dynamic subtest: bcs0
[193.104635] Dynamic subtest bcs0: SUCCESS (6.013s)
[193.140867] Starting dynamic subtest: vcs0
[199.131930] Dynamic subtest vcs0: SUCCESS (6.020s)
[199.162868] Starting dynamic subtest: vecs0
[205.075491] Dynamic subtest vecs0: SUCCESS (5.940s)
[205.080500] Subtest preemptive-hang: SUCCESS (24.164s)
[205.368309] [031/155] (875s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[205.553053] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[205.556971] Starting dynamic subtest: pipe-A-valid-mode
[206.691697] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.132s)
[206.695870] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (1.136s)
[207.040131] [032/155] (874s left) kms_psr (psr-cursor-mmap-gtt)
[207.253925] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[207.369176] [033/155] (874s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[207.496217] Starting subtest: etime-multi-wait-for-submit-submitted
[207.602514] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[207.754226] [034/155] (873s left) kms_content_protection (dp-mst-lic-type-1)
[207.978451] Starting subtest: dp-mst-lic-type-1
[207.986075] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[208.145144] [035/155] (873s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-render)
[208.366105] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-render
[208.372114] Subtest fbchdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[208.524107] [036/155] (873s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[208.748654] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[208.755485] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[208.907829] [037/155] (873s left) kms_feature_discovery (chamelium)
[209.107259] Starting subtest: chamelium
[209.115051] Subtest chamelium: SKIP (0.001s)
[209.273154] [038/155] (872s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[209.476173] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[209.600153] [039/155] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[209.830657] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[209.839086] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[209.991119] [040/155] (872s left) syncobj_wait (reset-multiple-signaled)
[210.106922] Starting subtest: reset-multiple-signaled
[210.111043] Subtest reset-multiple-signaled: SUCCESS (0.003s)
[210.270548] [041/155] (872s left) gem_ctx_persistence (legacy-engines-persistence)
[210.395877] Starting subtest: legacy-engines-persistence
[210.402340] Starting dynamic subtest: render
[211.140464] Dynamic subtest render: SUCCESS (0.744s)
[211.168945] Starting dynamic subtest: bsd
[211.910088] Dynamic subtest bsd: SUCCESS (0.763s)
[211.936816] Starting dynamic subtest: blt
[212.673085] Dynamic subtest blt: SUCCESS (0.762s)
[212.701526] Starting dynamic subtest: vebox
[213.443340] Dynamic subtest vebox: SUCCESS (0.767s)
[213.446891] Subtest legacy-engines-persistence: SUCCESS (3.050s)
[213.615263] [042/155] (868s left) kms_psr (psr2-cursor-blt)
[213.809494] Subtest psr2-cursor-blt: SKIP (0.000s)
[213.934965] [043/155] (868s left) gem_exec_balancer (hang)
[214.196632] Starting subtest: hang
[218.631962] Subtest hang: SUCCESS (4.436s)
[218.792678] [044/155] (863s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[219.019257] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[219.027150] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[219.169899] [045/155] (863s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[219.399024] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[219.406163] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[219.571534] [046/155] (863s left) kms_frontbuffer_tracking (fbc-suspend)
[219.787916] Starting subtest: fbc-suspend