[94.454642] Initializing watchdogs
[94.454840]   /dev/watchdog0
[94.493763] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[94.507929] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.514768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.520218] [001/132] (960s left) kms_vblank (wait-forked-busy-hang)
[94.710984] Starting subtest: wait-forked-busy-hang
[94.715236] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.876788] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.163s)
[101.899964] Starting dynamic subtest: pipe-A-HDMI-A-2
[108.913474] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.033s)
[108.940908] Starting dynamic subtest: pipe-C-HDMI-A-1
[115.878899] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.953s)
[115.895988] Starting dynamic subtest: pipe-C-HDMI-A-2
[122.918431] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.029s)
[122.919373] Subtest wait-forked-busy-hang: SUCCESS (28.203s)
[123.194490] [002/132] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[123.375468] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[125.989073] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.612s)
[126.262335] [003/132] (928s left) kms_tiled_display (basic-test-pattern)
[126.508600] Starting subtest: basic-test-pattern
[127.650990] Subtest basic-test-pattern: FAIL (0.938s)
[127.716497] [004/132] (927s left) kms_pm_dc (dc9-dpms)
[128.842434] Starting subtest: dc9-dpms
[128.845076] Subtest dc9-dpms: SKIP (0.000s)
[128.963241] [005/132] (926s left) gem_exec_reloc (basic-wc-cpu)
[129.073930] Starting subtest: basic-wc-cpu
[129.091540] Subtest basic-wc-cpu: SUCCESS (0.017s)
[129.230442] [006/132] (926s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[129.350350] Starting subtest: flip-vs-cursor-crc-legacy
[130.200882] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.848s)
[130.449325] [007/132] (925s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[130.579607] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[130.581268] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[130.715568] [008/132] (924s left) gem_create (create-ext-set-pat)
[130.929778] Starting subtest: create-ext-set-pat
[130.932120] Subtest create-ext-set-pat: SKIP (0.000s)
[131.053664] [009/132] (924s left) kms_cursor_crc (cursor-random-256x256)
[131.182951] Starting subtest: cursor-random-256x256
[131.220521] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.351065] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.130s)
[135.420399] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.258716] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.849s)
[139.259805] Subtest cursor-random-256x256: SUCCESS (8.071s)
[139.546471] [010/132] (916s left) kms_chamelium_frames (vga-frame-dump)
[140.041142] Subtest vga-frame-dump: SKIP (0.000s)
[140.276419] [011/132] (915s left) syncobj_timeline (single-wait-available-submitted)
[140.374231] Starting subtest: single-wait-available-submitted
[140.375103] Subtest single-wait-available-submitted: SUCCESS (0.002s)
[140.498939] [012/132] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[140.629993] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[143.575361] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (2.944s)
[143.786879] [013/132] (912s left) kms_chamelium_frames (hdmi-aspect-ratio)
[144.272501] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[144.512309] [014/132] (911s left) kms_feature_discovery (display)
[144.633520] Starting subtest: display
[144.634459] Subtest display: SUCCESS (0.000s)
[144.782091] [015/132] (911s left) kms_chamelium_audio (dp-audio-edid)
[145.257749] Subtest dp-audio-edid: SKIP (0.000s)
[145.487637] [016/132] (910s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[145.629309] Starting subtest: yf-tiled-64bpp-rotate-90
[145.631166] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[145.758697] [017/132] (910s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[145.870970] Starting subtest: yf-tiled-ccs-to-yf-tiled
[145.872069] Starting dynamic subtest: smem
[146.228298] Dynamic subtest smem: SUCCESS (0.356s)
[146.229706] Subtest yf-tiled-ccs-to-yf-tiled: SUCCESS (0.358s)
[146.464433] [018/132] (909s left) syncobj_wait (wait-any-snapshot)
[146.561668] Starting subtest: wait-any-snapshot
[146.647118] Subtest wait-any-snapshot: SUCCESS (0.084s)
[146.779578] [019/132] (909s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[146.893640] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[146.895800] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[147.131576] [020/132] (909s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[147.266197] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[147.267916] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[147.409460] [021/132] (909s left) perf_pmu (enable-race)
[147.513573] Starting subtest: enable-race
[147.514596] Starting dynamic subtest: rcs0
[160.149272] Dynamic subtest rcs0: SUCCESS (12.635s)
[160.165655] Starting dynamic subtest: bcs0
[172.826721] Dynamic subtest bcs0: SUCCESS (12.674s)
[172.843040] Starting dynamic subtest: vcs0
[185.459639] Dynamic subtest vcs0: SUCCESS (12.632s)
[185.476213] Starting dynamic subtest: vecs0
[198.089643] Dynamic subtest vecs0: SUCCESS (12.629s)
[198.090656] Subtest enable-race: SUCCESS (50.576s)
[198.213589] [022/132] (858s left) gem_exec_fence (concurrent)
[198.458714] Starting subtest: concurrent
[198.459953] Starting dynamic subtest: rcs0
[198.500869] Dynamic subtest rcs0: SUCCESS (0.040s)
[198.519209] Starting dynamic subtest: bcs0
[198.535891] Dynamic subtest bcs0: SUCCESS (0.035s)
[198.553821] Starting dynamic subtest: vcs0
[198.572353] Dynamic subtest vcs0: SUCCESS (0.035s)
[198.590457] Starting dynamic subtest: vecs0
[198.607545] Dynamic subtest vecs0: SUCCESS (0.034s)
[198.608735] Subtest concurrent: SUCCESS (0.150s)
[199.352559] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[199.355958] [023/132] (857s left) vgem_basic (unload)
[199.448197] Starting subtest: unload
[228.486227] Subtest unload: SUCCESS (29.038s)
[228.688521] [024/132] (828s left) gem_userptr_blits (probe)
[228.836673] Starting subtest: probe
[229.182052] Subtest probe: SUCCESS (0.346s)
[229.337884] [025/132] (827s left) syncobj_timeline (invalid-transfer-illegal-handle)
[229.433707] Starting subtest: invalid-transfer-illegal-handle
[229.434774] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[229.571542] [026/132] (827s left) kms_cursor_crc (cursor-sliding-512x512)
[229.712581] Starting subtest: cursor-sliding-512x512
[229.716331] Subtest cursor-sliding-512x512: SKIP (0.003s)
[229.870830] [027/132] (827s left) device_reset (unbind-reset-rebind)
[229.999604] Starting subtest: unbind-reset-rebind
[232.772699] Subtest unbind-reset-rebind: SUCCESS (2.774s)
[232.873020] [028/132] (824s left) i915_pm_rps (reset)
[232.990844] Starting subtest: reset
[237.565868] Subtest reset: SUCCESS (4.574s)
[237.706545] [029/132] (819s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[237.878874] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[237.879857] Starting dynamic subtest: pipe-A
[241.760790] Dynamic subtest pipe-A: SKIP (3.881s)
[241.779791] Starting dynamic subtest: pipe-B
[245.459636] Dynamic subtest pipe-B: SKIP (3.697s)
[245.478218] Starting dynamic subtest: pipe-C
[249.120835] Dynamic subtest pipe-C: SKIP (3.658s)
[249.122629] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (11.243s)
[249.601805] [030/132] (807s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[249.836652] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[252.378491] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.542s)
[252.599476] [031/132] (804s left) gem_exec_flush (basic-batch-kernel-default-uc)
[252.715708] Starting subtest: basic-batch-kernel-default-uc
[258.505645] Subtest basic-batch-kernel-default-uc: SUCCESS (5.790s)
[258.750671] [032/132] (798s left) kms_psr (psr2-sprite-plane-onoff)
[258.921518] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[259.026757] [033/132] (798s left) gem_exec_reloc (basic-cpu-read)
[259.134649] Starting subtest: basic-cpu-read
[259.153629] Subtest basic-cpu-read: SUCCESS (0.020s)
[259.368227] [034/132] (798s left) gem_exec_reloc (basic-range)
[259.473865] Starting subtest: basic-range
[259.544181] Subtest basic-range: SUCCESS (0.068s)
[259.750717] [035/132] (798s left) kms_async_flips (async-flip-suspend-resume)
[259.919879] Starting subtest: async-flip-suspend-resume
[260.477211] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.661516] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.893s)
[279.684720] Starting dynamic subtest: pipe-A-HDMI-A-2