[90.559444] Initializing watchdogs
[90.559622]   /dev/watchdog0
[90.594930] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.608119] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.615435] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.621777] [001/130] (960s left) gem_softpin (evict-active)
[91.061314] Starting subtest: evict-active
[91.074817] Subtest evict-active: SUCCESS (0.015s)
[91.228882] [002/130] (959s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[91.345947] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[91.443844] [003/130] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[91.660844] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[91.664708] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[91.786443] [004/130] (959s left) kms_prop_blob (invalid-set-prop)
[91.902987] Starting subtest: invalid-set-prop
[91.904664] Subtest invalid-set-prop: SUCCESS (0.000s)
[92.026377] [005/130] (959s left) gem_pwrite (basic-exhaustion)
[92.138424] Starting subtest: basic-exhaustion
[117.108849] Subtest basic-exhaustion: SUCCESS (24.959s)
[117.243944] [FACT gem_pwrite (basic-exhaustion)] new: kernel.kmod_is_loaded.vgem: true
[117.248715] [006/130] (934s left) kms_plane_cursor (primary)
[117.439273] Starting subtest: primary
[117.448667] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[120.078703] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.632s)
[120.141630] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[122.563052] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.432s)
[122.623541] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[125.044189] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.433s)
[125.293736] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[127.783772] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.500s)
[127.831666] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[130.235821] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.415s)
[130.278572] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[132.701166] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.433s)
[132.962922] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[135.436749] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.496s)
[135.481926] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[137.885762] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.416s)
[137.929456] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[140.351865] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.433s)
[140.566202] Subtest primary: SUCCESS (23.122s)
[140.838340] [007/130] (910s left) kms_properties (get_properties-sanity-atomic)
[141.041399] Starting subtest: get_properties-sanity-atomic
[141.046133] Subtest get_properties-sanity-atomic: SUCCESS (0.009s)
[141.182022] [008/130] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[141.398417] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[141.402601] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[141.536284] [009/130] (910s left) gem_pread (uncached)
[141.651632] Starting subtest: uncached
[144.752078] Subtest uncached: SUCCESS (3.098s)
[144.902834] [010/130] (906s left) prime_vgem (basic-fence-flip)
[145.046956] Starting subtest: basic-fence-flip
[145.566557] Subtest basic-fence-flip: SUCCESS (0.516s)
[145.718401] [011/130] (906s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[145.916092] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[145.920271] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[156.986808] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.064s)
[157.011886] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[168.130022] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.141s)
[168.151205] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[179.247875] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.116s)
[179.252646] Subtest 2x-flip-vs-absolute-wf_vblank: SUCCESS (33.335s)
[179.850532] [012/130] (872s left) api_intel_bb (reset-bb)
[179.962994] Starting subtest: reset-bb
[179.967769] Subtest reset-bb: SUCCESS (0.006s)
[180.116161] [013/130] (872s left) kms_draw_crc (draw-method-blt)
[180.310639] Starting subtest: draw-method-blt
[180.312173] Starting dynamic subtest: xrgb8888-untiled
[180.827853] Dynamic subtest xrgb8888-untiled: SUCCESS (0.515s)
[180.848219] Starting dynamic subtest: rgb565-untiled
[181.108177] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[181.125394] Starting dynamic subtest: xrgb2101010-untiled
[181.391888] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.283s)
[181.406658] Starting dynamic subtest: xbgr16161616f-untiled
[181.742047] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.349s)
[181.759636] Starting dynamic subtest: xrgb8888-xtiled
[181.943980] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.199s)
[181.959086] Starting dynamic subtest: rgb565-xtiled
[182.125508] Dynamic subtest rgb565-xtiled: SUCCESS (0.181s)
[182.140404] Starting dynamic subtest: xrgb2101010-xtiled
[182.295161] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.166s)
[182.313174] Starting dynamic subtest: xbgr16161616f-xtiled
[182.476291] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.181s)
[182.499313] Starting dynamic subtest: xrgb8888-ytiled
[182.680728] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.199s)
[182.698926] Starting dynamic subtest: rgb565-ytiled
[182.864214] Dynamic subtest rgb565-ytiled: SUCCESS (0.182s)
[182.879288] Starting dynamic subtest: xrgb2101010-ytiled
[183.041934] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.182s)
[183.058388] Starting dynamic subtest: xbgr16161616f-ytiled
[183.242452] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.199s)
[183.246212] Subtest draw-method-blt: SUCCESS (2.932s)
[183.483513] [014/130] (868s left) kms_fb_coherency (memset-crc)
[183.678853] Starting subtest: memset-crc
[183.681425] Starting dynamic subtest: mmap-gtt
[184.375603] Dynamic subtest mmap-gtt: SUCCESS (0.697s)
[184.603282] Starting dynamic subtest: mmap-offset-wc
[184.999373] Dynamic subtest mmap-offset-wc: SUCCESS (0.408s)
[185.238953] Starting dynamic subtest: mmap-offset-uc
[186.018750] Dynamic subtest mmap-offset-uc: SUCCESS (0.821s)
[186.247338] Starting dynamic subtest: mmap-legacy-wc
[186.653076] Dynamic subtest mmap-legacy-wc: SUCCESS (0.420s)
[186.858203] Subtest memset-crc: SUCCESS (3.175s)
[187.139812] [015/130] (865s left) syncobj_timeline (wait-all-for-submit-snapshot)
[187.263149] Starting subtest: wait-all-for-submit-snapshot
[187.350737] Subtest wait-all-for-submit-snapshot: SUCCESS (0.086s)
[187.492437] [016/130] (864s left) i915_pm_rc6_residency (rc6-idle)
[187.607945] Starting subtest: rc6-idle
[187.622288] Starting dynamic subtest: gt0-rcs0
[199.896359] Dynamic subtest gt0-rcs0: SUCCESS (12.275s)
[199.913681] Starting dynamic subtest: gt0-bcs0
[212.170562] Dynamic subtest gt0-bcs0: SUCCESS (12.273s)
[212.187788] Starting dynamic subtest: gt0-vcs0
[224.441834] Dynamic subtest gt0-vcs0: SUCCESS (12.269s)
[224.459273] Starting dynamic subtest: gt0-vecs0
[236.717717] Dynamic subtest gt0-vecs0: SUCCESS (12.272s)
[236.719771] Subtest rc6-idle: SUCCESS (49.109s)
[236.873499] [017/130] (815s left) kms_big_fb (linear-8bpp-rotate-90)
[237.086347] Starting subtest: linear-8bpp-rotate-90
[237.375171] Subtest linear-8bpp-rotate-90: SKIP (0.288s)
[237.612032] [018/130] (815s left) gem_readwrite (write-bad-handle)
[237.731074] Starting subtest: write-bad-handle
[237.734282] Subtest write-bad-handle: SUCCESS (0.000s)
[237.875284] [019/130] (814s left) kms_addfb_basic (unused-handle)
[237.990124] Starting subtest: unused-handle
[237.991634] Subtest unused-handle: SUCCESS (0.000s)
[238.212305] [020/130] (814s left) kms_psr (fbc-psr-primary-mmap-cpu)
[238.419674] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[238.513325] [021/130] (814s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[238.713582] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[238.717059] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[238.843161] [022/130] (814s left) gem_exec_schedule (submit-early-slice)
[239.001024] Starting subtest: submit-early-slice
[239.002888] Starting dynamic subtest: rcs0
[239.055328] Dynamic subtest rcs0: SUCCESS (0.049s)
[239.076084] Starting dynamic subtest: bcs0
[239.095432] Dynamic subtest bcs0: SUCCESS (0.044s)
[239.113058] Starting dynamic subtest: vcs0
[239.151267] Dynamic subtest vcs0: SUCCESS (0.055s)
[239.171591] Starting dynamic subtest: vecs0
[239.196875] Dynamic subtest vecs0: SUCCESS (0.046s)
[239.199403] Subtest submit-early-slice: SUCCESS (0.197s)
[239.598162] [023/130] (813s left) gem_ctx_persistence (heartbeat-hostile)
[239.719393] Starting subtest: heartbeat-hostile
[240.909500] Subtest heartbeat-hostile: SUCCESS (1.188s)
[241.047764] [024/130] (812s left) gem_exec_reloc (basic-concurrent0)
[241.175504] Starting subtest: basic-concurrent0
[246.641452] Subtest basic-concurrent0: SUCCESS (5.466s)
[246.878382] [025/130] (806s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[247.086883] Starting subtest: y-tiled-16bpp-rotate-270
[247.376208] Subtest y-tiled-16bpp-rotate-270: SKIP (0.287s)
[247.612902] [026/130] (805s left) kms_cursor_crc (cursor-sliding-512x512)
[247.837791] Starting subtest: cursor-sliding-512x512
[247.844223] Subtest cursor-sliding-512x512: SKIP (0.004s)
[247.994461] [027/130] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[248.211760] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[248.215271] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.398399] [028/130] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[248.615144] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[248.618261] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[248.762108] [029/130] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[248.978283] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[251.492035] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.511s)
[251.706450] [030/130] (802s left) gem_gtt_cpu_tlb
[251.987654] [031/130] (801s left) i915_suspend (basic-s2idle-without-i915)
[252.101925] Starting subtest: basic-s2idle-without-i915
[271.858022] Subtest basic-s2idle-without-i915: SUCCESS (4.753s)
[279.037675] [032/130] (796s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[279.257381] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[279.371725] [033/130] (796s left) kms_hdr (invalid-hdr)
[279.587148] Starting subtest: invalid-hdr
[306.681594] Subtest invalid-hdr: SKIP (26.753s)
[307.136557] [034/130] (769s left) gen7_exec_parse (batch-without-end)
[307.295389] Subtest batch-without-end: SKIP (0.000s)
[307.409694] [035/130] (769s left) syncobj_wait (wait-all-snapshot)
[307.532058] Starting subtest: wait-all-snapshot
[307.619596] Subtest wait-all-snapshot: SUCCESS (0.085s)
[307.772682] [036/130] (768s left) gem_exec_suspend (basic-s3)
[307.914555] Starting subtest: basic-S3
[307.916131] Starting dynamic subtest: smem