[87.598753] Initializing watchdogs
[87.598965]   /dev/watchdog0
[87.639155] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.654304] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.661624] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.669422] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[87.894532] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[90.902161] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.009s)
[91.214654] [002/133] (957s left) prime_busy (hang)
[91.341063] Starting subtest: hang
[91.345078] Starting dynamic subtest: rcs0
[97.650489] Dynamic subtest rcs0: SUCCESS (6.305s)
[97.674113] Starting dynamic subtest: bcs0
[104.628119] Dynamic subtest bcs0: SUCCESS (6.978s)
[104.649546] Starting dynamic subtest: vcs0
[111.668367] Dynamic subtest vcs0: SUCCESS (7.036s)
[111.686831] Starting dynamic subtest: vecs0
[118.637813] Dynamic subtest vecs0: SUCCESS (6.975s)
[118.641312] Subtest hang: SUCCESS (27.300s)
[118.796084] [003/133] (929s left) gem_exec_store (basic)
[118.928260] Starting subtest: basic
[118.968415] Subtest basic: SUCCESS (0.039s)
[119.219368] [004/133] (929s left) syncobj_timeline (invalid-query-one-illegal-handle)
[119.326869] Starting subtest: invalid-query-one-illegal-handle
[119.330194] Subtest invalid-query-one-illegal-handle: SUCCESS (0.002s)
[119.466323] [005/133] (929s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[119.667072] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[119.674218] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[119.803873] [006/133] (928s left) i915_drm_fdinfo (busy-idle)
[119.918036] Starting subtest: busy-idle
[119.922236] Starting dynamic subtest: rcs0
[120.551970] Dynamic subtest rcs0: SUCCESS (0.632s)
[120.575373] Starting dynamic subtest: bcs0
[121.187990] Dynamic subtest bcs0: SUCCESS (0.635s)
[121.211571] Starting dynamic subtest: vcs0
[121.816182] Dynamic subtest vcs0: SUCCESS (0.632s)
[121.844263] Starting dynamic subtest: vecs0
[122.447043] Dynamic subtest vecs0: SUCCESS (0.626s)
[122.451614] Subtest busy-idle: SUCCESS (2.527s)
[122.585745] [007/133] (926s left) kms_draw_crc (draw-method-blt)
[122.770307] Starting subtest: draw-method-blt
[122.774087] Starting dynamic subtest: xrgb8888-untiled
[123.269063] Dynamic subtest xrgb8888-untiled: SUCCESS (0.498s)
[123.289461] Starting dynamic subtest: rgb565-untiled
[123.550080] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[123.568990] Starting dynamic subtest: xrgb2101010-untiled
[123.850265] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.298s)
[123.873792] Starting dynamic subtest: xbgr16161616f-untiled
[124.130365] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.283s)
[124.156291] Starting dynamic subtest: xrgb8888-xtiled
[124.298605] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.166s)
[124.320700] Starting dynamic subtest: rgb565-xtiled
[124.483056] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s)
[124.509455] Starting dynamic subtest: xrgb2101010-xtiled
[124.629194] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.148s)
[124.653434] Starting dynamic subtest: xbgr16161616f-xtiled
[124.779269] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.148s)
[124.811470] Starting dynamic subtest: xrgb8888-ytiled
[124.966778] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.183s)
[124.988306] Starting dynamic subtest: rgb565-ytiled
[125.148731] Dynamic subtest rgb565-ytiled: SUCCESS (0.181s)
[125.168958] Starting dynamic subtest: xrgb2101010-ytiled
[125.316601] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.164s)
[125.338533] Starting dynamic subtest: xbgr16161616f-ytiled
[125.481080] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.166s)
[125.485133] Subtest draw-method-blt: SUCCESS (2.715s)
[125.716943] [008/133] (923s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[125.830236] Starting subtest: cpuset-medium-copy-odd
[135.513303] Subtest cpuset-medium-copy-odd: SUCCESS (9.684s)
[135.674644] [009/133] (913s left) perf (polling)
[136.119512] Starting subtest: polling
[136.124172] Starting dynamic subtest: 0-rcs0
[146.159828] Dynamic subtest 0-rcs0: SUCCESS (10.041s)
[146.164189] Subtest polling: SUCCESS (10.042s)
[146.265185] [010/133] (902s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[146.461210] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[146.464622] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.692070] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[146.717201] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.853859] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s)
[146.877617] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.022543] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s)
[147.066580] Starting dynamic subtest: pipe-B-HDMI-A-2
[147.250887] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s)
[147.271306] Starting dynamic subtest: pipe-C-HDMI-A-1
[147.416383] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[147.441905] Starting dynamic subtest: pipe-C-HDMI-A-2
[147.591941] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[147.599712] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.085s)
[147.708996] [011/133] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[147.924081] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[150.286374] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SUCCESS (2.370s)
[150.501678] [012/133] (898s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[150.712388] Starting subtest: yf-tiled-addfb-size-offset-overflow
[150.715780] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[150.854492] [013/133] (898s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[151.042197] Starting subtest: pixel-format-y-tiled-ccs-modifier
[151.263311] Starting dynamic subtest: pipe-A-plane-0
[151.582284] Dynamic subtest pipe-A-plane-0: SUCCESS (0.316s)
[151.604739] Starting dynamic subtest: pipe-A-plane-1
[151.845546] Dynamic subtest pipe-A-plane-1: SUCCESS (0.265s)
[151.868177] Starting dynamic subtest: pipe-A-plane-2
[152.114291] Dynamic subtest pipe-A-plane-2: SUCCESS (0.266s)
[152.136198] Starting dynamic subtest: pipe-A-plane-3
[152.378266] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[152.401064] Starting dynamic subtest: pipe-A-plane-4
[152.408967] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[152.852064] Starting dynamic subtest: pipe-B-plane-0
[153.253445] Dynamic subtest pipe-B-plane-0: SUCCESS (0.267s)
[153.320717] Starting dynamic subtest: pipe-B-plane-1
[153.716296] Dynamic subtest pipe-B-plane-1: SUCCESS (0.267s)
[153.782083] Starting dynamic subtest: pipe-B-plane-2
[154.078094] Dynamic subtest pipe-B-plane-2: SUCCESS (0.265s)
[154.121420] Starting dynamic subtest: pipe-B-plane-3
[154.151946] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[154.182968] Starting dynamic subtest: pipe-B-plane-4
[154.190426] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[154.193617] Subtest pixel-format-y-tiled-ccs-modifier: SUCCESS (2.997s)
[154.347783] [014/133] (895s left) kms_big_fb (linear-addfb)
[154.564552] Starting subtest: linear-addfb
[154.568135] Subtest linear-addfb: SUCCESS (0.000s)
[154.713885] [015/133] (894s left) kms_psr (psr-dpms)
[154.903042] Subtest psr-dpms: SKIP (0.000s)
[155.005578] [016/133] (894s left) kms_psr (psr-cursor-mmap-cpu)
[155.199112] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[155.304483] [017/133] (894s left) i915_query (query-topology-kernel-writes)
[155.423064] Starting subtest: query-topology-kernel-writes
[155.427652] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[155.546287] [018/133] (894s left) gem_exec_reloc (basic-wc-cpu-active)
[155.661537] Starting subtest: basic-wc-cpu-active
[155.800885] Subtest basic-wc-cpu-active: SUCCESS (0.139s)
[156.057592] [019/133] (893s left) gem_lmem_swapping (heavy-random)
[156.176169] Subtest heavy-random: SKIP (0.000s)
[156.280307] [020/133] (893s left) gem_mmap_gtt (zero-extend)
[156.387543] Starting subtest: zero-extend
[156.392442] Subtest zero-extend: SUCCESS (0.000s)
[156.510255] [021/133] (893s left) kms_psr (fbc-psr2-suspend)
[156.692507] Subtest fbc-psr2-suspend: SKIP (0.000s)
[156.805954] [022/133] (893s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[157.007140] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[159.409018] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (2.405s)
[159.689214] [023/133] (890s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[159.874964] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[159.882497] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[160.578268] [024/133] (889s left) gem_bad_reloc (negative-reloc-lut)
[160.700619] Starting subtest: negative-reloc-lut
[160.712907] Subtest negative-reloc-lut: SUCCESS (0.002s)
[160.841819] [025/133] (889s left) kms_flip (2x-flip-vs-dpms)
[161.025397] Starting subtest: 2x-flip-vs-dpms
[161.031219] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[162.833574] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.804s)
[162.860180] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[164.238775] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.403s)
[164.276181] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[165.801273] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.550s)
[165.807592] Subtest 2x-flip-vs-dpms: SUCCESS (4.772s)
[166.149654] [026/133] (884s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[166.349108] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[166.950378] Subtest async-flip-with-page-flip-events-linear-atomic: SKIP (0.599s)
[167.265178] [027/133] (883s left) kms_plane (planar-pixel-format-settings)
[167.457048] Starting subtest: planar-pixel-format-settings
[167.779999] Subtest planar-pixel-format-settings: SUCCESS (0.323s)
[168.016510] [028/133] (882s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[168.218064] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[168.325708] [029/133] (882s left) i915_hangman (error-state-basic)
[168.469320] Starting subtest: error-state-basic
[168.480120] Subtest error-state-basic: SUCCESS (0.014s)
[168.657588] [030/133] (882s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[168.857471] Starting subtest: 4-tiled-16bpp-rotate-0
[168.865147] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[168.999852] [031/133] (881s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[169.133941] Starting subtest: y-tiled-ccs-to-yf-tiled
[169.137587] Starting dynamic subtest: smem
[169.486972] Dynamic subtest smem: SUCCESS (0.322s)
[169.552084] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.324s)
[170.040544] [032/133] (881s left) gem_exec_parallel (engines)
[170.500232] Starting subtest: engines
[170.566441] Starting dynamic subtest: basic
[173.652121] Dynamic subtest basic: SUCCESS (3.316s)
[173.674498] Starting dynamic subtest: contexts
[178.088269] Dynamic subtest contexts: SUCCESS (4.436s)
[178.111204] Starting dynamic subtest: fds
[183.219618] Dynamic subtest fds: SUCCESS (5.131s)
[183.243151] Starting dynamic subtest: userptr
[186.553657] Dynamic subtest userptr: SUCCESS (3.332s)
[186.558052] Subtest engines: SUCCESS (16.221s)
[186.830180] [033/133] (864s left) gem_exec_balancer (waits)
[186.959530] Starting subtest: waits
[191.268747] Subtest waits: SUCCESS (4.311s)
[191.548992] [034/133] (859s left) kms_chamelium_edid (hdmi-mode-timings)
[192.153720] Subtest hdmi-mode-timings: SKIP (0.000s)
[192.481070] [035/133] (859s left) vgem_basic (dmabuf-mmap)
[192.727478] Starting subtest: dmabuf-mmap
[192.750977] Subtest dmabuf-mmap: SUCCESS (0.031s)
[192.905499] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[192.912448] [036/133] (858s left) kms_pm_rpm (modeset-pc8-residency-stress)
[194.855806] Starting subtest: modeset-pc8-residency-stress
[194.866058] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[195.242868] [037/133] (856s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[195.444531] Starting subtest: y-tiled-64bpp-rotate-90
[195.753708] Subtest y-tiled-64bpp-rotate-90: SKIP (0.309s)
[196.016668] [038/133] (855s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[196.233667] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[196.239887] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[196.379871] [039/133] (855s left) i915_suspend (basic-s3-without-i915)
[196.485666] Starting subtest: basic-s3-without-i915