[89.838549] Initializing watchdogs
[89.838739]   /dev/watchdog0
[89.873797] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.887878] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.895612] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.903778] [001/129] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[90.412605] Starting subtest: yf-tiled-32bpp-rotate-0
[95.494726] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.080s)
[96.094862] [002/129] (954s left) gem_wait (invalid-buf)
[96.279145] Starting subtest: invalid-buf
[96.280712] Subtest invalid-buf: SUCCESS (0.000s)
[96.593331] [003/129] (954s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[96.802470] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[96.892000] [004/129] (953s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[97.092086] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[139.536497] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (42.430s)
[139.813919] [005/129] (910s left) api_intel_allocator (reopen)
[139.930140] Starting subtest: reopen
[139.938421] Subtest reopen: SUCCESS (0.007s)
[140.062666] [006/129] (910s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[140.275107] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[142.693875] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (2.417s)
[142.953788] [007/129] (908s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[143.070376] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[143.072330] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[143.202246] [008/129] (907s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[143.413654] Starting subtest: cursor-vs-flip-atomic
[182.261779] Subtest cursor-vs-flip-atomic: SUCCESS (38.845s)
[182.527320] [009/129] (868s left) gem_unref_active_buffers
[182.892491] [010/129] (868s left) drm_read (empty-block)
[183.332237] Starting subtest: empty-block
[184.338648] Subtest empty-block: SUCCESS (1.002s)
[184.592095] [011/129] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[184.805774] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[184.809478] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[184.941207] [012/129] (866s left) gem_exec_schedule (semaphore-user)
[185.102337] Starting subtest: semaphore-user
[185.118664] Subtest semaphore-user: SUCCESS (0.016s)
[185.515680] [013/129] (865s left) api_intel_bb (purge-bb)
[185.629219] Starting subtest: purge-bb
[185.635094] Subtest purge-bb: SUCCESS (0.006s)
[185.803336] [014/129] (865s left) i915_hangman (engine-engine-hang)
[185.943484] Starting subtest: engine-engine-hang
[185.945394] Starting dynamic subtest: rcs0
[186.532672] Dynamic subtest rcs0: SUCCESS (0.587s)
[186.548231] Starting dynamic subtest: bcs0
[187.105957] Dynamic subtest bcs0: SUCCESS (0.572s)
[187.122381] Starting dynamic subtest: vcs0
[187.693680] Dynamic subtest vcs0: SUCCESS (0.587s)
[187.709333] Starting dynamic subtest: vecs0
[188.263382] Dynamic subtest vecs0: SUCCESS (0.567s)
[188.264989] Subtest engine-engine-hang: SUCCESS (2.318s)
[188.414555] [015/129] (863s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[188.624200] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[188.628234] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[188.757686] [016/129] (862s left) gem_ctx_persistence (engines-mixed-process)
[188.889873] Starting subtest: engines-mixed-process
[188.891614] Starting dynamic subtest: rcs0
[189.304151] Dynamic subtest rcs0: SUCCESS (0.413s)
[189.341685] Starting dynamic subtest: bcs0
[189.676593] Dynamic subtest bcs0: SUCCESS (0.375s)
[189.706985] Starting dynamic subtest: vcs0
[190.060918] Dynamic subtest vcs0: SUCCESS (0.383s)
[190.078041] Starting dynamic subtest: vecs0
[190.444794] Dynamic subtest vecs0: SUCCESS (0.380s)
[190.446639] Subtest engines-mixed-process: SUCCESS (1.560s)
[190.576437] [017/129] (861s left) kms_cursor_legacy (single-move)
[190.777928] Starting subtest: single-move
[190.780063] Starting dynamic subtest: pipe-A
[196.188209] Dynamic subtest pipe-A: SUCCESS (5.407s)
[196.203871] Starting dynamic subtest: pipe-B
[201.593442] Dynamic subtest pipe-B: SUCCESS (5.404s)
[201.610192] Starting dynamic subtest: pipe-C
[206.998864] Dynamic subtest pipe-C: SUCCESS (5.403s)
[207.014869] Starting dynamic subtest: all-pipes
[212.405218] Dynamic subtest all-pipes: SUCCESS (5.407s)
[212.407589] Subtest single-move: SUCCESS (21.626s)
[212.553143] [018/129] (839s left) gem_pxp (verify-pxp-stale-ctx-execution)
[215.213077] Starting subtest: verify-pxp-stale-ctx-execution
[215.216478] Subtest verify-pxp-stale-ctx-execution: SKIP (0.001s)
[215.353575] [019/129] (836s left) gem_watchdog (default-virtual)
[215.480472] Starting subtest: default-virtual
[216.510327] Subtest default-virtual: SUCCESS (1.026s)
[216.619847] [020/129] (835s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[216.830420] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[216.912935] [021/129] (835s left) perf (disabled-read-error)
[217.117190] Starting subtest: disabled-read-error
[217.209100] Subtest disabled-read-error: SUCCESS (0.089s)
[217.306333] [022/129] (834s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[217.516367] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[217.519762] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[217.644942] [023/129] (834s left) kms_cdclk (plane-scaling)
[217.766018] Subtest plane-scaling: SKIP (0.000s)
[217.866302] [024/129] (834s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[220.509193] Starting subtest: protected-encrypted-src-copy-not-readible
[220.512376] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[220.630123] [025/129] (831s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[220.820735] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[220.822180] Starting dynamic subtest: pipe-A-valid-mode
[221.193364] Dynamic subtest pipe-A-valid-mode: SKIP (0.369s)
[221.236741] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.372s)
[221.447833] [026/129] (831s left) kms_plane_lowres (tiling-yf)
[221.644050] Starting subtest: tiling-yf
[221.650636] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.313898] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.644s)
[229.570036] Starting dynamic subtest: pipe-A-HDMI-A-2
[236.869024] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.328s)
[237.085924] Starting dynamic subtest: pipe-B-HDMI-A-1
[244.132880] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.061s)
[244.401476] Starting dynamic subtest: pipe-B-HDMI-A-2
[251.436898] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (7.068s)
[251.642228] Starting dynamic subtest: pipe-C-HDMI-A-1
[258.708899] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.089s)
[258.934838] Starting dynamic subtest: pipe-C-HDMI-A-2
[265.951348] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.038s)
[266.183146] Subtest tiling-yf: SUCCESS (44.532s)
[266.644468] [027/129] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[266.882252] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[266.885975] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[267.027154] [028/129] (785s left) kms_3d
[272.752081] [029/129] (780s left) kms_content_protection (atomic-dpms)
[272.993897] Starting subtest: atomic-dpms
[274.733701] Subtest atomic-dpms: SKIP (1.724s)
[275.190127] [030/129] (777s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[275.316837] Starting subtest: etime-single-wait-all-for-submit-submitted
[275.425098] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[275.561434] [031/129] (777s left) kms_pm_rpm (cursor-dpms)
[277.498269] Starting subtest: cursor-dpms
[279.477468] Subtest cursor-dpms: SUCCESS (1.979s)
[279.818106] [032/129] (773s left) kms_sequence (get-busy)
[280.024292] Starting subtest: get-busy
[280.026702] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.903985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.870s)
[282.920790] Starting dynamic subtest: pipe-A-HDMI-A-2
[285.541263] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.636s)
[285.564956] Starting dynamic subtest: pipe-B-HDMI-A-1
[288.132915] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.578s)
[288.150085] Starting dynamic subtest: pipe-B-HDMI-A-2
[290.741149] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.606s)
[290.774701] Starting dynamic subtest: pipe-C-HDMI-A-1
[293.331522] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.585s)
[293.376982] Starting dynamic subtest: pipe-C-HDMI-A-2
[295.977186] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.629s)
[295.979174] Subtest get-busy: SUCCESS (15.951s)
[296.242219] [033/129] (756s left) kms_busy (extended-modeset-hang-newfb)
[296.473140] Starting subtest: extended-modeset-hang-newfb
[296.474633] Starting dynamic subtest: pipe-A
[305.034273] Dynamic subtest pipe-A: SUCCESS (8.544s)
[305.054279] Starting dynamic subtest: pipe-C
[313.010100] Dynamic subtest pipe-C: SUCCESS (7.974s)
[313.011801] Subtest extended-modeset-hang-newfb: SUCCESS (16.536s)
[313.358175] [034/129] (739s left) kms_lease (implicit-plane-lease)
[313.563129] Starting subtest: implicit-plane-lease
[313.568084] Subtest implicit-plane-lease: SUCCESS (0.005s)
[313.703715] [035/129] (739s left) kms_addfb_basic (master-rmfb)
[313.828373] Starting subtest: master-rmfb
[313.830175] Subtest master-rmfb: SUCCESS (0.001s)
[314.043911] [036/129] (739s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[314.256095] Starting subtest: primary-yf-tiled-reflect-x-90
[314.262711] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.004s)
[314.390909] [037/129] (739s left) gem_exec_fence (submit-chain)
[314.666189] Starting subtest: submit-chain
[314.688652] Subtest submit-chain: SUCCESS (0.022s)
[315.435968] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[315.443319] [038/129] (738s left) gem_mmap_gtt (cpuset-medium-copy)
[315.560334] Starting subtest: cpuset-medium-copy
[325.044894] Subtest cpuset-medium-copy: SUCCESS (9.483s)
[325.226856] [039/129] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[325.595668] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[328.990595] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.396s)
[329.205988] [040/129] (724s left) prime_self_import (basic-with_one_bo)
[329.318610] Starting subtest: basic-with_one_bo
[329.329915] Subtest basic-with_one_bo: SUCCESS (0.010s)
[329.489568] [041/129] (724s left) gem_exec_params (no-blt)
[329.619283] Starting subtest: no-blt
[329.627480] Subtest no-blt: SUCCESS (0.003s)
[329.788147] [042/129] (724s left) gem_exec_balancer (sequential)
[329.930569] Starting subtest: sequential
[333.536890] Subtest sequential: SUCCESS (3.605s)
[333.808180] [043/129] (720s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[334.013084] Starting subtest: cursor-vs-flip-atomic-transitions
[373.334802] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (39.319s)
[373.657716] [044/129] (680s left) kms_properties (plane-properties-atomic)
[373.874393] Starting subtest: plane-properties-atomic
[373.875869] Starting dynamic subtest: pipe-A-HDMI-A-1
[374.643915] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.757s)
[374.666839] Starting dynamic subtest: pipe-B-HDMI-A-2
[375.233961] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.595s)
[375.256761] Starting dynamic subtest: pipe-C-HDMI-A-1
[375.846114] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.601s)
[375.850326] Subtest plane-properties-atomic: SUCCESS (1.973s)
[376.125315] [045/129] (678s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[376.347464] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[376.447105] [046/129] (677s left) dmabuf_sync_file (import-basic)
[376.591299] Starting subtest: import-basic
[376.609846] Subtest import-basic: SUCCESS (0.024s)
[376.748153] [047/129] (677s left) gem_softpin (evict-single-offset)
[376.872277] Starting subtest: evict-single-offset
[413.683600] Subtest evict-single-offset: SUCCESS (36.809s)
[413.848454] [048/129] (640s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[414.159043] Starting subtest: plane-all-transition-nonblocking-fencing
[414.168178] Starting dynamic subtest: pipe-A-HDMI-A-1
[418.233892] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.066s)
[418.432880] Starting dynamic subtest: pipe-A-HDMI-A-2
[422.302779] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.887s)
[422.498702] Starting dynamic subtest: pipe-B-HDMI-A-1
[426.365873] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.875s)
[426.555822] Starting dynamic subtest: pipe-B-HDMI-A-2
[430.397940] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.871s)
[430.559273] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (16.396s)
[430.851875] [049/129] (623s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[431.077746] Starting subtest: cursor-rapid-movement-256x85
[431.121197] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.066044] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.945s)
[432.172084] Starting dynamic subtest: pipe-C-HDMI-A-1
[432.713030] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.586s)
[432.714728] Subtest cursor-rapid-movement-256x85: SUCCESS (1.632s)
[433.012894] [050/129] (621s left) kms_psr (fbc-psr-dpms)
[433.221229] Subtest fbc-psr-dpms: SKIP (0.000s)
[433.331847] [051/129] (621s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[433.538901] Starting subtest: plane-scaler-unity-scaling-with-rotation
[433.540389] Starting dynamic subtest: pipe-A
[437.277234] Dynamic subtest pipe-A: SKIP (3.734s)
[437.345322] Starting dynamic subtest: pipe-B
[441.048231] Dynamic subtest pipe-B: SKIP (3.767s)
[441.083929] Starting dynamic subtest: pipe-C
[444.787899] Dynamic subtest pipe-C: SKIP (3.736s)
[444.792230] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (11.245s)
[445.277156] [052/129] (609s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[445.893928] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[446.149214] [053/129] (608s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[446.359515] Starting subtest: cursorA-vs-flipA-atomic-transitions
[457.613783] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.251s)
[457.900120] [054/129] (597s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[458.134482] Starting subtest: fbc-rgb101010-draw-render
[461.137766] Subtest fbc-rgb101010-draw-render: SUCCESS (3.003s)
[461.402800] [055/129] (593s left) gem_gtt_cpu_tlb
[461.688268] [056/129] (593s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[461.917207] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[461.921844] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[462.065196] [057/129] (593s left) kms_big_fb (linear-16bpp-rotate-180)
[462.287065] Starting subtest: linear-16bpp-rotate-180
[467.088654] Subtest linear-16bpp-rotate-180: SUCCESS (4.801s)
[467.604787] [058/129] (587s left) kms_flip (2x-flip-vs-dpms)
[467.806403] Starting subtest: 2x-flip-vs-dpms
[467.810826] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[469.506793] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.694s)
[469.539458] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[470.876281] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.348s)
[470.904297] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[472.170784] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.292s)
[472.172295] Subtest 2x-flip-vs-dpms: SUCCESS (4.364s)
[472.493630] [059/129] (583s left) gem_readwrite (new-obj)
[472.616474] Starting subtest: new-obj
[472.621100] Subtest new-obj: SUCCESS (0.001s)
[472.778466] [060/129] (582s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[472.896159] Starting subtest: single-wait-all-for-submit-signaled
[472.897853] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[473.047718] [061/129] (582s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[473.272429] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[473.277588] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[473.463158] [062/129] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[473.693971] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[473.698546] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[473.842962] [063/129] (582s left) kms_flip (2x-flip-vs-suspend)
[474.045026] Starting subtest: 2x-flip-vs-suspend
[474.053848] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2