[87.402377] Initializing watchdogs
[87.402546]   /dev/watchdog0
[87.441505] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.456798] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.464489] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.472199] [001/134] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[87.699561] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[89.683259] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.988s)
[89.893266] [002/134] (958s left) kms_psr (fbc-psr-suspend)
[90.080999] Subtest fbc-psr-suspend: SKIP (0.000s)
[90.174877] [003/134] (957s left) syncobj_timeline (invalid-signal-illegal-point)
[90.289992] Starting subtest: invalid-signal-illegal-point
[90.295097] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[90.441854] [004/134] (957s left) kms_cursor_crc (cursor-offscreen-32x32)
[90.637409] Starting subtest: cursor-offscreen-32x32
[90.790463] Subtest cursor-offscreen-32x32: SKIP (0.146s)
[90.963285] [005/134] (957s left) gem_vm_create (create-ext)
[91.089710] Starting subtest: create-ext
[91.098248] Subtest create-ext: SUCCESS (0.007s)
[91.261812] [006/134] (957s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[91.457101] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[91.461107] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[102.679934] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.224s)
[102.698494] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[113.814996] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.130s)
[113.833994] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[124.792664] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.972s)
[124.797036] Subtest 2x-flip-vs-absolute-wf_vblank: SUCCESS (33.341s)
[125.382225] [007/134] (923s left) syncobj_timeline (wait-all-delayed-signal)
[125.493529] Starting subtest: wait-all-delayed-signal
[125.603423] Subtest wait-all-delayed-signal: SUCCESS (0.106s)
[125.759168] [008/134] (922s left) core_hotunplug (unbind-rebind)
[125.952575] Starting subtest: unbind-rebind
[133.061555] Subtest unbind-rebind: SUCCESS (7.112s)
[133.150887] [009/134] (915s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[133.361587] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[136.242341] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (2.885s)
[136.459887] [010/134] (912s left) kms_pm_dc (dc5-retention-flops)
[147.761988] Starting subtest: dc5-retention-flops
[147.768970] Subtest dc5-retention-flops: SKIP (0.000s)
[147.926077] [011/134] (900s left) gem_spin_batch (engines)
[148.057187] Starting subtest: engines
[148.060526] Starting dynamic subtest: rcs0
[151.296857] Dynamic subtest rcs0: SUCCESS (3.236s)
[151.316251] Starting dynamic subtest: bcs0
[154.532830] Dynamic subtest bcs0: SUCCESS (3.233s)
[154.551958] Starting dynamic subtest: vcs0
[157.761521] Dynamic subtest vcs0: SUCCESS (3.230s)
[157.781369] Starting dynamic subtest: vecs0
[160.995349] Dynamic subtest vecs0: SUCCESS (3.229s)
[160.999365] Subtest engines: SUCCESS (12.934s)
[161.273179] [012/134] (887s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[161.458878] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[161.462202] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.495615] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[161.530293] Starting dynamic subtest: pipe-A-HDMI-A-2
[161.565124] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[161.585261] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.616500] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[161.635398] Starting dynamic subtest: pipe-B-HDMI-A-2
[161.696200] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[161.715409] Starting dynamic subtest: pipe-C-HDMI-A-1
[161.751640] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[161.771678] Starting dynamic subtest: pipe-C-HDMI-A-2
[161.806866] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[161.813636] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.018s)
[162.841147] [013/134] (886s left) gem_userptr_blits (forbidden-operations)
[163.447324] Starting subtest: forbidden-operations
[163.517306] Subtest forbidden-operations: SUCCESS (0.002s)
[163.762559] [014/134] (885s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[163.962813] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[163.969754] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[164.128883] [015/134] (885s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[164.318966] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[164.323454] Starting dynamic subtest: pipe-A
[164.625014] Dynamic subtest pipe-A: SUCCESS (0.305s)
[164.648561] Starting dynamic subtest: pipe-B
[165.005527] Dynamic subtest pipe-B: SUCCESS (0.380s)
[165.034103] Starting dynamic subtest: pipe-C
[165.079920] Dynamic subtest pipe-C: SUCCESS (0.071s)
[165.083187] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.760s)
[165.523736] [016/134] (884s left) gem_ctx_shared (detached-shared-gtt)
[165.649114] Starting subtest: detached-shared-gtt
[167.801976] Subtest detached-shared-gtt: SUCCESS (2.152s)
[168.091188] [017/134] (881s left) syncobj_timeline (multi-wait-signaled)
[168.196187] Starting subtest: multi-wait-signaled
[168.200228] Subtest multi-wait-signaled: SUCCESS (0.003s)
[168.361230] [018/134] (881s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[168.570821] Starting subtest: y-tiled-64bpp-rotate-270
[168.858476] Subtest y-tiled-64bpp-rotate-270: SKIP (0.284s)
[169.108974] [019/134] (880s left) gem_exec_reloc (basic-wc-active)
[169.236608] Starting subtest: basic-wc-active
[169.373664] Subtest basic-wc-active: SUCCESS (0.140s)
[169.638906] [020/134] (880s left) syncobj_wait (single-wait-signaled)
[169.746392] Starting subtest: single-wait-signaled
[169.750907] Subtest single-wait-signaled: SUCCESS (0.001s)
[169.889064] [021/134] (880s left) syncobj_timeline (wait-for-submit-snapshot)
[169.997959] Starting subtest: wait-for-submit-snapshot
[170.084670] Subtest wait-for-submit-snapshot: SUCCESS (0.088s)
[170.257969] [022/134] (879s left) prime_mmap (test_invalid_sync_flags)
[170.357382] Starting subtest: test_invalid_sync_flags
[170.360948] Starting dynamic subtest: test_invalid_sync_flags-smem
[170.364474] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[170.367912] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[170.524317] [023/134] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[170.718425] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[170.725414] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[170.892891] [024/134] (879s left) gem_ctx_param (invalid-ctx-set)
[170.995176] Starting subtest: invalid-ctx-set
[171.000122] Subtest invalid-ctx-set: SUCCESS (0.000s)
[171.156748] [025/134] (879s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[171.367801] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[171.374938] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[171.540987] [026/134] (879s left) gem_request_retire (retire-vma-not-inactive)
[171.657252] Starting subtest: retire-vma-not-inactive
[171.681905] Subtest retire-vma-not-inactive: SUCCESS (0.023s)
[171.856855] [027/134] (878s left) gem_exec_schedule (preempt)
[171.989545] Starting subtest: preempt
[171.992592] Starting dynamic subtest: rcs0
[172.043845] Dynamic subtest rcs0: SUCCESS (0.052s)
[172.064808] Starting dynamic subtest: bcs0
[172.122353] Dynamic subtest bcs0: SUCCESS (0.075s)
[172.142069] Starting dynamic subtest: vcs0
[172.184152] Dynamic subtest vcs0: SUCCESS (0.065s)
[172.205152] Starting dynamic subtest: vecs0
[172.233183] Dynamic subtest vecs0: SUCCESS (0.050s)
[172.238990] Subtest preempt: SUCCESS (0.245s)
[172.643237] [028/134] (878s left) gem_render_copy (yf-tiled)
[172.766710] Starting subtest: yf-tiled
[172.770133] Starting dynamic subtest: smem
[173.078272] Dynamic subtest smem: SUCCESS (0.308s)
[173.082054] Subtest yf-tiled: SUCCESS (0.309s)
[173.341874] [029/134] (877s left) gem_exec_fence (basic-wait)
[173.597078] Starting subtest: basic-wait
[173.602372] Starting dynamic subtest: rcs0
[173.613433] Dynamic subtest rcs0: SUCCESS (0.014s)
[173.634496] Starting dynamic subtest: bcs0
[173.638333] Dynamic subtest bcs0: SUCCESS (0.022s)
[173.659655] Starting dynamic subtest: vcs0
[173.663160] Dynamic subtest vcs0: SUCCESS (0.018s)
[173.684391] Starting dynamic subtest: vecs0
[173.688451] Dynamic subtest vecs0: SUCCESS (0.021s)
[173.692495] Subtest basic-wait: SUCCESS (0.083s)
[174.445547] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[174.452253] [030/134] (876s left) kms_cursor_crc (cursor-sliding-512x170)
[174.646733] Starting subtest: cursor-sliding-512x170
[174.653359] Subtest cursor-sliding-512x170: SKIP (0.003s)
[174.832216] [031/134] (876s left) gem_exec_store (pages)
[174.960055] Starting subtest: pages
[174.963897] Starting dynamic subtest: rcs0
[175.050826] Dynamic subtest rcs0: SUCCESS (0.090s)
[175.071107] Starting dynamic subtest: bcs0
[175.145429] Dynamic subtest bcs0: SUCCESS (0.090s)
[175.166042] Starting dynamic subtest: vcs0
[175.235409] Dynamic subtest vcs0: SUCCESS (0.088s)
[175.256126] Starting dynamic subtest: vecs0
[175.314505] Dynamic subtest vecs0: SUCCESS (0.079s)
[175.318363] Subtest pages: SUCCESS (0.356s)
[175.603725] [032/134] (875s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[175.805763] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[175.813496] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[175.987727] [033/134] (875s left) kms_color (ctm-blue-to-red)
[176.172759] Starting subtest: ctm-blue-to-red
[176.176217] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.088516] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.912s)
[177.118437] Starting dynamic subtest: pipe-A-HDMI-A-2
[177.736968] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.648s)
[177.772602] Starting dynamic subtest: pipe-B-HDMI-A-1
[178.376869] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.637s)
[178.426277] Starting dynamic subtest: pipe-B-HDMI-A-2
[179.000988] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.621s)
[179.050295] Starting dynamic subtest: pipe-C-HDMI-A-1
[179.634148] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.633s)
[179.672324] Starting dynamic subtest: pipe-C-HDMI-A-2
[180.260661] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.627s)
[180.264552] Subtest ctm-blue-to-red: SUCCESS (4.086s)
[180.589559] [034/134] (870s left) gem_mmap_offset (mmap-boundaries)
[180.696513] Starting subtest: mmap-boundaries
[180.699860] Starting dynamic subtest: smem0
[181.595718] Dynamic subtest smem0: SUCCESS (0.893s)
[181.599623] Subtest mmap-boundaries: SUCCESS (0.895s)
[181.789135] [035/134] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[181.992485] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[181.999092] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[182.152817] [036/134] (869s left) kms_properties (connector-properties-legacy)
[182.345415] Starting subtest: connector-properties-legacy
[182.349070] Starting dynamic subtest: pipe-A-HDMI-A-1
[184.197377] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.843s)
[184.256698] Starting dynamic subtest: pipe-A-HDMI-A-2
[185.930874] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.731s)
[185.934693] Subtest connector-properties-legacy: SUCCESS (3.585s)
[186.245356] [037/134] (865s left) gem_eio (in-flight-immediate)
[186.400691] Starting subtest: in-flight-immediate
[187.333151] Subtest in-flight-immediate: SUCCESS (0.934s)
[187.609327] [038/134] (864s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[187.809664] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[190.201668] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (2.397s)
[190.492626] [039/134] (861s left) gem_softpin (evict-active-interruptible)
[190.613699] Starting subtest: evict-active-interruptible
[190.630613] Subtest evict-active-interruptible: SUCCESS (0.017s)
[190.791900] [040/134] (861s left) kms_frontbuffer_tracking (fbc-tiling-4)
[190.999100] Starting subtest: fbc-tiling-4
[191.005902] Subtest fbc-tiling-4: SKIP (0.000s)
[191.196117] [041/134] (860s left) api_intel_bb (simple-bb-ctx)
[191.305708] Starting subtest: simple-bb-ctx
[191.316493] Subtest simple-bb-ctx: SUCCESS (0.014s)
[191.510534] [042/134] (860s left) kms_frontbuffer_tracking (fbc-suspend)
[191.721230] Starting subtest: fbc-suspend