[88.116393] Initializing watchdogs
[88.116569]   /dev/watchdog0
[88.157094] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[88.172064] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.179166] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.187172] [001/133] (960s left) prime_vgem (basic-fence-mmap)
[88.413679] Starting subtest: basic-fence-mmap
[88.475934] Subtest basic-fence-mmap: SUCCESS (0.057s)
[88.635767] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[88.642204] [002/133] (960s left) gem_exec_reloc (basic-wc-cpu)
[88.759214] Starting subtest: basic-wc-cpu
[88.779825] Subtest basic-wc-cpu: SUCCESS (0.020s)
[89.037980] [003/133] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[89.239803] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[91.711999] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.477s)
[91.949920] [004/133] (957s left) kms_psr (fbc-psr2-sprite-render)
[92.133863] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[92.249760] [005/133] (956s left) gem_sync (basic-store-each)
[92.397992] Starting subtest: basic-store-each
[95.070552] Subtest basic-store-each: SUCCESS (2.688s)
[95.354058] [006/133] (953s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[95.566785] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[95.583166] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[96.205873] [007/133] (953s left) gem_exec_fence (submit)
[96.471708] Starting subtest: submit
[96.477260] Starting dynamic subtest: rcs0
[96.496361] Dynamic subtest rcs0: SUCCESS (0.025s)
[96.519297] Starting dynamic subtest: bcs0
[96.523054] Dynamic subtest bcs0: SUCCESS (0.023s)
[96.544952] Starting dynamic subtest: vcs0
[96.548966] Dynamic subtest vcs0: SUCCESS (0.022s)
[96.570150] Starting dynamic subtest: vecs0
[96.574588] Dynamic subtest vecs0: SUCCESS (0.023s)
[96.578856] Subtest submit: SUCCESS (0.096s)
[97.266957] [008/133] (952s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[97.450934] Starting subtest: plane-primary-overlay-mutable-zpos
[98.442893] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.981s)
[98.941802] [009/133] (950s left) gem_render_copy (yf-tiled)
[99.070210] Starting subtest: yf-tiled
[99.073556] Starting dynamic subtest: smem
[99.388919] Dynamic subtest smem: SUCCESS (0.318s)
[99.392607] Subtest yf-tiled: SUCCESS (0.320s)
[99.675555] [010/133] (949s left) kms_invalid_mode (bad-htotal)
[99.851888] Starting subtest: bad-htotal
[99.855850] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.366321] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.389s)
[100.435623] Starting dynamic subtest: pipe-A-HDMI-A-2
[100.503578] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[100.573069] Starting dynamic subtest: pipe-B-HDMI-A-1
[100.642328] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[100.711926] Starting dynamic subtest: pipe-B-HDMI-A-2
[100.780373] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[100.882376] Starting dynamic subtest: pipe-C-HDMI-A-1
[100.949972] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[101.051097] Starting dynamic subtest: pipe-C-HDMI-A-2
[101.116819] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[101.182125] Subtest bad-htotal: SUCCESS (0.415s)
[101.636473] [011/133] (948s left) kms_color_pipeline (plane-lut1d-lut1d)
[101.842790] Starting subtest: plane-lut1d-lut1d
[102.894523] Subtest plane-lut1d-lut1d: SKIP (1.028s)
[103.152924] [012/133] (946s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[103.299394] Starting subtest: map-fixed-invalidate-overlap
[103.302528] Starting dynamic subtest: gtt
[103.551167] Dynamic subtest gtt: SUCCESS (0.252s)
[103.569958] Starting dynamic subtest: wb
[103.708861] Dynamic subtest wb: SUCCESS (0.157s)
[103.727081] Starting dynamic subtest: wc
[103.862445] Dynamic subtest wc: SUCCESS (0.153s)
[103.880761] Starting dynamic subtest: uc
[104.017106] Dynamic subtest uc: SUCCESS (0.153s)
[104.020400] Subtest map-fixed-invalidate-overlap: SUCCESS (0.719s)
[104.200752] [013/133] (945s left) gem_exec_reloc (basic-gtt-wc)
[104.316253] Starting subtest: basic-gtt-wc
[104.332644] Subtest basic-gtt-wc: SUCCESS (0.016s)
[104.586398] [014/133] (945s left) gem_fence_thrash (bo-write-verify-y)
[104.689075] Starting subtest: bo-write-verify-y
[105.847067] Subtest bo-write-verify-y: SUCCESS (1.162s)
[106.019461] [015/133] (944s left) syncobj_timeline (invalid-signal-illegal-handle)
[106.127354] Starting subtest: invalid-signal-illegal-handle
[106.131957] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[106.310410] [016/133] (944s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[107.024094] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[107.361358] [017/133] (943s left) kms_addfb_basic (basic)
[107.666723] Starting subtest: basic
[107.672137] Subtest basic: SUCCESS (0.002s)
[108.153325] [018/133] (942s left) gem_exec_basic (basic)
[108.412404] Starting subtest: basic
[108.417356] Starting dynamic subtest: rcs0-smem
[108.422322] Dynamic subtest rcs0-smem: SUCCESS (0.007s)
[108.462768] Starting dynamic subtest: bcs0-smem
[108.465817] Dynamic subtest bcs0-smem: SUCCESS (0.007s)
[108.493867] Starting dynamic subtest: vcs0-smem
[108.497831] Dynamic subtest vcs0-smem: SUCCESS (0.017s)
[108.531043] Starting dynamic subtest: vecs0-smem
[108.536739] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[108.539995] Subtest basic: SUCCESS (0.042s)
[108.860876] [019/133] (942s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[109.067788] Starting subtest: yf-tiled-8bpp-rotate-90
[109.074720] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[109.240760] [020/133] (941s left) gem_exec_alignment (many)
[109.359434] Starting subtest: many
[148.103615] Subtest many: SUCCESS (38.749s)
[149.077223] [021/133] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[149.427519] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[149.433867] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[149.593633] [022/133] (901s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[149.779521] Starting subtest: psr-dirtyfb-ioctl
[149.806987] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[149.958729] [023/133] (901s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[150.157964] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[150.273491] [024/133] (901s left) gem_ctx_param (invalid-set-ringsize)
[150.376177] Starting subtest: invalid-set-ringsize
[150.379984] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[150.554038] [025/133] (901s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[150.767095] Starting subtest: x-tiled-16bpp-rotate-0
[154.046597] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.279s)
[154.405942] [026/133] (897s left) kms_cursor_crc (cursor-dpms)
[154.604705] Starting subtest: cursor-dpms
[154.608286] Starting dynamic subtest: pipe-A-HDMI-A-1
[156.300076] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.688s)
[156.339919] Starting dynamic subtest: pipe-C-HDMI-A-1
[157.665457] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.362s)
[157.668801] Subtest cursor-dpms: SUCCESS (3.060s)
[158.015526] [027/133] (893s left) kms_pipe_crc_basic (nonblocking-crc)
[158.203846] Starting subtest: nonblocking-crc
[158.207339] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.239845] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.033s)
[159.262379] Starting dynamic subtest: pipe-B-HDMI-A-2
[159.931324] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.689s)
[159.952923] Starting dynamic subtest: pipe-C-HDMI-A-1
[160.684466] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.699s)
[160.722247] Subtest nonblocking-crc: SUCCESS (2.435s)
[160.936415] [028/133] (891s left) kms_plane_cursor (viewport)
[161.124087] Starting subtest: viewport
[161.130482] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[163.752212] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.630s)
[163.838838] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[166.304063] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.483s)
[166.388654] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[168.837765] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.464s)
[169.126709] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64
[171.636095] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.528s)
[171.704541] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128
[174.153046] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.463s)
[174.222061] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256
[176.687069] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.483s)
[176.979313] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[179.463073] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.539s)
[179.531043] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[181.944113] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.433s)
[182.016098] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[184.478135] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.483s)
[184.730758] Subtest viewport: SUCCESS (23.608s)
[185.041239] [029/133] (867s left) prime_busy (hang)
[185.175429] Starting subtest: hang
[185.178651] Starting dynamic subtest: rcs0
[191.663761] Dynamic subtest rcs0: SUCCESS (6.486s)
[191.684482] Starting dynamic subtest: bcs0
[198.637750] Dynamic subtest bcs0: SUCCESS (6.975s)
[198.658810] Starting dynamic subtest: vcs0
[205.614033] Dynamic subtest vcs0: SUCCESS (6.972s)
[205.634537] Starting dynamic subtest: vecs0
[212.654962] Dynamic subtest vecs0: SUCCESS (7.038s)
[212.658978] Subtest hang: SUCCESS (27.484s)
[212.819805] [030/133] (839s left) i915_drm_fdinfo (virtual-busy-all)
[212.936797] Starting subtest: virtual-busy-all
[212.941653] Subtest virtual-busy-all: SUCCESS (0.001s)
[213.105751] [031/133] (839s left) gem_userptr_blits (vma-merge)
[213.261427] Starting subtest: vma-merge
[213.416254] Subtest vma-merge: SUCCESS (0.156s)
[213.614619] [032/133] (838s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[213.812982] Starting subtest: fbc-rgb565-draw-blt
[216.611386] Subtest fbc-rgb565-draw-blt: SUCCESS (2.800s)
[216.905460] [033/133] (835s left) gem_exec_schedule (independent)
[217.061956] Starting subtest: independent
[217.065462] Starting dynamic subtest: rcs0
[217.204853] Dynamic subtest rcs0: SUCCESS (0.145s)
[217.228555] Starting dynamic subtest: bcs0
[217.358332] Dynamic subtest bcs0: SUCCESS (0.150s)
[217.380552] Starting dynamic subtest: vcs0
[217.500557] Dynamic subtest vcs0: SUCCESS (0.138s)
[217.522512] Starting dynamic subtest: vecs0
[217.657077] Dynamic subtest vecs0: SUCCESS (0.153s)
[217.661547] Subtest independent: SUCCESS (0.599s)
[218.070866] [034/133] (834s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[218.256343] Starting subtest: short-flip-after-cursor-toggle
[219.595412] Subtest short-flip-after-cursor-toggle: SUCCESS (1.332s)
[219.899032] [035/133] (832s left) kms_prop_blob (blob-prop-core)
[220.024313] Starting subtest: blob-prop-core
[220.027556] Subtest blob-prop-core: SUCCESS (0.000s)
[220.194945] [036/133] (832s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[220.405308] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[220.418267] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.004s)
[220.595323] [037/133] (832s left) syncobj_wait (invalid-signal-illegal-handle)
[220.712336] Starting subtest: invalid-signal-illegal-handle
[220.715626] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[220.903802] [038/133] (832s left) gem_exec_reloc (basic-write-wc-active)
[221.028787] Starting subtest: basic-write-wc-active
[221.157065] Subtest basic-write-wc-active: SUCCESS (0.136s)
[221.415033] [039/133] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[221.614365] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[224.033293] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.427s)
[224.330479] [040/133] (828s left) gem_lmem_swapping (heavy-random)
[224.447370] Subtest heavy-random: SKIP (0.000s)
[224.559766] [041/133] (828s left) kms_sequence (get-busy)
[224.751147] Starting subtest: get-busy
[224.754274] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.636211] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.889s)
[227.657872] Starting dynamic subtest: pipe-A-HDMI-A-2
[230.244565] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.606s)
[230.285026] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.854214] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.601s)
[232.875471] Starting dynamic subtest: pipe-B-HDMI-A-2
[235.458387] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.596s)
[235.497780] Starting dynamic subtest: pipe-C-HDMI-A-1
[238.040567] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.581s)
[238.108584] Starting dynamic subtest: pipe-C-HDMI-A-2
[240.619232] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.576s)
[240.623225] Subtest get-busy: SUCCESS (15.880s)
[240.933189] [042/133] (812s left) gen7_exec_parse (basic-offset)
[241.060511] Subtest basic-offset: SKIP (0.000s)
[241.173827] [043/133] (812s left) gem_mmap_gtt (basic-small-bo-tiledy)
[241.280133] Starting subtest: basic-small-bo-tiledY
[241.521028] Subtest basic-small-bo-tiledY: SUCCESS (0.245s)
[241.758724] [044/133] (811s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[242.040070] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[242.043365] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[242.211606] [045/133] (811s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[242.319531] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[242.428058] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[242.612918] [046/133] (811s left) gem_create (create-invalid-size)
[242.718321] Starting subtest: create-invalid-size
[242.722977] Subtest create-invalid-size: SUCCESS (0.000s)
[243.012495] [047/133] (810s left) kms_fb_coherency (memset-crc)
[243.213557] Starting subtest: memset-crc
[243.217721] Starting dynamic subtest: mmap-gtt
[244.016157] Dynamic subtest mmap-gtt: SUCCESS (0.804s)
[244.282265] Starting dynamic subtest: mmap-offset-wc
[244.644909] Dynamic subtest mmap-offset-wc: SUCCESS (0.401s)
[244.884120] Starting dynamic subtest: mmap-offset-uc
[245.700060] Dynamic subtest mmap-offset-uc: SUCCESS (0.817s)
[245.947657] Starting dynamic subtest: mmap-legacy-wc
[246.313525] Dynamic subtest mmap-legacy-wc: SUCCESS (0.390s)
[246.557596] Subtest memset-crc: SUCCESS (3.299s)
[246.838338] [048/133] (807s left) gem_pxp (create-regular-context-1)
[249.487362] Starting subtest: create-regular-context-1
[249.496541] Subtest create-regular-context-1: SKIP (0.000s)
[249.668471] [049/133] (804s left) kms_flip (2x-busy-flip)
[249.861912] Starting subtest: 2x-busy-flip
[249.866723] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[251.173048] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.207s)
[251.238939] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[252.223038] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.146s)
[252.247331] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[253.398160] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.170s)
[253.401497] Subtest 2x-busy-flip: SUCCESS (3.540s)
[254.027557] [050/133] (800s left) syncobj_timeline (wait-all-snapshot)
[254.142233] Starting subtest: wait-all-snapshot
[254.222095] Subtest wait-all-snapshot: SUCCESS (0.085s)
[254.373506] [051/133] (800s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[254.575342] Starting subtest: 4-tiled-8bpp-rotate-270
[254.584090] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[254.727644] [052/133] (799s left) api_intel_bb (misplaced-blitter)
[254.832881] Starting subtest: misplaced-blitter
[254.845684] Subtest misplaced-blitter: SUCCESS (0.012s)
[255.043507] [053/133] (799s left) kms_async_flips (async-flip-suspend-resume)
[255.231100] Starting subtest: async-flip-suspend-resume
[255.808469] Starting dynamic subtest: pipe-A-HDMI-A-1
[274.631603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.133s)
[274.871644] Starting dynamic subtest: pipe-A-HDMI-A-2