[87.744322] Initializing watchdogs
[87.744491]   /dev/watchdog0
[87.784800] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.799513] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.807684] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.813074] [001/133] (960s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[88.004318] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[88.007324] Starting dynamic subtest: pipe-A
[89.171225] Dynamic subtest pipe-A: SUCCESS (1.164s)
[89.197492] Starting dynamic subtest: pipe-B
[90.299054] Dynamic subtest pipe-B: SUCCESS (1.128s)
[90.334230] Starting dynamic subtest: pipe-C
[90.776292] Dynamic subtest pipe-C: SUCCESS (0.479s)
[90.777399] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.773s)
[91.319381] [002/133] (957s left) kms_chamelium_edid (hdmi-edid-read)
[91.932030] Subtest hdmi-edid-read: SKIP (0.000s)
[92.224742] [003/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[92.434919] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[95.545568] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.109s)
[95.811095] [004/133] (952s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[95.998104] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[96.096902] [005/133] (952s left) i915_drm_fdinfo (isolation)
[96.215550] Starting subtest: isolation
[96.217148] Starting dynamic subtest: rcs0
[96.750109] Dynamic subtest rcs0: SUCCESS (0.533s)
[96.772279] Starting dynamic subtest: bcs0
[97.290281] Dynamic subtest bcs0: SUCCESS (0.539s)
[97.311826] Starting dynamic subtest: vcs0
[97.821696] Dynamic subtest vcs0: SUCCESS (0.529s)
[97.842909] Starting dynamic subtest: vecs0
[98.355529] Dynamic subtest vecs0: SUCCESS (0.532s)
[98.357198] Subtest isolation: SUCCESS (2.138s)
[98.534157] [006/133] (950s left) gem_userptr_blits (sync-unmap)
[98.673040] Starting subtest: sync-unmap
[98.724303] Subtest sync-unmap: SUCCESS (0.052s)
[98.894180] [007/133] (949s left) gem_wait (write-wait)
[99.023886] Starting subtest: write-wait
[99.027925] Starting dynamic subtest: all-engines
[100.144166] Dynamic subtest all-engines: SUCCESS (1.118s)
[100.167296] Starting dynamic subtest: rcs0
[101.184220] Dynamic subtest rcs0: SUCCESS (1.035s)
[101.205252] Starting dynamic subtest: bcs0
[102.215039] Dynamic subtest bcs0: SUCCESS (1.033s)
[102.243111] Starting dynamic subtest: vcs0
[103.252666] Dynamic subtest vcs0: SUCCESS (1.030s)
[103.271458] Starting dynamic subtest: vecs0
[104.286163] Dynamic subtest vecs0: SUCCESS (1.037s)
[104.287309] Subtest write-wait: SUCCESS (5.260s)
[104.583637] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[104.590134] [008/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[104.777171] Starting subtest: cursorA-vs-flipA-varying-size
[116.113825] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.334s)
[116.467886] [009/133] (932s left) gem_exec_reloc (basic-wc-read-noreloc)
[116.592336] Starting subtest: basic-wc-read-noreloc
[116.601411] Subtest basic-wc-read-noreloc: SUCCESS (0.008s)
[116.823913] [010/133] (932s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[117.016712] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[117.018943] Starting dynamic subtest: pipe-A
[123.293592] Dynamic subtest pipe-A: SKIP (6.273s)
[123.328279] Starting dynamic subtest: pipe-B
[127.550258] Dynamic subtest pipe-B: SKIP (4.252s)
[127.591103] Starting dynamic subtest: pipe-C
[131.789329] Dynamic subtest pipe-C: SKIP (4.240s)
[131.795511] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (14.774s)
[132.282675] [011/133] (916s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[132.427078] Starting subtest: cpuset-medium-copy-XY
[143.982420] Subtest cpuset-medium-copy-XY: SUCCESS (11.559s)
[144.199907] [012/133] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[144.576677] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[144.582267] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.734695] [013/133] (904s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[144.856359] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[144.963930] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[145.101659] [014/133] (904s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[145.303861] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[145.565477] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.257s)
[145.850156] [015/133] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[146.049025] Starting subtest: psr-rgb565-draw-blt
[146.052209] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[146.233405] [016/133] (903s left) gem_lmem_swapping (heavy-verify-random)
[146.348614] Subtest heavy-verify-random: SKIP (0.000s)
[146.458397] [017/133] (903s left) gem_exec_gttfill (all-engines)
[146.588438] Starting subtest: all-engines
[176.244112] Subtest all-engines: SUCCESS (29.659s)
[176.526105] [018/133] (873s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[176.795393] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[176.799116] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.003s)
[176.950873] [019/133] (873s left) gem_softpin (allocator-fork)
[177.068333] Starting subtest: allocator-fork
[179.440414] Subtest allocator-fork: SUCCESS (2.368s)
[179.582275] [020/133] (870s left) prime_vgem (basic-gtt)
[179.709802] Starting subtest: basic-gtt
[179.747458] Subtest basic-gtt: SUCCESS (0.041s)
[179.901047] [021/133] (870s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[180.119145] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[180.121395] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[180.266841] [022/133] (870s left) kms_pm_dc (dc5-retention-flops)
[181.468074] Starting subtest: dc5-retention-flops
[181.472204] Subtest dc5-retention-flops: SKIP (0.000s)
[181.616213] [023/133] (868s left) gem_exec_schedule (smoketest)
[181.882701] Starting subtest: smoketest
[181.886183] Starting dynamic subtest: rcs0
[187.307094] Dynamic subtest rcs0: SUCCESS (5.415s)
[187.340046] Starting dynamic subtest: bcs0
[192.733279] Dynamic subtest bcs0: SUCCESS (5.419s)
[192.754062] Starting dynamic subtest: vcs0
[198.158026] Dynamic subtest vcs0: SUCCESS (5.422s)
[198.180389] Starting dynamic subtest: vecs0
[203.585978] Dynamic subtest vecs0: SUCCESS (5.426s)
[203.587268] Subtest smoketest: SUCCESS (21.700s)
[203.849910] [024/133] (846s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[204.412069] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[204.722804] [025/133] (845s left) kms_feature_discovery (display-2x)
[204.926220] Starting subtest: display-2x
[204.927778] Subtest display-2x: SUCCESS (0.001s)
[205.083809] [026/133] (845s left) gem_exec_fence (syncobj-invalid-wait)
[205.638650] Starting subtest: syncobj-invalid-wait
[205.641169] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[206.052975] [027/133] (844s left) kms_psr (psr-primary-page-flip)
[206.247057] Subtest psr-primary-page-flip: SKIP (0.000s)
[206.364653] [028/133] (844s left) kms_async_flips (invalid-async-flip)
[206.564393] Starting subtest: invalid-async-flip
[207.171110] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.466356] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.293s)
[207.787385] Starting dynamic subtest: pipe-A-HDMI-A-2
[208.046373] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.276s)
[208.380584] Starting dynamic subtest: pipe-B-HDMI-A-1
[208.594786] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.234s)
[208.948134] Starting dynamic subtest: pipe-B-HDMI-A-2
[209.123921] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.216s)
[209.425418] Starting dynamic subtest: pipe-C-HDMI-A-1
[209.607660] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.206s)
[209.930178] Starting dynamic subtest: pipe-C-HDMI-A-2
[210.129950] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.219s)
[210.135710] Subtest invalid-async-flip: SUCCESS (3.569s)
[210.823251] [029/133] (840s left) kms_fbcon_fbt (psr-suspend)
[210.942296] Starting subtest: psr-suspend
[210.944569] Subtest psr-suspend: SKIP (0.000s)
[211.155393] [030/133] (839s left) prime_vgem (basic-fence-blt)
[211.296158] Starting subtest: basic-fence-blt
[211.409074] Subtest basic-fence-blt: SUCCESS (0.116s)
[211.591494] [031/133] (839s left) kms_cursor_crc (cursor-sliding-64x64)
[211.803173] Starting subtest: cursor-sliding-64x64
[211.873139] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.989161] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.113s)
[216.105064] Starting dynamic subtest: pipe-C-HDMI-A-1
[219.801863] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.737s)
[219.804057] Subtest cursor-sliding-64x64: SUCCESS (8.003s)
[220.159645] [032/133] (831s left) gem_userptr_blits (process-exit)
[220.306104] Starting subtest: process-exit
[220.330649] Subtest process-exit: SUCCESS (0.026s)
[220.528923] [033/133] (830s left) api_intel_bb (render)
[220.639122] Starting subtest: render
[220.642434] Starting dynamic subtest: render-none-512
[220.746981] Dynamic subtest render-none-512: SUCCESS (0.109s)
[220.769362] Starting dynamic subtest: render-none-reloc-512
[220.855079] Dynamic subtest render-none-reloc-512: SUCCESS (0.105s)
[220.877631] Starting dynamic subtest: render-none-1024
[221.236370] Dynamic subtest render-none-1024: SUCCESS (0.377s)
[221.257890] Starting dynamic subtest: render-none-reloc-1024
[221.608731] Dynamic subtest render-none-reloc-1024: SUCCESS (0.368s)
[221.629804] Starting dynamic subtest: render-x-512
[221.700313] Dynamic subtest render-x-512: SUCCESS (0.091s)
[221.722583] Starting dynamic subtest: render-x-reloc-512
[221.792886] Dynamic subtest render-x-reloc-512: SUCCESS (0.087s)
[221.814682] Starting dynamic subtest: render-x-1024
[222.116460] Dynamic subtest render-x-1024: SUCCESS (0.322s)
[222.139072] Starting dynamic subtest: render-x-reloc-1024
[222.443632] Dynamic subtest render-x-reloc-1024: SUCCESS (0.325s)
[222.467154] Starting dynamic subtest: render-y-512
[222.538906] Dynamic subtest render-y-512: SUCCESS (0.091s)
[222.558492] Starting dynamic subtest: render-y-reloc-512
[222.629274] Dynamic subtest render-y-reloc-512: SUCCESS (0.088s)
[222.651597] Starting dynamic subtest: render-y-1024
[222.957079] Dynamic subtest render-y-1024: SUCCESS (0.322s)
[222.978816] Starting dynamic subtest: render-y-reloc-1024
[223.287509] Dynamic subtest render-y-reloc-1024: SUCCESS (0.326s)
[223.288821] Subtest render: SUCCESS (2.650s)
[223.443268] [034/133] (827s left) prime_udl
[223.663157] [035/133] (827s left) kms_frontbuffer_tracking (fbc-suspend)
[223.875241] Starting subtest: fbc-suspend