[110.213883] Initializing watchdogs
[110.214208]   /dev/watchdog0
[110.256073] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[110.270901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[110.278133] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[110.285753] [001/133] (960s left) kms_psr (fbc-psr2-basic)
[110.496148] Subtest fbc-psr2-basic: SKIP (0.000s)
[110.603869] [002/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[110.820342] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[110.826945] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[110.976971] [003/133] (959s left) syncobj_timeline (wait-all-interrupted)
[111.089573] Starting subtest: wait-all-interrupted
[111.194924] Subtest wait-all-interrupted: SUCCESS (0.105s)
[111.356042] [004/133] (959s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[111.544097] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[111.549237] Starting dynamic subtest: pipe-A-HDMI-A-1
[111.600557] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[111.638405] Starting dynamic subtest: pipe-A-HDMI-A-2
[111.693577] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[111.729772] Starting dynamic subtest: pipe-B-HDMI-A-1
[111.766783] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[111.786114] Starting dynamic subtest: pipe-B-HDMI-A-2
[111.822405] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[111.842348] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.876092] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[111.896267] Starting dynamic subtest: pipe-C-HDMI-A-2
[111.933314] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[111.939396] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.020s)
[112.613323] [005/133] (958s left) syncobj_wait (single-wait-signaled)
[112.728289] Starting subtest: single-wait-signaled
[112.731498] Subtest single-wait-signaled: SUCCESS (0.001s)
[112.867802] [006/133] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[113.076737] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[115.482605] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (2.416s)
[115.790040] [007/133] (955s left) kms_getfb (getfb2-handle-zero)
[115.992053] Starting subtest: getfb2-handle-zero
[115.995667] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[116.119333] [008/133] (955s left) gem_mmap_gtt (fault-concurrent-x)
[116.241711] Starting subtest: fault-concurrent-X
[119.586087] Subtest fault-concurrent-X: SUCCESS (3.348s)
[119.764347] [009/133] (951s left) gem_exec_reloc (basic-cpu-read)
[119.895034] Starting subtest: basic-cpu-read
[119.921883] Subtest basic-cpu-read: SUCCESS (0.024s)
[120.153998] [010/133] (951s left) syncobj_wait (invalid-signal-one-illegal-handle)
[120.271140] Starting subtest: invalid-signal-one-illegal-handle
[120.275306] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[120.399521] [011/133] (951s left) gem_mmap_gtt (basic-copy)
[120.514378] Starting subtest: basic-copy
[121.282541] Subtest basic-copy: SUCCESS (0.772s)
[121.465564] [012/133] (950s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[121.675058] Starting subtest: y-tiled-16bpp-rotate-90
[122.013609] Subtest y-tiled-16bpp-rotate-90: SKIP (0.341s)
[122.269422] [013/133] (949s left) gem_mmap_offset (open-flood)
[122.387483] Starting subtest: open-flood
[143.959517] Subtest open-flood: SUCCESS (21.576s)
[144.117148] [014/133] (927s left) kms_color (degamma)
[144.304609] Starting subtest: degamma
[144.307911] Starting dynamic subtest: pipe-A-HDMI-A-1
[145.780313] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.401s)
[145.846502] Starting dynamic subtest: pipe-A-HDMI-A-2
[146.456156] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.680s)
[146.520222] Starting dynamic subtest: pipe-B-HDMI-A-1
[147.203165] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.701s)
[147.268383] Starting dynamic subtest: pipe-B-HDMI-A-2
[147.914899] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.708s)
[147.979325] Starting dynamic subtest: pipe-C-HDMI-A-1
[148.531995] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.668s)
[148.628398] Starting dynamic subtest: pipe-C-HDMI-A-2
[149.240561] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.670s)
[149.244191] Subtest degamma: SUCCESS (4.838s)
[149.476659] [015/133] (922s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[149.699102] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[149.705767] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[149.843827] [016/133] (922s left) gem_exec_reloc (basic-gtt-cpu)
[149.973352] Starting subtest: basic-gtt-cpu
[149.990826] Subtest basic-gtt-cpu: SUCCESS (0.019s)
[150.209990] [017/133] (922s left) gem_exec_schedule (u-semaphore-user)
[150.365358] Starting subtest: u-semaphore-user
[150.384922] Subtest u-semaphore-user: SUCCESS (0.024s)
[150.776282] [018/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[150.983763] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[150.989999] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.001s)
[151.126652] [019/133] (921s left) sriov_basic (enable-vfs-bind-unbind-each)
[151.253444] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[151.350952] [020/133] (921s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[151.548762] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[151.555801] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[151.695381] [021/133] (920s left) i915_fb_tiling (basic-x-tiling)
[151.809894] Starting subtest: basic-x-tiling
[151.813133] Subtest basic-x-tiling: SUCCESS (0.001s)
[151.957290] [022/133] (920s left) prime_self_import (basic-llseek-size)
[152.067734] Starting subtest: basic-llseek-size
[152.074142] Subtest basic-llseek-size: SUCCESS (0.008s)
[152.223877] [023/133] (920s left) gen9_exec_parse (batch-zero-length)
[152.356328] Starting subtest: batch-zero-length
[152.360496] Subtest batch-zero-length: SUCCESS (0.004s)
[152.625235] [024/133] (920s left) kms_psr (psr2-primary-mmap-gtt)
[152.820478] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[152.930319] [025/133] (920s left) dmabuf_sync_file (import-basic)
[153.140512] Starting subtest: import-basic
[153.143746] Subtest import-basic: SUCCESS (0.007s)
[153.272365] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[153.278856] [026/133] (919s left) kms_psr (fbc-psr-primary-mmap-cpu)
[153.481953] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[153.593991] [027/133] (919s left) gem_render_copy (linear-to-vebox-yf-tiled)
[153.726093] Starting subtest: linear-to-vebox-yf-tiled
[153.733638] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[154.032987] [028/133] (919s left) kms_dp_aux_dev (basic)
[154.147978] Starting subtest: basic
[154.154737] Subtest basic: SKIP (0.001s)
[154.300958] [029/133] (919s left) api_intel_bb (crc32)
[154.424228] Starting subtest: crc32
[154.432936] Subtest crc32: SKIP (0.000s)
[154.581373] [030/133] (918s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[154.766074] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[154.778111] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[155.481336] [031/133] (918s left) gem_exec_basic (basic)
[155.610642] Starting subtest: basic
[155.614269] Starting dynamic subtest: rcs0-smem
[155.619333] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[155.641947] Starting dynamic subtest: bcs0-smem
[155.645808] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[155.667754] Starting dynamic subtest: vcs0-smem
[155.671976] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[155.695094] Starting dynamic subtest: vecs0-smem
[155.698964] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[155.702789] Subtest basic: SUCCESS (0.015s)
[155.897498] [032/133] (917s left) gem_pipe_control_store_loop (reused-buffer)
[156.016842] Starting subtest: reused-buffer
[158.183457] Subtest reused-buffer: SUCCESS (2.159s)
[158.357437] [033/133] (915s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[158.480461] Starting subtest: writes-after-reads
[161.840317] Subtest writes-after-reads: SUCCESS (3.361s)
[161.995358] [034/133] (911s left) api_intel_bb (purge-bb)
[162.108250] Starting subtest: purge-bb
[162.119143] Subtest purge-bb: SUCCESS (0.010s)
[162.280816] [035/133] (911s left) kms_force_connector_basic (force-edid)
[162.560947] Starting subtest: force-edid
[162.740467] Subtest force-edid: SUCCESS (0.177s)
[163.084510] [036/133] (911s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[163.209338] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[163.213479] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[163.364822] [037/133] (910s left) prime_mmap (test_refcounting)
[163.478047] Starting subtest: test_refcounting
[163.481066] Starting dynamic subtest: test_refcounting-smem
[163.490436] Dynamic subtest test_refcounting-smem: SUCCESS (0.011s)
[163.494890] Subtest test_refcounting: SUCCESS (0.013s)
[163.647654] [038/133] (910s left) i915_selftest (mock)
[165.387057] Starting subtest: mock
[165.390662] Starting dynamic subtest: sanitycheck
[167.022099] Dynamic subtest sanitycheck: SUCCESS (1.640s)
[167.047297] Starting dynamic subtest: shmem
[168.656114] Dynamic subtest shmem: SUCCESS (1.632s)
[168.680233] Starting dynamic subtest: fence
[177.082057] Dynamic subtest fence: SUCCESS (8.423s)
[177.106203] Starting dynamic subtest: scatterlist
[179.730201] Dynamic subtest scatterlist: SUCCESS (2.646s)
[179.754558] Starting dynamic subtest: syncmap
[183.441600] Dynamic subtest syncmap: SUCCESS (3.709s)
[183.465825] Starting dynamic subtest: uncore
[185.067197] Dynamic subtest uncore: SUCCESS (1.623s)
[185.091598] Starting dynamic subtest: ring
[186.687356] Dynamic subtest ring: SUCCESS (1.618s)
[186.711829] Starting dynamic subtest: engine
[188.320678] Dynamic subtest engine: SUCCESS (1.631s)
[188.345184] Starting dynamic subtest: timelines
[198.123513] Dynamic subtest timelines: SUCCESS (9.799s)
[198.149264] Starting dynamic subtest: requests
[202.044154] Dynamic subtest requests: SUCCESS (3.919s)
[202.070265] Starting dynamic subtest: objects
[203.872148] Dynamic subtest objects: SUCCESS (1.825s)
[203.898254] Starting dynamic subtest: phys
[205.714624] Dynamic subtest phys: SUCCESS (1.841s)
[205.739166] Starting dynamic subtest: dmabuf
[207.577076] Dynamic subtest dmabuf: SUCCESS (1.860s)
[207.602203] Starting dynamic subtest: vma
[227.975731] Dynamic subtest vma: SUCCESS (20.394s)
[228.001175] Starting dynamic subtest: evict
[232.101100] Dynamic subtest evict: SUCCESS (4.124s)
[232.128182] Starting dynamic subtest: gtt
[237.802203] Dynamic subtest gtt: SUCCESS (5.699s)
[237.827215] Starting dynamic subtest: hugepages
[240.035618] Dynamic subtest hugepages: SUCCESS (2.231s)
[240.059916] Starting dynamic subtest: memory_region
[248.128236] Dynamic subtest memory_region: SUCCESS (8.091s)
[248.131643] Subtest mock: SUCCESS (82.748s)
[248.205651] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[248.208715] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[248.216464] [039/133] (826s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[251.187632] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[253.891928] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.707s)
[254.300760] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[254.303603] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[254.312742] [040/133] (820s left) syncobj_timeline (etime-multi-wait-submitted)
[254.424914] Starting subtest: etime-multi-wait-submitted
[254.537167] Subtest etime-multi-wait-submitted: SUCCESS (0.110s)
[254.695366] [041/133] (819s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[254.902409] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[255.017843] [042/133] (819s left) kms_invalid_mode (bad-hsync-end)
[255.228232] Starting subtest: bad-hsync-end
[255.233484] Starting dynamic subtest: pipe-A-HDMI-A-1
[255.680034] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.458s)
[255.707478] Starting dynamic subtest: pipe-A-HDMI-A-2
[255.710857] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[255.737317] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.743739] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[255.789171] Starting dynamic subtest: pipe-B-HDMI-A-2
[255.794551] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.005s)
[255.842570] Starting dynamic subtest: pipe-C-HDMI-A-1
[255.849117] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[255.874549] Starting dynamic subtest: pipe-C-HDMI-A-2
[255.877696] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.003s)
[255.880891] Subtest bad-hsync-end: SUCCESS (0.507s)
[256.097950] [043/133] (818s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[256.231333] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[256.238565] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[256.507831] [044/133] (818s left) gem_ctx_engines (execute-allforone)
[256.658394] Starting subtest: execute-allforone
[256.678331] Subtest execute-allforone: SUCCESS (0.026s)
[256.944515] [045/133] (818s left) kms_cursor_crc (cursor-random-64x21)
[257.151896] Starting subtest: cursor-random-64x21
[257.211896] Starting dynamic subtest: pipe-A-HDMI-A-1
[261.429454] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.211s)
[261.564773] Starting dynamic subtest: pipe-C-HDMI-A-1
[265.428420] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.919s)
[265.431511] Subtest cursor-random-64x21: SUCCESS (8.274s)
[265.869281] [046/133] (809s left) kms_addfb_basic (too-wide)
[266.072914] Starting subtest: too-wide
[266.076544] Subtest too-wide: SUCCESS (0.000s)
[266.225199] [047/133] (809s left) gem_exec_balancer (bonded-pair)
[266.365560] Starting subtest: bonded-pair
[270.741927] Subtest bonded-pair: SUCCESS (4.378s)
[271.022752] [048/133] (804s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[271.242371] Starting subtest: fbcpsr-rgb565-draw-blt
[271.248756] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[271.408765] [049/133] (804s left) gem_exec_suspend (basic)
[271.544804] Starting subtest: basic
[271.550506] Starting dynamic subtest: smem
[272.720771] Dynamic subtest smem: SUCCESS (1.174s)
[272.724523] Subtest basic: SUCCESS (1.176s)
[272.989716] [050/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[273.193451] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[273.201136] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[273.359756] [051/133] (802s left) kms_addfb_basic (size-max)
[273.557819] Starting subtest: size-max
[273.561093] Subtest size-max: SUCCESS (0.001s)
[273.722879] [052/133] (802s left) gem_ctx_isolation (preservation-s3)
[273.861703] Starting subtest: preservation-S3
[273.864903] Starting dynamic subtest: rcs0