[89.701134] Initializing watchdogs
[89.701305]   /dev/watchdog0
[89.742140] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.757348] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.764372] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.772382] [001/133] (960s left) kms_chamelium_color (ctm-blue-to-red)
[89.978121] Subtest ctm-blue-to-red: SKIP (0.000s)
[90.077458] [002/133] (960s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[90.277322] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[90.374685] [003/133] (960s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[90.596840] Starting subtest: yf-tiled-32bpp-rotate-0
[95.753106] Subtest yf-tiled-32bpp-rotate-0: SUCCESS (5.153s)
[96.156109] [004/133] (954s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[96.277107] Starting subtest: framebuffer-vs-set-tiling
[96.280561] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[96.504920] [005/133] (954s left) gem_mmap_gtt (basic-read-write)
[96.622326] Starting subtest: basic-read-write
[96.625767] Subtest basic-read-write: SUCCESS (0.012s)
[96.769743] [006/133] (953s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[96.950285] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[96.954063] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.000679] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[97.034916] Starting dynamic subtest: pipe-A-HDMI-A-2
[97.082906] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[97.105347] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.138573] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[97.158069] Starting dynamic subtest: pipe-B-HDMI-A-2
[97.190282] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[97.208711] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.240018] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[97.258289] Starting dynamic subtest: pipe-C-HDMI-A-2
[97.288062] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[97.294023] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.019s)
[97.950882] [007/133] (952s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[98.164153] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[98.402936] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.236s)
[98.667840] [008/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[98.870059] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[98.878112] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[99.017663] [009/133] (951s left) gem_exec_schedule (preempt-user)
[99.175858] Starting subtest: preempt-user
[99.179300] Starting dynamic subtest: rcs0
[99.232086] Dynamic subtest rcs0: SUCCESS (0.057s)
[99.252481] Starting dynamic subtest: bcs0
[99.317263] Dynamic subtest bcs0: SUCCESS (0.079s)
[99.337381] Starting dynamic subtest: vcs0
[99.366691] Dynamic subtest vcs0: SUCCESS (0.053s)
[99.394852] Starting dynamic subtest: vecs0
[99.415963] Dynamic subtest vecs0: SUCCESS (0.050s)
[99.419218] Subtest preempt-user: SUCCESS (0.243s)
[99.817646] [010/133] (951s left) kms_sequence (queue-busy)
[99.997500] Starting subtest: queue-busy
[100.004118] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.901084] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.899s)
[102.923732] Starting dynamic subtest: pipe-A-HDMI-A-2
[105.539704] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.632s)
[105.573245] Starting dynamic subtest: pipe-B-HDMI-A-1
[108.150336] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.608s)
[108.192066] Starting dynamic subtest: pipe-B-HDMI-A-2
[110.761175] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.610s)
[110.784080] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.373050] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.606s)
[113.397666] Starting dynamic subtest: pipe-C-HDMI-A-2
[115.983876] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.611s)
[115.987981] Subtest queue-busy: SUCCESS (15.987s)
[116.377395] [011/133] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[116.588881] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[116.599155] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[116.734487] [012/133] (934s left) kms_hdmi_inject (inject-4k)
[117.269814] Starting subtest: inject-4k
[117.500171] Subtest inject-4k: SUCCESS (0.237s)
[117.911634] [013/133] (933s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[118.116182] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[121.208642] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.089s)
[121.475399] [014/133] (930s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[121.664094] Starting subtest: cursorB-vs-flipB-varying-size
[132.997516] Subtest cursorB-vs-flipB-varying-size: SUCCESS (11.330s)
[133.284714] [015/133] (918s left) gem_partial_pwrite_pread (reads)
[133.418731] Starting subtest: reads
[139.820836] Subtest reads: SUCCESS (6.408s)
[139.983179] [016/133] (911s left) core_getclient (basic)
[140.092418] Starting subtest: basic
[140.097262] Subtest basic: SUCCESS (0.000s)
[140.216922] [017/133] (911s left) dmabuf_sync_file (import-multiple-read-only)
[140.419034] Starting subtest: import-multiple-read-only
[140.433665] Subtest import-multiple-read-only: SUCCESS (0.013s)
[140.554956] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[140.562295] [018/133] (911s left) i915_drm_fdinfo (virtual-busy-hang)
[140.679040] Starting subtest: virtual-busy-hang
[144.886342] Subtest virtual-busy-hang: SUCCESS (4.208s)
[145.029438] [019/133] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[145.231801] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[145.238486] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[145.378559] [020/133] (906s left) kms_addfb_basic (addfb25-modifier-no-flag)
[145.566362] Starting subtest: addfb25-modifier-no-flag
[145.571537] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[145.728041] [021/133] (906s left) gem_exec_alignment (many)
[145.854499] Starting subtest: many
[186.444630] Subtest many: SUCCESS (40.594s)
[187.591823] [022/133] (864s left) i915_pm_rc6_residency (rc6-accuracy)
[187.826144] Starting subtest: rc6-accuracy
[187.829782] Starting dynamic subtest: gt0
[190.998507] Dynamic subtest gt0: SUCCESS (3.172s)
[191.002617] Subtest rc6-accuracy: SUCCESS (3.174s)
[191.143348] [023/133] (861s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[191.280765] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[191.298072] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.007s)
[191.440174] [024/133] (861s left) gem_ctx_persistence (processes)
[191.562321] Starting subtest: processes
[192.063833] Subtest processes: SUCCESS (0.496s)
[192.243498] [025/133] (860s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[192.821145] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[193.108637] [026/133] (859s left) gem_ctx_param (set-priority-invalid-size)
[193.224219] Starting subtest: set-priority-invalid-size
[193.227399] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[193.371694] [027/133] (859s left) perf (global-sseu-config-invalid)
[193.652200] Starting subtest: global-sseu-config-invalid
[193.657179] Starting dynamic subtest: 0-rcs0
[193.678497] Dynamic subtest 0-rcs0: SUCCESS (0.030s)
[193.682747] Subtest global-sseu-config-invalid: SUCCESS (0.031s)
[193.793576] [028/133] (859s left) gem_tiled_fence_blits (basic)
[194.038191] Starting subtest: basic
[194.068635] Subtest basic: SUCCESS (0.036s)
[194.256056] [029/133] (858s left) kms_psr (fbc-psr-sprite-plane-move)
[194.596128] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[194.717800] [030/133] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[194.920086] Starting subtest: basic-busy-flip-before-cursor-varying-size
[194.926291] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[195.080593] [031/133] (858s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[195.267528] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[195.278414] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[195.990631] [032/133] (857s left) perf_pmu (invalid-open)
[196.114358] Starting subtest: invalid-open
[196.118311] Subtest invalid-open: SUCCESS (0.001s)
[196.264846] [033/133] (857s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[196.453203] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[196.459673] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[196.601897] [034/133] (856s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[196.722146] Starting subtest: basic-write-cpu-read-gtt
[196.732101] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[196.866734] [035/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[197.078105] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[197.085063] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[197.233608] [036/133] (856s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[197.427569] Starting subtest: plane-downscale-factor-0-75-with-rotation
[197.432255] Starting dynamic subtest: pipe-A
[201.592075] Dynamic subtest pipe-A: SKIP (4.157s)
[201.644585] Starting dynamic subtest: pipe-B
[206.029136] Dynamic subtest pipe-B: SKIP (4.433s)
[206.078426] Starting dynamic subtest: pipe-C
[210.548462] Dynamic subtest pipe-C: SKIP (4.518s)
[210.555924] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (13.117s)
[211.063386] [037/133] (842s left) api_intel_bb (blit-reloc-purge-cache)
[211.243833] Starting subtest: blit-reloc-purge-cache
[211.263460] Subtest blit-reloc-purge-cache: SUCCESS (0.023s)
[211.427466] [038/133] (842s left) gem_exec_schedule (manyslice)
[211.601791] Starting subtest: manyslice
[211.606042] Starting dynamic subtest: rcs0
[212.886093] Dynamic subtest rcs0: SUCCESS (1.290s)
[212.952044] Starting dynamic subtest: bcs0
[214.144753] Dynamic subtest bcs0: SUCCESS (1.232s)
[214.208266] Starting dynamic subtest: vcs0
[214.776984] Dynamic subtest vcs0: SUCCESS (0.622s)
[214.857143] Starting dynamic subtest: vecs0
[215.881376] Dynamic subtest vecs0: SUCCESS (1.102s)
[215.890862] Subtest manyslice: SUCCESS (4.291s)
[216.264149] [039/133] (837s left) gem_spin_batch (resubmit)
[216.411476] Starting subtest: resubmit
[216.416217] Starting dynamic subtest: rcs0
[216.423092] Dynamic subtest rcs0: SUCCESS (0.008s)
[216.453978] Starting dynamic subtest: bcs0
[216.458256] Dynamic subtest bcs0: SUCCESS (0.011s)
[216.480290] Starting dynamic subtest: vcs0
[216.483507] Dynamic subtest vcs0: SUCCESS (0.012s)
[216.505582] Starting dynamic subtest: vecs0
[216.508646] Dynamic subtest vecs0: SUCCESS (0.006s)
[216.511946] Subtest resubmit: SUCCESS (0.055s)
[216.746248] [040/133] (837s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[216.963059] Starting subtest: 4-tiled-32bpp-rotate-90
[216.971091] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[217.113518] [041/133] (837s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[217.322230] Starting subtest: cursor-vs-flip-legacy
[257.228227] Subtest cursor-vs-flip-legacy: SUCCESS (39.901s)
[257.580471] [042/133] (796s left) gen7_exec_parse (basic-allocation)
[257.705083] Subtest basic-allocation: SKIP (0.000s)
[257.818877] [043/133] (796s left) kms_content_protection (content-type-change)
[258.008091] Starting subtest: content-type-change
[258.048296] Subtest content-type-change: SKIP (0.029s)
[258.206444] [044/133] (796s left) gem_exec_whisper (basic-contexts-forked-all)
[258.355206] Starting subtest: basic-contexts-forked-all
[271.394381] Subtest basic-contexts-forked-all: SUCCESS (13.042s)
[271.664593] [045/133] (783s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[271.869220] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[271.993840] [046/133] (782s left) vgem_basic (bad-flag)
[272.123486] Starting subtest: bad-flag
[272.127013] Subtest bad-flag: SUCCESS (0.000s)
[272.246665] [047/133] (782s left) perf (polling-parameterized)
[272.511425] Starting subtest: polling-parameterized
[292.556850] Subtest polling-parameterized: SUCCESS (20.045s)
[292.681496] [048/133] (762s left) kms_pipe_crc_basic (suspend-read-crc)
[292.870815] Starting subtest: suspend-read-crc
[292.877060] Starting dynamic subtest: pipe-A-HDMI-A-1