[93.693763] Initializing watchdogs
[93.693954]   /dev/watchdog0
[93.735866] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[93.750616] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[93.757744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[93.763350] [001/156] (960s left) syncobj_timeline (invalid-query-illegal-handle)
[93.893541] Starting subtest: invalid-query-illegal-handle
[93.894920] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[94.049567] [002/156] (960s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[94.265343] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[94.269066] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[94.403830] [003/156] (960s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[94.603090] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[94.706644] [004/156] (959s left) gem_userptr_blits (sync-unmap-after-close)
[94.847808] Starting subtest: sync-unmap-after-close
[94.893854] Subtest sync-unmap-after-close: SUCCESS (0.044s)
[95.061755] [005/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[95.272982] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[95.276102] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[95.408857] [006/156] (959s left) gem_exec_params (invalid-flag)
[95.529906] Starting subtest: invalid-flag
[95.531363] Subtest invalid-flag: SUCCESS (0.002s)
[95.686187] [007/156] (959s left) gem_exec_create (madvise)
[95.814983] Starting subtest: madvise
[95.816321] Starting dynamic subtest: smem
[115.945766] Dynamic subtest smem: SUCCESS (20.133s)
[115.949044] Subtest madvise: SUCCESS (20.134s)
[117.393761] [008/156] (937s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[117.595307] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[117.599959] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[117.735512] [009/156] (937s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt)
[117.938359] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt
[117.940597] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.001s)
[118.075399] [010/156] (936s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.279257] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.282328] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.417362] [011/156] (936s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[118.610139] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[118.611171] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.627176] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[118.665590] Starting dynamic subtest: pipe-A-HDMI-A-2
[118.695463] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[118.731437] Starting dynamic subtest: pipe-B-HDMI-A-1
[118.758388] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[118.793851] Starting dynamic subtest: pipe-B-HDMI-A-2
[118.819338] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.005s)
[118.848397] Starting dynamic subtest: pipe-C-HDMI-A-1
[118.857484] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.004s)
[118.877614] Starting dynamic subtest: pipe-C-HDMI-A-2
[118.887799] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.005s)
[118.890501] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.046s)
[119.727243] [012/156] (935s left) kms_getfb (getfb-handle-protection)
[119.926107] Starting subtest: getfb-handle-protection
[119.954572] Subtest getfb-handle-protection: SUCCESS (0.031s)
[120.099654] [013/156] (935s left) kms_psr (fbc-psr-suspend)
[120.289210] Subtest fbc-psr-suspend: SKIP (0.000s)
[120.387730] [014/156] (934s left) i915_drm_fdinfo (most-busy-idle-check-all)
[120.499741] Starting subtest: most-busy-idle-check-all
[120.503085] Starting dynamic subtest: rcs0
[121.128202] Dynamic subtest rcs0: SUCCESS (0.629s)
[121.148570] Starting dynamic subtest: bcs0
[121.747181] Dynamic subtest bcs0: SUCCESS (0.618s)
[121.767453] Starting dynamic subtest: vcs0
[122.374551] Dynamic subtest vcs0: SUCCESS (0.627s)
[122.394599] Starting dynamic subtest: vecs0
[123.003554] Dynamic subtest vecs0: SUCCESS (0.628s)
[123.004702] Subtest most-busy-idle-check-all: SUCCESS (2.504s)
[123.135902] [015/156] (932s left) gem_partial_pwrite_pread (write-snoop)
[123.254766] Starting subtest: write-snoop
[137.315223] Subtest write-snoop: SUCCESS (14.064s)
[137.467522] [016/156] (917s left) dmabuf_sync_file (export-multiwait)
[137.692932] Starting subtest: export-multiwait
[137.697613] Subtest export-multiwait: SUCCESS (0.008s)
[137.821949] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[137.825483] [017/156] (917s left) fbdev (eof)
[137.943680] Starting subtest: eof
[137.945545] Subtest eof: SUCCESS (0.000s)
[138.120227] [018/156] (917s left) gem_eio (wait-wedge-10ms)
[138.257146] Starting subtest: wait-wedge-10ms
[138.364550] Subtest wait-wedge-10ms: SUCCESS (0.114s)
[138.608574] [019/156] (917s left) gem_exec_schedule (thriceslice)
[138.747690] Starting subtest: thriceslice
[138.750163] Starting dynamic subtest: rcs0
[138.763299] Dynamic subtest rcs0: SUCCESS (0.015s)
[138.800884] Starting dynamic subtest: bcs0
[138.802382] Dynamic subtest bcs0: SUCCESS (0.013s)
[138.822838] Starting dynamic subtest: vcs0
[138.823902] Dynamic subtest vcs0: SUCCESS (0.011s)
[138.843752] Starting dynamic subtest: vecs0
[138.844751] Dynamic subtest vecs0: SUCCESS (0.013s)
[138.845716] Subtest thriceslice: SUCCESS (0.054s)
[139.238482] [020/156] (916s left) kms_cursor_crc (cursor-onscreen-512x512)
[139.446224] Starting subtest: cursor-onscreen-512x512
[139.449307] Subtest cursor-onscreen-512x512: SKIP (0.003s)
[139.594461] [021/156] (916s left) gem_exec_balancer (parallel-balancer)
[139.837518] Subtest parallel-balancer: SKIP (0.000s)
[140.022794] [022/156] (915s left) kms_psr (psr-cursor-mmap-cpu)
[140.208355] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[140.317285] [023/156] (915s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[140.533241] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[140.536446] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[140.676751] [024/156] (915s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[140.868098] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[140.871666] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[141.027708] [025/156] (915s left) kms_big_fb (linear-8bpp-rotate-0)
[141.241281] Starting subtest: linear-8bpp-rotate-0
[145.217719] Subtest linear-8bpp-rotate-0: SUCCESS (3.975s)
[145.527700] [026/156] (910s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw)
[145.726491] Starting subtest: fbchdr-1p-pri-indfb-multidraw
[145.730816] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[145.875854] [027/156] (910s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[146.087067] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[146.090238] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[146.226276] [028/156] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[146.427219] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[148.950567] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.521s)
[149.258593] [029/156] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[149.466154] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[152.333970] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.868s)
[152.626501] [030/156] (904s left) gem_ctx_persistence (engines-hang)
[152.739741] Starting subtest: engines-hang
[152.742171] Starting dynamic subtest: rcs0
[152.771223] Dynamic subtest rcs0: SUCCESS (0.029s)
[152.794855] Starting dynamic subtest: bcs0
[152.796409] Dynamic subtest bcs0: SKIP (0.007s)
[152.819455] Starting dynamic subtest: vcs0
[152.826316] Dynamic subtest vcs0: SUCCESS (0.050s)
[152.848568] Starting dynamic subtest: vecs0
[152.864677] Dynamic subtest vecs0: SUCCESS (0.033s)
[152.865842] Subtest engines-hang: SUCCESS (0.126s)
[153.009189] [031/156] (903s left) kms_content_protection (content-type-change)
[153.210338] Starting subtest: content-type-change
[153.227170] Subtest content-type-change: SKIP (0.013s)
[153.372127] [032/156] (903s left) kms_chamelium_edid (hdmi-mode-timings)
[153.926255] Subtest hdmi-mode-timings: SKIP (0.000s)
[154.238479] [033/156] (902s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[154.446158] Starting subtest: pipe-fbc-rte
[154.451985] Subtest pipe-fbc-rte: SKIP (0.001s)
[154.603408] [034/156] (902s left) gem_exec_create (basic)
[154.735410] Starting subtest: basic
[154.739154] Starting dynamic subtest: smem
[156.784257] Dynamic subtest smem: SUCCESS (2.050s)
[156.786052] Subtest basic: SUCCESS (2.052s)
[157.041708] [035/156] (900s left) gem_ctx_shared (disjoint-timelines)
[157.164037] Starting subtest: disjoint-timelines
[157.186757] Subtest disjoint-timelines: SUCCESS (0.021s)
[157.458256] [036/156] (899s left) gem_eio (in-flight-suspend)
[157.589251] Starting subtest: in-flight-suspend