[97.472323] Initializing watchdogs
[97.472496]   /dev/watchdog0
[97.510234] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[97.523949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[97.530432] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[97.535647] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[97.733546] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[97.738018] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[97.910122] [002/133] (960s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[98.075358] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[98.154312] [003/133] (960s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[98.350068] Starting subtest: dp-mst-type-0-suspend-resume
[98.352144] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[98.510221] [004/133] (959s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[98.603545] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[98.711747] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.107s)
[98.862727] [005/133] (959s left) syncobj_wait (wait-for-submit-complex)
[98.955622] Starting subtest: wait-for-submit-complex
[99.021902] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[99.185541] [006/133] (959s left) drm_buddy (drm_buddy)
[99.275715] Starting subtest: drm_buddy
[99.278584] Subtest drm_buddy: SKIP (0.002s)
[99.421112] [007/133] (959s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[99.584894] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[99.585918] Starting dynamic subtest: pipe-A
[103.279054] Dynamic subtest pipe-A: SKIP (3.692s)
[103.293406] Starting dynamic subtest: pipe-B
[106.807248] Dynamic subtest pipe-B: SKIP (3.525s)
[106.821329] Starting dynamic subtest: pipe-C
[110.348087] Dynamic subtest pipe-C: SKIP (3.537s)
[110.350025] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (10.760s)
[110.831362] [008/133] (947s left) syncobj_timeline (wait-all-for-submit-complex)
[110.980306] Starting subtest: wait-all-for-submit-complex
[111.193541] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[111.346812] [009/133] (947s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[111.441386] Starting subtest: invalid-multi-wait-all-unsubmitted
[111.443537] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[111.596807] [010/133] (947s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[111.775127] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[114.227408] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.454s)
[114.514770] [011/133] (944s left) gem_exec_schedule (preempt-queue-chain)
[114.645041] Starting subtest: preempt-queue-chain
[114.646841] Starting dynamic subtest: rcs0
[115.035199] Dynamic subtest rcs0: SUCCESS (0.384s)
[115.054813] Starting dynamic subtest: bcs0
[115.422581] Dynamic subtest bcs0: SUCCESS (0.387s)
[115.440349] Starting dynamic subtest: vcs0
[115.842120] Dynamic subtest vcs0: SUCCESS (0.418s)
[115.862854] Starting dynamic subtest: vecs0
[116.240513] Dynamic subtest vecs0: SUCCESS (0.391s)
[116.241988] Subtest preempt-queue-chain: SUCCESS (1.594s)
[116.649355] [012/133] (942s left) prime_vgem (basic-write)
[116.832021] Starting subtest: basic-write
[116.912957] Subtest basic-write: SUCCESS (0.083s)
[117.070987] [FACT prime_vgem (basic-write)] new: kernel.kmod_is_loaded.vgem: true
[117.076172] [013/133] (941s left) kms_prop_blob (blob-prop-core)
[117.168919] Starting subtest: blob-prop-core
[117.170077] Subtest blob-prop-core: SUCCESS (0.000s)
[117.325013] [014/133] (941s left) kms_cursor_crc (cursor-random-32x32)
[117.493413] Starting subtest: cursor-random-32x32
[117.635727] Subtest cursor-random-32x32: SKIP (0.140s)
[117.825424] [015/133] (941s left) i915_query (query-topology-unsupported)
[117.917340] Starting subtest: query-topology-unsupported
[117.919366] Subtest query-topology-unsupported: SKIP (0.000s)
[118.075485] [016/133] (941s left) kms_pm_rpm (basic-pci-d3-state)
[119.964792] Starting subtest: basic-pci-d3-state
[120.263889] Subtest basic-pci-d3-state: SUCCESS (0.299s)
[120.575500] [017/133] (938s left) perf_pmu (module-unload)
[120.700327] Starting subtest: module-unload
[125.934199] Subtest module-unload: FAIL (5.207s)
[125.992210] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[125.994915] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true
[125.999593] [018/133] (933s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[128.405318] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[128.407316] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[128.614426] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[128.617197] [FACT kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)] new: kernel.kmod_is_loaded.i915: true
[128.623987] [019/133] (930s left) gem_exec_fence (basic-busy)
[128.870274] Starting subtest: basic-busy
[128.871960] Starting dynamic subtest: rcs0
[128.914133] Dynamic subtest rcs0: SUCCESS (0.041s)
[128.930845] Starting dynamic subtest: bcs0
[128.940148] Dynamic subtest bcs0: SUCCESS (0.023s)
[128.955911] Starting dynamic subtest: vcs0
[128.964218] Dynamic subtest vcs0: SUCCESS (0.021s)
[128.980559] Starting dynamic subtest: vecs0
[128.992278] Dynamic subtest vecs0: SUCCESS (0.025s)
[128.993441] Subtest basic-busy: SUCCESS (0.122s)
[129.694824] [020/133] (929s left) kms_psr (pr-sprite-render)
[129.862882] Subtest pr-sprite-render: SKIP (0.000s)
[129.967399] [021/133] (929s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[130.137532] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[130.142468] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[130.306670] [022/133] (929s left) gem_spin_batch (engines)
[130.423528] Starting subtest: engines
[130.424601] Starting dynamic subtest: rcs0
[133.662733] Dynamic subtest rcs0: SUCCESS (3.236s)
[133.680077] Starting dynamic subtest: bcs0
[136.898105] Dynamic subtest bcs0: SUCCESS (3.234s)
[136.917144] Starting dynamic subtest: vcs0
[140.135770] Dynamic subtest vcs0: SUCCESS (3.233s)
[140.152283] Starting dynamic subtest: vecs0
[143.372102] Dynamic subtest vecs0: SUCCESS (3.234s)
[143.373188] Subtest engines: SUCCESS (12.951s)
[143.657157] [023/133] (916s left) gem_exec_flush (basic-wb-rw-before-default)
[143.773380] Starting subtest: basic-wb-rw-before-default
[149.215638] Subtest basic-wb-rw-before-default: SUCCESS (5.443s)
[149.499483] [024/133] (910s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[149.680120] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[149.681946] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[149.874999] [025/133] (910s left) i915_pm_freq_api (freq-reset-multiple)
[149.979265] Subtest freq-reset-multiple: SKIP (0.000s)
[150.083320] [026/133] (909s left) gem_mmap_wc (pf-nonblock)
[150.173450] Starting subtest: pf-nonblock
[150.178157] Subtest pf-nonblock: SUCCESS (0.005s)
[150.325620] [027/133] (909s left) gem_userptr_blits (access-control)
[150.469791] Starting subtest: access-control
[150.472321] Subtest access-control: SKIP (0.000s)
[150.665542] [028/133] (909s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[150.833332] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[150.835210] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.000s)
[150.990306] [029/133] (909s left) syncobj_timeline (invalid-signal-illegal-handle)
[151.087067] Starting subtest: invalid-signal-illegal-handle
[151.088187] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[151.259252] [030/133] (909s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[151.442127] Starting subtest: fbc-1p-pri-indfb-multidraw
[168.353600] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (16.913s)
[168.668962] [031/133] (891s left) kms_force_connector_basic (force-edid)
[168.926762] Starting subtest: force-edid
[169.068835] Subtest force-edid: SUCCESS (0.152s)
[169.405680] [032/133] (891s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[170.038628] Starting subtest: syncobj-timeline-multiple-ext-nodes
[170.042942] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[170.322093] [033/133] (890s left) kms_atomic (test-only)
[170.483768] Starting subtest: test-only
[170.757983] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.658771] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.897s)
[171.659899] Subtest test-only: SUCCESS (1.174s)
[171.960145] [034/133] (888s left) i915_pm_rc6_residency (rc6-fence)
[172.053460] Starting subtest: rc6-fence
[172.066235] Starting dynamic subtest: gt0
[187.320344] Dynamic subtest gt0: SUCCESS (15.256s)
[187.324342] Subtest rc6-fence: SUCCESS (15.271s)
[187.466464] [035/133] (873s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[187.652310] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[187.655797] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[187.826691] [036/133] (873s left) gem_mmap_gtt (basic-copy)
[187.919169] Starting subtest: basic-copy
[188.697194] Subtest basic-copy: SUCCESS (0.779s)
[188.881962] [037/133] (872s left) gem_ctx_engines (independent)
[188.999773] Starting subtest: independent
[189.000848] Starting dynamic subtest: rcs0
[189.177357] Dynamic subtest rcs0: SUCCESS (0.178s)
[189.199903] Starting dynamic subtest: bcs0
[189.383240] Dynamic subtest bcs0: SUCCESS (0.203s)
[189.404065] Starting dynamic subtest: vcs0
[189.553960] Dynamic subtest vcs0: SUCCESS (0.165s)
[189.572128] Starting dynamic subtest: vecs0
[189.720858] Dynamic subtest vecs0: SUCCESS (0.166s)
[189.741061] Starting dynamic subtest: all-engines
[190.136264] Dynamic subtest all-engines: SUCCESS (0.412s)
[190.139675] Subtest independent: SUCCESS (1.140s)
[190.448394] [038/133] (870s left) kms_big_fb (linear-16bpp-rotate-180)
[190.631966] Starting subtest: linear-16bpp-rotate-180
[195.326436] Subtest linear-16bpp-rotate-180: SUCCESS (4.694s)
[195.758829] [039/133] (865s left) perf (oa-exponents)
[195.969597] Starting subtest: oa-exponents
[195.973068] Starting dynamic subtest: 0-rcs0
[199.996753] Dynamic subtest 0-rcs0: SUCCESS (4.023s)
[199.998146] Subtest oa-exponents: SUCCESS (4.026s)
[200.101633] [040/133] (861s left) kms_pm_rpm (modeset-lpsp-stress)
[201.882428] Starting subtest: modeset-lpsp-stress
[202.080662] Subtest modeset-lpsp-stress: SKIP (0.196s)
[202.452910] [041/133] (858s left) gem_media_vme
[202.651828] [042/133] (858s left) kms_psr (fbc-pr-sprite-plane-move)
[202.820337] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[202.917613] [043/133] (858s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[203.095680] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[203.097769] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[203.287241] [044/133] (858s left) gem_ctx_shared (q-out-order)
[203.402198] Starting subtest: Q-out-order
[203.403299] Starting dynamic subtest: rcs0
[203.494123] Dynamic subtest rcs0: SUCCESS (0.090s)
[203.518521] Starting dynamic subtest: bcs0
[203.587989] Dynamic subtest bcs0: SUCCESS (0.090s)
[203.614446] Starting dynamic subtest: vcs0
[203.672415] Dynamic subtest vcs0: SUCCESS (0.079s)
[203.696458] Starting dynamic subtest: vecs0
[203.756799] Dynamic subtest vecs0: SUCCESS (0.081s)
[203.759152] Subtest Q-out-order: SUCCESS (0.356s)
[204.076153] [045/133] (857s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[204.257377] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[206.807584] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SUCCESS (2.552s)
[207.062472] [046/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[207.244181] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[207.246140] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[207.435907] [047/133] (854s left) kms_chamelium_audio (dp-audio-edid)
[207.970227] Subtest dp-audio-edid: SKIP (0.000s)
[208.208056] [048/133] (853s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[208.393030] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[209.993684] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.599s)
[210.259346] [049/133] (851s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[210.448108] Starting subtest: yf-tiled-8bpp-rotate-90
[210.450457] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[210.608484] [050/133] (851s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[210.772335] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[210.774188] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[210.942171] [051/133] (851s left) prime_mmap_coherency (write)
[211.044839] Starting subtest: write
[216.462169] Subtest write: SUCCESS (5.417s)
[216.925097] [052/133] (845s left) kms_cursor_crc (cursor-dpms)
[217.099927] Starting subtest: cursor-dpms
[217.101870] Starting dynamic subtest: pipe-A-HDMI-A-1
[218.769207] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.664s)
[218.789917] Starting dynamic subtest: pipe-C-HDMI-A-1
[220.138680] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.363s)
[220.139721] Subtest cursor-dpms: SUCCESS (3.038s)
[220.476879] [053/133] (841s left) gem_exec_reloc (basic-cpu-active)
[220.581500] Starting subtest: basic-cpu-active
[220.722475] Subtest basic-cpu-active: SUCCESS (0.141s)
[220.960854] [054/133] (841s left) kms_cursor_crc (cursor-suspend)
[221.130272] Starting subtest: cursor-suspend
[221.134560] Starting dynamic subtest: pipe-A-HDMI-A-1