[88.761213] Initializing watchdogs
[88.761410]   /dev/watchdog0
[88.800544] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.815300] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.821498] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.826468] [001/133] (960s left) perf (disabled-read-error)
[89.079243] Starting subtest: disabled-read-error
[89.116790] Subtest disabled-read-error: SUCCESS (0.039s)
[89.214223] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[89.422092] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[89.426075] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[89.560298] [003/133] (959s left) kms_properties (get_properties-sanity-atomic)
[89.736073] Starting subtest: get_properties-sanity-atomic
[89.744094] Subtest get_properties-sanity-atomic: SUCCESS (0.007s)
[89.863570] [004/133] (959s left) gem_fenced_exec_thrash (2-spare-fences)
[89.975066] Starting subtest: 2-spare-fences
[92.154837] Subtest 2-spare-fences: SUCCESS (2.168s)
[92.310609] [005/133] (957s left) api_intel_allocator (gem-pool)
[92.412122] Starting subtest: gem-pool
[92.427650] Subtest gem-pool: SUCCESS (0.016s)
[92.564364] [006/133] (957s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[92.758289] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[95.789367] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (3.028s)
[95.999423] [007/133] (953s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[96.192067] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[96.195761] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[96.310457] [008/133] (953s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[96.893104] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[97.229315] [009/133] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[97.438672] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[100.420584] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.980s)
[100.629252] [010/133] (949s left) i915_drm_fdinfo (busy-check-all)
[100.740180] Starting subtest: busy-check-all
[100.743638] Starting dynamic subtest: rcs0
[101.269120] Dynamic subtest rcs0: SUCCESS (0.525s)
[101.284961] Starting dynamic subtest: bcs0
[101.797658] Dynamic subtest bcs0: SUCCESS (0.530s)
[101.815294] Starting dynamic subtest: vcs0
[102.327534] Dynamic subtest vcs0: SUCCESS (0.530s)
[102.347427] Starting dynamic subtest: vecs0
[102.856121] Dynamic subtest vecs0: SUCCESS (0.526s)
[102.857398] Subtest busy-check-all: SUCCESS (2.114s)
[102.982822] [011/133] (947s left) i915_pm_freq_api (freq-suspend)
[103.093318] Subtest freq-suspend: SKIP (0.000s)
[103.187222] [012/133] (946s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[103.359270] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[103.363120] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[103.492179] [013/133] (946s left) gem_pwrite (basic-random)
[103.594042] Starting subtest: basic-random
[109.770327] Subtest basic-random: SUCCESS (6.172s)
[109.912178] [014/133] (940s left) kms_atomic_transition (plane-all-modeset-transition)
[110.210748] Starting subtest: plane-all-modeset-transition
[110.214530] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.542608] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.327s)
[154.743248] Starting dynamic subtest: pipe-A-HDMI-A-2
[198.738552] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.019s)
[198.927122] Starting dynamic subtest: pipe-B-HDMI-A-1
[239.567937] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.657s)
[239.748304] Starting dynamic subtest: pipe-B-HDMI-A-2
[280.376788] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.649s)
[280.535592] Subtest plane-all-modeset-transition: SUCCESS (170.330s)
[280.860172] [015/133] (769s left) syncobj_timeline (etime-multi-wait-submitted)
[280.974144] Starting subtest: etime-multi-wait-submitted
[281.086801] Subtest etime-multi-wait-submitted: SUCCESS (0.110s)
[281.246983] [016/133] (769s left) kms_content_protection (lic-type-0-hdcp14)
[281.450936] Starting subtest: lic-type-0-hdcp14
[281.488600] Subtest lic-type-0-hdcp14: SKIP (0.033s)
[281.613520] [017/133] (768s left) kms_vrr (max-min)
[281.790131] Starting subtest: max-min
[281.793570] Subtest max-min: SKIP (0.000s)
[281.913945] [018/133] (768s left) i915_pm_rpm (system-suspend-execbuf)
[283.847519] Starting subtest: system-suspend-execbuf
[306.338088] Subtest system-suspend-execbuf: SUCCESS (6.905s)
[309.713488] [019/133] (744s left) gem_exec_whisper (basic-normal-all)
[309.862934] Starting subtest: basic-normal-all
[316.382812] Subtest basic-normal-all: SUCCESS (6.618s)
[316.627718] [020/133] (737s left) gem_exec_params (dr1-dirt)
[316.733699] Starting subtest: DR1-dirt
[316.735692] Subtest DR1-dirt: SUCCESS (0.001s)
[316.874263] [021/133] (737s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[317.047752] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[317.049660] Starting dynamic subtest: pipe-A
[317.369823] Dynamic subtest pipe-A: SUCCESS (0.322s)
[317.414907] Starting dynamic subtest: pipe-B
[317.825861] Dynamic subtest pipe-B: SUCCESS (0.460s)
[317.872070] Starting dynamic subtest: pipe-C
[317.909077] Dynamic subtest pipe-C: SUCCESS (0.082s)
[317.911736] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.867s)
[318.353890] [022/133] (735s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[318.539598] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[329.863851] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.369s)
[330.217632] [023/133] (723s left) gem_fence_thrash (bo-write-verify-y)
[330.336929] Starting subtest: bo-write-verify-y
[331.538410] Subtest bo-write-verify-y: SUCCESS (1.203s)
[331.680080] [024/133] (722s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[331.912017] Starting subtest: x-tiled-16bpp-rotate-90
[332.248679] Subtest x-tiled-16bpp-rotate-90: SKIP (0.337s)
[332.514337] [025/133] (721s left) kms_plane (pixel-format-y-tiled-modifier)
[332.713134] Starting subtest: pixel-format-y-tiled-modifier
[332.962955] Starting dynamic subtest: pipe-A-plane-0
[333.825847] Dynamic subtest pipe-A-plane-0: SUCCESS (0.865s)
[333.848511] Starting dynamic subtest: pipe-A-plane-1
[334.640821] Dynamic subtest pipe-A-plane-1: SUCCESS (0.814s)
[334.663895] Starting dynamic subtest: pipe-A-plane-2
[335.207338] Dynamic subtest pipe-A-plane-2: SUCCESS (0.564s)
[335.229085] Starting dynamic subtest: pipe-A-plane-3
[335.774786] Dynamic subtest pipe-A-plane-3: SUCCESS (0.565s)
[335.810249] Starting dynamic subtest: pipe-A-plane-4
[335.816227] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[336.211450] Starting dynamic subtest: pipe-B-plane-0
[336.991276] Dynamic subtest pipe-B-plane-0: SUCCESS (0.800s)
[337.012933] Starting dynamic subtest: pipe-B-plane-1
[337.806918] Dynamic subtest pipe-B-plane-1: SUCCESS (0.814s)
[337.828527] Starting dynamic subtest: pipe-B-plane-2
[338.439695] Dynamic subtest pipe-B-plane-2: SUCCESS (0.631s)
[338.461252] Starting dynamic subtest: pipe-B-plane-3
[339.005889] Dynamic subtest pipe-B-plane-3: SUCCESS (0.565s)
[339.040943] Starting dynamic subtest: pipe-B-plane-4
[339.052073] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[339.257708] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.560s)
[339.773563] [026/133] (714s left) syncobj_timeline (device-signal-unordered)
[339.909743] Starting subtest: device-signal-unordered
[339.911990] Subtest device-signal-unordered: SUCCESS (0.006s)
[340.060688] [027/133] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[340.260365] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[340.263989] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[340.405388] [028/133] (714s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[340.592678] Starting subtest: flip-vs-cursor-busy-crc-legacy
[341.665477] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (1.071s)
[341.998353] [029/133] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[342.217889] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[342.221065] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[342.377920] [030/133] (712s left) kms_plane_lowres (tiling-x)
[342.556268] Starting subtest: tiling-x
[342.564510] Starting dynamic subtest: pipe-A-HDMI-A-1
[350.367337] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.804s)
[350.711688] Starting dynamic subtest: pipe-A-HDMI-A-2
[358.260594] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.590s)
[358.573329] Starting dynamic subtest: pipe-B-HDMI-A-1
[365.826038] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.296s)
[366.132678] Starting dynamic subtest: pipe-B-HDMI-A-2
[373.416190] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.333s)
[373.676718] Starting dynamic subtest: pipe-C-HDMI-A-1
[381.013648] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.383s)
[381.278942] Starting dynamic subtest: pipe-C-HDMI-A-2
[388.457597] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.222s)
[388.661355] Subtest tiling-x: SUCCESS (46.104s)
[388.986344] [031/133] (665s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[389.112707] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[389.119047] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.003s)
[389.267115] [032/133] (665s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[389.465685] Starting subtest: y-tiled-64bpp-rotate-270
[389.906736] Subtest y-tiled-64bpp-rotate-270: SKIP (0.436s)
[390.229258] [033/133] (664s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[390.441050] Starting subtest: yf-tiled-16bpp-rotate-270
[390.819501] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.371s)
[391.066809] [034/133] (663s left) gem_mmap_gtt (fault-concurrent-x)
[391.174692] Starting subtest: fault-concurrent-X
[397.358356] Subtest fault-concurrent-X: SUCCESS (6.188s)
[397.516112] [035/133] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[397.717998] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[397.720751] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[397.850081] [036/133] (657s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[398.043625] Starting subtest: bad-pixel-format-y-tiled-ccs
[398.044564] Starting dynamic subtest: pipe-A-HDMI-A-1
[398.056804] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[398.105936] Starting dynamic subtest: pipe-A-HDMI-A-2
[398.130841] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[398.170026] Starting dynamic subtest: pipe-B-HDMI-A-1
[398.194882] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[398.235907] Starting dynamic subtest: pipe-B-HDMI-A-2
[398.260823] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.003s)
[398.297784] Starting dynamic subtest: pipe-C-HDMI-A-1
[398.307918] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[398.331923] Starting dynamic subtest: pipe-C-HDMI-A-2
[398.340206] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[398.341271] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.062s)
[399.116038] [037/133] (656s left) gem_bad_reloc (negative-reloc-lut)
[399.239694] Starting subtest: negative-reloc-lut
[399.245988] Subtest negative-reloc-lut: SUCCESS (0.002s)
[399.388961] [038/133] (655s left) kms_busy (extended-modeset-hang-oldfb)
[399.594129] Starting subtest: extended-modeset-hang-oldfb
[399.598781] Starting dynamic subtest: pipe-A
[403.796521] Dynamic subtest pipe-A: SUCCESS (4.201s)
[403.826276] Starting dynamic subtest: pipe-C
[408.739519] Dynamic subtest pipe-C: SUCCESS (4.931s)
[408.747565] Subtest extended-modeset-hang-oldfb: SUCCESS (9.155s)
[409.111606] [039/133] (646s left) kms_pm_dc (dc6-psr)
[410.314702] Starting subtest: dc6-psr
[410.316945] Subtest dc6-psr: SKIP (0.000s)
[410.489573] [040/133] (645s left) perf_pmu (pmu-read)
[410.603472] Starting subtest: pmu-read
[410.613560] Subtest pmu-read: SUCCESS (0.010s)
[410.760289] [041/133] (644s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[411.518349] Starting subtest: syncobj-timeline-invalid-flags
[411.524023] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.002s)
[411.783417] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[411.788768] [042/133] (643s left) gem_softpin (allocator-nopin)
[411.902183] Starting subtest: allocator-nopin
[412.135632] Subtest allocator-nopin: SUCCESS (0.226s)
[412.307497] [043/133] (643s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[412.485790] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[412.487108] Starting dynamic subtest: pipe-A-HDMI-A-1
[412.557680] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[412.605125] Starting dynamic subtest: pipe-A-HDMI-A-2
[412.714685] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.013s)
[412.736897] Starting dynamic subtest: pipe-B-HDMI-A-1
[412.777480] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.013s)
[412.801207] Starting dynamic subtest: pipe-B-HDMI-A-2
[412.837162] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.013s)
[412.859454] Starting dynamic subtest: pipe-C-HDMI-A-1
[412.898778] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[412.922919] Starting dynamic subtest: pipe-C-HDMI-A-2
[412.957824] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[412.959526] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.106s)
[413.674142] [044/133] (642s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[413.869972] Starting subtest: basic-max-pipe-crc-check
[413.878679] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[413.989728] [045/133] (642s left) gem_ctx_isolation (preservation-s3)
[414.124542] Starting subtest: preservation-S3
[414.129804] Starting dynamic subtest: rcs0