[91.448840] Initializing watchdogs
[91.449111]   /dev/watchdog0
[91.489533] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.504373] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.510667] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.518469] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[91.764653] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[91.773153] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[91.917958] [002/133] (960s left) kms_chamelium_frames (hdmi-aspect-ratio)
[92.530861] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[92.811459] [003/133] (959s left) kms_cursor_crc (cursor-onscreen-512x170)
[93.036582] Starting subtest: cursor-onscreen-512x170
[93.043348] Subtest cursor-onscreen-512x170: SKIP (0.003s)
[93.197657] [004/133] (959s left) gem_exec_whisper (basic-fds-forked-all)
[93.344976] Starting subtest: basic-fds-forked-all
[110.753147] Subtest basic-fds-forked-all: SUCCESS (17.404s)
[111.008851] [005/133] (941s left) gem_mmap (basic-small-bo)
[111.124225] Starting subtest: basic-small-bo
[111.925576] Subtest basic-small-bo: SUCCESS (0.807s)
[112.082682] [006/133] (940s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[112.452795] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[112.460239] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[112.594104] [007/133] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[112.807050] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[112.815305] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[112.942857] [008/133] (939s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[113.085761] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[113.181747] [009/133] (939s left) gem_eio (in-flight-contexts-immediate)
[113.317677] Starting subtest: in-flight-contexts-immediate
[125.014092] Subtest in-flight-contexts-immediate: SUCCESS (11.697s)
[125.260514] [010/133] (927s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[125.385675] Starting subtest: y-tiled-ccs-to-x-tiled
[125.391704] Starting dynamic subtest: smem
[125.621583] Dynamic subtest smem: SUCCESS (0.234s)
[125.625496] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.235s)
[125.878753] [011/133] (927s left) gem_exec_params (rs-invalid)
[125.996783] Starting subtest: rs-invalid
[126.004146] Subtest rs-invalid: SUCCESS (0.006s)
[126.159814] [012/133] (926s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[126.276517] Starting subtest: etime-single-wait-for-submit-submitted
[126.383152] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[126.526932] [013/133] (926s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[126.716741] Starting subtest: short-flip-after-cursor-toggle
[128.074136] Subtest short-flip-after-cursor-toggle: SUCCESS (1.361s)
[128.412315] [014/133] (924s left) syncobj_wait (invalid-signal-illegal-handle)
[128.527401] Starting subtest: invalid-signal-illegal-handle
[128.532312] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[128.655581] [015/133] (924s left) gem_exec_schedule (preempt-queue)
[128.806105] Starting subtest: preempt-queue
[128.809404] Starting dynamic subtest: rcs0
[129.084497] Dynamic subtest rcs0: SUCCESS (0.289s)
[129.118262] Starting dynamic subtest: bcs0
[129.384524] Dynamic subtest bcs0: SUCCESS (0.299s)
[129.408477] Starting dynamic subtest: vcs0
[129.673071] Dynamic subtest vcs0: SUCCESS (0.287s)
[129.696973] Starting dynamic subtest: vecs0
[129.986484] Dynamic subtest vecs0: SUCCESS (0.314s)
[129.989962] Subtest preempt-queue: SUCCESS (1.195s)
[130.391697] [016/133] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[130.599400] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[130.606065] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[130.741399] [017/133] (922s left) kms_getfb (getfb2-handle-protection)
[130.938052] Starting subtest: getfb2-handle-protection
[130.999118] Subtest getfb2-handle-protection: SUCCESS (0.065s)
[131.141241] [018/133] (922s left) gem_create (busy-create)
[131.262417] Starting subtest: busy-create
[131.265749] Starting dynamic subtest: smem0
[163.515172] Dynamic subtest smem0: SUCCESS (32.252s)
[163.519407] Subtest busy-create: SUCCESS (32.253s)
[163.773801] [019/133] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[163.974264] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[163.984125] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[164.108550] [020/133] (889s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[164.230807] Starting subtest: yf-tiled-ccs-to-y-tiled
[164.234715] Starting dynamic subtest: smem
[164.474295] Dynamic subtest smem: SUCCESS (0.241s)
[164.478443] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.244s)
[164.725180] [021/133] (889s left) kms_scaling_modes (scaling-mode-none)
[164.907167] Starting subtest: scaling-mode-none
[164.936608] Subtest scaling-mode-none: SKIP (0.005s)
[165.058213] [022/133] (888s left) api_intel_bb (intel-bb-blit-none)
[165.163669] Starting subtest: intel-bb-blit-none
[168.841488] Subtest intel-bb-blit-none: SUCCESS (3.680s)
[169.008117] [023/133] (885s left) gem_ctx_shared (exec-shared-gtt)
[169.141387] Starting subtest: exec-shared-gtt
[169.144871] Starting dynamic subtest: rcs0
[169.149350] Dynamic subtest rcs0: SUCCESS (0.010s)
[169.186630] Starting dynamic subtest: bcs0
[169.190511] Dynamic subtest bcs0: SUCCESS (0.011s)
[169.213540] Starting dynamic subtest: vcs0
[169.218056] Dynamic subtest vcs0: SUCCESS (0.007s)
[169.243072] Starting dynamic subtest: vecs0
[169.247393] Dynamic subtest vecs0: SUCCESS (0.008s)
[169.251846] Subtest exec-shared-gtt: SUCCESS (0.040s)
[169.427890] [024/133] (884s left) gem_userptr_blits (sync-unmap-after-close)
[169.569693] Starting subtest: sync-unmap-after-close
[169.607191] Subtest sync-unmap-after-close: SUCCESS (0.038s)
[169.773851] [025/133] (884s left) gem_exec_balancer (full-late)
[169.901416] Starting subtest: full-late
[174.464988] Subtest full-late: SUCCESS (4.564s)
[174.743591] [026/133] (879s left) gem_exec_reloc (basic-cpu-wc)
[174.864466] Starting subtest: basic-cpu-wc
[174.887447] Subtest basic-cpu-wc: SUCCESS (0.019s)
[175.092922] [027/133] (879s left) gem_partial_pwrite_pread (write)
[175.210430] Starting subtest: write
[189.340904] Subtest write: SUCCESS (14.131s)
[189.490568] [028/133] (865s left) dumb_buffer (map-invalid-size)
[189.599908] Starting subtest: map-invalid-size
[189.603445] Subtest map-invalid-size: SUCCESS (0.000s)
[189.738718] [029/133] (864s left) kms_plane (plane-panning-bottom-right-suspend)
[189.927863] Starting subtest: plane-panning-bottom-right-suspend
[189.931280] Starting dynamic subtest: pipe-A