[96.076713] Initializing watchdogs
[96.076891]   /dev/watchdog0
[96.117193] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[96.132149] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[96.139632] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[96.147837] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[96.374553] Starting subtest: fbcpsr-modesetfrombusy
[96.383214] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[96.536352] [002/130] (960s left) api_intel_bb (intel-bb-blit-y)
[96.657217] Starting subtest: intel-bb-blit-y
[99.926567] Subtest intel-bb-blit-y: SUCCESS (3.270s)
[100.097276] [003/130] (956s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[100.289104] Starting subtest: cursorB-vs-flipA-atomic
[111.730450] Subtest cursorB-vs-flipA-atomic: SUCCESS (11.446s)
[112.035877] [004/130] (944s left) kms_flip (2x-blocking-absolute-wf_vblank)
[112.231216] Starting subtest: 2x-blocking-absolute-wf_vblank
[112.235859] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[123.002061] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.767s)
[123.022291] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[133.794395] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.789s)
[133.813640] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[144.568073] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.769s)
[144.573108] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (32.340s)
[145.229401] [005/130] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[145.455083] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[148.041882] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.593s)
[148.367462] [006/130] (908s left) kms_prop_blob (invalid-get-prop-any)
[148.481136] Starting subtest: invalid-get-prop-any
[148.484531] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[148.634745] [007/130] (908s left) gem_create (create-valid-nonaligned)
[148.741214] Starting subtest: create-valid-nonaligned
[148.745086] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[149.040578] [008/130] (908s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[149.260664] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[149.267654] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[149.417531] [009/130] (908s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[149.636673] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[149.643107] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[149.784329] [010/130] (907s left) gem_mmap_gtt (big-copy-odd)
[149.896222] Starting subtest: big-copy-odd
[159.473052] Subtest big-copy-odd: SUCCESS (9.577s)
[159.671235] [011/130] (897s left) gem_exec_endless (dispatch)
[159.973838] Starting subtest: dispatch
[159.977643] Starting dynamic subtest: rcs0
[159.992525] Dynamic subtest rcs0: SUCCESS (0.011s)
[160.030834] Starting dynamic subtest: bcs0
[160.040798] Dynamic subtest bcs0: SKIP (0.001s)
[160.060881] Starting dynamic subtest: vcs0
[160.069362] Dynamic subtest vcs0: SUCCESS (0.008s)
[160.090188] Starting dynamic subtest: vecs0
[160.098416] Dynamic subtest vecs0: SUCCESS (0.009s)
[160.102348] Subtest dispatch: SUCCESS (0.032s)
[160.187338] [012/130] (897s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[160.412687] Starting subtest: psr-1p-pri-indfb-multidraw
[160.423290] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[160.550941] [013/130] (897s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[160.757094] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[162.881688] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SUCCESS (2.129s)
[163.098807] [014/130] (894s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[163.292127] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[163.299316] Starting dynamic subtest: pipe-A-valid-mode
[163.930097] Dynamic subtest pipe-A-valid-mode: SKIP (0.637s)
[163.939066] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.640s)
[164.399286] [015/130] (893s left) kms_atomic (plane-cursor-legacy)
[164.597111] Starting subtest: plane-cursor-legacy
[164.600780] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.204082] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.604s)
[165.209526] Subtest plane-cursor-legacy: SUCCESS (0.607s)
[165.539708] [016/130] (892s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[165.746569] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[165.756369] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[166.459453] [017/130] (891s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[166.649067] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[166.653065] Starting dynamic subtest: pipe-A-HDMI-A-1
[166.877222] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[166.898406] Starting dynamic subtest: pipe-A-HDMI-A-2
[167.040477] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.012s)
[167.061969] Starting dynamic subtest: pipe-B-HDMI-A-1
[167.214568] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.012s)
[167.255494] Starting dynamic subtest: pipe-B-HDMI-A-2
[167.444956] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.012s)
[167.465056] Starting dynamic subtest: pipe-C-HDMI-A-1
[167.601640] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.012s)
[167.626087] Starting dynamic subtest: pipe-C-HDMI-A-2
[167.773649] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.012s)
[167.781412] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.089s)
[167.892414] [018/130] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[168.096091] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[170.597194] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.504s)
[170.878315] [019/130] (887s left) core_setmaster (master-drop-set-root)
[171.097590] Starting subtest: master-drop-set-root
[171.131964] Subtest master-drop-set-root: SUCCESS (0.031s)
[171.230259] [020/130] (887s left) gem_ccs (ctrl-surf-copy-new-ctx)
[171.349687] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[171.455163] [021/130] (887s left) kms_cdclk (mode-transition-all-outputs)
[171.577805] Subtest mode-transition-all-outputs: SKIP (0.000s)
[171.673248] [022/130] (886s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[171.867263] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[171.975798] [023/130] (886s left) gem_ccs (suspend-resume)
[172.108090] Subtest suspend-resume: SKIP (0.000s)
[172.220492] [024/130] (886s left) perf (buffer-fill)
[172.487353] Starting subtest: buffer-fill
[172.491781] Starting dynamic subtest: 0-rcs0
[175.590772] Dynamic subtest 0-rcs0: SUCCESS (3.108s)
[175.595086] Subtest buffer-fill: SUCCESS (3.110s)
[175.695515] [025/130] (883s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[175.888937] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[175.990705] [026/130] (883s left) gem_mmap_wc (pf-nonblock)
[176.111816] Starting subtest: pf-nonblock
[176.116337] Subtest pf-nonblock: SUCCESS (0.006s)
[176.246573] [027/130] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[176.455147] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[176.463059] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[176.598387] [028/130] (882s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[176.719057] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[176.724104] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.003s)
[176.861962] [029/130] (882s left) gem_eio (wait-immediate)
[177.000016] Starting subtest: wait-immediate
[177.105356] Subtest wait-immediate: SUCCESS (0.106s)
[177.348715] [030/130] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[177.554253] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[179.775978] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SUCCESS (2.227s)
[179.996484] [031/130] (879s left) kms_properties (get_properties-sanity-atomic)
[180.184413] Starting subtest: get_properties-sanity-atomic
[180.196678] Subtest get_properties-sanity-atomic: SUCCESS (0.008s)
[180.346939] [032/130] (879s left) gem_ctx_isolation (clean)
[180.485022] Starting subtest: clean
[180.489493] Starting dynamic subtest: rcs0
[180.565546] Dynamic subtest rcs0: SUCCESS (0.084s)
[180.588225] Starting dynamic subtest: bcs0
[180.708332] Dynamic subtest bcs0: SUCCESS (0.142s)
[180.733301] Starting dynamic subtest: vcs0
[180.795678] Dynamic subtest vcs0: SUCCESS (0.086s)
[180.818141] Starting dynamic subtest: vecs0
[180.891033] Dynamic subtest vecs0: SUCCESS (0.093s)
[180.895528] Subtest clean: SUCCESS (0.411s)
[181.145985] [033/130] (878s left) kms_chamelium_frames (dp-crc-fast)
[181.776218] Subtest dp-crc-fast: SKIP (0.000s)
[182.088063] [034/130] (877s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[182.284307] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[182.292516] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[183.080892] [035/130] (876s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[183.194278] Starting subtest: etime-single-wait-available-unsubmitted
[183.300476] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.107s)
[183.445491] [036/130] (876s left) syncobj_timeline (signal)
[183.558922] Starting subtest: signal
[183.562476] Subtest signal: SUCCESS (0.001s)
[183.698513] [037/130] (876s left) syncobj_eventfd (binary-wait)
[183.812321] Starting subtest: binary-wait
[183.822928] Subtest binary-wait: SUCCESS (0.011s)
[183.964514] [038/130] (876s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[184.155111] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[184.258665] [039/130] (876s left) kms_psr (psr-cursor-mmap-gtt)
[184.458060] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[184.572887] [040/130] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[184.795671] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[184.802388] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[184.951690] [041/130] (875s left) sw_sync (sync_merge)
[185.062385] Starting subtest: sync_merge
[185.066326] Subtest sync_merge: SUCCESS (0.001s)
[185.180999] [042/130] (875s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[185.366072] Starting subtest: plane-lut1d-post-ctm3x4
[187.071128] Subtest plane-lut1d-post-ctm3x4: SKIP (1.699s)
[187.430162] [043/130] (873s left) gem_exec_fence (basic-wait-all)
[187.568617] Starting subtest: basic-wait-all
[187.590954] Subtest basic-wait-all: SUCCESS (0.022s)
[188.511804] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[188.518911] [044/130] (872s left) gem_mmap_offset (blt-coherency)
[188.634208] Starting subtest: blt-coherency
[188.643081] Subtest blt-coherency: SUCCESS (0.018s)
[188.801650] [045/130] (872s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[188.911997] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[189.012749] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.102s)
[189.166501] [046/130] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[189.392079] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[189.406263] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.004s)
[189.556893] [047/130] (871s left) gem_exec_whisper (basic-queues-priority)
[189.695528] Starting subtest: basic-queues-priority
[195.914147] Subtest basic-queues-priority: SUCCESS (6.216s)
[196.188349] [048/130] (864s left) api_intel_allocator (two-level-inception)
[196.298676] Starting subtest: two-level-inception
[201.834097] Subtest two-level-inception: SUCCESS (5.539s)
[201.988453] [049/130] (859s left) i915_suspend (forcewake)
[202.105081] Starting subtest: forcewake