[88.947728] Initializing watchdogs
[88.947948]   /dev/watchdog0
[88.987484] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.002469] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.009415] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.017295] [001/133] (960s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[89.226878] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[89.234968] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[89.371326] [002/133] (960s left) kms_mmap_write_crc (main)
[89.572170] Starting subtest: main
[89.578058] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.134407] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.552s)
[93.140179] Subtest main: SUCCESS (3.555s)
[93.476377] [003/133] (956s left) fbdev (nullptr)
[93.607959] Starting subtest: nullptr
[93.613360] Subtest nullptr: SUCCESS (0.000s)
[93.764718] [004/133] (956s left) gem_exec_nop (basic-series)
[93.918963] Starting subtest: basic-series
[96.961046] Subtest basic-series: SUCCESS (3.051s)
[97.221963] [005/133] (952s left) core_setmaster (master-drop-set-user)
[97.404459] Starting subtest: master-drop-set-user
[97.446148] Subtest master-drop-set-user: SUCCESS (0.045s)
[97.529540] [006/133] (952s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[97.733317] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[97.833453] [007/133] (952s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[98.048405] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[100.505901] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.468s)
[100.790264] [008/133] (949s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[100.904887] Starting subtest: etime-single-wait-for-submit-submitted
[101.014342] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.111s)
[101.155405] [009/133] (949s left) gem_wait (invalid-flags)
[101.273061] Starting subtest: invalid-flags
[101.277100] Subtest invalid-flags: SUCCESS (0.000s)
[101.572924] [010/133] (948s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[101.760804] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[101.766228] Starting dynamic subtest: pipe-A
[102.101637] Dynamic subtest pipe-A: SUCCESS (0.339s)
[102.141211] Starting dynamic subtest: pipe-B
[102.617772] Dynamic subtest pipe-B: SUCCESS (0.425s)
[102.688508] Starting dynamic subtest: pipe-C
[102.885644] Dynamic subtest pipe-C: SUCCESS (0.056s)
[102.952464] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.823s)
[103.453533] [011/133] (947s left) kms_draw_crc (draw-method-mmap-wc)
[103.912428] Starting subtest: draw-method-mmap-wc
[103.919242] Starting dynamic subtest: xrgb8888-untiled
[104.242821] Dynamic subtest xrgb8888-untiled: SUCCESS (0.466s)
[104.263615] Starting dynamic subtest: rgb565-untiled
[104.477565] Dynamic subtest rgb565-untiled: SUCCESS (0.231s)
[104.499604] Starting dynamic subtest: xrgb2101010-untiled
[104.745119] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.267s)
[104.766908] Starting dynamic subtest: xbgr16161616f-untiled
[105.013163] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.265s)
[105.031991] Starting dynamic subtest: xrgb8888-xtiled
[105.194817] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.184s)
[105.213505] Starting dynamic subtest: rgb565-xtiled
[105.376501] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s)
[105.395367] Starting dynamic subtest: xrgb2101010-xtiled
[105.546369] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.165s)
[105.564712] Starting dynamic subtest: xbgr16161616f-xtiled
[105.709675] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.165s)
[105.729371] Starting dynamic subtest: xrgb8888-ytiled
[105.895115] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.183s)
[105.913327] Starting dynamic subtest: rgb565-ytiled
[106.080058] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[106.099592] Starting dynamic subtest: xrgb2101010-ytiled
[106.242855] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.165s)
[106.261905] Starting dynamic subtest: xbgr16161616f-ytiled
[106.411045] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.166s)
[106.415479] Subtest draw-method-mmap-wc: SUCCESS (2.633s)
[106.667943] [012/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[106.880046] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[109.401505] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.526s)
[109.617307] [013/133] (941s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[109.814063] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[109.909555] [014/133] (941s left) gem_pxp (display-protected-crc)
[112.574348] Starting subtest: display-protected-crc
[112.582219] Subtest display-protected-crc: SKIP (0.000s)
[112.729870] [015/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[112.931491] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[112.939144] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.068456] [016/133] (938s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[113.260928] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[113.264193] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.311517] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[113.350395] Starting dynamic subtest: pipe-A-HDMI-A-2
[113.400545] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[113.435436] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.470712] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[113.492072] Starting dynamic subtest: pipe-B-HDMI-A-2
[113.526958] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[113.557618] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.590706] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[113.609714] Starting dynamic subtest: pipe-C-HDMI-A-2
[113.644483] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[113.651376] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.020s)
[114.319207] [017/133] (936s left) gem_exec_reloc (basic-softpin)
[114.448755] Starting subtest: basic-softpin
[114.452264] Subtest basic-softpin: SUCCESS (0.005s)
[114.672674] [018/133] (936s left) gem_mmap_gtt (fault-concurrent-y)
[114.787978] Starting subtest: fault-concurrent-Y
[120.298658] Subtest fault-concurrent-Y: SUCCESS (5.515s)
[120.456919] [019/133] (931s left) gem_flink_race (flink_name)
[120.562081] Starting subtest: flink_name
[125.942346] Subtest flink_name: SUCCESS (5.376s)
[126.084968] [020/133] (925s left) perf (global-sseu-config)
[126.295092] Starting subtest: global-sseu-config
[126.299756] Starting dynamic subtest: 0-rcs0
[126.346253] Dynamic subtest 0-rcs0: SUCCESS (0.055s)
[126.350079] Subtest global-sseu-config: SUCCESS (0.057s)
[126.451677] [021/133] (925s left) gem_exec_fence (syncobj-invalid-flags)
[127.101224] Starting subtest: syncobj-invalid-flags
[127.105358] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[127.495766] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[127.502140] [022/133] (924s left) kms_busy (extended-pageflip-hang-oldfb)
[127.693355] Starting subtest: extended-pageflip-hang-oldfb
[127.698120] Starting dynamic subtest: pipe-A
[128.251437] Dynamic subtest pipe-A: SUCCESS (0.555s)
[128.283709] Starting dynamic subtest: pipe-C
[128.694770] Dynamic subtest pipe-C: SUCCESS (0.434s)
[128.698276] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.002s)
[129.063844] [023/133] (922s left) gem_ctx_persistence (legacy-engines-hang)
[129.187186] Starting subtest: legacy-engines-hang
[129.191170] Starting dynamic subtest: render
[129.218246] Dynamic subtest render: SUCCESS (0.031s)
[129.246612] Starting dynamic subtest: bsd
[129.257759] Dynamic subtest bsd: SUCCESS (0.030s)
[129.284728] Starting dynamic subtest: blt
[129.292159] Dynamic subtest blt: SKIP (0.005s)
[129.317511] Starting dynamic subtest: vebox
[129.321460] Dynamic subtest vebox: SUCCESS (0.033s)
[129.325435] Subtest legacy-engines-hang: SUCCESS (0.108s)
[129.474420] [024/133] (922s left) gem_vm_create (create-ext)
[129.593699] Starting subtest: create-ext
[129.602617] Subtest create-ext: SUCCESS (0.006s)
[129.760302] [025/133] (922s left) gem_exec_schedule (fairslice-all)
[129.900539] Starting subtest: fairslice-all
[132.007509] Subtest fairslice-all: SUCCESS (2.107s)
[132.411572] [026/133] (919s left) kms_vblank (query-busy)
[132.599777] Starting subtest: query-busy
[132.604152] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.468136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.863s)
[135.492459] Starting dynamic subtest: pipe-A-HDMI-A-2
[138.092451] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.620s)
[138.122371] Starting dynamic subtest: pipe-C-HDMI-A-1
[140.690033] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.585s)
[140.723792] Starting dynamic subtest: pipe-C-HDMI-A-2
[143.269604] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.579s)
[143.273973] Subtest query-busy: SUCCESS (10.672s)
[143.577054] [027/133] (908s left) kms_pm_dc (dc9-dpms)
[144.781259] Starting subtest: dc9-dpms
[144.797098] Subtest dc9-dpms: SKIP (0.000s)
[144.925494] [028/133] (907s left) gem_exec_params (invalid-bsd-ring)
[145.044156] Starting subtest: invalid-bsd-ring
[145.048670] Subtest invalid-bsd-ring: SUCCESS (0.004s)
[145.204983] [029/133] (907s left) kms_psr (psr-cursor-plane-move)
[145.401062] Subtest psr-cursor-plane-move: SKIP (0.000s)
[145.518498] [030/133] (907s left) syncobj_timeline (invalid-wait-bad-flags)
[145.630389] Starting subtest: invalid-wait-bad-flags
[145.634522] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[145.789347] [031/133] (906s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[146.007113] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[146.015089] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[146.183099] [032/133] (906s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[146.366074] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[146.371084] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.387355] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[146.432059] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.452545] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[146.490160] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.506162] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[146.528093] Starting dynamic subtest: pipe-B-HDMI-A-2
[146.546266] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[146.567244] Starting dynamic subtest: pipe-C-HDMI-A-1
[146.579545] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[146.599515] Starting dynamic subtest: pipe-C-HDMI-A-2
[146.612356] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[146.618461] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.022s)
[147.314461] [033/133] (905s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[147.536753] Starting subtest: fbc-rgb565-draw-render
[150.351931] Subtest fbc-rgb565-draw-render: SUCCESS (2.819s)
[150.648928] [034/133] (902s left) gem_sync (basic-store-each)
[150.797077] Starting subtest: basic-store-each
[153.222827] Subtest basic-store-each: SUCCESS (2.442s)
[153.499311] [035/133] (899s left) kms_psr (psr-dpms)
[153.691110] Subtest psr-dpms: SKIP (0.000s)
[153.813243] [036/133] (899s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[154.052223] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[154.070091] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[154.202637] [037/133] (899s left) syncobj_basic (bad-fd-to-handle)
[154.308087] Starting subtest: bad-fd-to-handle
[154.311196] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[154.450792] [038/133] (898s left) gem_exec_whisper (basic-fds-forked-all)
[154.582167] Starting subtest: basic-fds-forked-all
[170.895661] Subtest basic-fds-forked-all: SUCCESS (16.312s)
[171.151590] [039/133] (882s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[171.358248] Starting subtest: x-tiled-32bpp-rotate-270
[171.686390] Subtest x-tiled-32bpp-rotate-270: SKIP (0.326s)
[171.951822] [040/133] (881s left) prime_busy (before-wait)
[172.071997] Starting subtest: before-wait
[172.090837] Starting dynamic subtest: rcs0
[172.098923] Dynamic subtest rcs0: SUCCESS (0.013s)
[172.144737] Starting dynamic subtest: bcs0
[172.148330] Dynamic subtest bcs0: SUCCESS (0.019s)
[172.174119] Starting dynamic subtest: vcs0
[172.180467] Dynamic subtest vcs0: SUCCESS (0.020s)
[172.202881] Starting dynamic subtest: vecs0
[172.207243] Dynamic subtest vecs0: SUCCESS (0.012s)
[172.270639] Subtest before-wait: SUCCESS (0.197s)
[172.432821] [041/133] (881s left) perf_pmu (rc6-suspend)
[172.547180] Starting subtest: rc6-suspend