[89.541527] Initializing watchdogs
[89.541732]   /dev/watchdog0
[89.581952] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.596471] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.603910] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.610157] [001/132] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[89.831356] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[91.216860] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.385s)
[91.561168] [002/132] (958s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[91.734311] Starting subtest: plane-lut1d-ctm3x4
[93.274383] Subtest plane-lut1d-ctm3x4: SKIP (1.533s)
[93.568632] [003/132] (956s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[93.760245] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[93.763392] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[93.883970] [004/132] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[94.085265] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[94.088468] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[94.217915] [005/132] (956s left) kms_psr (psr-cursor-plane-move)
[94.405062] Subtest psr-cursor-plane-move: SKIP (0.000s)
[94.489815] [006/132] (956s left) gem_close_race (basic-threads)
[94.636096] Starting subtest: basic-threads
[95.833732] Subtest basic-threads: SUCCESS (1.202s)
[96.086699] [007/132] (954s left) kms_pm_rpm (pc8-residency)
[98.035642] Starting subtest: pc8-residency
[98.043059] Subtest pc8-residency: SKIP (0.000s)
[98.423339] [008/132] (952s left) kms_content_protection (content-type-change)
[98.630473] Starting subtest: content-type-change
[98.645877] Subtest content-type-change: SKIP (0.014s)
[98.774950] [009/132] (952s left) gem_vm_create (execbuf)
[98.886760] Starting subtest: execbuf
[98.900854] Subtest execbuf: SUCCESS (0.008s)
[99.060214] [010/132] (951s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[99.191047] Starting subtest: mixed-tiled-to-y-tiled-ccs
[99.193893] Starting dynamic subtest: smem
[99.424814] Dynamic subtest smem: SUCCESS (0.232s)
[99.427474] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.234s)
[99.678293] [011/132] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[99.871070] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[101.543730] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.669s)
[101.796507] [012/132] (949s left) kms_psr (psr-sprite-render)
[101.986527] Subtest psr-sprite-render: SKIP (0.000s)
[102.082147] [013/132] (949s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[102.261129] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[102.264405] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[102.420895] [014/132] (948s left) gem_spin_batch (resubmit-all)
[102.547308] Starting subtest: resubmit-all
[102.550145] Starting dynamic subtest: rcs0
[102.559269] Dynamic subtest rcs0: SUCCESS (0.014s)
[102.584394] Starting dynamic subtest: bcs0
[102.587205] Dynamic subtest bcs0: SUCCESS (0.008s)
[102.605037] Starting dynamic subtest: vcs0
[102.607383] Dynamic subtest vcs0: SUCCESS (0.006s)
[102.625400] Starting dynamic subtest: vecs0
[102.627740] Dynamic subtest vecs0: SUCCESS (0.005s)
[102.630239] Subtest resubmit-all: SUCCESS (0.038s)
[102.840519] [015/132] (948s left) syncobj_timeline (invalid-wait-illegal-handle)
[102.942251] Starting subtest: invalid-wait-illegal-handle
[102.944096] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[103.074922] [016/132] (948s left) kms_chamelium_color (ctm-0-25)
[103.249160] Subtest ctm-0-25: SKIP (0.000s)
[103.347288] [017/132] (948s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[103.467194] Starting subtest: untiled-to-tiled
[103.600679] Subtest untiled-to-tiled: SUCCESS (0.133s)
[103.740408] [018/132] (947s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[103.970986] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[106.431295] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.465s)
[106.691831] [019/132] (944s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[106.880602] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[106.978885] [020/132] (944s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[107.090449] Starting subtest: multi-wait-available-unsubmitted-signaled
[107.092196] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.003s)
[107.224918] [021/132] (944s left) syncobj_wait (multi-wait-submitted-signaled)
[107.330167] Starting subtest: multi-wait-submitted-signaled
[107.336212] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[107.474051] [022/132] (944s left) gem_exec_nop (basic-series)
[107.602685] Starting subtest: basic-series
[110.655735] Subtest basic-series: SUCCESS (3.055s)
[110.910197] [023/132] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[111.104549] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[113.663073] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.554s)
[113.860124] [024/132] (938s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[114.053276] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[114.150053] [025/132] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[114.353899] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[114.357440] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[114.493090] [026/132] (937s left) gem_exec_whisper (basic-fds-forked)
[114.624729] Starting subtest: basic-fds-forked
[123.726602] Subtest basic-fds-forked: SUCCESS (9.100s)
[123.979174] [027/132] (928s left) kms_psr (pr-sprite-render)
[124.166558] Subtest pr-sprite-render: SKIP (0.000s)
[124.272559] [028/132] (928s left) gem_partial_pwrite_pread (write-display)
[124.385734] Starting subtest: write-display
[138.705726] Subtest write-display: SUCCESS (14.320s)
[138.863281] [029/132] (913s left) kms_atomic_transition (plane-toggle-modeset-transition)
[139.045826] Starting subtest: plane-toggle-modeset-transition
[139.054103] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.452259] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.400s)
[142.481442] Starting dynamic subtest: pipe-A-HDMI-A-2
[145.548444] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.090s)
[145.576036] Starting dynamic subtest: pipe-B-HDMI-A-1
[148.383344] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.825s)
[148.405977] Starting dynamic subtest: pipe-B-HDMI-A-2
[151.244640] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.858s)
[151.248789] Subtest plane-toggle-modeset-transition: SUCCESS (12.200s)
[151.546582] [030/132] (901s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[151.652906] Starting subtest: multi-wait-for-submit-unsubmitted
[151.762906] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[151.899576] [031/132] (900s left) kms_addfb_basic (invalid-set-prop-any)
[152.000192] Starting subtest: invalid-set-prop-any
[152.002240] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[152.228820] [032/132] (900s left) gem_exec_schedule (deep)
[152.494469] Starting subtest: deep
[152.496257] Starting dynamic subtest: rcs0
[165.920096] Dynamic subtest rcs0: SUCCESS (13.421s)
[165.980870] Starting dynamic subtest: bcs0
[180.320077] Dynamic subtest bcs0: SUCCESS (14.390s)
[180.375492] Starting dynamic subtest: vcs0
[194.235488] Dynamic subtest vcs0: SUCCESS (13.904s)
[194.288101] Starting dynamic subtest: vecs0
[207.860425] Dynamic subtest vecs0: SUCCESS (13.612s)
[207.869168] Subtest deep: SUCCESS (55.362s)
[208.902892] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[208.907652] [033/132] (843s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[209.108197] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[209.113046] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[209.253927] [034/132] (843s left) i915_drm_fdinfo (idle)
[209.359618] Starting subtest: idle
[209.361282] Starting dynamic subtest: rcs0
[209.878490] Dynamic subtest rcs0: SUCCESS (0.514s)
[209.901553] Starting dynamic subtest: bcs0
[210.386035] Dynamic subtest bcs0: SUCCESS (0.507s)
[210.408637] Starting dynamic subtest: vcs0
[210.896810] Dynamic subtest vcs0: SUCCESS (0.507s)
[210.917825] Starting dynamic subtest: vecs0
[211.404833] Dynamic subtest vecs0: SUCCESS (0.506s)
[211.407685] Subtest idle: SUCCESS (2.040s)
[211.584286] [035/132] (841s left) core_hotunplug (unbind-rebind)
[211.778160] Starting subtest: unbind-rebind
[215.836312] Subtest unbind-rebind: SUCCESS (4.058s)
[215.938722] [036/132] (837s left) i915_selftest (perf)
[217.548746] Starting subtest: perf
[217.550492] Starting dynamic subtest: engine_cs
[220.221665] Dynamic subtest engine_cs: SUCCESS (2.671s)
[220.243449] Starting dynamic subtest: request
[225.779532] Dynamic subtest request: SUCCESS (5.555s)
[225.801126] Starting dynamic subtest: migrate
[228.675704] Dynamic subtest migrate: SUCCESS (2.894s)
[228.698272] Starting dynamic subtest: region
[232.251076] Dynamic subtest region: SUCCESS (3.574s)
[232.253061] Subtest perf: SUCCESS (14.705s)
[232.332254] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[232.335540] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[232.340101] [037/132] (820s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[235.261534] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[235.267631] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[235.456199] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[235.459065] [FACT kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[235.467149] [038/132] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[235.681116] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[235.684792] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[235.869669] [039/132] (817s left) prime_udl
[236.091370] [040/132] (817s left) gem_userptr_blits (readonly-pwrite-unsync)
[236.215196] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[236.404380] [041/132] (817s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[236.508212] Starting subtest: single-wait-for-submit-available-signaled
[236.510168] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[236.684215] [042/132] (817s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[236.876206] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[236.879985] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[237.018979] [043/132] (816s left) kms_sequence (get-idle)
[237.218100] Starting subtest: get-idle
[237.220997] Starting dynamic subtest: pipe-A-HDMI-A-1
[239.991926] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.773s)
[240.015189] Starting dynamic subtest: pipe-A-HDMI-A-2
[242.478856] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.484s)
[242.509354] Starting dynamic subtest: pipe-B-HDMI-A-1
[244.894062] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.406s)
[244.916526] Starting dynamic subtest: pipe-B-HDMI-A-2
[247.324946] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.430s)
[247.351064] Starting dynamic subtest: pipe-C-HDMI-A-1
[249.792050] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.462s)
[249.817496] Starting dynamic subtest: pipe-C-HDMI-A-2
[252.241437] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.445s)
[252.245141] Subtest get-idle: SUCCESS (15.030s)
[252.537152] [044/132] (801s left) kms_cursor_crc (cursor-random-64x21)
[252.761557] Starting subtest: cursor-random-64x21
[252.832208] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.998073] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.161s)
[257.119311] Starting dynamic subtest: pipe-C-HDMI-A-1
[260.923795] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.847s)
[260.926479] Subtest cursor-random-64x21: SUCCESS (8.161s)
[261.318424] [045/132] (792s left) perf (invalid-oa-format-id)
[261.540880] Starting subtest: invalid-oa-format-id
[261.566833] Subtest invalid-oa-format-id: SUCCESS (0.025s)
[261.680763] [046/132] (792s left) kms_frontbuffer_tracking (fbc-suspend)
[261.881073] Starting subtest: fbc-suspend