[164.515145] Initializing watchdogs
[164.515330]   /dev/watchdog0
[164.555764] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[164.570804] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[164.577822] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[164.585746] [001/133] (960s left) kms_chamelium_color (ctm-blue-to-red)
[164.808668] Subtest ctm-blue-to-red: SKIP (0.000s)
[164.919101] [002/133] (960s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[165.134084] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[165.261426] [003/133] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[165.473532] Starting subtest: yf-tiled-32bpp-rotate-0
[170.874032] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.403s)
[171.298693] [004/133] (954s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[171.413090] Starting subtest: framebuffer-vs-set-tiling
[171.417070] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[171.660693] [005/133] (953s left) gem_mmap_gtt (basic-read-write)
[171.778872] Starting subtest: basic-read-write
[171.788241] Subtest basic-read-write: SUCCESS (0.013s)
[171.928939] [006/133] (953s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[172.116075] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[172.119194] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.154915] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[172.188065] Starting dynamic subtest: pipe-A-HDMI-A-2
[172.231221] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[172.265572] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.306211] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[172.325883] Starting dynamic subtest: pipe-B-HDMI-A-2
[172.359705] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[172.379134] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.410350] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[172.428901] Starting dynamic subtest: pipe-C-HDMI-A-2
[172.459578] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[172.465969] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.018s)
[173.177804] [007/133] (952s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[173.397253] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[173.646430] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.247s)
[173.914381] [008/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[174.149640] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[174.156470] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[174.302635] [009/133] (951s left) gem_exec_schedule (preempt-user)
[174.457013] Starting subtest: preempt-user
[174.460997] Starting dynamic subtest: rcs0
[174.520188] Dynamic subtest rcs0: SUCCESS (0.059s)
[174.545023] Starting dynamic subtest: bcs0
[174.601905] Dynamic subtest bcs0: SUCCESS (0.080s)
[174.630944] Starting dynamic subtest: vcs0
[174.658777] Dynamic subtest vcs0: SUCCESS (0.055s)
[174.681668] Starting dynamic subtest: vecs0
[174.711828] Dynamic subtest vecs0: SUCCESS (0.053s)
[174.717219] Subtest preempt-user: SUCCESS (0.250s)
[175.561971] [010/133] (950s left) kms_sequence (queue-busy)
[175.956113] Starting subtest: queue-busy
[176.023396] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.723572] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.880s)
[178.745404] Starting dynamic subtest: pipe-A-HDMI-A-2
[181.353832] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.627s)
[181.387990] Starting dynamic subtest: pipe-B-HDMI-A-1
[183.959204] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.602s)
[183.992366] Starting dynamic subtest: pipe-B-HDMI-A-2
[186.592127] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.624s)
[186.612527] Starting dynamic subtest: pipe-C-HDMI-A-1
[189.265192] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.670s)
[189.292151] Starting dynamic subtest: pipe-C-HDMI-A-2
[191.956957] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.693s)
[191.964528] Subtest queue-busy: SUCCESS (16.117s)
[192.299625] [011/133] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[192.527214] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[192.533971] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[192.668682] [012/133] (933s left) kms_hdmi_inject (inject-4k)
[193.196286] Starting subtest: inject-4k
[193.443503] Subtest inject-4k: SUCCESS (0.246s)
[193.859610] [013/133] (932s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[194.074346] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[197.198764] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.124s)
[197.485265] [014/133] (929s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[197.676917] Starting subtest: cursorB-vs-flipB-varying-size
[209.078653] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.285s)
[209.699969] [015/133] (917s left) gem_partial_pwrite_pread (reads)
[210.172789] Starting subtest: reads
[216.707324] Subtest reads: SUCCESS (6.679s)
[216.865237] [016/133] (910s left) core_getclient (basic)
[216.976027] Starting subtest: basic
[216.980275] Subtest basic: SUCCESS (0.000s)
[217.114679] [017/133] (910s left) dmabuf_sync_file (import-multiple-read-only)
[217.340098] Starting subtest: import-multiple-read-only
[217.351088] Subtest import-multiple-read-only: SUCCESS (0.017s)
[217.469587] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[217.476386] [018/133] (910s left) i915_drm_fdinfo (virtual-busy-hang)
[217.592443] Starting subtest: virtual-busy-hang
[221.761444] Subtest virtual-busy-hang: SUCCESS (4.169s)
[221.923624] [019/133] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[222.128257] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[222.136978] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[222.277551] [020/133] (905s left) kms_addfb_basic (addfb25-modifier-no-flag)
[222.468979] Starting subtest: addfb25-modifier-no-flag
[222.474057] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[222.629619] [021/133] (905s left) gem_exec_alignment (many)
[222.748079] Starting subtest: many
[240.148093] Subtest many: SUCCESS (17.379s)
[240.814426] [022/133] (887s left) i915_pm_rc6_residency (rc6-accuracy)
[241.069482] Starting subtest: rc6-accuracy
[241.072875] Starting dynamic subtest: gt0
[244.246851] Dynamic subtest gt0: SUCCESS (3.173s)
[244.250425] Subtest rc6-accuracy: SUCCESS (3.177s)
[244.395257] [023/133] (883s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[244.530207] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[244.534243] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[244.706356] [024/133] (883s left) gem_ctx_persistence (processes)
[244.830164] Starting subtest: processes
[245.320242] Subtest processes: SUCCESS (0.482s)
[245.503568] [025/133] (882s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[246.113527] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[246.401769] [026/133] (881s left) gem_ctx_param (set-priority-invalid-size)
[246.524486] Starting subtest: set-priority-invalid-size
[246.530261] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[246.667726] [027/133] (881s left) perf (global-sseu-config-invalid)
[246.930079] Starting subtest: global-sseu-config-invalid
[246.934634] Starting dynamic subtest: 0-rcs0
[246.959021] Dynamic subtest 0-rcs0: SUCCESS (0.030s)
[246.963296] Subtest global-sseu-config-invalid: SUCCESS (0.032s)
[247.090228] [028/133] (881s left) gem_tiled_fence_blits (basic)
[247.346322] Starting subtest: basic
[247.379257] Subtest basic: SUCCESS (0.036s)
[247.567641] [029/133] (881s left) kms_psr (fbc-psr-sprite-plane-move)
[247.938146] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[248.062243] [030/133] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[248.260644] Starting subtest: basic-busy-flip-before-cursor-varying-size
[248.267051] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[248.417393] [031/133] (880s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[248.612475] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[248.623056] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[249.403711] [032/133] (879s left) perf_pmu (invalid-open)
[249.523038] Starting subtest: invalid-open
[249.526667] Subtest invalid-open: SUCCESS (0.001s)
[249.685543] [033/133] (879s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[249.872952] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[249.883629] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[250.020926] [034/133] (879s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[250.132071] Starting subtest: basic-write-cpu-read-gtt
[250.138652] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[250.297674] [035/133] (879s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[250.506671] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[250.513275] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[250.655384] [036/133] (878s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[250.844634] Starting subtest: plane-downscale-factor-0-75-with-rotation
[250.849531] Starting dynamic subtest: pipe-A
[255.928077] Dynamic subtest pipe-A: SKIP (5.078s)
[255.971598] Starting dynamic subtest: pipe-B
[262.716235] Dynamic subtest pipe-B: SKIP (6.781s)
[262.763630] Starting dynamic subtest: pipe-C
[268.802554] Dynamic subtest pipe-C: SKIP (6.086s)
[268.812632] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (17.955s)
[269.450586] [037/133] (860s left) api_intel_bb (blit-reloc-purge-cache)
[269.607990] Starting subtest: blit-reloc-purge-cache
[269.632627] Subtest blit-reloc-purge-cache: SUCCESS (0.023s)
[269.807166] [038/133] (859s left) gem_exec_schedule (manyslice)
[269.971131] Starting subtest: manyslice
[269.978142] Starting dynamic subtest: rcs0
[271.357582] Dynamic subtest rcs0: SUCCESS (1.378s)
[271.412063] Starting dynamic subtest: bcs0
[272.845118] Dynamic subtest bcs0: SUCCESS (1.474s)
[272.915079] Starting dynamic subtest: vcs0
[273.505093] Dynamic subtest vcs0: SUCCESS (0.640s)
[273.559852] Starting dynamic subtest: vecs0
[274.589166] Dynamic subtest vecs0: SUCCESS (1.058s)
[274.594056] Subtest manyslice: SUCCESS (4.617s)
[274.994080] [039/133] (854s left) gem_spin_batch (resubmit)
[275.141966] Starting subtest: resubmit
[275.145371] Starting dynamic subtest: rcs0
[275.151153] Dynamic subtest rcs0: SUCCESS (0.009s)
[275.199886] Starting dynamic subtest: bcs0
[275.204258] Dynamic subtest bcs0: SUCCESS (0.014s)
[275.226125] Starting dynamic subtest: vcs0
[275.229272] Dynamic subtest vcs0: SUCCESS (0.011s)
[275.250814] Starting dynamic subtest: vecs0
[275.254091] Dynamic subtest vecs0: SUCCESS (0.012s)
[275.257098] Subtest resubmit: SUCCESS (0.066s)
[275.490436] [040/133] (854s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[275.722289] Starting subtest: 4-tiled-32bpp-rotate-90
[275.729730] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[275.889818] [041/133] (854s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[276.104192] Starting subtest: cursor-vs-flip-legacy
[316.824092] Subtest cursor-vs-flip-legacy: SUCCESS (40.718s)
[317.229995] [042/133] (812s left) gen7_exec_parse (basic-allocation)
[317.351724] Subtest basic-allocation: SKIP (0.000s)
[317.466810] [043/133] (812s left) kms_content_protection (content-type-change)
[317.676278] Starting subtest: content-type-change
[317.715073] Subtest content-type-change: SKIP (0.031s)
[317.860869] [044/133] (812s left) gem_exec_whisper (basic-contexts-forked-all)
[318.003545] Starting subtest: basic-contexts-forked-all
[332.051518] Subtest basic-contexts-forked-all: SUCCESS (14.048s)
[332.327277] [045/133] (798s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[332.530046] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[332.657775] [046/133] (797s left) vgem_basic (bad-flag)
[332.799499] Starting subtest: bad-flag
[332.803305] Subtest bad-flag: SUCCESS (0.000s)
[332.954465] [047/133] (797s left) perf (polling-parameterized)
[333.209250] Starting subtest: polling-parameterized
[353.250711] Subtest polling-parameterized: SUCCESS (20.043s)
[353.378202] [048/133] (777s left) kms_pipe_crc_basic (suspend-read-crc)
[353.567242] Starting subtest: suspend-read-crc
[353.571183] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.385310] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.795s)
[372.417344] Starting dynamic subtest: pipe-B-HDMI-A-2