[44.986307] Initializing watchdogs
[44.986379]   /dev/watchdog0
[45.001828] [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.008060] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.010542] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.012671] [001/133] (960s left) syncobj_basic (bad-pad-fd-to-handle)
[45.049457] Starting subtest: bad-pad-fd-to-handle
[45.050155] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[45.100920] [002/133] (960s left) gem_ctx_persistence (engines-hang)
[45.141143] Starting subtest: engines-hang
[45.141876] Starting dynamic subtest: rcs0
[45.180517] Dynamic subtest rcs0: SUCCESS (0.039s)
[45.194439] Starting dynamic subtest: bcs0
[45.226958] Dynamic subtest bcs0: SUCCESS (0.046s)
[45.233469] Starting dynamic subtest: vcs0
[45.254010] Dynamic subtest vcs0: SUCCESS (0.027s)
[45.260318] Starting dynamic subtest: vcs1
[45.288597] Dynamic subtest vcs1: SUCCESS (0.034s)
[45.302104] Starting dynamic subtest: vecs0
[45.336747] Dynamic subtest vecs0: SUCCESS (0.047s)
[45.338149] Subtest engines-hang: SUCCESS (0.196s)
[45.413520] [003/133] (960s left) gem_exec_whisper (basic-fds-forked)
[45.455535] Starting subtest: basic-fds-forked
[48.732697] Subtest basic-fds-forked: SUCCESS (3.268s)
[48.906684] [004/133] (956s left) gem_exec_flush (basic-wb-rw-default)
[48.950182] Starting subtest: basic-wb-rw-default
[54.375416] Subtest basic-wb-rw-default: SUCCESS (5.425s)
[54.580347] [005/133] (951s left) kms_psr (psr-sprite-mmap-gtt)
[54.669154] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[54.705961] [006/133] (951s left) kms_async_flips (test-cursor-atomic)
[54.790569] Starting subtest: test-cursor-atomic
[54.910276] Starting dynamic subtest: pipe-A-HDMI-A-1
[55.003557] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.093s)
[55.137016] Starting dynamic subtest: pipe-B-HDMI-A-1
[55.208567] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.077s)
[55.342548] Starting dynamic subtest: pipe-C-HDMI-A-1
[55.412452] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.077s)
[55.528050] Starting dynamic subtest: pipe-D-HDMI-A-1
[55.591347] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.069s)
[55.592121] Subtest test-cursor-atomic: SUCCESS (0.801s)
[55.844978] [007/133] (949s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[55.882409] Starting subtest: invalid-single-wait-all-unsubmitted
[55.883123] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[55.944211] [008/133] (949s left) kms_properties (invalid-properties-atomic)
[56.028241] Starting subtest: invalid-properties-atomic
[56.600564] Subtest invalid-properties-atomic: SUCCESS (0.564s)
[56.655311] [009/133] (949s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[56.742594] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[56.744055] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[56.835778] [010/133] (949s left) gem_ctx_persistence (many-contexts)
[56.872463] Starting subtest: many-contexts
[95.882104] Subtest many-contexts: SUCCESS (39.002s)
[95.938361] [011/133] (909s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[96.026485] Starting subtest: disable-crc-after-crtc
[96.028149] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.404182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.377s)
[96.411870] Starting dynamic subtest: pipe-B-HDMI-A-1
[96.705334] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.299s)
[96.715148] Starting dynamic subtest: pipe-C-HDMI-A-1
[97.019169] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.312s)
[97.027475] Starting dynamic subtest: pipe-D-HDMI-A-1
[97.358477] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.338s)
[97.359229] Subtest disable-crc-after-crtc: SUCCESS (1.333s)
[97.502304] [012/133] (908s left) gem_exec_suspend (basic-s3-devices)
[97.552792] Starting subtest: basic-S3-devices
[97.553493] Starting dynamic subtest: smem
[104.517698] Dynamic subtest smem: SUCCESS (6.954s)
[104.520178] Subtest basic-S3-devices: SUCCESS (6.954s)
[112.726968] [013/133] (901s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[112.838365] Starting subtest: y-tiled-8bpp-rotate-180
[113.877662] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.039s)
[113.997375] [014/133] (900s left) kms_prop_blob (blob-prop-lifetime)
[114.029851] Starting subtest: blob-prop-lifetime
[114.030562] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[114.086512] [015/133] (899s left) kms_big_fb (linear-16bpp-rotate-180)
[114.180712] Starting subtest: linear-16bpp-rotate-180
[115.319218] Subtest linear-16bpp-rotate-180: SUCCESS (1.138s)
[115.450515] [016/133] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[115.540470] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[116.869176] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.329s)
[116.987692] [017/133] (897s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[117.073283] Starting subtest: basic-flip-after-cursor-varying-size
[117.583212] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.510s)
[117.712474] [018/133] (896s left) kms_feature_discovery (chamelium)
[117.801500] Starting subtest: chamelium
[117.802893] Subtest chamelium: SKIP (0.000s)
[117.853550] [019/133] (896s left) gem_bad_reloc (negative-reloc-bltcopy)
[117.890434] Starting subtest: negative-reloc-bltcopy
[118.992288] Subtest negative-reloc-bltcopy: SUCCESS (1.092s)
[119.121713] [020/133] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[119.212794] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[119.214174] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.299360] [021/133] (894s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[119.388235] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[119.389659] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[119.443749] [022/133] (894s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[119.526755] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[119.528182] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[119.578247] [023/133] (894s left) gem_mmap_gtt (big-bo-tiledx)
[119.611266] Starting subtest: big-bo-tiledX
[119.897408] Subtest big-bo-tiledX: SUCCESS (0.286s)
[120.058577] [024/133] (894s left) gen9_exec_parse (bb-oversize)
[120.143328] Subtest bb-oversize: SKIP (0.000s)
[120.182815] [025/133] (894s left) kms_rotation_crc (sprite-rotation-180)
[120.270829] Starting subtest: sprite-rotation-180
[123.760229] Subtest sprite-rotation-180: SUCCESS (3.490s)
[123.933746] [026/133] (890s left) kms_cursor_legacy (single-bo)
[124.022423] Starting subtest: single-bo
[124.023130] Starting dynamic subtest: pipe-A
[129.436205] Dynamic subtest pipe-A: SUCCESS (5.380s)
[129.443454] Starting dynamic subtest: pipe-B
[134.814124] Dynamic subtest pipe-B: SUCCESS (5.378s)
[134.821541] Starting dynamic subtest: pipe-C
[140.192302] Dynamic subtest pipe-C: SUCCESS (5.378s)
[140.199525] Starting dynamic subtest: pipe-D
[145.570941] Dynamic subtest pipe-D: SUCCESS (5.378s)
[145.578167] Starting dynamic subtest: all-pipes
[150.925473] Dynamic subtest all-pipes: SUCCESS (5.379s)
[150.926193] Subtest single-bo: SUCCESS (26.896s)
[150.980814] [027/133] (863s left) gem_wait (invalid-buf)
[151.020873] Starting subtest: invalid-buf
[151.021588] Subtest invalid-buf: SUCCESS (0.000s)
[151.225582] [028/133] (863s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[151.315718] Starting subtest: psr-rgb101010-draw-blt
[151.317157] Subtest psr-rgb101010-draw-blt: SKIP (0.000s)
[151.410606] [029/133] (863s left) gem_pipe_control_store_loop (reused-buffer)
[151.447588] Starting subtest: reused-buffer
[153.607257] Subtest reused-buffer: SUCCESS (2.151s)
[153.701873] [030/133] (860s left) kms_addfb_basic (unused-offsets)
[153.735204] Starting subtest: unused-offsets
[153.735988] Subtest unused-offsets: SUCCESS (0.000s)
[153.884702] [031/133] (860s left) dmabuf_sync_file (import-basic)
[153.985119] Starting subtest: import-basic
[153.986746] Subtest import-basic: SUCCESS (0.002s)
[154.068427] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[154.070317] [032/133] (860s left) syncobj_timeline (etime-multi-wait-all-submitted)
[154.103704] Starting subtest: etime-multi-wait-all-submitted
[154.207663] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[154.282221] [033/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[154.369489] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[154.370883] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[154.450143] [034/133] (860s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[154.542736] Starting subtest: flip-vs-cursor-busy-crc-atomic
[154.925466] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.383s)
[155.083268] [035/133] (859s left) kms_async_flips (async-flip-suspend-resume)
[155.171894] Starting subtest: async-flip-suspend-resume
[155.287039] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.967244] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.360s)
[173.096339] Starting dynamic subtest: pipe-B-HDMI-A-1
[190.926617] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.265s)
[191.074692] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.929939] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.248s)
[209.048843] Starting dynamic subtest: pipe-D-HDMI-A-1
[226.919865] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.249s)
[226.920630] Subtest async-flip-suspend-resume: SUCCESS (9.607s)
[235.151335] [036/133] (787s left) kms_cursor_crc (cursor-sliding-64x64)
[235.243686] Starting subtest: cursor-sliding-64x64
[235.248257] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.076304] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.827s)
[237.109483] Starting dynamic subtest: pipe-D-HDMI-A-1
[238.908906] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.805s)
[238.909666] Subtest cursor-sliding-64x64: SUCCESS (3.664s)
[239.062010] [037/133] (783s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[239.151912] Starting subtest: plane-all-modeset-transition-internal-panels
[239.153272] Subtest plane-all-modeset-transition-internal-panels: SKIP (0.000s)
[239.206711] [038/133] (783s left) gen7_exec_parse (basic-allocation)
[239.243119] Subtest basic-allocation: SKIP (0.000s)
[239.285910] [039/133] (783s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[239.370120] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[239.371473] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[239.430577] [040/133] (783s left) gem_lmem_swapping (massive)
[239.467166] Subtest massive: SKIP (0.000s)
[239.510888] [041/133] (783s left) kms_psr (pr-sprite-plane-onoff)
[239.596289] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[239.640441] [042/133] (783s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[239.674829] Starting subtest: invalid-signal-one-illegal-handle
[239.675565] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[239.734632] [043/133] (783s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[239.824416] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[239.825838] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[239.911769] [044/133] (783s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[240.001146] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[240.002551] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[240.104775] [045/133] (783s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[240.248204] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[240.343684] [046/133] (782s left) gem_exec_params (invalid-fence-in-submit)
[240.382748] Starting subtest: invalid-fence-in-submit
[240.386055] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[240.493500] [047/133] (782s left) gem_partial_pwrite_pread (writes-after-reads-display)
[240.530857] Starting subtest: writes-after-reads-display
[252.748433] Subtest writes-after-reads-display: SUCCESS (12.216s)
[252.854958] [048/133] (770s left) gem_exec_balancer (parallel-bb-first)
[253.017469] Subtest parallel-bb-first: SKIP (0.000s)
[253.093801] [049/133] (770s left) syncobj_timeline (signal)
[253.126442] Starting subtest: signal
[253.127521] Subtest signal: SUCCESS (0.000s)
[253.190235] [050/133] (770s left) kms_plane_scaling (invalid-parameters)
[253.285526] Starting subtest: invalid-parameters
[253.286257] Starting dynamic subtest: less-than-1-height-src
[253.300466] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[253.308458] Starting dynamic subtest: less-than-1-width-src
[253.316138] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[253.316857] Subtest invalid-parameters: SUCCESS (0.031s)
[253.423761] [051/133] (770s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[253.509569] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[253.556489] [052/133] (770s left) gem_media_vme
[253.638877] [053/133] (769s left) i915_drm_fdinfo (isolation)
[253.674239] Starting subtest: isolation
[253.674939] Starting dynamic subtest: rcs0
[254.198947] Dynamic subtest rcs0: SUCCESS (0.524s)
[254.210325] Starting dynamic subtest: bcs0
[254.723805] Dynamic subtest bcs0: SUCCESS (0.523s)
[254.735314] Starting dynamic subtest: vcs0
[255.254297] Dynamic subtest vcs0: SUCCESS (0.529s)
[255.262476] Starting dynamic subtest: vcs1
[255.778572] Dynamic subtest vcs1: SUCCESS (0.523s)
[255.790076] Starting dynamic subtest: vecs0
[256.301917] Dynamic subtest vecs0: SUCCESS (0.520s)
[256.302914] Subtest isolation: SUCCESS (2.627s)
[256.392097] [054/133] (767s left) gem_spin_batch (spin-each)
[256.433569] Starting subtest: spin-each
[259.793435] Subtest spin-each: SUCCESS (3.341s)
[259.954373] [055/133] (763s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[260.043800] Starting subtest: fbcpsr-suspend
[260.045173] Subtest fbcpsr-suspend: SKIP (0.000s)
[260.128332] [056/133] (763s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[260.165547] Starting subtest: writes-after-reads
[261.168962] Subtest writes-after-reads: SUCCESS (1.003s)
[261.270869] [057/133] (762s left) fbdev (info)
[261.302522] Starting subtest: info
[261.303230] Subtest info: SUCCESS (0.000s)
[261.363467] [058/133] (762s left) kms_cursor_crc (cursor-onscreen-32x10)
[261.452066] Starting subtest: cursor-onscreen-32x10
[261.502865] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[261.613535] [059/133] (762s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[261.709598] Starting subtest: x-tiled-32bpp-rotate-0
[262.935230] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.225s)
[263.079899] [060/133] (760s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[263.171044] Starting subtest: fbcpsr-modesetfrombusy
[263.172433] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[263.276130] [061/133] (760s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[263.360133] Starting subtest: flip-vs-cursor-crc-atomic
[263.666317] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.307s)
[263.799965] [062/133] (760s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[264.274674] Starting subtest: syncobj-stationary-timeline-chain-engines
[264.335345] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.071s)
[264.531927] [063/133] (759s left) syncobj_wait (wait-all-delayed-signal)
[264.566002] Starting subtest: wait-all-delayed-signal
[264.668639] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[264.755117] [064/133] (759s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[264.844122] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[264.844824] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.851554] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[264.861698] Starting dynamic subtest: pipe-B-HDMI-A-1
[264.868555] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[264.878467] Starting dynamic subtest: pipe-C-HDMI-A-1
[264.885325] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[264.895020] Starting dynamic subtest: pipe-D-HDMI-A-1
[264.902101] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[264.903500] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[265.098076] [065/133] (759s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[265.132723] Starting subtest: single-wait-all-for-submit-available-signaled
[265.133447] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[265.214408] [066/133] (758s left) sriov_basic (enable-vfs-autoprobe-on)
[265.248330] Starting subtest: enable-vfs-autoprobe-on
[265.249094] Starting dynamic subtest: numvfs-1
[265.279383] Dynamic subtest numvfs-1: FAIL (0.017s)
[265.287449] Starting dynamic subtest: numvfs-2
[265.309235] Dynamic subtest numvfs-2: FAIL (0.006s)
[265.317431] Starting dynamic subtest: numvfs-3
[265.338944] Dynamic subtest numvfs-3: FAIL (0.006s)
[265.347094] Starting dynamic subtest: numvfs-4
[265.369389] Dynamic subtest numvfs-4: FAIL (0.006s)
[265.382685] Starting dynamic subtest: numvfs-5
[265.406447] Dynamic subtest numvfs-5: FAIL (0.006s)
[265.420044] Starting dynamic subtest: numvfs-6
[265.443718] Dynamic subtest numvfs-6: FAIL (0.006s)
[265.457137] Starting dynamic subtest: numvfs-7
[265.480852] Dynamic subtest numvfs-7: FAIL (0.006s)
[265.494404] Starting dynamic subtest: numvfs-random
[265.517770] Dynamic subtest numvfs-random: FAIL (0.006s)
[265.531265] Starting dynamic subtest: numvfs-all
[265.555084] Dynamic subtest numvfs-all: FAIL (0.006s)
[265.555951] Subtest enable-vfs-autoprobe-on: FAIL (0.072s)
[265.594271] [067/133] (758s left) kms_vblank (ts-continuation-idle)
[265.679266] Starting subtest: ts-continuation-idle
[265.680986] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.852855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.172s)
[265.864485] Starting dynamic subtest: pipe-D-HDMI-A-1
[265.994587] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.138s)
[265.995334] Subtest ts-continuation-idle: SUCCESS (0.316s)
[266.139460] [068/133] (758s left) i915_suspend (basic-s3-without-i915)
[266.191553] Starting subtest: basic-s3-without-i915