[87.887986] Initializing watchdogs
[87.888255]   /dev/watchdog0
[87.928219] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[87.943394] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.951669] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.957485] [001/133] (960s left) gem_wait (wait)
[88.113790] Starting subtest: wait
[88.116209] Starting dynamic subtest: all-engines
[89.157625] Dynamic subtest all-engines: SUCCESS (1.047s)
[89.175300] Starting dynamic subtest: rcs0
[90.193795] Dynamic subtest rcs0: SUCCESS (1.032s)
[90.212299] Starting dynamic subtest: bcs0
[91.230115] Dynamic subtest bcs0: SUCCESS (1.029s)
[91.245891] Starting dynamic subtest: vcs0
[92.258073] Dynamic subtest vcs0: SUCCESS (1.032s)
[92.275739] Starting dynamic subtest: vecs0
[93.286124] Dynamic subtest vecs0: SUCCESS (1.025s)
[93.288111] Subtest wait: SUCCESS (5.172s)
[93.592256] [002/133] (954s left) gem_exec_balancer (bonded-pair)
[93.716628] Starting subtest: bonded-pair
[98.131409] Subtest bonded-pair: SUCCESS (4.410s)
[98.407113] [003/133] (950s left) gen9_exec_parse (bb-start-out)
[98.534275] Starting subtest: bb-start-out
[98.540096] Subtest bb-start-out: SUCCESS (0.006s)
[98.793468] [004/133] (949s left) kms_force_connector_basic (prune-stale-modes)
[99.093927] Starting subtest: prune-stale-modes
[99.255064] Subtest prune-stale-modes: SUCCESS (0.169s)
[99.570802] [005/133] (949s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[99.821987] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[99.826458] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[99.957913] [006/133] (948s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[100.063416] Starting subtest: multi-wait-for-submit-submitted-signaled
[100.067409] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.003s)
[100.191910] [007/133] (948s left) gem_mmap_gtt (cpuset-medium-copy)
[100.296833] Starting subtest: cpuset-medium-copy
[108.791152] Subtest cpuset-medium-copy: SUCCESS (8.487s)
[108.934847] [008/133] (940s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[109.287301] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[109.294267] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.312089] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[109.338524] Starting dynamic subtest: pipe-A-HDMI-A-2
[109.350308] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[109.367510] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.378663] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[109.395925] Starting dynamic subtest: pipe-B-HDMI-A-2
[109.407251] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[109.424414] Starting dynamic subtest: pipe-C-HDMI-A-1
[109.435619] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[109.452840] Starting dynamic subtest: pipe-C-HDMI-A-2
[109.464364] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[109.466598] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.018s)
[110.399722] [009/133] (938s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[110.605304] Starting subtest: fbcpsr-indfb-scaledprimary
[110.610278] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[110.751608] [010/133] (938s left) kms_dirtyfb (default-dirtyfb-ioctl)
[110.928223] Starting subtest: default-dirtyfb-ioctl
[110.933172] Starting dynamic subtest: A-HDMI-A-1
[112.657053] Dynamic subtest A-HDMI-A-1: SUCCESS (1.725s)
[112.695037] Starting dynamic subtest: A-HDMI-A-2
[114.287788] Dynamic subtest A-HDMI-A-2: SUCCESS (1.626s)
[114.289148] Subtest default-dirtyfb-ioctl: SUCCESS (3.362s)
[114.586742] [011/133] (934s left) kms_vblank (wait-forked-busy-hang)
[114.809413] Starting subtest: wait-forked-busy-hang
[114.810595] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.856032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.044s)
[121.883078] Starting dynamic subtest: pipe-A-HDMI-A-2
[128.830941] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.970s)
[128.863441] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.851889] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (7.004s)
[135.879805] Starting dynamic subtest: pipe-C-HDMI-A-2
[142.831126] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.973s)
[142.833225] Subtest wait-forked-busy-hang: SUCCESS (28.024s)
[143.162776] [012/133] (906s left) gem_exec_fence (syncobj-timeline-export)
[143.924146] Starting subtest: syncobj-timeline-export
[143.932509] Subtest syncobj-timeline-export: SUCCESS (0.010s)
[144.209780] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[144.217559] [013/133] (905s left) kms_cursor_crc (cursor-offscreen-64x64)
[144.402895] Starting subtest: cursor-offscreen-64x64
[144.451243] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.413309] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.961s)
[147.524616] Starting dynamic subtest: pipe-C-HDMI-A-1
[150.043379] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.559s)
[150.045245] Subtest cursor-offscreen-64x64: SUCCESS (5.639s)
[150.429517] [014/133] (899s left) kms_cursor_crc (cursor-sliding-64x64)
[150.625176] Starting subtest: cursor-sliding-64x64
[150.689315] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.749174] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.060s)
[154.861946] Starting dynamic subtest: pipe-C-HDMI-A-1
[158.576640] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.745s)
[158.579360] Subtest cursor-sliding-64x64: SUCCESS (7.953s)
[158.925918] [015/133] (890s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[159.134250] Starting subtest: psr-rgb565-draw-pwrite
[159.138393] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[159.287954] [016/133] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[159.494567] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[162.120331] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SUCCESS (2.623s)
[162.322531] [017/133] (887s left) kms_psr (fbc-pr-sprite-plane-onoff)
[162.510218] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[162.613804] [018/133] (887s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[162.826752] Starting subtest: yf-tiled-addfb-size-offset-overflow
[162.829183] Subtest yf-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[162.970938] [019/133] (887s left) gem_exec_nop (basic-parallel)
[163.093059] Starting subtest: basic-parallel
[166.213313] Subtest basic-parallel: SUCCESS (3.120s)
[166.491856] [020/133] (883s left) sysfs_heartbeat_interval (invalid)
[166.603043] Starting subtest: invalid
[166.605427] Starting dynamic subtest: vecs0
[166.610111] Dynamic subtest vecs0: SUCCESS (0.001s)
[166.636295] Starting dynamic subtest: vcs0
[166.637878] Dynamic subtest vcs0: SUCCESS (0.001s)
[166.658993] Starting dynamic subtest: bcs0
[166.660853] Dynamic subtest bcs0: SUCCESS (0.001s)
[166.680926] Starting dynamic subtest: rcs0
[166.682310] Dynamic subtest rcs0: SUCCESS (0.004s)
[166.684243] Subtest invalid: SUCCESS (0.015s)
[166.766447] [021/133] (883s left) gem_exec_create (forked)
[166.889120] Starting subtest: forked
[166.890436] Starting dynamic subtest: smem
[186.955160] Dynamic subtest smem: SUCCESS (20.068s)
[186.957066] Subtest forked: SUCCESS (20.070s)
[187.207663] [022/133] (863s left) kms_draw_crc (draw-method-mmap-wc)
[187.388064] Starting subtest: draw-method-mmap-wc
[187.391166] Starting dynamic subtest: xrgb8888-untiled
[187.850904] Dynamic subtest xrgb8888-untiled: SUCCESS (0.465s)
[187.870288] Starting dynamic subtest: rgb565-untiled
[188.098086] Dynamic subtest rgb565-untiled: SUCCESS (0.246s)
[188.118991] Starting dynamic subtest: xrgb2101010-untiled
[188.368151] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.265s)
[188.390712] Starting dynamic subtest: xbgr16161616f-untiled
[188.633782] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.264s)
[188.654235] Starting dynamic subtest: xrgb8888-xtiled
[188.816897] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.183s)
[188.836151] Starting dynamic subtest: rgb565-xtiled
[188.998310] Dynamic subtest rgb565-xtiled: SUCCESS (0.179s)
[189.017999] Starting dynamic subtest: xrgb2101010-xtiled
[189.167416] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.163s)
[189.186988] Starting dynamic subtest: xbgr16161616f-xtiled
[189.352161] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.182s)
[189.370973] Starting dynamic subtest: xrgb8888-ytiled
[189.533395] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.183s)
[189.552251] Starting dynamic subtest: rgb565-ytiled
[189.717484] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[189.736387] Starting dynamic subtest: xrgb2101010-ytiled
[189.886161] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.163s)
[189.904915] Starting dynamic subtest: xbgr16161616f-ytiled
[190.048622] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.166s)
[190.050153] Subtest draw-method-mmap-wc: SUCCESS (2.664s)
[190.326032] [023/133] (860s left) kms_flip (modeset-vs-vblank-race-interruptible)
[190.528178] Starting subtest: modeset-vs-vblank-race-interruptible
[190.531950] Starting dynamic subtest: A-HDMI-A1
[193.289580] Dynamic subtest A-HDMI-A1: SUCCESS (2.756s)
[193.324082] Starting dynamic subtest: B-HDMI-A1
[195.770423] Dynamic subtest B-HDMI-A1: SUCCESS (2.474s)
[195.810286] Starting dynamic subtest: C-HDMI-A1
[198.283395] Dynamic subtest C-HDMI-A1: SUCCESS (2.508s)
[198.312995] Starting dynamic subtest: A-HDMI-A2
[200.791613] Dynamic subtest A-HDMI-A2: SUCCESS (2.505s)
[200.828208] Starting dynamic subtest: B-HDMI-A2
[203.214933] Dynamic subtest B-HDMI-A2: SUCCESS (2.416s)
[203.260215] Starting dynamic subtest: C-HDMI-A2
[205.609408] Dynamic subtest C-HDMI-A2: SUCCESS (2.388s)
[205.610563] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (15.079s)
[206.133674] [024/133] (844s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[206.713964] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[207.002221] [025/133] (843s left) kms_plane_multiple (2x-tiling-y)
[207.182078] Starting subtest: 2x-tiling-y
[207.193065] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[208.288280] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.100s)
[208.330291] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[209.439876] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.128s)
[209.497386] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[210.711985] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.251s)
[210.765064] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[211.849616] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.114s)
[211.909333] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[213.294765] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.424s)
[213.354252] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[214.415792] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.099s)
[214.476403] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[215.727697] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.291s)
[215.784104] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[216.797498] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.030s)
[216.852220] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[217.930918] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.111s)
[217.989325] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[219.030894] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.075s)
[219.100498] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[220.450862] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.380s)
[220.493083] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[221.519492] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.047s)
[221.541140] Subtest 2x-tiling-y: SUCCESS (14.353s)
[222.266552] [026/133] (828s left) gem_ctx_isolation (preservation-s3)
[222.403034] Starting subtest: preservation-S3
[222.407143] Starting dynamic subtest: rcs0