[86.467967] Initializing watchdogs
[86.468246]   /dev/watchdog0
[86.510863] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[86.525605] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.531706] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.539811] [001/134] (960s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[86.668923] Starting subtest: multi-wait-all-for-submit-signaled
[86.674388] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[86.833062] [002/134] (960s left) kms_psr (psr-sprite-plane-onoff)
[87.028086] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[87.128872] [003/134] (960s left) kms_psr (psr2-cursor-blt)
[87.323862] Subtest psr2-cursor-blt: SKIP (0.000s)
[87.429870] [004/134] (959s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[87.637456] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[87.643924] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[87.815053] [005/134] (959s left) drm_read (short-buffer-wakeup)
[88.308850] Starting subtest: short-buffer-wakeup
[120.523825] Subtest short-buffer-wakeup: SUCCESS (32.214s)
[120.797316] [006/134] (926s left) prime_mmap (test_userptr)
[120.903467] Starting subtest: test_userptr
[120.907153] Starting dynamic subtest: test_userptr-smem
[120.910404] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[120.913922] Subtest test_userptr: SUCCESS (0.002s)
[121.081258] [007/134] (926s left) kms_pm_rpm (basic-pci-d3-state)
[122.996486] Starting subtest: basic-pci-d3-state
[123.466772] Subtest basic-pci-d3-state: SUCCESS (0.474s)
[123.784272] [008/134] (923s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[123.971988] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[124.015738] Starting dynamic subtest: pipe-A-valid-mode
[124.912424] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.933s)
[124.916954] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SUCCESS (0.936s)
[125.209402] [009/134] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[125.420673] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[125.427514] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[125.589527] [010/134] (922s left) perf (disabled-read-error)
[125.832626] Starting subtest: disabled-read-error
[125.869268] Subtest disabled-read-error: SUCCESS (0.039s)
[125.956190] [011/134] (921s left) i915_drm_fdinfo (memory-info-resident)
[126.070344] Starting subtest: memory-info-resident
[126.073774] Starting dynamic subtest: smem0
[127.062855] Dynamic subtest smem0: SUCCESS (0.994s)
[127.066558] Subtest memory-info-resident: SUCCESS (0.995s)
[127.221241] [012/134] (920s left) kms_psr (fbc-pr-primary-render)
[127.396769] Subtest fbc-pr-primary-render: SKIP (0.000s)
[127.518922] [013/134] (920s left) gem_request_retire (retire-vma-not-inactive)
[127.643098] Starting subtest: retire-vma-not-inactive
[127.672991] Subtest retire-vma-not-inactive: SUCCESS (0.029s)
[127.842237] [014/134] (920s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[128.020031] Starting subtest: plane-all-modeset-transition-fencing
[128.023142] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.342785] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (44.320s)
[172.537374] Starting dynamic subtest: pipe-A-HDMI-A-2
[216.535752] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (44.015s)
[216.728330] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.367097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (40.655s)
[257.543183] Starting dynamic subtest: pipe-B-HDMI-A-2
[298.185342] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (40.656s)
[298.342541] Subtest plane-all-modeset-transition-fencing: SUCCESS (170.322s)
[298.627048] [015/134] (749s left) gem_gtt_cpu_tlb
[298.906593] [016/134] (749s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[299.101753] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[299.109581] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[299.273082] [017/134] (749s left) kms_prop_blob (basic)
[299.379901] Starting subtest: basic
[299.383204] Subtest basic: SUCCESS (0.000s)
[299.540707] [018/134] (749s left) gem_exec_fence (syncobj-unused-fence)
[300.165731] Starting subtest: syncobj-unused-fence
[300.169379] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[300.586376] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[300.593577] [019/134] (748s left) gem_exec_schedule (preempt-other)
[300.730074] Starting subtest: preempt-other
[300.733399] Starting dynamic subtest: rcs0
[300.792766] Dynamic subtest rcs0: SUCCESS (0.062s)
[300.819809] Starting dynamic subtest: bcs0
[300.855495] Dynamic subtest bcs0: SUCCESS (0.061s)
[300.879484] Starting dynamic subtest: vcs0
[300.917170] Dynamic subtest vcs0: SUCCESS (0.061s)
[300.941093] Starting dynamic subtest: vecs0
[300.980094] Dynamic subtest vecs0: SUCCESS (0.059s)
[300.984014] Subtest preempt-other: SUCCESS (0.245s)
[301.399964] [020/134] (747s left) kms_psr (fbc-pr-sprite-render)
[301.584047] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[301.697604] [021/134] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[301.902705] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[301.911753] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[302.085966] [022/134] (746s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[302.206985] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[302.214958] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[302.487158] [023/134] (746s left) perf (non-zero-reason)
[302.713727] Starting subtest: non-zero-reason
[302.717338] Starting dynamic subtest: 0-rcs0
[352.917485] Dynamic subtest 0-rcs0: SUCCESS (50.201s)
[352.921355] Subtest non-zero-reason: SUCCESS (50.202s)
[353.022932] [024/134] (696s left) syncobj_wait (single-wait-submitted)
[353.130281] Starting subtest: single-wait-submitted
[353.236232] Subtest single-wait-submitted: SUCCESS (0.106s)
[353.417134] [025/134] (695s left) kms_chamelium_frames (hdmi-aspect-ratio)
[353.976288] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[354.243473] [026/134] (695s left) gem_pxp (display-protected-crc)
[356.891281] Starting subtest: display-protected-crc
[356.899188] Subtest display-protected-crc: SKIP (0.000s)
[357.068828] [027/134] (692s left) gen3_mixed_blits
[357.283186] [028/134] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[357.483424] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[360.674815] Subtest fbc-2p-primscrn-spr-indfb-move: SUCCESS (3.195s)
[360.934941] [029/134] (688s left) kms_vrr (flipline)
[361.118582] Starting subtest: flipline
[361.133627] Subtest flipline: SKIP (0.001s)
[361.303802] [030/134] (688s left) kms_rotation_crc (primary-rotation-90)
[361.483571] Starting subtest: primary-rotation-90
[375.940031] Subtest primary-rotation-90: SUCCESS (14.456s)
[376.215977] [031/134] (673s left) gem_ctx_persistence (heartbeat-hostile)
[376.335231] Starting subtest: heartbeat-hostile
[377.465644] Subtest heartbeat-hostile: SUCCESS (1.129s)
[377.654581] [032/134] (672s left) kms_plane_alpha_blend (alpha-basic)
[377.831203] Starting subtest: alpha-basic
[378.038563] Starting dynamic subtest: pipe-A-HDMI-A-1
[379.669611] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.557s)
[379.688340] Starting dynamic subtest: pipe-C-HDMI-A-1
[380.667729] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.418s)
[380.670701] Subtest alpha-basic: FAIL (2.241s)
[380.812068] [033/134] (669s left) gem_exec_reloc (basic-cpu-gtt-active)
[380.937768] Starting subtest: basic-cpu-gtt-active
[381.106947] Subtest basic-cpu-gtt-active: SUCCESS (0.131s)
[381.762883] [034/134] (668s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[382.365172] Starting subtest: yf-tiled-addfb-size-offset-overflow
[382.516174] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[382.609969] [035/134] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[382.807923] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[382.816346] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[382.994310] [036/134] (667s left) gem_exec_schedule (semaphore-user)
[383.135903] Starting subtest: semaphore-user
[383.150748] Subtest semaphore-user: SUCCESS (0.018s)
[383.559457] [037/134] (667s left) gem_lmem_swapping (verify)
[383.673265] Subtest verify: SKIP (0.000s)
[383.785390] [038/134] (667s left) perf_pmu (frequency)
[383.899889] Starting subtest: frequency
[383.903402] Starting dynamic subtest: gt0
[385.999104] Dynamic subtest gt0: SUCCESS (2.086s)
[386.020353] Starting dynamic subtest: idle-gt0
[386.510896] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[386.515560] Subtest frequency: SUCCESS (2.602s)
[386.692339] [039/134] (664s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[386.883130] Starting subtest: extended-pageflip-modeset-hang-oldfb
[386.886624] Starting dynamic subtest: pipe-A
[390.828226] Dynamic subtest pipe-A: SUCCESS (3.946s)
[390.856962] Starting dynamic subtest: pipe-C
[394.851498] Dynamic subtest pipe-C: SUCCESS (4.011s)
[394.854918] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (7.971s)
[395.215682] [040/134] (656s left) gem_busy (parallel)
[395.480870] Starting subtest: parallel
[395.485019] Starting dynamic subtest: rcs0
[395.515031] Dynamic subtest rcs0: SUCCESS (0.033s)
[395.540532] Starting dynamic subtest: bcs0
[395.545059] Dynamic subtest bcs0: SUCCESS (0.029s)
[395.572200] Starting dynamic subtest: vcs0
[395.582777] Dynamic subtest vcs0: SUCCESS (0.033s)
[395.605900] Starting dynamic subtest: vecs0
[395.617103] Dynamic subtest vecs0: SUCCESS (0.036s)
[395.621398] Subtest parallel: SUCCESS (0.138s)
[395.930248] [041/134] (655s left) i915_query (query-regions-unallocated)
[396.036065] Starting subtest: query-regions-unallocated
[396.039246] Subtest query-regions-unallocated: SUCCESS (0.000s)
[396.195963] [042/134] (655s left) i915_pm_freq_api (freq-basic-api)
[396.316697] Subtest freq-basic-api: SKIP (0.000s)
[396.431236] [043/134] (655s left) kms_psr (fbc-psr-primary-mmap-gtt)
[396.604982] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[396.724627] [044/134] (654s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[397.298663] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[397.573865] [045/134] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[397.779605] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[397.786719] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[397.965096] [046/134] (653s left) gem_exec_whisper (basic-sync-all)
[398.091125] Starting subtest: basic-sync-all
[405.337439] Subtest basic-sync-all: SUCCESS (7.242s)
[405.616556] [047/134] (646s left) gem_exec_async (forked-writes)
[405.742978] Starting subtest: forked-writes
[405.747501] Starting dynamic subtest: rcs0
[405.801525] Dynamic subtest rcs0: SUCCESS (0.062s)
[405.825427] Starting dynamic subtest: bcs0
[405.866633] Dynamic subtest bcs0: SUCCESS (0.062s)
[405.892945] Starting dynamic subtest: vcs0
[405.935942] Dynamic subtest vcs0: SUCCESS (0.063s)
[405.959130] Starting dynamic subtest: vecs0
[406.002966] Dynamic subtest vecs0: SUCCESS (0.065s)
[406.006961] Subtest forked-writes: SUCCESS (0.264s)
[406.298497] [048/134] (645s left) gem_ctx_shared (single-timeline)
[406.424541] Starting subtest: single-timeline
[406.443312] Subtest single-timeline: SUCCESS (0.013s)
[406.748498] [049/134] (645s left) vgem_basic (mmap)
[406.861617] Starting subtest: mmap
[406.880595] Subtest mmap: SUCCESS (0.022s)
[407.034583] [050/134] (645s left) gem_mmap_gtt (fault-concurrent)
[407.139832] Starting subtest: fault-concurrent
[410.522417] Subtest fault-concurrent: SUCCESS (3.387s)
[410.699557] [051/134] (641s left) kms_vblank (query-forked-busy-hang)
[410.878224] Starting subtest: query-forked-busy-hang
[410.881494] Starting dynamic subtest: pipe-A-HDMI-A-1
[417.858139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.974s)
[417.899231] Starting dynamic subtest: pipe-A-HDMI-A-2
[424.832583] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.970s)
[424.861092] Starting dynamic subtest: pipe-C-HDMI-A-1
[431.853376] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.012s)
[431.902034] Starting dynamic subtest: pipe-C-HDMI-A-2
[438.826314] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.964s)
[438.830778] Subtest query-forked-busy-hang: SUCCESS (27.949s)
[439.141516] [052/134] (613s left) kms_invalid_mode (uint-max-clock)
[439.353420] Starting subtest: uint-max-clock
[439.357034] Starting dynamic subtest: pipe-A-HDMI-A-1
[439.726935] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.396s)
[439.770550] Starting dynamic subtest: pipe-A-HDMI-A-2
[439.815104] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[439.839023] Starting dynamic subtest: pipe-B-HDMI-A-1
[439.875617] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[439.907708] Starting dynamic subtest: pipe-B-HDMI-A-2
[439.911798] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[439.935726] Starting dynamic subtest: pipe-C-HDMI-A-1
[439.939175] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[439.959953] Starting dynamic subtest: pipe-C-HDMI-A-2
[439.963288] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[439.966489] Subtest uint-max-clock: SUCCESS (0.446s)
[440.105292] [053/134] (612s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[440.316356] Starting subtest: psr-rgb565-draw-blt
[440.322582] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[440.500155] [054/134] (612s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[440.705612] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[440.720177] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s)
[440.883819] [055/134] (611s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[441.069861] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[442.463065] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.317s)
[443.014406] [056/134] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[443.219664] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[443.229192] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[443.409681] [057/134] (609s left) kms_psr (psr2-suspend)
[443.596588] Subtest psr2-suspend: SKIP (0.000s)
[443.707827] [058/134] (609s left) kms_plane_scaling (planes-downscale-factor-0-5)
[443.893855] Starting subtest: planes-downscale-factor-0-5
[443.898780] Starting dynamic subtest: pipe-A
[444.211954] Dynamic subtest pipe-A: SUCCESS (0.322s)
[444.233582] Starting dynamic subtest: pipe-B
[444.587721] Dynamic subtest pipe-B: SUCCESS (0.374s)
[444.610496] Starting dynamic subtest: pipe-C
[444.666775] Dynamic subtest pipe-C: SUCCESS (0.075s)
[444.671680] Subtest planes-downscale-factor-0-5: SUCCESS (0.778s)
[445.137423] [059/134] (608s left) kms_flip (2x-flip-vs-suspend)
[445.334330] Starting subtest: 2x-flip-vs-suspend
[445.337955] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2