[118.364922] Initializing watchdogs
[118.365244]   /dev/watchdog0
[118.405680] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[118.420278] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[118.428997] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[118.435210] [001/133] (960s left) kms_psr (psr-cursor-plane-move)
[118.641860] Subtest psr-cursor-plane-move: SKIP (0.000s)
[118.738764] [002/133] (960s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[118.927118] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[118.930066] Starting dynamic subtest: pipe-A
[119.786124] Dynamic subtest pipe-A: SUCCESS (0.863s)
[119.806070] Starting dynamic subtest: pipe-B
[120.634051] Dynamic subtest pipe-B: SUCCESS (0.846s)
[120.658127] Starting dynamic subtest: pipe-C
[121.481023] Dynamic subtest pipe-C: SUCCESS (0.845s)
[121.482241] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.559s)
[122.019418] [003/133] (957s left) sriov_basic (enable-vfs-autoprobe-off)
[122.129141] Subtest enable-vfs-autoprobe-off: SKIP (0.000s)
[122.229813] [004/133] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[122.418276] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[122.422424] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[122.586119] [005/133] (956s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[122.798081] Starting subtest: 4-tiled-8bpp-rotate-270
[122.802737] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[122.922964] [006/133] (956s left) gem_exec_flush (basic-wb-rw-before-default)
[123.055127] Starting subtest: basic-wb-rw-before-default
[128.472371] Subtest basic-wb-rw-before-default: SUCCESS (5.417s)
[128.755198] [007/133] (950s left) syncobj_basic (test-valid-cycle)
[128.852535] Starting subtest: test-valid-cycle
[128.853956] Subtest test-valid-cycle: SUCCESS (0.001s)
[128.974890] [008/133] (950s left) drm_buddy (drm_buddy)
[129.078021] Starting subtest: drm_buddy
[129.081156] Subtest drm_buddy: SKIP (0.002s)
[129.194187] [009/133] (950s left) syncobj_wait (invalid-wait-illegal-handle)
[129.299133] Starting subtest: invalid-wait-illegal-handle
[129.300642] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[129.425294] [010/133] (950s left) drm_read (short-buffer-nonblock)
[129.884493] Starting subtest: short-buffer-nonblock
[129.885555] Subtest short-buffer-nonblock: SUCCESS (0.001s)
[130.144705] [011/133] (949s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[130.398660] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[133.362368] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.959s)
[133.623787] [012/133] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[133.823595] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[136.510547] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.683s)
[136.725343] [013/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[136.913436] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[136.916868] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[137.056457] [014/133] (942s left) gem_exec_fence (basic-wait-all)
[137.181908] Starting subtest: basic-wait-all
[137.199652] Subtest basic-wait-all: SUCCESS (0.020s)
[138.099271] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[138.103623] [015/133] (941s left) syncobj_wait (invalid-signal-zero-handles)
[138.209491] Starting subtest: invalid-signal-zero-handles
[138.210868] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[138.352560] [016/133] (941s left) kms_psr (fbc-psr-primary-blt)
[138.539762] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[138.654739] [017/133] (941s left) gem_exec_whisper (basic-contexts-forked-all)
[138.787738] Starting subtest: basic-contexts-forked-all
[151.138708] Subtest basic-contexts-forked-all: SUCCESS (12.351s)
[151.407802] [018/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-5)
[151.584239] Starting subtest: planes-downscale-factor-0-5
[151.586596] Starting dynamic subtest: pipe-A
[151.892057] Dynamic subtest pipe-A: SUCCESS (0.309s)
[151.935989] Starting dynamic subtest: pipe-B
[152.349265] Dynamic subtest pipe-B: SUCCESS (0.458s)
[152.391602] Starting dynamic subtest: pipe-C
[152.434289] Dynamic subtest pipe-C: SUCCESS (0.076s)
[152.437108] Subtest planes-downscale-factor-0-5: SUCCESS (0.845s)
[152.874703] [019/133] (927s left) syncobj_wait (wait-all-interrupted)
[152.985436] Starting subtest: wait-all-interrupted
[153.094751] Subtest wait-all-interrupted: SUCCESS (0.104s)
[153.257908] [020/133] (927s left) i915_pm_rpm (sysfs-read)
[155.176245] Starting subtest: sysfs-read
[155.386997] Subtest sysfs-read: SUCCESS (0.207s)
[155.785749] [021/133] (924s left) drm_read (empty-block)
[156.241319] Starting subtest: empty-block
[157.247213] Subtest empty-block: SUCCESS (1.001s)
[157.498512] [022/133] (923s left) syncobj_timeline (single-wait-all-available-submitted)
[157.599293] Starting subtest: single-wait-all-available-submitted
[157.600804] Subtest single-wait-all-available-submitted: SUCCESS (0.001s)
[157.765125] [023/133] (923s left) gem_close_race (basic-process)
[157.894046] Starting subtest: basic-process
[157.975499] Subtest basic-process: SUCCESS (0.080s)
[158.234712] [024/133] (922s left) kms_getfb (getfb-reject-nv12)
[158.417166] Starting subtest: getfb-reject-nv12
[158.419069] Subtest getfb-reject-nv12: SUCCESS (0.004s)
[158.564848] [025/133] (922s left) kms_frontbuffer_tracking (psr-suspend)
[158.765181] Starting subtest: psr-suspend
[158.768696] Subtest psr-suspend: SKIP (0.000s)
[158.916770] [026/133] (922s left) kms_prime (d3hot)
[159.140497] Subtest D3hot: SKIP (0.000s)
[159.328935] [027/133] (921s left) kms_cursor_crc (cursor-suspend)
[159.521104] Starting subtest: cursor-suspend
[159.525375] Starting dynamic subtest: pipe-A-HDMI-A-1