[45.737695] Initializing watchdogs
[45.737750]   /dev/watchdog0
[45.765536] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.770947] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.773725] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.775594] [001/133] (960s left) syncobj_basic (bad-pad-fd-to-handle)
[45.813196] Starting subtest: bad-pad-fd-to-handle
[45.813929] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[45.878325] [002/133] (960s left) gem_ctx_persistence (engines-hang)
[45.918115] Starting subtest: engines-hang
[45.918860] Starting dynamic subtest: rcs0
[45.962581] Dynamic subtest rcs0: SUCCESS (0.044s)
[45.975789] Starting dynamic subtest: bcs0
[46.001602] Dynamic subtest bcs0: SUCCESS (0.038s)
[46.014915] Starting dynamic subtest: vcs0
[46.048435] Dynamic subtest vcs0: SUCCESS (0.046s)
[46.063079] Starting dynamic subtest: vcs1
[46.091447] Dynamic subtest vcs1: SUCCESS (0.042s)
[46.105602] Starting dynamic subtest: vecs0
[46.133450] Dynamic subtest vecs0: SUCCESS (0.041s)
[46.134482] Subtest engines-hang: SUCCESS (0.215s)
[46.211174] [003/133] (960s left) gem_exec_whisper (basic-fds-forked)
[46.253220] Starting subtest: basic-fds-forked
[49.393206] Subtest basic-fds-forked: SUCCESS (3.154s)
[49.558302] [004/133] (956s left) gem_exec_flush (basic-wb-rw-default)
[49.599516] Starting subtest: basic-wb-rw-default
[54.911343] Subtest basic-wb-rw-default: SUCCESS (5.429s)
[55.123956] [005/133] (951s left) kms_psr (psr-sprite-mmap-gtt)
[55.210213] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[55.250553] [006/133] (951s left) kms_async_flips (test-cursor-atomic)
[55.333318] Starting subtest: test-cursor-atomic
[55.461313] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.553895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.094s)
[55.679130] Starting dynamic subtest: pipe-B-HDMI-A-1
[55.758619] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.086s)
[55.878765] Starting dynamic subtest: pipe-C-HDMI-A-1
[55.939147] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.068s)
[56.052387] Starting dynamic subtest: pipe-D-HDMI-A-1
[56.111675] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.066s)
[56.112405] Subtest test-cursor-atomic: SUCCESS (0.789s)
[56.354941] [007/133] (950s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[56.393189] Starting subtest: invalid-single-wait-all-unsubmitted
[56.393943] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[56.456189] [008/133] (950s left) kms_properties (invalid-properties-atomic)
[56.540211] Starting subtest: invalid-properties-atomic
[57.107127] Subtest invalid-properties-atomic: SUCCESS (0.565s)
[57.164666] [009/133] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[57.251438] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[57.252860] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[57.347857] [010/133] (949s left) gem_ctx_persistence (many-contexts)
[57.384143] Starting subtest: many-contexts
[96.891198] Subtest many-contexts: SUCCESS (39.575s)
[96.944452] [011/133] (909s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[97.030226] Starting subtest: disable-crc-after-crtc
[97.030901] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.381767] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.350s)
[97.389450] Starting dynamic subtest: pipe-B-HDMI-A-1
[97.709100] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.325s)
[97.717290] Starting dynamic subtest: pipe-C-HDMI-A-1
[98.031180] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.320s)
[98.039192] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.381824] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.349s)
[98.382524] Subtest disable-crc-after-crtc: SUCCESS (1.352s)
[98.563503] [012/133] (908s left) gem_exec_suspend (basic-s3-devices)
[98.607746] Starting subtest: basic-S3-devices
[98.608436] Starting dynamic subtest: smem
[105.605841] Dynamic subtest smem: SUCCESS (6.998s)
[105.606547] Subtest basic-S3-devices: SUCCESS (6.998s)
[114.844694] [013/133] (900s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[114.952047] Starting subtest: y-tiled-8bpp-rotate-180
[115.964429] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.012s)
[116.103541] [014/133] (899s left) kms_prop_blob (blob-prop-lifetime)
[116.137288] Starting subtest: blob-prop-lifetime
[116.138086] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[116.196351] [015/133] (899s left) kms_big_fb (linear-16bpp-rotate-180)
[116.291739] Starting subtest: linear-16bpp-rotate-180
[117.706378] Subtest linear-16bpp-rotate-180: SUCCESS (1.414s)
[117.834094] [016/133] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[117.924322] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[119.239698] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.316s)
[119.355573] [017/133] (896s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[119.442281] Starting subtest: basic-flip-after-cursor-varying-size
[119.947759] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.505s)
[120.078048] [018/133] (895s left) kms_feature_discovery (chamelium)
[120.166363] Starting subtest: chamelium
[120.167821] Subtest chamelium: SKIP (0.000s)
[120.224647] [019/133] (895s left) gem_bad_reloc (negative-reloc-bltcopy)
[120.274011] Starting subtest: negative-reloc-bltcopy
[121.344083] Subtest negative-reloc-bltcopy: SUCCESS (1.074s)
[121.457628] [020/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[121.547473] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[121.548835] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[121.647623] [021/133] (894s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[121.731742] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[121.733141] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[121.783341] [022/133] (894s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[121.868910] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[121.870282] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[121.925038] [023/133] (894s left) gem_mmap_gtt (big-bo-tiledx)
[121.957335] Starting subtest: big-bo-tiledX
[122.332073] Subtest big-bo-tiledX: SUCCESS (0.375s)
[122.430889] [024/133] (893s left) gen9_exec_parse (bb-oversize)
[122.525909] Subtest bb-oversize: SKIP (0.000s)
[122.563411] [025/133] (893s left) kms_rotation_crc (sprite-rotation-180)
[122.649585] Starting subtest: sprite-rotation-180
[126.129893] Subtest sprite-rotation-180: SUCCESS (3.480s)
[126.303456] [026/133] (889s left) kms_cursor_legacy (single-bo)
[126.393473] Starting subtest: single-bo
[126.394173] Starting dynamic subtest: pipe-A
[131.807860] Dynamic subtest pipe-A: SUCCESS (5.380s)
[131.815165] Starting dynamic subtest: pipe-B
[137.186682] Dynamic subtest pipe-B: SUCCESS (5.378s)
[137.194280] Starting dynamic subtest: pipe-C
[142.565234] Dynamic subtest pipe-C: SUCCESS (5.378s)
[142.572739] Starting dynamic subtest: pipe-D
[147.943906] Dynamic subtest pipe-D: SUCCESS (5.378s)
[147.951064] Starting dynamic subtest: all-pipes
[153.323795] Dynamic subtest all-pipes: SUCCESS (5.379s)
[153.324567] Subtest single-bo: SUCCESS (26.896s)
[153.357456] [027/133] (862s left) gem_wait (invalid-buf)
[153.395687] Starting subtest: invalid-buf
[153.396392] Subtest invalid-buf: SUCCESS (0.000s)
[153.603898] [028/133] (862s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[153.694477] Starting subtest: psr-rgb101010-draw-blt
[153.695838] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[153.790624] [029/133] (862s left) gem_pipe_control_store_loop (reused-buffer)
[153.827476] Starting subtest: reused-buffer
[155.987810] Subtest reused-buffer: SUCCESS (2.151s)
[156.077685] [030/133] (860s left) kms_addfb_basic (unused-offsets)
[156.111065] Starting subtest: unused-offsets
[156.111763] Subtest unused-offsets: SUCCESS (0.000s)
[156.246963] [031/133] (860s left) dmabuf_sync_file (import-basic)
[156.333277] Starting subtest: import-basic
[156.333994] Subtest import-basic: SUCCESS (0.002s)
[156.380125] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[156.382676] [032/133] (860s left) syncobj_timeline (etime-multi-wait-all-submitted)
[156.416911] Starting subtest: etime-multi-wait-all-submitted
[156.519738] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[156.594776] [033/133] (859s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[156.682465] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[156.683815] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[156.763923] [034/133] (859s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[156.847476] Starting subtest: flip-vs-cursor-busy-crc-atomic
[157.254794] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.407s)
[157.404781] [035/133] (859s left) kms_async_flips (async-flip-suspend-resume)
[157.491746] Starting subtest: async-flip-suspend-resume
[157.624383] Starting dynamic subtest: pipe-A-HDMI-A-1
[175.485611] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.331s)
[175.619757] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.469378] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.231s)
[193.586030] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.461540] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.260s)
[211.582303] Starting dynamic subtest: pipe-D-HDMI-A-1
[229.467202] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.236s)
[229.467994] Subtest async-flip-suspend-resume: SUCCESS (9.532s)
[237.733909] [036/133] (786s left) kms_cursor_crc (cursor-sliding-64x64)
[237.826138] Starting subtest: cursor-sliding-64x64
[237.831286] Starting dynamic subtest: pipe-A-HDMI-A-1
[239.628962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.849s)
[239.665891] Starting dynamic subtest: pipe-D-HDMI-A-1
[241.428283] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.811s)
[241.429000] Subtest cursor-sliding-64x64: SUCCESS (3.694s)
[241.569446] [037/133] (783s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[241.656678] Starting subtest: plane-all-modeset-transition-internal-panels
[241.658003] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[241.714687] [038/133] (783s left) gen7_exec_parse (basic-allocation)
[241.751567] Subtest basic-allocation: SKIP (0.000s)
[241.789886] [039/133] (782s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[241.874104] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[241.875545] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[241.933809] [040/133] (782s left) gem_lmem_swapping (massive)
[241.970690] Subtest massive: SKIP (0.000s)
[242.011997] [041/133] (782s left) kms_psr (pr-sprite-plane-onoff)
[242.097028] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[242.135252] [042/133] (782s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[242.168338] Starting subtest: invalid-signal-one-illegal-handle
[242.169029] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[242.232349] [043/133] (782s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[242.319851] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[242.321278] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[242.410908] [044/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[242.497630] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[242.499062] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[242.589303] [045/133] (782s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[242.727920] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[242.820085] [046/133] (782s left) gem_exec_params (invalid-fence-in-submit)
[242.867795] Starting subtest: invalid-fence-in-submit
[242.870437] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[242.976507] [047/133] (782s left) gem_partial_pwrite_pread (writes-after-reads-display)
[243.014006] Starting subtest: writes-after-reads-display
[255.248567] Subtest writes-after-reads-display: SUCCESS (12.334s)
[255.350545] [048/133] (769s left) gem_exec_balancer (parallel-bb-first)
[255.510140] Subtest parallel-bb-first: SKIP (0.000s)
[255.604755] [049/133] (769s left) syncobj_timeline (signal)
[255.638397] Starting subtest: signal
[255.639102] Subtest signal: SUCCESS (0.000s)
[255.701655] [050/133] (769s left) kms_plane_scaling (invalid-parameters)
[255.796760] Starting subtest: invalid-parameters
[255.797446] Starting dynamic subtest: less-than-1-height-src
[255.812357] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[255.820709] Starting dynamic subtest: less-than-1-width-src
[255.827026] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[255.827729] Subtest invalid-parameters: SUCCESS (0.031s)
[255.923400] [051/133] (769s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[256.010166] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[256.051971] [052/133] (769s left) gem_media_vme
[256.133961] [053/133] (769s left) i915_drm_fdinfo (isolation)
[256.170108] Starting subtest: isolation
[256.170831] Starting dynamic subtest: rcs0
[256.690257] Dynamic subtest rcs0: SUCCESS (0.521s)
[256.702158] Starting dynamic subtest: bcs0
[257.214249] Dynamic subtest bcs0: SUCCESS (0.524s)
[257.225955] Starting dynamic subtest: vcs0
[257.736217] Dynamic subtest vcs0: SUCCESS (0.521s)
[257.746963] Starting dynamic subtest: vcs1
[258.259126] Dynamic subtest vcs1: SUCCESS (0.524s)
[258.270916] Starting dynamic subtest: vecs0
[258.783362] Dynamic subtest vecs0: SUCCESS (0.524s)
[258.784464] Subtest isolation: SUCCESS (2.621s)
[258.873363] [054/133] (766s left) gem_spin_batch (spin-each)
[258.916060] Starting subtest: spin-each
[262.274527] Subtest spin-each: SUCCESS (3.349s)
[262.437820] [055/133] (762s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[262.528507] Starting subtest: fbcpsr-suspend
[262.529868] Subtest fbcpsr-suspend: SKIP (0.000s)
[262.607064] [056/133] (762s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[262.645132] Starting subtest: writes-after-reads
[263.673042] Subtest writes-after-reads: SUCCESS (1.029s)
[263.775034] [057/133] (761s left) fbdev (info)
[263.806493] Starting subtest: info
[263.807194] Subtest info: SUCCESS (0.000s)
[263.865716] [058/133] (761s left) kms_cursor_crc (cursor-onscreen-32x10)
[263.952433] Starting subtest: cursor-onscreen-32x10
[264.004984] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[264.093595] [059/133] (761s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[264.187770] Starting subtest: x-tiled-32bpp-rotate-0
[265.452580] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.266s)
[265.578880] [060/133] (760s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[265.673704] Starting subtest: fbcpsr-modesetfrombusy
[265.675062] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[265.801999] [061/133] (759s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[265.885863] Starting subtest: flip-vs-cursor-crc-atomic
[266.194384] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.308s)
[266.337753] [062/133] (759s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[266.806404] Starting subtest: syncobj-stationary-timeline-chain-engines
[266.867678] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.070s)
[267.053193] [063/133] (758s left) syncobj_wait (wait-all-delayed-signal)
[267.086926] Starting subtest: wait-all-delayed-signal
[267.188974] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[267.274189] [064/133] (758s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[267.360072] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[267.362098] Starting dynamic subtest: pipe-A-HDMI-A-1
[267.368948] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[267.379822] Starting dynamic subtest: pipe-B-HDMI-A-1
[267.386714] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[267.397142] Starting dynamic subtest: pipe-C-HDMI-A-1
[267.403963] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[267.413880] Starting dynamic subtest: pipe-D-HDMI-A-1
[267.420854] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[267.422196] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[267.603084] [065/133] (758s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[267.639743] Starting subtest: single-wait-all-for-submit-available-signaled
[267.640455] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[267.699349] [066/133] (758s left) sriov_basic (enable-vfs-autoprobe-on)
[267.734722] Starting subtest: enable-vfs-autoprobe-on
[267.735386] Starting dynamic subtest: numvfs-1
[267.808589] Dynamic subtest numvfs-1: FAIL (0.062s)
[267.816990] Starting dynamic subtest: numvfs-2
[267.858433] Dynamic subtest numvfs-2: FAIL (0.048s)
[267.866802] Starting dynamic subtest: numvfs-3
[267.900837] Dynamic subtest numvfs-3: FAIL (0.041s)
[267.909174] Starting dynamic subtest: numvfs-4
[267.942924] Dynamic subtest numvfs-4: FAIL (0.041s)
[267.951271] Starting dynamic subtest: numvfs-5
[267.984869] Dynamic subtest numvfs-5: FAIL (0.041s)
[267.993310] Starting dynamic subtest: numvfs-6
[268.026952] Dynamic subtest numvfs-6: FAIL (0.041s)
[268.035469] Starting dynamic subtest: numvfs-7
[268.069188] Dynamic subtest numvfs-7: FAIL (0.041s)
[268.077591] Starting dynamic subtest: numvfs-random
[268.111879] Dynamic subtest numvfs-random: FAIL (0.041s)
[268.120297] Starting dynamic subtest: numvfs-all
[268.154095] Dynamic subtest numvfs-all: FAIL (0.041s)
[268.154777] Subtest enable-vfs-autoprobe-on: FAIL (0.407s)
[268.207772] [067/133] (757s left) kms_vblank (ts-continuation-idle)
[268.293481] Starting subtest: ts-continuation-idle
[268.294227] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.468222] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.174s)
[268.482249] Starting dynamic subtest: pipe-D-HDMI-A-1
[268.616968] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.144s)
[268.617770] Subtest ts-continuation-idle: SUCCESS (0.324s)
[268.786343] [068/133] (757s left) i915_suspend (basic-s3-without-i915)
[268.821087] Starting subtest: basic-s3-without-i915