[89.203774] Initializing watchdogs
[89.203948]   /dev/watchdog0
[89.244919] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.260799] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.267911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.274625] [001/131] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[89.500487] Starting subtest: x-tiled-8bpp-rotate-180
[92.888725] Subtest x-tiled-8bpp-rotate-180: SUCCESS (3.390s)
[93.216394] [002/131] (956s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[93.403092] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[93.407138] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[93.534782] [003/131] (956s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[93.721063] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[93.814336] [004/131] (956s left) kms_frontbuffer_tracking (psr-slowdraw)
[94.013092] Starting subtest: psr-slowdraw
[94.017260] Subtest psr-slowdraw: SKIP (0.000s)
[94.149962] [005/131] (955s left) kms_flip (plain-flip-fb-recreate)
[94.339193] Starting subtest: plain-flip-fb-recreate
[94.342161] Starting dynamic subtest: A-HDMI-A1
[100.306815] Dynamic subtest A-HDMI-A1: SUCCESS (5.963s)
[100.325138] Starting dynamic subtest: B-HDMI-A1
[106.027343] Dynamic subtest B-HDMI-A1: SUCCESS (5.716s)
[106.045994] Starting dynamic subtest: C-HDMI-A1
[111.707205] Dynamic subtest C-HDMI-A1: SUCCESS (5.676s)
[111.725053] Starting dynamic subtest: A-HDMI-A2
[117.416288] Dynamic subtest A-HDMI-A2: SUCCESS (5.704s)
[117.433790] Starting dynamic subtest: B-HDMI-A2
[123.099903] Dynamic subtest B-HDMI-A2: SUCCESS (5.681s)
[123.117508] Starting dynamic subtest: C-HDMI-A2
[128.792432] Dynamic subtest C-HDMI-A2: SUCCESS (5.690s)
[128.794246] Subtest plain-flip-fb-recreate: SUCCESS (34.450s)
[129.274980] [006/131] (920s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[129.384530] Starting subtest: invalid-signal-one-illegal-handle
[129.387223] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.002s)
[129.523239] [007/131] (920s left) api_intel_allocator (open-vm)
[129.627936] Starting subtest: open-vm
[129.634641] Subtest open-vm: SUCCESS (0.005s)
[129.774194] [008/131] (920s left) gem_exec_params (cliprects_ptr-dirt)
[129.890170] Starting subtest: cliprects_ptr-dirt
[129.893076] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[130.025700] [009/131] (920s left) gem_ctx_persistence (engines-hang)
[130.138670] Starting subtest: engines-hang
[130.140406] Starting dynamic subtest: rcs0
[130.179642] Dynamic subtest rcs0: SUCCESS (0.039s)
[130.200441] Starting dynamic subtest: bcs0
[130.208902] Dynamic subtest bcs0: SKIP (0.009s)
[130.236968] Starting dynamic subtest: vcs0
[130.241065] Dynamic subtest vcs0: SUCCESS (0.025s)
[130.265368] Starting dynamic subtest: vecs0
[130.267348] Dynamic subtest vecs0: SUCCESS (0.023s)
[130.270170] Subtest engines-hang: SUCCESS (0.100s)
[130.403532] [010/131] (920s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[130.603128] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[133.438229] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.834s)
[133.723118] [011/131] (916s left) kms_psr (fbc-psr2-primary-page-flip)
[133.913079] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[134.007646] [012/131] (916s left) i915_drm_fdinfo (busy)
[134.119069] Starting subtest: busy
[134.120892] Starting dynamic subtest: rcs0
[134.651165] Dynamic subtest rcs0: SUCCESS (0.530s)
[134.672722] Starting dynamic subtest: bcs0
[135.192806] Dynamic subtest bcs0: SUCCESS (0.539s)
[135.216804] Starting dynamic subtest: vcs0
[135.721127] Dynamic subtest vcs0: SUCCESS (0.527s)
[135.744153] Starting dynamic subtest: vecs0
[136.247465] Dynamic subtest vecs0: SUCCESS (0.527s)
[136.250548] Subtest busy: SUCCESS (2.127s)
[136.375503] [013/131] (914s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[136.564056] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[136.661426] [014/131] (914s left) kms_cursor_crc (cursor-offscreen-64x64)
[136.855697] Starting subtest: cursor-offscreen-64x64
[136.916353] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.760381] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.842s)
[139.896840] Starting dynamic subtest: pipe-C-HDMI-A-1
[142.404328] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.538s)
[142.405999] Subtest cursor-offscreen-64x64: SUCCESS (5.543s)
[142.740979] [015/131] (908s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[142.930168] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[142.932121] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.953412] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[142.990530] Starting dynamic subtest: pipe-A-HDMI-A-2
[143.020315] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[143.056394] Starting dynamic subtest: pipe-B-HDMI-A-1
[143.086458] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[143.121526] Starting dynamic subtest: pipe-B-HDMI-A-2
[143.145652] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[143.162697] Starting dynamic subtest: pipe-C-HDMI-A-1
[143.178434] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[143.197198] Starting dynamic subtest: pipe-C-HDMI-A-2
[143.213094] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[143.216217] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.022s)
[143.958488] [016/131] (907s left) syncobj_timeline (single-wait-available-signaled)
[144.061976] Starting subtest: single-wait-available-signaled
[144.066235] Subtest single-wait-available-signaled: SUCCESS (0.002s)
[144.225230] [017/131] (906s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[144.401073] Starting subtest: 2x-flip-vs-modeset-vs-hang
[144.410239] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[158.639665] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (14.231s)
[158.641341] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (14.239s)
[159.012362] [018/131] (892s left) syncobj_timeline (multi-wait-available-signaled)
[159.121159] Starting subtest: multi-wait-available-signaled
[159.123177] Subtest multi-wait-available-signaled: SUCCESS (0.002s)
[159.251736] [019/131] (892s left) kms_content_protection (uevent-hdcp14)
[159.438232] Starting subtest: uevent-hdcp14
[159.457262] Subtest uevent-hdcp14: SKIP (0.012s)
[159.601151] [020/131] (891s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[159.794101] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[159.799121] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[159.962247] [021/131] (891s left) perf_pmu (semaphore-wait-idle)
[160.078272] Starting subtest: semaphore-wait-idle
[160.080406] Starting dynamic subtest: rcs0
[160.593884] Dynamic subtest rcs0: SUCCESS (0.517s)
[160.616763] Starting dynamic subtest: bcs0
[161.116626] Dynamic subtest bcs0: SUCCESS (0.518s)
[161.136443] Starting dynamic subtest: vcs0
[161.631259] Dynamic subtest vcs0: SUCCESS (0.515s)
[161.652653] Starting dynamic subtest: vecs0
[162.149868] Dynamic subtest vecs0: SUCCESS (0.514s)
[162.152757] Subtest semaphore-wait-idle: SUCCESS (2.072s)
[162.313339] [022/131] (889s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[162.519394] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[162.523671] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[162.662100] [023/131] (888s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[162.838133] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[162.844633] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[162.970499] [024/131] (888s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[163.176974] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[163.181992] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[163.318241] [025/131] (888s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[163.428464] Starting subtest: no-spare-fences-interruptible
[165.606788] Subtest no-spare-fences-interruptible: SUCCESS (2.165s)
[165.735311] [026/131] (886s left) kms_psr (pr-sprite-blt)
[165.916685] Subtest pr-sprite-blt: SKIP (0.000s)
[166.010301] [027/131] (885s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[166.201737] Starting subtest: flip-vs-cursor-busy-crc-atomic
[167.244721] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.043s)
[167.592457] [028/131] (884s left) kms_psr (psr2-dpms)
[167.785086] Subtest psr2-dpms: SKIP (0.000s)
[167.883620] [029/131] (884s left) syncobj_wait (single-wait-all-signaled)
[167.989448] Starting subtest: single-wait-all-signaled
[167.992658] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[168.128474] [030/131] (884s left) gem_render_copy_redux (interruptible)
[168.250049] Starting subtest: interruptible
[169.660562] Subtest interruptible: SUCCESS (1.413s)
[169.796578] [031/131] (882s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[169.994086] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[172.864153] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (2.864s)
[173.046474] [032/131] (879s left) i915_pm_freq_api (freq-basic-api)
[173.161747] Subtest freq-basic-api: SKIP (0.000s)
[173.268830] [033/131] (879s left) gem_exercise_blt (fast-copy)
[173.383095] Starting subtest: fast-copy
[173.387699] Starting dynamic subtest: linear-smem-smem
[173.438092] Dynamic subtest linear-smem-smem: SUCCESS (0.052s)
[173.459187] Starting dynamic subtest: ymajor-smem-smem
[173.479157] Dynamic subtest ymajor-smem-smem: SUCCESS (0.041s)
[173.501802] Starting dynamic subtest: yfmajor-smem-smem
[173.518087] Dynamic subtest yfmajor-smem-smem: SUCCESS (0.039s)
[173.542242] Starting dynamic subtest: tile64-smem-smem
[173.558910] Dynamic subtest tile64-smem-smem: SUCCESS (0.038s)
[173.560860] Subtest fast-copy: SUCCESS (0.176s)
[173.713336] [034/131] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[173.909158] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[177.095293] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SUCCESS (3.188s)
[177.275936] [035/131] (875s left) gem_partial_pwrite_pread (reads-display)
[177.392350] Starting subtest: reads-display
[183.930446] Subtest reads-display: SUCCESS (6.537s)
[184.082599] [036/131] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[184.283751] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[184.287102] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[184.426158] [037/131] (868s left) gem_ctx_param (basic-default)
[184.533387] Starting subtest: basic-default
[184.537151] Subtest basic-default: SUCCESS (0.000s)
[184.664576] [038/131] (868s left) gem_exec_balancer (parallel)
[184.908097] Subtest parallel: SKIP (0.000s)
[185.079871] [039/131] (867s left) gem_create (create-ext-set-pat)
[185.306458] Starting subtest: create-ext-set-pat
[185.309978] Subtest create-ext-set-pat: SKIP (0.000s)
[185.446624] [040/131] (867s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[185.631661] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[185.635701] Starting dynamic subtest: pipe-A-valid-mode
[186.535176] Dynamic subtest pipe-A-valid-mode: SKIP (0.904s)
[186.538359] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.908s)
[187.081528] [041/131] (866s left) gem_exec_reloc (basic-gtt-cpu-active)
[187.201399] Starting subtest: basic-gtt-cpu-active
[187.340540] Subtest basic-gtt-cpu-active: SUCCESS (0.138s)
[187.568439] [042/131] (865s left) perf (rc6-disable)
[187.788318] Starting subtest: rc6-disable
[187.979764] Subtest rc6-disable: SUCCESS (0.192s)
[188.082638] [043/131] (865s left) gem_mmap_offset (clear-via-pagefault)
[188.185237] Starting subtest: clear-via-pagefault
[188.189196] Starting dynamic subtest: smem0
[209.903227] Dynamic subtest smem0: SUCCESS (21.709s)
[209.905969] Subtest clear-via-pagefault: SUCCESS (21.711s)
[210.067608] [044/131] (843s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[210.243110] Starting subtest: psr-dirtyfb-ioctl
[210.256793] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[210.386758] [045/131] (843s left) kms_lease (lease-unleased-crtc)
[210.573125] Starting subtest: lease-unleased-crtc
[210.575157] Starting dynamic subtest: pipe-A-HDMI-A-1
[210.826626] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.247s)
[210.889053] Starting dynamic subtest: pipe-A-HDMI-A-2
[210.913102] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.058s)
[210.954665] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.192065] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.278s)
[211.246599] Starting dynamic subtest: pipe-B-HDMI-A-2
[211.270061] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.061s)
[211.311202] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.337262] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.067s)
[211.380017] Starting dynamic subtest: pipe-C-HDMI-A-2
[211.408243] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.066s)
[211.411363] Subtest lease-unleased-crtc: SUCCESS (0.834s)
[211.802302] [046/131] (841s left) gem_render_copy (yf-tiled)
[211.933989] Starting subtest: yf-tiled
[211.936407] Starting dynamic subtest: smem
[212.255610] Dynamic subtest smem: SUCCESS (0.326s)
[212.257763] Subtest yf-tiled: SUCCESS (0.328s)
[212.509643] [047/131] (841s left) i915_suspend (sysfs-reader)
[212.611095] Starting subtest: sysfs-reader