[88.172634] Initializing watchdogs
[88.172867]   /dev/watchdog0
[88.213411] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.228290] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.235875] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.241929] [001/133] (960s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[88.443313] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[88.445174] Starting dynamic subtest: pipe-A-HDMI-A-1
[88.471185] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[88.506575] Starting dynamic subtest: pipe-A-HDMI-A-2
[88.536462] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[88.570470] Starting dynamic subtest: pipe-B-HDMI-A-1
[88.602334] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[88.635466] Starting dynamic subtest: pipe-B-HDMI-A-2
[88.660205] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[88.678416] Starting dynamic subtest: pipe-C-HDMI-A-1
[88.695760] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.003s)
[88.714815] Starting dynamic subtest: pipe-C-HDMI-A-2
[88.730697] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.004s)
[88.733747] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.041s)
[89.514693] [002/133] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[89.721977] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[89.726969] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[89.862385] [003/133] (959s left) perf_pmu (frequency)
[89.987358] Starting subtest: frequency
[89.992409] Starting dynamic subtest: gt0
[92.086912] Dynamic subtest gt0: SUCCESS (2.092s)
[92.105529] Starting dynamic subtest: idle-gt0
[92.599589] Dynamic subtest idle-gt0: SUCCESS (0.510s)
[92.601920] Subtest frequency: SUCCESS (2.612s)
[92.765295] [004/133] (956s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[92.954085] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[92.957433] Starting dynamic subtest: pipe-A-valid-mode
[94.043912] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.088s)
[94.046213] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.092s)
[94.390142] [005/133] (954s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[94.496089] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[94.602973] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[94.742494] [006/133] (954s left) kms_cursor_crc (cursor-sliding-max-size)
[94.951110] Starting subtest: cursor-sliding-max-size
[94.957396] Subtest cursor-sliding-max-size: SKIP (0.000s)
[95.089290] [007/133] (954s left) gen7_exec_parse (load-register-reg)
[95.205059] Subtest load-register-reg: SKIP (0.000s)
[95.297861] [008/133] (954s left) gem_softpin (invalid)
[95.415079] Starting subtest: invalid
[95.424672] Subtest invalid: SUCCESS (0.016s)
[95.574465] [009/133] (953s left) syncobj_timeline (signal-point-0)
[95.681897] Starting subtest: signal-point-0
[95.684415] Subtest signal-point-0: SUCCESS (0.001s)
[95.822113] [010/133] (953s left) syncobj_wait (multi-wait-all-submitted)
[95.930530] Starting subtest: multi-wait-all-submitted
[96.036131] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[96.174310] [011/133] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[96.373181] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[96.376508] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[96.535895] [012/133] (953s left) fbdev (eof)
[96.646884] Starting subtest: eof
[96.648568] Subtest eof: SUCCESS (0.001s)
[96.788483] [013/133] (952s left) syncobj_timeline (reset-during-wait-for-submit)
[96.891997] Starting subtest: reset-during-wait-for-submit
[96.998331] Subtest reset-during-wait-for-submit: SUCCESS (0.106s)
[97.171197] [014/133] (952s left) dmabuf_sync_file (import-multiple-read-write)
[97.368597] Starting subtest: import-multiple-read-write
[97.381074] Subtest import-multiple-read-write: SUCCESS (0.018s)
[97.496596] [FACT dmabuf_sync_file (import-multiple-read-write)] new: kernel.kmod_is_loaded.vgem: true
[97.501873] [015/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[97.696146] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[97.700606] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[97.844378] [016/133] (952s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[98.043050] Starting subtest: 4-tiled-8bpp-rotate-270
[98.046758] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[98.182930] [017/133] (951s left) kms_psr (fbc-psr-primary-render)
[98.365111] Subtest fbc-psr-primary-render: SKIP (0.000s)
[98.488793] [018/133] (951s left) i915_pm_rps (waitboost)
[98.605610] Starting subtest: waitboost
[102.185547] Subtest waitboost: SUCCESS (3.578s)
[102.336754] [019/133] (948s left) kms_vblank (wait-forked-hang)
[102.520635] Starting subtest: wait-forked-hang
[102.523498] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.898190] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.371s)
[109.944315] Starting dynamic subtest: pipe-A-HDMI-A-2
[116.887191] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.977s)
[116.931562] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.848272] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.942s)
[123.887104] Starting dynamic subtest: pipe-C-HDMI-A-2
[130.872829] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.018s)
[130.875115] Subtest wait-forked-hang: SUCCESS (28.351s)
[131.179628] [020/133] (919s left) kms_flip (2x-flip-vs-wf_vblank)
[131.369087] Starting subtest: 2x-flip-vs-wf_vblank
[131.379113] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[133.145273] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.768s)
[133.165098] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[134.840223] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.691s)
[134.860053] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[136.467144] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.617s)
[136.470292] Subtest 2x-flip-vs-wf_vblank: SUCCESS (5.090s)
[137.056507] [021/133] (913s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[137.256596] Starting subtest: dp-mst-lic-type-0-hdcp14
[137.261198] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[137.401969] [022/133] (913s left) gem_pipe_control_store_loop (fresh-buffer)
[137.515771] Starting subtest: fresh-buffer
[139.672673] Subtest fresh-buffer: SUCCESS (2.155s)
[139.852907] [023/133] (910s left) prime_mmap (test_userptr)
[139.953310] Starting subtest: test_userptr
[139.955298] Starting dynamic subtest: test_userptr-smem
[139.958111] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[139.960024] Subtest test_userptr: SUCCESS (0.004s)
[140.135229] [024/133] (910s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[140.239126] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[140.344947] [025/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[140.534403] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[140.540053] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[140.693989] [026/133] (910s left) gem_mmap_gtt (medium-copy-xy)
[140.802150] Starting subtest: medium-copy-XY
[146.627071] Subtest medium-copy-XY: SUCCESS (5.825s)
[146.781338] [027/133] (904s left) gem_pwrite (basic-exhaustion)
[146.990086] Starting subtest: basic-exhaustion
[172.483151] Subtest basic-exhaustion: SUCCESS (25.493s)
[172.644183] [028/133] (878s left) i915_drm_fdinfo (memory-info-shared)
[172.757752] Starting subtest: memory-info-shared
[172.761267] Starting dynamic subtest: smem0
[172.800256] Dynamic subtest smem0: SUCCESS (0.041s)
[172.804185] Subtest memory-info-shared: SUCCESS (0.043s)
[172.940185] [029/133] (878s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[173.134186] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[173.139608] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[173.272289] [030/133] (878s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[173.460969] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[173.464235] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.486516] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[173.530241] Starting dynamic subtest: pipe-A-HDMI-A-2
[173.560351] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[173.604191] Starting dynamic subtest: pipe-B-HDMI-A-1
[173.642123] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[173.664106] Starting dynamic subtest: pipe-B-HDMI-A-2
[173.680968] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[173.702056] Starting dynamic subtest: pipe-C-HDMI-A-1
[173.717955] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[173.739315] Starting dynamic subtest: pipe-C-HDMI-A-2
[173.754284] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[173.757297] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.024s)
[174.540745] [031/133] (876s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[174.725907] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[174.835112] [032/133] (876s left) perf_pmu (idle-no-semaphores)
[174.947554] Starting subtest: idle-no-semaphores
[174.949783] Starting dynamic subtest: rcs0
[175.460975] Dynamic subtest rcs0: SUCCESS (0.512s)
[175.484543] Starting dynamic subtest: bcs0
[175.972058] Dynamic subtest bcs0: SUCCESS (0.508s)
[175.993304] Starting dynamic subtest: vcs0
[176.483936] Dynamic subtest vcs0: SUCCESS (0.512s)
[176.505464] Starting dynamic subtest: vecs0
[177.002049] Dynamic subtest vecs0: SUCCESS (0.512s)
[177.004830] Subtest idle-no-semaphores: SUCCESS (2.054s)
[177.164388] [033/133] (874s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[177.346162] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[177.350609] Starting dynamic subtest: pipe-A-valid-mode
[178.418439] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.067s)
[178.422577] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SUCCESS (1.071s)
[178.784905] [034/133] (873s left) gem_exec_store (cachelines)
[178.921897] Starting subtest: cachelines
[178.925177] Starting dynamic subtest: rcs0
[178.955930] Dynamic subtest rcs0: SUCCESS (0.036s)
[178.981293] Starting dynamic subtest: bcs0
[178.984204] Dynamic subtest bcs0: SUCCESS (0.023s)
[179.007961] Starting dynamic subtest: vcs0
[179.009769] Dynamic subtest vcs0: SUCCESS (0.019s)
[179.033354] Starting dynamic subtest: vecs0
[179.035162] Dynamic subtest vecs0: SUCCESS (0.027s)
[179.037484] Subtest cachelines: SUCCESS (0.109s)
[179.304344] [035/133] (872s left) i915_drm_fdinfo (virtual-idle)
[179.416231] Starting subtest: virtual-idle
[181.446880] Subtest virtual-idle: SUCCESS (2.029s)
[181.588611] [036/133] (870s left) kms_plane (pixel-format-yf-tiled-modifier)
[181.766115] Starting subtest: pixel-format-yf-tiled-modifier
[181.972062] Starting dynamic subtest: pipe-A-plane-0
[182.690721] Dynamic subtest pipe-A-plane-0: SUCCESS (0.718s)
[182.721090] Starting dynamic subtest: pipe-A-plane-1
[183.457128] Dynamic subtest pipe-A-plane-1: SUCCESS (0.763s)
[183.478437] Starting dynamic subtest: pipe-A-plane-2
[183.888339] Dynamic subtest pipe-A-plane-2: SUCCESS (0.432s)
[183.909374] Starting dynamic subtest: pipe-A-plane-3
[184.339077] Dynamic subtest pipe-A-plane-3: SUCCESS (0.450s)
[184.364351] Starting dynamic subtest: pipe-A-plane-4
[184.372475] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[184.754401] Starting dynamic subtest: pipe-B-plane-0
[185.400699] Dynamic subtest pipe-B-plane-0: SUCCESS (0.663s)
[185.424255] Starting dynamic subtest: pipe-B-plane-1
[186.067680] Dynamic subtest pipe-B-plane-1: SUCCESS (0.666s)
[186.088474] Starting dynamic subtest: pipe-B-plane-2
[186.501557] Dynamic subtest pipe-B-plane-2: SUCCESS (0.432s)
[186.522761] Starting dynamic subtest: pipe-B-plane-3
[186.950116] Dynamic subtest pipe-B-plane-3: SUCCESS (0.449s)
[186.974523] Starting dynamic subtest: pipe-B-plane-4
[186.981782] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[187.184795] Subtest pixel-format-yf-tiled-modifier: SUCCESS (5.417s)
[187.546093] [037/133] (864s left) kms_vrr (lobf)
[187.737297] Starting subtest: lobf
[187.741600] Subtest lobf: SKIP (0.000s)
[187.878241] [038/133] (864s left) gem_exec_balancer (nohangcheck)
[188.135061] Starting subtest: nohangcheck
[192.517156] Subtest nohangcheck: SUCCESS (4.381s)
[192.663773] [039/133] (859s left) gem_exec_schedule (pi-userfault)
[192.945077] Starting subtest: pi-userfault
[192.947985] Starting dynamic subtest: rcs0
[192.960102] Dynamic subtest rcs0: SUCCESS (0.012s)
[192.988143] Starting dynamic subtest: bcs0
[192.990234] Dynamic subtest bcs0: SUCCESS (0.012s)
[193.015754] Starting dynamic subtest: vcs0
[193.018282] Dynamic subtest vcs0: SUCCESS (0.015s)
[193.040568] Starting dynamic subtest: vecs0
[193.043528] Dynamic subtest vecs0: SUCCESS (0.012s)
[193.045643] Subtest pi-userfault: SUCCESS (0.060s)
[193.263628] [040/133] (859s left) gem_exec_fence (submit)
[193.521255] Starting subtest: submit
[193.525303] Starting dynamic subtest: rcs0
[193.540463] Dynamic subtest rcs0: SUCCESS (0.021s)
[193.572508] Starting dynamic subtest: bcs0
[193.575226] Dynamic subtest bcs0: SUCCESS (0.024s)
[193.606362] Starting dynamic subtest: vcs0
[193.609778] Dynamic subtest vcs0: SUCCESS (0.023s)
[193.633124] Starting dynamic subtest: vecs0
[193.636499] Dynamic subtest vecs0: SUCCESS (0.023s)
[193.639182] Subtest submit: SUCCESS (0.097s)
[194.314308] [041/133] (858s left) sysfs_heartbeat_interval (precise)
[194.432114] Starting subtest: precise
[194.434822] Starting dynamic subtest: vecs0
[195.890087] Dynamic subtest vecs0: SUCCESS (1.455s)
[195.918296] Starting dynamic subtest: vcs0
[197.350392] Dynamic subtest vcs0: SUCCESS (1.460s)
[197.380837] Starting dynamic subtest: bcs0
[198.821672] Dynamic subtest bcs0: SUCCESS (1.469s)
[198.850637] Starting dynamic subtest: rcs0
[200.255556] Dynamic subtest rcs0: SUCCESS (1.432s)
[200.258125] Subtest precise: SUCCESS (5.826s)
[200.414974] [042/133] (852s left) gem_spin_batch (user-each)
[200.542191] Starting subtest: user-each
[203.927766] Subtest user-each: SUCCESS (3.387s)
[204.197678] [043/133] (848s left) gem_lmem_swapping (heavy-verify-random)
[204.313183] Subtest heavy-verify-random: SKIP (0.000s)
[204.418302] [044/133] (848s left) drm_read (short-buffer-nonblock)
[204.855337] Starting subtest: short-buffer-nonblock
[204.856973] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[205.127151] [045/133] (847s left) syncobj_timeline (host-signal-points)
[205.234652] Starting subtest: host-signal-points
[205.253596] Subtest host-signal-points: SUCCESS (0.023s)
[205.394235] [046/133] (847s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[205.603772] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[208.580302] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.978s)
[208.842338] [047/133] (844s left) gem_workarounds (suspend-resume)
[208.973308] Starting subtest: suspend-resume