[83.558887] Initializing watchdogs
[83.559157]   /dev/watchdog0
[83.597725] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[83.611873] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[83.618572] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[83.627242] [001/132] (960s left) gem_exec_reloc (basic-write-cpu-active)
[83.762954] Starting subtest: basic-write-cpu-active
[83.906061] Subtest basic-write-cpu-active: SUCCESS (0.142s)
[84.134926] [002/132] (960s left) kms_chamelium_hpd (vga-hpd)
[84.700336] Subtest vga-hpd: SKIP (0.000s)
[84.951952] [003/132] (959s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[85.172172] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[87.000117] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.825s)
[87.279408] [004/132] (957s left) kms_vblank (query-forked-busy)
[87.461786] Starting subtest: query-forked-busy
[87.465100] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.331621] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.864s)
[90.365263] Starting dynamic subtest: pipe-A-HDMI-A-2
[92.926533] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.592s)
[92.966181] Starting dynamic subtest: pipe-C-HDMI-A-1
[95.512136] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.575s)
[95.546262] Starting dynamic subtest: pipe-C-HDMI-A-2
[98.078362] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.560s)
[98.081416] Subtest query-forked-busy: SUCCESS (10.611s)
[98.371693] [005/132] (946s left) i915_query (hwconfig_table)
[98.484596] Starting subtest: hwconfig_table
[98.493542] Subtest hwconfig_table: SKIP (0.000s)
[98.634204] [006/132] (945s left) gem_render_copy (y-tiled-ccs-to-linear)
[98.745455] Starting subtest: y-tiled-ccs-to-linear
[98.749294] Starting dynamic subtest: smem
[98.940388] Dynamic subtest smem: SUCCESS (0.193s)
[98.944202] Subtest y-tiled-ccs-to-linear: SUCCESS (0.194s)
[99.235891] [007/132] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[99.435547] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[99.442023] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[99.589684] [008/132] (945s left) kms_hdr (bpc-switch)
[99.764648] Starting subtest: bpc-switch
[126.616369] Subtest bpc-switch: SKIP (26.766s)
[126.984144] [009/132] (917s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[127.220867] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[127.224207] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.293474] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[127.320177] Starting dynamic subtest: pipe-A-HDMI-A-2
[127.354744] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[127.372105] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.405402] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[127.422893] Starting dynamic subtest: pipe-B-HDMI-A-2
[127.456076] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[127.473950] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.506365] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[127.524067] Starting dynamic subtest: pipe-C-HDMI-A-2
[127.558685] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[127.565369] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.041s)
[128.570179] [010/132] (916s left) gem_ctx_param (vm)
[129.043174] Starting subtest: vm
[129.193746] Subtest vm: SUCCESS (0.050s)
[129.273850] [011/132] (916s left) kms_prop_blob (blob-prop-core)
[129.382976] Starting subtest: blob-prop-core
[129.387022] Subtest blob-prop-core: SUCCESS (0.000s)
[129.570774] [012/132] (915s left) gem_exec_schedule (reorder-wide)
[129.835229] Starting subtest: reorder-wide
[129.839900] Starting dynamic subtest: rcs0
[130.047642] Dynamic subtest rcs0: SUCCESS (0.212s)
[130.072859] Starting dynamic subtest: bcs0
[130.347503] Dynamic subtest bcs0: SUCCESS (0.300s)
[130.380879] Starting dynamic subtest: vcs0
[130.498377] Dynamic subtest vcs0: SUCCESS (0.152s)
[130.518400] Starting dynamic subtest: vecs0
[130.648507] Dynamic subtest vecs0: SUCCESS (0.146s)
[130.654490] Subtest reorder-wide: SUCCESS (0.821s)
[130.949307] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[130.956652] [013/132] (914s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[131.151510] Starting subtest: psr-rgb101010-draw-mmap-wc
[131.160188] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.001s)
[131.315955] [014/132] (914s left) gem_userptr_blits (huge-split)
[131.468712] Starting subtest: huge-split
[131.481267] Subtest huge-split: SUCCESS (0.010s)
[131.683457] [015/132] (914s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[131.893955] Starting subtest: 4-tiled-8bpp-rotate-180
[131.901046] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[132.049105] [016/132] (913s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[132.235201] Starting subtest: cursorB-vs-flipA-toggle
[143.614878] Subtest cursorB-vs-flipA-toggle: SUCCESS (11.372s)
[143.956295] [017/132] (902s left) kms_vrr (max-min)
[144.154425] Starting subtest: max-min
[144.167710] Subtest max-min: SKIP (0.000s)
[144.336928] [018/132] (901s left) kms_colorop (plane-xr30-xr30-ctm_3x4_50_desat)
[144.610797] Subtest plane-XR30-XR30-ctm_3x4_50_desat: SKIP (0.000s)
[144.789971] [019/132] (901s left) perf_pmu (multi-client)
[144.905964] Starting subtest: multi-client
[144.910118] Starting dynamic subtest: rcs0
[145.940517] Dynamic subtest rcs0: SUCCESS (1.027s)
[145.961281] Starting dynamic subtest: bcs0
[146.971195] Dynamic subtest bcs0: SUCCESS (1.030s)
[146.992134] Starting dynamic subtest: vcs0
[148.011481] Dynamic subtest vcs0: SUCCESS (1.028s)
[148.032806] Starting dynamic subtest: vecs0
[149.041140] Dynamic subtest vecs0: SUCCESS (1.027s)
[149.044725] Subtest multi-client: SUCCESS (4.130s)
[149.204638] [020/132] (897s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[149.402609] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[149.410391] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[149.573461] [021/132] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[149.761381] Starting subtest: basic-flip-before-cursor-legacy
[151.114812] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.350s)
[151.417721] [022/132] (895s left) gem_ctx_shared (create-shared-gtt)
[151.546138] Starting subtest: create-shared-gtt
[153.700970] Subtest create-shared-gtt: SUCCESS (2.151s)
[153.978839] [023/132] (892s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[154.087021] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[154.198356] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[154.362617] [024/132] (892s left) gem_exec_schedule (pi-ringfull)
[154.623706] Starting subtest: pi-ringfull
[154.629162] Starting dynamic subtest: rcs0
[154.686636] Dynamic subtest rcs0: SUCCESS (0.064s)
[154.708513] Starting dynamic subtest: bcs0
[154.738252] Dynamic subtest bcs0: SUCCESS (0.049s)
[154.760841] Starting dynamic subtest: vcs0
[154.788438] Dynamic subtest vcs0: SUCCESS (0.048s)
[154.809845] Starting dynamic subtest: vecs0
[154.838354] Dynamic subtest vecs0: SUCCESS (0.048s)
[154.842053] Subtest pi-ringfull: SUCCESS (0.223s)
[155.112980] [025/132] (891s left) gem_lmem_swapping (heavy-verify-random-ccs)
[155.228875] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[155.348393] [026/132] (891s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[155.555650] Starting subtest: fbcpsr-rgb565-draw-render
[155.563399] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[155.731092] [027/132] (891s left) gem_exec_store (dword)
[155.858086] Starting subtest: dword
[155.861651] Starting dynamic subtest: rcs0
[155.894300] Dynamic subtest rcs0: SUCCESS (0.033s)
[155.914886] Starting dynamic subtest: bcs0
[155.920144] Dynamic subtest bcs0: SUCCESS (0.021s)
[155.943052] Starting dynamic subtest: vcs0
[155.946344] Dynamic subtest vcs0: SUCCESS (0.020s)
[155.967575] Starting dynamic subtest: vecs0
[155.971492] Dynamic subtest vecs0: SUCCESS (0.024s)
[155.975561] Subtest dword: SUCCESS (0.112s)
[156.264845] [028/132] (890s left) gem_exec_reloc (basic-range-active)
[156.380217] Starting subtest: basic-range-active
[156.461870] Subtest basic-range-active: SUCCESS (0.080s)
[156.733317] [029/132] (890s left) dmabuf_sync_file (export-before-signal)
[156.861688] Starting subtest: export-before-signal
[156.865852] Subtest export-before-signal: SUCCESS (0.002s)
[157.011784] [030/132] (890s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[157.151870] Starting subtest: map-fixed-invalidate-overlap
[157.156509] Starting dynamic subtest: gtt
[157.383806] Dynamic subtest gtt: SUCCESS (0.234s)
[157.404852] Starting dynamic subtest: wb
[157.538590] Dynamic subtest wb: SUCCESS (0.152s)
[157.558870] Starting dynamic subtest: wc
[157.690973] Dynamic subtest wc: SUCCESS (0.149s)
[157.711562] Starting dynamic subtest: uc
[157.843296] Dynamic subtest uc: SUCCESS (0.149s)
[157.846675] Subtest map-fixed-invalidate-overlap: SUCCESS (0.697s)
[158.049400] [031/132] (889s left) kms_colorop (check_plane_colorop_ids)
[158.304692] Starting subtest: check_plane_colorop_ids
[158.311513] Subtest check_plane_colorop_ids: SUCCESS (0.000s)
[158.484192] [032/132] (889s left) syncobj_timeline (single-wait-signaled)
[158.604812] Starting subtest: single-wait-signaled
[158.609403] Subtest single-wait-signaled: SUCCESS (0.002s)
[158.779158] [033/132] (888s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[158.888303] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[158.891888] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[159.036384] [034/132] (888s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[159.222174] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[159.226746] Starting dynamic subtest: pipe-A
[159.554504] Dynamic subtest pipe-A: SUCCESS (0.327s)
[159.577248] Starting dynamic subtest: pipe-B
[159.943928] Dynamic subtest pipe-B: SUCCESS (0.390s)
[159.975566] Starting dynamic subtest: pipe-C
[160.028240] Dynamic subtest pipe-C: SUCCESS (0.081s)
[160.031606] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.809s)
[160.506349] [035/132] (887s left) sw_sync (sync_busy_fork_unixsocket)
[160.612685] Starting subtest: sync_busy_fork_unixsocket
[160.637090] Subtest sync_busy_fork_unixsocket: SUCCESS (0.026s)
[160.807267] [036/132] (887s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[160.988901] Starting subtest: cursorA-vs-flipA-varying-size
[172.408759] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.304s)
[173.000641] [037/132] (875s left) kms_atomic_interruptible (legacy-setmode)
[173.516802] Starting subtest: legacy-setmode
[173.585563] Starting dynamic subtest: pipe-A-HDMI-A-1
[180.075405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.737s)
[180.078940] Subtest legacy-setmode: SUCCESS (6.744s)
[180.389745] [038/132] (868s left) gem_lmem_swapping (parallel-random-verify)
[180.505961] Subtest parallel-random-verify: SKIP (0.000s)
[180.617978] [039/132] (868s left) kms_psr (fbc-pr-primary-mmap-cpu)
[180.800956] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[180.920480] [040/132] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[181.128844] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[181.135835] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[181.319966] [041/132] (867s left) gem_ctx_param (get-priority-new-ctx)
[181.423570] Starting subtest: get-priority-new-ctx
[181.428225] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[181.586547] [042/132] (867s left) gem_workarounds (suspend-resume)
[181.728711] Starting subtest: suspend-resume