[97.027371] Initializing watchdogs
[97.027571]   /dev/watchdog0
[97.066335] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[97.081405] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[97.087642] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[97.092546] [001/133] (960s left) kms_dp_link_training (non-uhbr-sst)
[97.291827] Starting subtest: non-uhbr-sst
[97.300343] Subtest non-uhbr-sst: SKIP (0.000s)
[97.435230] [002/133] (960s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[97.557229] Starting subtest: invalid-bsd2-flag-on-vebox
[97.559559] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[97.706334] [003/133] (960s left) gem_ctx_persistence (heartbeat-hostile)
[97.819771] Starting subtest: heartbeat-hostile
[98.970118] Subtest heartbeat-hostile: SUCCESS (1.150s)
[99.124263] [004/133] (958s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[99.231301] Starting subtest: etime-multi-wait-all-for-submit-submitted
[99.340060] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[99.474982] [005/133] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[99.663207] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[99.665320] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[99.790294] [006/133] (958s left) gem_exec_store (basic)
[99.916872] Starting subtest: basic
[99.977070] Subtest basic: SUCCESS (0.059s)
[100.223261] [007/133] (957s left) kms_vrr (max-min)
[100.401203] Starting subtest: max-min
[100.408140] Subtest max-min: SKIP (0.000s)
[100.523479] [008/133] (957s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[100.716247] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[100.812398] [009/133] (957s left) gen9_exec_parse (valid-registers)
[100.939168] Starting subtest: valid-registers
[101.110968] Subtest valid-registers: SUCCESS (0.173s)
[101.378790] [010/133] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[101.563908] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[101.566430] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[101.690601] [011/133] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[101.892080] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[101.896563] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.022396] [012/133] (956s left) perf (buffer-fill)
[102.222619] Starting subtest: buffer-fill
[102.227219] Starting dynamic subtest: 0-rcs0
[105.290369] Dynamic subtest 0-rcs0: SUCCESS (3.066s)
[105.291512] Subtest buffer-fill: SUCCESS (3.066s)
[105.375147] [013/133] (953s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[105.568288] Starting subtest: 4-tiled-8bpp-rotate-180
[105.573333] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[105.688537] [014/133] (952s left) gem_ctx_shared (q-smoketest)
[105.812708] Starting subtest: Q-smoketest
[105.817424] Starting dynamic subtest: rcs0
[111.248205] Dynamic subtest rcs0: SUCCESS (5.429s)
[111.269037] Starting dynamic subtest: bcs0
[116.676156] Dynamic subtest bcs0: SUCCESS (5.431s)
[116.692574] Starting dynamic subtest: vcs0
[122.106201] Dynamic subtest vcs0: SUCCESS (5.421s)
[122.122431] Starting dynamic subtest: vecs0
[127.537151] Dynamic subtest vecs0: SUCCESS (5.435s)
[127.537982] Subtest Q-smoketest: SUCCESS (21.722s)
[127.805849] [015/133] (930s left) gem_create (hog-create)
[127.915992] Starting subtest: hog-create
[127.916976] Starting dynamic subtest: smem0
[160.162120] Dynamic subtest smem0: SUCCESS (32.245s)
[160.163196] Subtest hog-create: SUCCESS (32.247s)
[160.433413] [016/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[160.626697] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[163.054847] Subtest fbc-2p-scndscrn-cur-indfb-move: SUCCESS (2.424s)
[163.260428] [017/133] (895s left) syncobj_wait (multi-wait-for-submit-submitted)
[163.362964] Starting subtest: multi-wait-for-submit-submitted
[163.466643] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[163.594135] [018/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[163.798960] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[163.801235] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[163.924579] [019/133] (895s left) kms_flip (2x-modeset-vs-vblank-race)
[164.122812] Starting subtest: 2x-modeset-vs-vblank-race
[164.129105] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[168.709135] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (4.583s)
[168.745089] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[173.209096] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (4.495s)
[173.245742] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[177.710080] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (4.496s)
[177.713066] Subtest 2x-modeset-vs-vblank-race: SUCCESS (13.590s)
[178.451922] [020/133] (880s left) gem_close (many-handles-one-vma)
[178.579396] Starting subtest: many-handles-one-vma
[178.660322] Subtest many-handles-one-vma: SUCCESS (0.081s)
[178.803436] [021/133] (880s left) gem_userptr_blits (coherency-unsync)
[178.922264] Subtest coherency-unsync: SKIP (0.000s)
[179.132372] [022/133] (880s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[179.326077] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[179.330168] Starting dynamic subtest: A-HDMI-A1
[185.261904] Dynamic subtest A-HDMI-A1: SUCCESS (5.930s)
[185.281782] Starting dynamic subtest: B-HDMI-A1
[191.116954] Dynamic subtest B-HDMI-A1: SUCCESS (5.851s)
[191.137797] Starting dynamic subtest: C-HDMI-A1
[196.759557] Dynamic subtest C-HDMI-A1: SUCCESS (5.635s)
[196.780166] Starting dynamic subtest: A-HDMI-A2
[202.451267] Dynamic subtest A-HDMI-A2: SUCCESS (5.683s)
[202.469206] Starting dynamic subtest: B-HDMI-A2
[208.100321] Dynamic subtest B-HDMI-A2: SUCCESS (5.654s)
[208.123540] Starting dynamic subtest: C-HDMI-A2
[213.747477] Dynamic subtest C-HDMI-A2: SUCCESS (5.636s)
[213.753017] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (34.419s)
[214.304433] [023/133] (845s left) kms_draw_crc (draw-method-mmap-gtt)
[214.484063] Starting subtest: draw-method-mmap-gtt
[214.486139] Starting dynamic subtest: xrgb8888-untiled
[214.974344] Dynamic subtest xrgb8888-untiled: SUCCESS (0.493s)
[215.001165] Starting dynamic subtest: rgb565-untiled
[215.221876] Dynamic subtest rgb565-untiled: SUCCESS (0.246s)
[215.240391] Starting dynamic subtest: xrgb2101010-untiled
[215.493195] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.265s)
[215.512710] Starting dynamic subtest: xbgr16161616f-untiled
[215.757725] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.266s)
[215.775416] Starting dynamic subtest: xrgb8888-xtiled
[215.905553] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.148s)
[215.925984] Starting dynamic subtest: rgb565-xtiled
[216.056829] Dynamic subtest rgb565-xtiled: SUCCESS (0.145s)
[216.075074] Starting dynamic subtest: xrgb2101010-xtiled
[216.189978] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.130s)
[216.211079] Starting dynamic subtest: xbgr16161616f-xtiled
[216.326259] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[216.343640] Starting dynamic subtest: xrgb8888-ytiled
[216.473265] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.149s)
[216.496493] Starting dynamic subtest: rgb565-ytiled
[216.624135] Dynamic subtest rgb565-ytiled: SUCCESS (0.146s)
[216.646933] Starting dynamic subtest: xrgb2101010-ytiled
[216.758237] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.129s)
[216.779606] Starting dynamic subtest: xbgr16161616f-ytiled
[216.923396] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.162s)
[216.924691] Subtest draw-method-mmap-gtt: SUCCESS (2.443s)
[217.169840] [024/133] (842s left) kms_prime (d3hot)
[217.374867] Subtest D3hot: SKIP (0.000s)
[217.672720] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[217.676858] [025/133] (841s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[217.876591] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[219.960157] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SUCCESS (2.084s)
[220.214855] [026/133] (839s left) gem_exec_fence (syncobj-import)
[220.777388] Starting subtest: syncobj-import
[220.783319] Subtest syncobj-import: SUCCESS (0.006s)
[221.181940] [027/133] (838s left) syncobj_wait (multi-wait-all-signaled)
[221.286123] Starting subtest: multi-wait-all-signaled
[221.288228] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[221.429919] [028/133] (838s left) kms_hdr (bpc-switch-dpms)
[221.620172] Starting subtest: bpc-switch-dpms
[250.815846] Subtest bpc-switch-dpms: SKIP (29.193s)
[251.312316] [029/133] (808s left) perf_pmu (semaphore-busy)
[251.454265] Starting subtest: semaphore-busy
[251.455876] Starting dynamic subtest: rcs0
[253.007781] Dynamic subtest rcs0: SUCCESS (1.552s)
[253.031135] Starting dynamic subtest: bcs0
[254.563758] Dynamic subtest bcs0: SUCCESS (1.549s)
[254.585400] Starting dynamic subtest: vcs0
[256.114374] Dynamic subtest vcs0: SUCCESS (1.545s)
[256.134802] Starting dynamic subtest: vecs0
[257.667850] Dynamic subtest vecs0: SUCCESS (1.547s)
[257.669610] Subtest semaphore-busy: SUCCESS (6.213s)
[257.818786] [030/133] (802s left) kms_atomic_interruptible (atomic-setmode)
[258.006053] Starting subtest: atomic-setmode
[258.009205] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.890780] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.882s)
[264.894459] Subtest atomic-setmode: SUCCESS (6.888s)
[265.298262] [031/133] (794s left) kms_psr (pr-cursor-blt)
[265.495132] Subtest pr-cursor-blt: SKIP (0.000s)
[265.605361] [032/133] (794s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[265.823931] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[265.830512] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[265.969457] [033/133] (794s left) gem_exec_balancer (nohangcheck)
[266.230033] Starting subtest: nohangcheck
[270.555777] Subtest nohangcheck: SUCCESS (4.329s)
[270.706401] [034/133] (789s left) api_intel_allocator (two-level-inception-interruptible)
[270.813709] Starting subtest: two-level-inception-interruptible
[276.366551] Subtest two-level-inception-interruptible: SUCCESS (5.556s)
[276.504568] [035/133] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[276.715130] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[276.718096] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[276.871385] [036/133] (783s left) dmabuf_sync_file (export-wait-after-attach)
[276.986104] Starting subtest: export-wait-after-attach
[276.987235] Subtest export-wait-after-attach: SUCCESS (0.002s)
[277.122538] [037/133] (783s left) syncobj_timeline (invalid-transfer-non-existent-point)
[277.225234] Starting subtest: invalid-transfer-non-existent-point
[277.226989] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[277.372367] [038/133] (783s left) kms_cursor_crc (cursor-random-64x64)
[277.568299] Starting subtest: cursor-random-64x64
[277.609108] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.811108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.199s)
[281.920263] Starting dynamic subtest: pipe-C-HDMI-A-1
[285.754875] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.880s)
[285.760777] Subtest cursor-random-64x64: SUCCESS (8.192s)
[286.170399] [039/133] (774s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[286.296092] Starting subtest: yf-tiled-to-vebox-x-tiled
[286.298742] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[286.559586] [040/133] (774s left) i915_suspend (forcewake)
[286.663580] Starting subtest: forcewake