[91.300369] Initializing watchdogs
[91.300567]   /dev/watchdog0
[91.342788] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.357810] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.364825] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.373715] [001/131] (960s left) sysfs_preempt_timeout (timeout)
[91.507805] Starting subtest: timeout
[91.511366] Starting dynamic subtest: vecs0
[92.371489] Dynamic subtest vecs0: SUCCESS (0.865s)
[92.391490] Starting dynamic subtest: vcs0
[93.208041] Dynamic subtest vcs0: SUCCESS (0.833s)
[93.227503] Starting dynamic subtest: bcs0
[94.051720] Dynamic subtest bcs0: SUCCESS (0.841s)
[94.072469] Starting dynamic subtest: rcs0
[94.910112] Dynamic subtest rcs0: SUCCESS (0.856s)
[94.914653] Subtest timeout: SUCCESS (3.400s)
[95.070749] [002/131] (956s left) syncobj_wait (multi-wait-for-submit-signaled)
[95.177124] Starting subtest: multi-wait-for-submit-signaled
[95.181566] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[95.337918] [003/131] (956s left) perf_pmu (most-busy-idle-check-all)
[95.460255] Starting subtest: most-busy-idle-check-all
[95.463526] Starting dynamic subtest: rcs0
[96.083513] Dynamic subtest rcs0: SUCCESS (0.623s)
[96.103961] Starting dynamic subtest: bcs0
[96.704691] Dynamic subtest bcs0: SUCCESS (0.621s)
[96.725926] Starting dynamic subtest: vcs0
[97.329432] Dynamic subtest vcs0: SUCCESS (0.624s)
[97.349384] Starting dynamic subtest: vecs0
[97.950137] Dynamic subtest vecs0: SUCCESS (0.622s)
[97.953797] Subtest most-busy-idle-check-all: SUCCESS (2.495s)
[98.133683] [004/131] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[98.341750] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[98.349367] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[98.509940] [005/131] (953s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[98.703492] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[98.808854] [006/131] (953s left) perf (gen12-group-exclusive-stream-ctx-handle)
[99.065370] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[99.078531] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[99.167964] [007/131] (953s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[99.385738] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[99.475594] [008/131] (953s left) kms_flip (2x-plain-flip-interruptible)
[99.673319] Starting subtest: 2x-plain-flip-interruptible
[99.682669] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[101.140688] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.459s)
[101.161536] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[102.519765] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.373s)
[102.541482] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[103.850901] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.329s)
[103.854136] Subtest 2x-plain-flip-interruptible: SUCCESS (4.175s)
[104.490345] [009/131] (948s left) gem_partial_pwrite_pread (reads-uncached)
[104.611620] Starting subtest: reads-uncached
[111.227648] Subtest reads-uncached: SUCCESS (6.618s)
[111.408250] [010/131] (941s left) gem_softpin (safe-alignment)
[111.536681] Starting subtest: safe-alignment
[111.564452] Subtest safe-alignment: SUCCESS (0.032s)
[111.764995] [011/131] (941s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[111.962290] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[111.967934] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[112.140950] [012/131] (940s left) gem_exec_balancer (parallel-contexts)
[112.387371] Subtest parallel-contexts: SKIP (0.000s)
[112.567134] [013/131] (940s left) gem_tiled_blits (normal)
[113.187922] Starting subtest: normal
[157.091712] Subtest normal: SUCCESS (43.897s)
[157.301301] [014/131] (895s left) prime_self_import (basic-llseek-size)
[157.518475] Starting subtest: basic-llseek-size
[157.530909] Subtest basic-llseek-size: SUCCESS (0.012s)
[157.723738] [015/131] (895s left) i915_drm_fdinfo (virtual-busy-hang)
[157.839624] Starting subtest: virtual-busy-hang
[162.016303] Subtest virtual-busy-hang: SUCCESS (4.176s)
[162.190613] [016/131] (891s left) gem_pipe_control_store_loop (fresh-buffer)
[162.307402] Starting subtest: fresh-buffer
[164.462062] Subtest fresh-buffer: SUCCESS (2.155s)
[164.633250] [017/131] (888s left) sw_sync (sync_multi_consumer_producer)
[164.760187] Starting subtest: sync_multi_consumer_producer
[165.249423] Subtest sync_multi_consumer_producer: SUCCESS (0.488s)
[165.401288] [018/131] (888s left) core_getversion (basic)
[165.503173] Starting subtest: basic
[165.512702] Subtest basic: SUCCESS (0.000s)
[165.666159] [019/131] (887s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[165.854552] Starting subtest: primary-yf-tiled-reflect-x-270
[165.864096] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.003s)
[166.019601] [020/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[166.236187] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[169.183872] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.948s)
[169.484234] [021/131] (884s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[169.695476] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[169.922188] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.222s)
[170.185939] [022/131] (883s left) vgem_basic (create)
[170.418785] Starting subtest: create
[170.422670] Subtest create: SUCCESS (0.002s)
[170.568190] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[170.574857] [023/131] (883s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[170.764921] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[170.888463] [024/131] (883s left) gem_gtt_cpu_tlb
[171.192486] [025/131] (882s left) kms_getfb (getfb2-handle-closed)
[171.378311] Starting subtest: getfb2-handle-closed
[171.384075] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[171.561966] [026/131] (882s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[171.772448] Starting subtest: psr-rgb565-draw-mmap-cpu
[171.778945] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[171.959546] [027/131] (882s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[172.160260] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[172.166269] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[172.342801] [028/131] (882s left) kms_flip (2x-flip-vs-rmfb)
[172.555468] Starting subtest: 2x-flip-vs-rmfb
[172.560126] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[183.398862] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.868s)
[183.422125] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[194.113270] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.709s)
[194.136213] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[204.804085] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.684s)
[204.808079] Subtest 2x-flip-vs-rmfb: SUCCESS (32.278s)
[205.460331] [029/131] (849s left) kms_chamelium_hpd (dp-hpd)
[206.039603] Subtest dp-hpd: SKIP (0.000s)
[206.343389] [030/131] (848s left) prime_self_import (export-vs-gem_close-race)
[206.451996] Starting subtest: export-vs-gem_close-race
[211.470798] Subtest export-vs-gem_close-race: SUCCESS (5.013s)
[211.649036] [031/131] (843s left) fbdev (info)
[211.754831] Starting subtest: info
[211.759064] Subtest info: SUCCESS (0.000s)
[211.938270] [032/131] (842s left) gem_exec_schedule (u-submit-late-slice)
[212.078863] Starting subtest: u-submit-late-slice
[212.082203] Starting dynamic subtest: rcs0
[212.132781] Dynamic subtest rcs0: SUCCESS (0.054s)
[212.155365] Starting dynamic subtest: bcs0
[212.193081] Dynamic subtest bcs0: SUCCESS (0.057s)
[212.216712] Starting dynamic subtest: vcs0
[212.250849] Dynamic subtest vcs0: SUCCESS (0.056s)
[212.275917] Starting dynamic subtest: vecs0
[212.306930] Dynamic subtest vecs0: SUCCESS (0.053s)
[212.310669] Subtest u-submit-late-slice: SUCCESS (0.230s)
[212.750767] [033/131] (842s left) syncobj_timeline (reset-signaled)
[212.859177] Starting subtest: reset-signaled
[212.863763] Subtest reset-signaled: SUCCESS (0.001s)
[213.049890] [034/131] (842s left) syncobj_timeline (etime-single-wait-submitted)
[213.158809] Starting subtest: etime-single-wait-submitted
[213.269310] Subtest etime-single-wait-submitted: SUCCESS (0.109s)
[213.447869] [035/131] (841s left) kms_cursor_crc (cursor-onscreen-512x170)
[213.669911] Starting subtest: cursor-onscreen-512x170
[213.677256] Subtest cursor-onscreen-512x170: SKIP (0.004s)
[213.863961] [036/131] (841s left) syncobj_timeline (wait-any-snapshot)
[213.975711] Starting subtest: wait-any-snapshot
[214.060834] Subtest wait-any-snapshot: SUCCESS (0.086s)
[214.260813] [037/131] (841s left) prime_mmap (test_userptr)
[214.371160] Starting subtest: test_userptr
[214.375911] Starting dynamic subtest: test_userptr-smem
[214.380065] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[214.383947] Subtest test_userptr: SUCCESS (0.005s)
[214.572588] [038/131] (840s left) gem_exec_fence (submit)
[214.836136] Starting subtest: submit
[214.839777] Starting dynamic subtest: rcs0
[214.860743] Dynamic subtest rcs0: SUCCESS (0.023s)
[214.887372] Starting dynamic subtest: bcs0
[214.890839] Dynamic subtest bcs0: SUCCESS (0.024s)
[214.917116] Starting dynamic subtest: vcs0
[214.920466] Dynamic subtest vcs0: SUCCESS (0.023s)
[214.946381] Starting dynamic subtest: vecs0
[214.950255] Dynamic subtest vecs0: SUCCESS (0.022s)
[214.954105] Subtest submit: SUCCESS (0.103s)
[215.666812] [039/131] (840s left) kms_scaling_modes (scaling-mode-full-aspect)
[215.858647] Starting subtest: scaling-mode-full-aspect
[215.885235] Subtest scaling-mode-full-aspect: SKIP (0.004s)
[216.036705] [040/131] (839s left) gem_mmap_gtt (basic-wc)
[216.173943] Starting subtest: basic-wc
[216.804299] Subtest basic-wc: SUCCESS (0.632s)
[216.985867] [041/131] (838s left) gem_pxp (hw-rejects-pxp-context)
[219.641693] Starting subtest: hw-rejects-pxp-context
[219.646150] Subtest hw-rejects-pxp-context: SUCCESS (0.001s)
[219.816584] [042/131] (836s left) kms_pm_backlight (fade-with-dpms)
[220.017288] Subtest fade-with-dpms: SKIP (0.000s)
[220.135117] [043/131] (835s left) kms_joiner (basic-ultra-joiner)
[220.340086] Subtest basic-ultra-joiner: SKIP (0.000s)
[220.498921] [044/131] (835s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[220.741041] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[220.747409] Starting dynamic subtest: pipe-A-valid-mode
[221.658051] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.965s)
[221.661595] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (0.969s)
[222.020982] [045/131] (834s left) gem_workarounds (suspend-resume-context)
[222.164247] Starting subtest: suspend-resume-context