[89.632191] Initializing watchdogs
[89.632367]   /dev/watchdog0
[89.672331] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.687402] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.694776] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.702925] [001/133] (960s left) perf (disabled-read-error)
[89.964226] Starting subtest: disabled-read-error
[90.001675] Subtest disabled-read-error: SUCCESS (0.041s)
[90.103994] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[90.318803] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[90.325814] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[90.457189] [003/133] (959s left) kms_properties (get_properties-sanity-atomic)
[90.643425] Starting subtest: get_properties-sanity-atomic
[90.654179] Subtest get_properties-sanity-atomic: SUCCESS (0.010s)
[90.788555] [004/133] (959s left) gem_fenced_exec_thrash (2-spare-fences)
[90.906237] Starting subtest: 2-spare-fences
[93.078110] Subtest 2-spare-fences: SUCCESS (2.168s)
[93.250985] [005/133] (957s left) api_intel_allocator (gem-pool)
[93.358744] Starting subtest: gem-pool
[93.373113] Subtest gem-pool: SUCCESS (0.018s)
[93.530554] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[93.733319] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[96.750792] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (3.022s)
[96.936744] [007/133] (953s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[97.136531] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[97.143530] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[97.271681] [008/133] (953s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[97.824111] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[98.098608] [009/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[98.315085] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[101.126035] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.817s)
[101.343841] [010/133] (949s left) i915_drm_fdinfo (busy-check-all)
[101.466453] Starting subtest: busy-check-all
[101.469777] Starting dynamic subtest: rcs0
[101.995491] Dynamic subtest rcs0: SUCCESS (0.529s)
[102.016600] Starting dynamic subtest: bcs0
[102.533457] Dynamic subtest bcs0: SUCCESS (0.533s)
[102.568869] Starting dynamic subtest: vcs0
[103.082779] Dynamic subtest vcs0: SUCCESS (0.549s)
[103.102259] Starting dynamic subtest: vecs0
[103.610312] Dynamic subtest vecs0: SUCCESS (0.528s)
[103.614586] Subtest busy-check-all: SUCCESS (2.142s)
[103.744285] [011/133] (947s left) i915_pm_freq_api (freq-suspend)
[103.864648] Subtest freq-suspend: SKIP (0.000s)
[103.969253] [012/133] (947s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[104.157165] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[104.168042] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[104.297715] [013/133] (947s left) gem_pwrite (basic-random)
[104.413758] Starting subtest: basic-random
[110.312581] Subtest basic-random: SUCCESS (5.896s)
[110.465126] [014/133] (940s left) kms_atomic_transition (plane-all-modeset-transition)
[110.802103] Starting subtest: plane-all-modeset-transition
[110.805160] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.131240] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.326s)
[155.325617] Starting dynamic subtest: pipe-A-HDMI-A-2
[199.321840] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.010s)
[199.517711] Starting dynamic subtest: pipe-B-HDMI-A-1
[240.145751] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.647s)
[240.327908] Starting dynamic subtest: pipe-B-HDMI-A-2
[280.961399] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.652s)
[281.119359] Subtest plane-all-modeset-transition: SUCCESS (170.310s)
[281.446750] [015/133] (770s left) syncobj_timeline (etime-multi-wait-submitted)
[281.578657] Starting subtest: etime-multi-wait-submitted
[281.686541] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[281.827923] [016/133] (769s left) kms_content_protection (lic-type-0-hdcp14)
[282.033406] Starting subtest: lic-type-0-hdcp14
[282.072838] Subtest lic-type-0-hdcp14: SKIP (0.033s)
[282.213340] [017/133] (769s left) kms_vrr (max-min)
[282.439908] Starting subtest: max-min
[282.455383] Subtest max-min: SKIP (0.000s)
[282.622285] [018/133] (769s left) i915_pm_rpm (system-suspend-execbuf)
[284.587186] Starting subtest: system-suspend-execbuf
[306.364871] Subtest system-suspend-execbuf: SUCCESS (6.187s)
[314.743857] [019/133] (745s left) gem_exec_whisper (basic-normal-all)
[314.900593] Starting subtest: basic-normal-all
[321.606494] Subtest basic-normal-all: SUCCESS (6.702s)
[321.859514] [020/133] (738s left) gem_exec_params (dr1-dirt)
[321.980601] Starting subtest: DR1-dirt
[321.985317] Subtest DR1-dirt: SUCCESS (0.000s)
[322.125563] [021/133] (737s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[322.307800] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[322.312846] Starting dynamic subtest: pipe-A
[322.629086] Dynamic subtest pipe-A: SUCCESS (0.322s)
[322.681232] Starting dynamic subtest: pipe-B
[323.025867] Dynamic subtest pipe-B: SUCCESS (0.396s)
[323.078305] Starting dynamic subtest: pipe-C
[323.109862] Dynamic subtest pipe-C: SUCCESS (0.079s)
[323.114921] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.800s)
[323.588425] [022/133] (736s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[323.790945] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[335.264208] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.409s)
[336.093213] [023/133] (724s left) gem_fence_thrash (bo-write-verify-y)
[336.646837] Starting subtest: bo-write-verify-y
[337.675650] Subtest bo-write-verify-y: SUCCESS (1.213s)
[337.820705] [024/133] (723s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[338.029694] Starting subtest: x-tiled-16bpp-rotate-90
[338.378360] Subtest x-tiled-16bpp-rotate-90: SKIP (0.344s)
[338.659837] [025/133] (722s left) kms_plane (pixel-format-y-tiled-modifier)
[338.861399] Starting subtest: pixel-format-y-tiled-modifier
[339.091496] Starting dynamic subtest: pipe-A-plane-0
[339.975985] Dynamic subtest pipe-A-plane-0: SUCCESS (0.883s)
[340.002355] Starting dynamic subtest: pipe-A-plane-1
[340.810216] Dynamic subtest pipe-A-plane-1: SUCCESS (0.830s)
[340.836005] Starting dynamic subtest: pipe-A-plane-2
[341.391249] Dynamic subtest pipe-A-plane-2: SUCCESS (0.582s)
[341.417354] Starting dynamic subtest: pipe-A-plane-3
[341.959029] Dynamic subtest pipe-A-plane-3: SUCCESS (0.564s)
[342.001281] Starting dynamic subtest: pipe-A-plane-4
[342.013425] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[342.357056] Starting dynamic subtest: pipe-B-plane-0
[343.068808] Dynamic subtest pipe-B-plane-0: SUCCESS (0.733s)
[343.095553] Starting dynamic subtest: pipe-B-plane-1
[343.835075] Dynamic subtest pipe-B-plane-1: SUCCESS (0.765s)
[343.861325] Starting dynamic subtest: pipe-B-plane-2
[344.419478] Dynamic subtest pipe-B-plane-2: SUCCESS (0.581s)
[344.446110] Starting dynamic subtest: pipe-B-plane-3
[345.010273] Dynamic subtest pipe-B-plane-3: SUCCESS (0.581s)
[345.068057] Starting dynamic subtest: pipe-B-plane-4
[345.080810] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[345.286868] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.430s)
[345.630513] [026/133] (715s left) syncobj_timeline (device-signal-unordered)
[345.755077] Starting subtest: device-signal-unordered
[345.759087] Subtest device-signal-unordered: SUCCESS (0.003s)
[345.898575] [027/133] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[346.106116] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[346.112830] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[346.261790] [028/133] (715s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[346.445518] Starting subtest: flip-vs-cursor-busy-crc-legacy
[347.502317] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.056s)
[347.840007] [029/133] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[348.049182] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[348.055618] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[348.204801] [030/133] (713s left) kms_plane_lowres (tiling-x)
[348.400820] Starting subtest: tiling-x
[348.404643] Starting dynamic subtest: pipe-A-HDMI-A-1
[356.164838] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.765s)
[356.479864] Starting dynamic subtest: pipe-A-HDMI-A-2
[363.873520] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.443s)
[364.175813] Starting dynamic subtest: pipe-B-HDMI-A-1
[371.287033] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.142s)
[371.588877] Starting dynamic subtest: pipe-B-HDMI-A-2
[378.719782] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.171s)
[378.988078] Starting dynamic subtest: pipe-C-HDMI-A-1
[386.156870] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.203s)
[386.414841] Starting dynamic subtest: pipe-C-HDMI-A-2
[393.566178] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.188s)
[393.771926] Subtest tiling-x: SUCCESS (45.378s)
[394.169441] [031/133] (667s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[394.294599] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[394.310261] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[394.478989] [032/133] (667s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[394.690839] Starting subtest: y-tiled-64bpp-rotate-270
[395.182445] Subtest y-tiled-64bpp-rotate-270: SKIP (0.331s)
[395.735185] [033/133] (666s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[396.292450] Starting subtest: yf-tiled-16bpp-rotate-270
[396.458013] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.302s)
[396.570587] [034/133] (665s left) gem_mmap_gtt (fault-concurrent-x)
[396.688858] Starting subtest: fault-concurrent-X
[402.325508] Subtest fault-concurrent-X: SUCCESS (5.639s)
[402.512018] [035/133] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[402.724037] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[402.730956] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[402.898594] [036/133] (659s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[403.084849] Starting subtest: bad-pixel-format-y-tiled-ccs
[403.088852] Starting dynamic subtest: pipe-A-HDMI-A-1
[403.130277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[403.189209] Starting dynamic subtest: pipe-A-HDMI-A-2
[403.235846] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[403.262241] Starting dynamic subtest: pipe-B-HDMI-A-1
[403.299860] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[403.325761] Starting dynamic subtest: pipe-B-HDMI-A-2
[403.355096] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[403.380775] Starting dynamic subtest: pipe-C-HDMI-A-1
[403.415512] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[403.445535] Starting dynamic subtest: pipe-C-HDMI-A-2
[403.480468] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[403.483765] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.041s)
[404.120921] [037/133] (658s left) gem_bad_reloc (negative-reloc-lut)
[404.250957] Starting subtest: negative-reloc-lut
[404.263255] Subtest negative-reloc-lut: SUCCESS (0.002s)
[404.418689] [038/133] (658s left) kms_busy (extended-modeset-hang-oldfb)
[404.633718] Starting subtest: extended-modeset-hang-oldfb
[404.637770] Starting dynamic subtest: pipe-A
[408.773941] Dynamic subtest pipe-A: SUCCESS (4.140s)
[408.811766] Starting dynamic subtest: pipe-C
[412.739384] Dynamic subtest pipe-C: SUCCESS (3.954s)
[412.754545] Subtest extended-modeset-hang-oldfb: SUCCESS (8.121s)
[413.140235] [039/133] (649s left) kms_pm_dc (dc6-psr)
[414.354013] Starting subtest: dc6-psr
[414.361641] Subtest dc6-psr: SKIP (0.000s)
[414.504677] [040/133] (648s left) perf_pmu (pmu-read)
[414.631041] Starting subtest: pmu-read
[414.641828] Subtest pmu-read: SUCCESS (0.010s)
[414.782713] [041/133] (648s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[415.544519] Starting subtest: syncobj-timeline-invalid-flags
[415.549004] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[415.820363] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[415.828168] [042/133] (647s left) gem_softpin (allocator-nopin)
[415.956647] Starting subtest: allocator-nopin
[416.184813] Subtest allocator-nopin: SUCCESS (0.231s)
[416.407946] [043/133] (646s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[416.591831] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[416.595666] Starting dynamic subtest: pipe-A-HDMI-A-1
[416.784289] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[416.829569] Starting dynamic subtest: pipe-A-HDMI-A-2
[416.992766] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[417.023466] Starting dynamic subtest: pipe-B-HDMI-A-1
[417.159500] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[417.209358] Starting dynamic subtest: pipe-B-HDMI-A-2
[417.392224] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[417.418582] Starting dynamic subtest: pipe-C-HDMI-A-1
[417.562661] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[417.601211] Starting dynamic subtest: pipe-C-HDMI-A-2
[417.733825] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[417.741914] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.101s)
[417.873236] [044/133] (645s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[418.066392] Starting subtest: basic-max-pipe-crc-check
[418.073783] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[418.199025] [045/133] (645s left) gem_ctx_isolation (preservation-s3)
[418.336829] Starting subtest: preservation-S3
[418.341903] Starting dynamic subtest: rcs0