[57.430146] Initializing watchdogs
[57.430196]   /dev/watchdog0
[57.444959] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.449716] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.452198] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.454110] [001/132] (960s left) prime_mmap (test_forked)
[57.507282] Starting subtest: test_forked
[57.508193] Starting dynamic subtest: test_forked-smem
[57.546990] Dynamic subtest test_forked-smem: SUCCESS (0.041s)
[57.547936] Subtest test_forked: SUCCESS (0.042s)
[57.640679] [002/132] (960s left) gem_exec_params (rel-constants-invalid-ring)
[57.690212] Starting subtest: rel-constants-invalid-ring
[57.691306] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[57.781527] [003/132] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[57.866298] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[57.868205] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[57.931942] [004/132] (960s left) api_intel_allocator (two-level-inception)
[57.983134] Starting subtest: two-level-inception
[63.407780] Subtest two-level-inception: SUCCESS (5.404s)
[63.475962] [005/132] (954s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[63.588906] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[63.589818] Starting dynamic subtest: pipe-A-eDP-1
[70.150865] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.575s)
[70.157559] Starting dynamic subtest: pipe-B-eDP-1
[77.155589] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.010s)
[77.156523] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.587s)
[78.032526] [006/132] (940s left) kms_pipe_crc_basic (nonblocking-crc)
[78.129352] Starting subtest: nonblocking-crc
[78.130352] Starting dynamic subtest: pipe-A-eDP-1
[78.879038] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[78.890230] Starting dynamic subtest: pipe-B-eDP-1
[80.269219] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[80.276436] Starting dynamic subtest: pipe-C-eDP-1
[81.653010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[81.658922] Starting dynamic subtest: pipe-D-eDP-1
[82.973893] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[82.974738] Subtest nonblocking-crc: SUCCESS (4.847s)
[83.781430] [007/132] (934s left) kms_color (ctm-0-75)
[83.866876] Starting subtest: ctm-0-75
[83.867735] Starting dynamic subtest: pipe-A-eDP-1
[88.820693] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.953s)
[88.827164] Starting dynamic subtest: pipe-B-eDP-1
[94.469972] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.650s)
[94.476465] Starting dynamic subtest: pipe-C-eDP-1
[99.840807] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.370s)
[99.847811] Starting dynamic subtest: pipe-D-eDP-1
[105.156774] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.316s)
[105.157586] Subtest ctm-0-75: SUCCESS (21.290s)
[105.976567] [008/132] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[106.107944] Starting subtest: basic-flip-before-cursor-legacy
[107.043671] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.934s)
[107.912248] [009/132] (910s left) sriov_basic (enable-vfs-autoprobe-on)
[107.960084] Starting subtest: enable-vfs-autoprobe-on
[107.960905] Starting dynamic subtest: numvfs-1
[107.987606] Dynamic subtest numvfs-1: FAIL (0.009s)
[107.994395] Starting dynamic subtest: numvfs-2
[108.023851] Dynamic subtest numvfs-2: FAIL (0.004s)
[108.030843] Starting dynamic subtest: numvfs-3
[108.056913] Dynamic subtest numvfs-3: FAIL (0.004s)
[108.063417] Starting dynamic subtest: numvfs-4
[108.089199] Dynamic subtest numvfs-4: FAIL (0.004s)
[108.094968] Starting dynamic subtest: numvfs-5
[108.120334] Dynamic subtest numvfs-5: FAIL (0.004s)
[108.126063] Starting dynamic subtest: numvfs-6
[108.151065] Dynamic subtest numvfs-6: FAIL (0.004s)
[108.156627] Starting dynamic subtest: numvfs-7
[108.181807] Dynamic subtest numvfs-7: FAIL (0.004s)
[108.187561] Starting dynamic subtest: numvfs-random
[108.220753] Dynamic subtest numvfs-random: FAIL (0.004s)
[108.226542] Starting dynamic subtest: numvfs-all
[108.251902] Dynamic subtest numvfs-all: FAIL (0.004s)
[108.252689] Subtest enable-vfs-autoprobe-on: FAIL (0.042s)
[108.277748] [010/132] (909s left) perf (blocking)
[108.390819] Starting subtest: blocking
[108.391645] Starting dynamic subtest: 0-rcs0
[118.432308] Dynamic subtest 0-rcs0: SUCCESS (10.021s)
[118.440502] Starting dynamic subtest: 1-vcs1
[128.477867] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[128.478960] Subtest blocking: SUCCESS (20.043s)
[128.504883] [011/132] (889s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[128.606503] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[132.408154] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.802s)
[133.543103] [012/132] (884s left) kms_psr (fbc-psr-suspend)
[133.628175] Starting subtest: fbc-psr-suspend
[133.629033] Starting dynamic subtest: eDP-1
[133.630861] Dynamic subtest eDP-1: SKIP (0.000s)
[133.632473] Subtest fbc-psr-suspend: SKIP (0.001s)
[133.700957] [013/132] (884s left) gem_reg_read (timestamp-monotonic)
[133.753158] Starting subtest: timestamp-monotonic
[138.781515] Subtest timestamp-monotonic: SUCCESS (4.982s)
[138.809170] [014/132] (879s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[138.918304] Starting subtest: x-tiled-16bpp-rotate-270
[138.937865] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[139.033951] [015/132] (879s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[139.084858] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[139.187941] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[139.256505] [016/132] (879s left) gem_render_copy_redux (interruptible)
[139.303229] Starting subtest: interruptible
[139.565915] Subtest interruptible: SUCCESS (0.264s)
[139.675298] [017/132] (878s left) kms_cursor_crc (cursor-random-128x128)
[139.872272] Starting subtest: cursor-random-128x128
[139.875891] Starting dynamic subtest: pipe-A-eDP-1
[143.233312] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.358s)
[143.262808] Starting dynamic subtest: pipe-D-eDP-1
[147.221183] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[147.222040] Subtest cursor-random-128x128: SUCCESS (7.349s)
[148.093191] [018/132] (870s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[148.658489] Starting subtest: syncobj-timeline-invalid-flags
[148.659716] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[150.376669] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[150.378404] [019/132] (868s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[150.466350] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[150.468060] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[150.550769] [020/132] (867s left) gem_exec_fence (syncobj-wait)
[150.957302] Starting subtest: syncobj-wait
[152.359562] Subtest syncobj-wait: SUCCESS (1.394s)
[152.690907] [021/132] (865s left) perf_pmu (busy-idle-check-all)
[152.734825] Starting subtest: busy-idle-check-all
[152.735795] Starting dynamic subtest: rcs0
[153.390759] Dynamic subtest rcs0: SUCCESS (0.655s)
[153.402443] Starting dynamic subtest: bcs0
[154.048016] Dynamic subtest bcs0: SUCCESS (0.655s)
[154.058815] Starting dynamic subtest: vcs0
[155.367509] Dynamic subtest vcs0: SUCCESS (1.308s)
[155.377531] Starting dynamic subtest: vcs1
[157.352285] Dynamic subtest vcs1: SUCCESS (1.982s)
[157.362259] Starting dynamic subtest: vecs0
[159.335596] Dynamic subtest vecs0: SUCCESS (1.981s)
[159.347078] Starting dynamic subtest: ccs0
[159.987272] Dynamic subtest ccs0: SUCCESS (0.658s)
[159.988604] Subtest busy-idle-check-all: SUCCESS (7.252s)
[160.078521] [022/132] (858s left) kms_pm_rpm (modeset-lpsp)
[161.603696] Starting subtest: modeset-lpsp
[163.065279] Subtest modeset-lpsp: SUCCESS (1.463s)
[163.157939] [023/132] (855s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[163.243180] Starting subtest: fbcpsr-shrfb-scaledprimary
[169.009388] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.766s)
[169.153355] [024/132] (849s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[169.252934] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[169.254792] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[169.344052] [025/132] (849s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[169.435236] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[169.436845] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[169.553744] [026/132] (849s left) gem_partial_pwrite_pread (reads)
[169.607754] Subtest reads: SKIP (0.000s)
[169.660620] [027/132] (849s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[171.476809] Starting subtest: dpms-mode-unset-non-lpsp
[172.642183] Subtest dpms-mode-unset-non-lpsp: SKIP (1.166s)
[173.010892] [028/132] (845s left) gem_mmap_gtt (basic-write)
[173.066065] Subtest basic-write: SKIP (0.000s)
[173.126059] [029/132] (845s left) gem_mmap_gtt (basic-copy)
[173.178680] Subtest basic-copy: SKIP (0.000s)
[173.228058] [030/132] (845s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[173.315458] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[173.317341] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[173.402370] [031/132] (845s left) gem_ctx_param (non-root-set)
[173.442582] Starting subtest: non-root-set
[173.462613] Subtest non-root-set: SUCCESS (0.020s)
[173.537795] [032/132] (845s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[173.639385] Starting subtest: flip-vs-cursor-legacy
[181.174760] Subtest flip-vs-cursor-legacy: SUCCESS (7.534s)
[182.024873] [033/132] (836s left) kms_psr (fbc-psr2-sprite-render)
[182.116157] Starting subtest: fbc-psr2-sprite-render
[182.116990] Starting dynamic subtest: eDP-1
[182.118838] Dynamic subtest eDP-1: SKIP (0.000s)
[182.120497] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[182.198768] [034/132] (836s left) kms_cursor_crc (cursor-offscreen-32x32)
[182.334594] Starting subtest: cursor-offscreen-32x32
[182.378733] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[182.660110] [035/132] (836s left) kms_flip (blocking-wf_vblank)
[182.748597] Starting subtest: blocking-wf_vblank
[182.750949] Starting dynamic subtest: A-eDP1
[191.706479] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[191.716642] Starting dynamic subtest: B-eDP1
[200.640100] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[200.648574] Starting dynamic subtest: C-eDP1
[209.574637] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[209.582556] Starting dynamic subtest: D-eDP1
[218.498810] Dynamic subtest D-eDP1: SUCCESS (8.920s)
[218.500189] Subtest blocking-wf_vblank: SUCCESS (35.714s)
[219.685580] [036/132] (799s left) kms_lease (lease-invalid-plane)
[219.778308] Starting subtest: lease-invalid-plane
[219.779205] Starting dynamic subtest: pipe-A-eDP-1
[219.780077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[219.787329] Starting dynamic subtest: pipe-B-eDP-1
[219.788348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[219.795551] Starting dynamic subtest: pipe-C-eDP-1
[219.796422] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[219.803328] Starting dynamic subtest: pipe-D-eDP-1
[219.804242] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[219.805186] Subtest lease-invalid-plane: SUCCESS (0.004s)
[219.847168] [037/132] (799s left) gem_create (create-ext-set-pat)
[220.018200] Starting subtest: create-ext-set-pat
[220.019310] Subtest create-ext-set-pat: SUCCESS (0.001s)
[220.105192] [038/132] (799s left) dmabuf_sync_file (export-before-signal)
[220.139068] Starting subtest: export-before-signal
[220.140082] Subtest export-before-signal: SUCCESS (0.001s)
[220.190925] [039/132] (798s left) gem_softpin (allocator-nopin)
[220.253698] Starting subtest: allocator-nopin
[220.358974] Subtest allocator-nopin: SUCCESS (0.106s)
[220.495047] [040/132] (798s left) gem_wait (busy)
[220.561683] Starting subtest: busy
[220.562702] Starting dynamic subtest: all-engines
[222.302833] Dynamic subtest all-engines: SUCCESS (1.740s)
[222.318093] Starting dynamic subtest: rcs0
[222.846463] Dynamic subtest rcs0: SUCCESS (0.541s)
[222.855981] Starting dynamic subtest: bcs0
[223.387314] Dynamic subtest bcs0: SUCCESS (0.540s)
[223.399446] Starting dynamic subtest: vcs0
[225.321419] Dynamic subtest vcs0: SUCCESS (1.923s)
[225.331142] Starting dynamic subtest: vcs1
[227.303486] Dynamic subtest vcs1: SUCCESS (1.979s)
[227.313066] Starting dynamic subtest: vecs0
[229.351416] Dynamic subtest vecs0: SUCCESS (2.045s)
[229.361253] Starting dynamic subtest: ccs0
[229.884798] Dynamic subtest ccs0: SUCCESS (0.540s)
[229.885892] Subtest busy: SUCCESS (9.323s)
[230.082796] [041/132] (789s left) kms_cdclk (plane-scaling)
[230.178344] Starting subtest: plane-scaling
[230.179216] Starting dynamic subtest: pipe-A-eDP-1
[230.470748] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s)
[230.478439] Starting dynamic subtest: pipe-B-eDP-1
[230.480214] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[230.488804] Starting dynamic subtest: pipe-C-eDP-1
[230.490561] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[230.500876] Starting dynamic subtest: pipe-D-eDP-1
[230.502944] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[230.504759] Subtest plane-scaling: SKIP (0.299s)
[231.321379] [042/132] (787s left) kms_content_protection (atomic-hdcp14)
[231.452585] Starting subtest: atomic-hdcp14
[231.454322] Subtest atomic-hdcp14: SKIP (0.000s)
[231.559222] [043/132] (787s left) gem_ctx_persistence (many-contexts)
[231.612533] Starting subtest: many-contexts
[276.799848] Subtest many-contexts: SUCCESS (45.184s)
[276.873374] [044/132] (742s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[276.963413] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[276.964341] Starting dynamic subtest: pipe-A-eDP-1
[277.837850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s)
[277.845390] Starting dynamic subtest: pipe-B-eDP-1
[279.334311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s)
[279.341335] Starting dynamic subtest: pipe-C-eDP-1
[280.854689] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.519s)
[280.864530] Starting dynamic subtest: pipe-D-eDP-1
[282.402879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s)
[282.403781] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.438s)
[283.547923] [045/132] (735s left) kms_getfb (getfb2-accept-nv12)
[283.630606] Starting subtest: getfb2-accept-nv12
[283.631541] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[283.731280] [046/132] (735s left) api_intel_bb (object-reloc-purge-cache)
[283.773419] Starting subtest: object-reloc-purge-cache
[283.776842] Subtest object-reloc-purge-cache: SKIP (0.002s)
[283.889781] [047/132] (735s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[283.987763] Starting subtest: yf-tiled-64bpp-rotate-90
[283.989559] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[284.073068] [048/132] (735s left) sysfs_preempt_timeout (idempotent)
[284.122246] Starting subtest: idempotent
[284.123160] Starting dynamic subtest: vecs0
[284.123931] Dynamic subtest vecs0: SUCCESS (0.000s)
[284.131211] Starting dynamic subtest: ccs0
[284.131935] Dynamic subtest ccs0: SUCCESS (0.000s)
[284.138700] Starting dynamic subtest: vcs0
[284.139506] Dynamic subtest vcs0: SUCCESS (0.000s)
[284.146091] Starting dynamic subtest: bcs0
[284.146832] Dynamic subtest bcs0: SUCCESS (0.000s)
[284.153560] Starting dynamic subtest: rcs0
[284.154393] Dynamic subtest rcs0: SUCCESS (0.000s)
[284.161157] Starting dynamic subtest: vcs1
[284.161912] Dynamic subtest vcs1: SUCCESS (0.000s)
[284.162692] Subtest idempotent: SUCCESS (0.007s)
[284.194042] [049/132] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[284.283806] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[284.285439] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[284.375095] [050/132] (735s left) kms_vblank (wait-idle-hang)
[284.460267] Starting subtest: wait-idle-hang
[284.461242] Starting dynamic subtest: pipe-A-eDP-1
[311.144486] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.682s)
[311.153407] Starting dynamic subtest: pipe-D-eDP-1
[335.136992] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.989s)
[335.137943] Subtest wait-idle-hang: SUCCESS (50.677s)
[335.983155] [051/132] (683s left) perf (short-reads)
[336.079379] Starting subtest: short-reads
[336.095763] Subtest short-reads: SUCCESS (0.017s)
[336.138559] [052/132] (683s left) kms_flip (2x-busy-flip)
[336.226159] Starting subtest: 2x-busy-flip
[336.236348] Subtest 2x-busy-flip: SKIP (0.011s)
[336.327157] [053/132] (683s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[336.409712] Starting subtest: psr-rgb565-draw-render
[343.396030] Subtest psr-rgb565-draw-render: SUCCESS (6.987s)
[343.515060] [054/132] (676s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[343.619635] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[343.621740] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[343.686825] [055/132] (676s left) kms_frontbuffer_tracking (fbc-2p-rte)
[343.782266] Starting subtest: fbc-2p-rte
[343.783876] Subtest fbc-2p-rte: SKIP (0.000s)
[343.879054] [056/132] (675s left) kms_async_flips (crc-atomic)
[343.974953] Starting subtest: crc-atomic
[344.364191] Starting dynamic subtest: pipe-A-eDP-1
[347.250082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[347.635827] Starting dynamic subtest: pipe-B-eDP-1
[350.587783] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.958s)
[350.967496] Starting dynamic subtest: pipe-C-eDP-1
[353.888389] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.928s)
[354.263214] Starting dynamic subtest: pipe-D-eDP-1
[357.119943] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.874s)
[357.120875] Subtest crc-atomic: SUCCESS (13.147s)
[358.282387] [057/132] (661s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[358.376413] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[358.377397] Starting dynamic subtest: pipe-A-eDP-1
[358.386964] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[358.403549] Starting dynamic subtest: pipe-B-eDP-1
[358.413720] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[358.429964] Starting dynamic subtest: pipe-C-eDP-1
[358.439302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[358.455649] Starting dynamic subtest: pipe-D-eDP-1
[358.465285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[358.467048] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[360.581394] [058/132] (659s left) kms_addfb_basic (unused-handle)
[360.638980] Starting subtest: unused-handle
[360.639969] Subtest unused-handle: SUCCESS (0.000s)
[360.757932] [059/132] (659s left) kms_draw_crc (draw-method-mmap-gtt)
[360.840434] Starting subtest: draw-method-mmap-gtt
[360.842088] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[360.943222] [060/132] (658s left) gem_mmap_offset (bad-extensions)
[360.989266] Starting subtest: bad-extensions
[360.990179] Subtest bad-extensions: SUCCESS (0.000s)
[361.080607] [061/132] (658s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[361.167514] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[361.168372] Starting dynamic subtest: pipe-A-eDP-1
[361.176521] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.188141] Starting dynamic subtest: pipe-B-eDP-1
[361.196672] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.205412] Starting dynamic subtest: pipe-C-eDP-1
[361.213818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.220971] Starting dynamic subtest: pipe-D-eDP-1
[361.229548] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.231213] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[363.349951] [062/132] (656s left) gen9_exec_parse (bb-chained)
[363.399515] Subtest bb-chained: SKIP (0.000s)
[363.470958] [063/132] (656s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[363.583721] Starting subtest: verify-pxp-stale-buf-optout-execution
[364.644251] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.060s)
[364.766566] [064/132] (655s left) gem_userptr_blits (sync-overlap)
[364.829586] Starting subtest: sync-overlap
[364.830536] Subtest sync-overlap: SUCCESS (0.000s)
[364.938622] [065/132] (655s left) kms_async_flips (async-flip-hang)
[365.022107] Starting subtest: async-flip-hang
[365.395699] Starting dynamic subtest: pipe-A-eDP-1
[391.802837] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.403s)
[392.184416] Starting dynamic subtest: pipe-B-eDP-1
[407.867784] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.688s)
[408.258322] Starting dynamic subtest: pipe-C-eDP-1
[423.801372] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.549s)
[424.176795] Starting dynamic subtest: pipe-D-eDP-1
[439.864794] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.693s)
[439.866349] Subtest async-flip-hang: SUCCESS (74.842s)
[441.099763] [066/132] (579s left) gem_exec_schedule (pi-ringfull)
[441.271209] Starting subtest: pi-ringfull
[441.272537] Starting dynamic subtest: rcs0
[441.304291] Dynamic subtest rcs0: SUCCESS (0.034s)
[441.313519] Starting dynamic subtest: bcs0
[441.345412] Dynamic subtest bcs0: SUCCESS (0.032s)
[441.357273] Starting dynamic subtest: vcs0
[441.366939] Dynamic subtest vcs0: SUCCESS (0.029s)
[441.375749] Starting dynamic subtest: vcs1
[441.397414] Dynamic subtest vcs1: SUCCESS (0.030s)
[441.405131] Starting dynamic subtest: vecs0
[441.425287] Dynamic subtest vecs0: SUCCESS (0.027s)
[441.438374] Starting dynamic subtest: ccs0
[441.452648] Dynamic subtest ccs0: SUCCESS (0.026s)
[441.453410] Subtest pi-ringfull: SUCCESS (0.183s)
[441.675579] [067/132] (578s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[441.766979] Starting subtest: y-tiled-16bpp-rotate-90
[441.768642] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[441.858472] [068/132] (578s left) gem_lmem_swapping (heavy-verify-random)
[441.893383] Subtest heavy-verify-random: SKIP (0.000s)
[441.934024] [069/132] (578s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[441.975886] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[442.026452] [070/132] (578s left) gem_exec_schedule (submit-late-slice)
[442.083541] Starting subtest: submit-late-slice
[442.084689] Starting dynamic subtest: rcs0
[442.119603] Dynamic subtest rcs0: SUCCESS (0.036s)
[442.129893] Starting dynamic subtest: bcs0
[442.148951] Dynamic subtest bcs0: SUCCESS (0.028s)
[442.156031] Starting dynamic subtest: vcs0
[442.182223] Dynamic subtest vcs0: SUCCESS (0.032s)
[442.189904] Starting dynamic subtest: vcs1
[442.212490] Dynamic subtest vcs1: SUCCESS (0.030s)
[442.219865] Starting dynamic subtest: vecs0
[442.242570] Dynamic subtest vecs0: SUCCESS (0.029s)
[442.249996] Starting dynamic subtest: ccs0
[442.274853] Dynamic subtest ccs0: SUCCESS (0.031s)
[442.275947] Subtest submit-late-slice: SUCCESS (0.192s)
[443.433764] [071/132] (576s left) gem_mmap (bad-object)
[443.488828] Subtest bad-object: SKIP (0.000s)
[443.552901] [072/132] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[443.638634] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[443.640413] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[443.727306] [073/132] (576s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[443.823596] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[443.825349] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[443.922551] [074/132] (576s left) gem_mmap_gtt (medium-copy-xy)
[443.980984] Subtest medium-copy-XY: SKIP (0.000s)
[444.047253] [075/132] (576s left) syncobj_wait (wait-any-snapshot)
[444.105615] Starting subtest: wait-any-snapshot
[444.187949] Subtest wait-any-snapshot: SUCCESS (0.081s)
[444.272589] [076/132] (576s left) syncobj_timeline (reset-multiple-signaled)
[444.326230] Starting subtest: reset-multiple-signaled
[444.327095] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[444.428880] [077/132] (576s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[444.519329] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[451.973849] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.455s)
[452.103625] [078/132] (568s left) gem_exec_params (invalid-bsd1-flag-on-render)
[452.167660] Starting subtest: invalid-bsd1-flag-on-render
[452.168594] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[452.274852] [079/132] (568s left) kms_invalid_mode (zero-vdisplay)
[452.377271] Starting subtest: zero-vdisplay
[452.378130] Starting dynamic subtest: pipe-A-eDP-1
[452.673820] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[452.683546] Starting dynamic subtest: pipe-B-eDP-1
[452.684405] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[452.692246] Starting dynamic subtest: pipe-C-eDP-1
[452.693126] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[452.702641] Starting dynamic subtest: pipe-D-eDP-1
[452.703488] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[452.704358] Subtest zero-vdisplay: SUCCESS (0.303s)
[453.468417] [080/132] (567s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[453.562743] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[454.630876] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[454.784154] [081/132] (565s left) kms_plane_multiple (tiling-x)
[454.881482] Starting subtest: tiling-x
[454.882427] Starting dynamic subtest: pipe-A-eDP-1
[458.640072] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.758s)
[458.647687] Starting dynamic subtest: pipe-B-eDP-1
[463.144107] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.503s)
[463.151834] Starting dynamic subtest: pipe-C-eDP-1
[467.483745] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.338s)
[467.492698] Starting dynamic subtest: pipe-D-eDP-1
[471.805670] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s)
[471.806523] Subtest tiling-x: SUCCESS (16.925s)
[472.606974] [082/132] (548s left) kms_psr (psr-sprite-plane-onoff)
[472.702272] Starting subtest: psr-sprite-plane-onoff
[472.703116] Starting dynamic subtest: eDP-1
[474.463536] Dynamic subtest eDP-1: SUCCESS (1.761s)
[474.464467] Subtest psr-sprite-plane-onoff: SUCCESS (1.762s)
[475.285250] [083/132] (545s left) i915_drm_fdinfo (memory-info-idle)
[475.324147] Starting subtest: memory-info-idle
[475.324886] Starting dynamic subtest: smem0
[475.378638] Dynamic subtest smem0: SUCCESS (0.054s)
[475.379585] Subtest memory-info-idle: SUCCESS (0.055s)
[475.460912] [084/132] (545s left) i915_selftest (mock)
[479.983805] Starting subtest: mock
[479.985226] Starting dynamic subtest: sanitycheck
[480.660180] Dynamic subtest sanitycheck: SUCCESS (0.676s)
[480.669372] Starting dynamic subtest: shmem
[481.362154] Dynamic subtest shmem: SUCCESS (0.700s)
[481.371654] Starting dynamic subtest: fence
[489.432970] Dynamic subtest fence: SUCCESS (8.068s)
[489.442131] Starting dynamic subtest: scatterlist
[491.118052] Dynamic subtest scatterlist: SUCCESS (1.683s)
[491.127067] Starting dynamic subtest: syncmap
[494.332941] Dynamic subtest syncmap: SUCCESS (3.212s)
[494.340946] Starting dynamic subtest: uncore
[495.037081] Dynamic subtest uncore: SUCCESS (0.702s)
[495.045386] Starting dynamic subtest: ring
[495.735079] Dynamic subtest ring: SUCCESS (0.696s)
[495.743559] Starting dynamic subtest: engine
[496.420305] Dynamic subtest engine: SUCCESS (0.683s)
[496.428778] Starting dynamic subtest: timelines
[500.276718] Dynamic subtest timelines: SUCCESS (3.854s)
[500.285383] Starting dynamic subtest: requests
[503.747046] Dynamic subtest requests: SUCCESS (3.469s)
[503.755823] Starting dynamic subtest: objects
[504.530377] Dynamic subtest objects: SUCCESS (0.782s)
[504.538660] Starting dynamic subtest: phys
[505.392931] Dynamic subtest phys: SUCCESS (0.862s)
[505.403542] Starting dynamic subtest: dmabuf
[506.173994] Dynamic subtest dmabuf: SUCCESS (0.779s)
[506.182539] Starting dynamic subtest: vma
[512.184562] Dynamic subtest vma: SUCCESS (6.008s)
[512.193135] Starting dynamic subtest: evict
[513.581644] Dynamic subtest evict: SUCCESS (1.395s)
[513.587713] Starting dynamic subtest: gtt
[517.065586] Dynamic subtest gtt: SUCCESS (3.483s)
[517.074516] Starting dynamic subtest: hugepages
[517.983707] Dynamic subtest hugepages: SUCCESS (0.917s)
[517.992891] Starting dynamic subtest: memory_region
[520.591983] Dynamic subtest memory_region: SUCCESS (2.606s)
[520.593127] Subtest mock: SUCCESS (40.609s)
[520.613213] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[520.614108] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[520.615787] [085/132] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[522.202045] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[522.203994] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[522.323785] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[522.325216] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)] new: kernel.kmod_is_loaded.i915: true
[522.328337] [086/132] (498s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[522.419014] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[522.430405] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[522.500672] [087/132] (498s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[522.581273] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[522.582107] Starting dynamic subtest: pipe-A
[522.667997] Dynamic subtest pipe-A: SUCCESS (0.087s)
[522.677792] Starting dynamic subtest: pipe-B
[523.850374] Dynamic subtest pipe-B: SUCCESS (1.180s)
[523.859642] Starting dynamic subtest: pipe-C
[524.955679] Dynamic subtest pipe-C: SUCCESS (1.104s)
[524.962375] Starting dynamic subtest: pipe-D
[526.100349] Dynamic subtest pipe-D: SUCCESS (1.144s)
[526.102417] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.521s)
[527.233182] [088/132] (493s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[527.364252] Starting subtest: 2x-long-cursor-vs-flip-atomic
[527.367160] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[527.502197] [089/132] (493s left) syncobj_wait (invalid-reset-illegal-handle)
[527.559836] Starting subtest: invalid-reset-illegal-handle
[527.560717] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[527.680418] [090/132] (493s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[527.769042] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[527.770838] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[527.865036] [091/132] (493s left) prime_vgem (basic-fence-mmap)
[527.949477] Starting subtest: basic-fence-mmap
[527.951828] Subtest basic-fence-mmap: SKIP (0.000s)
[528.034773] [092/132] (492s left) kms_cursor_legacy (torture-bo)
[528.149551] Starting subtest: torture-bo
[528.150459] Starting dynamic subtest: pipe-A
[534.041665] Dynamic subtest pipe-A: SUCCESS (5.844s)
[534.052383] Starting dynamic subtest: pipe-B
[540.549262] Dynamic subtest pipe-B: SUCCESS (6.542s)
[540.557762] Starting dynamic subtest: pipe-C
[547.504021] Dynamic subtest pipe-C: SUCCESS (6.952s)
[547.513473] Starting dynamic subtest: pipe-D
[555.405227] Dynamic subtest pipe-D: SUCCESS (7.898s)
[555.414887] Starting dynamic subtest: all-pipes
[562.003244] Dynamic subtest all-pipes: SUCCESS (6.604s)
[562.004407] Subtest torture-bo: SUCCESS (33.851s)
[562.151947] [093/132] (458s left) gem_ctx_exec (basic-norecovery)
[562.206831] Starting subtest: basic-norecovery
[562.379364] Subtest basic-norecovery: SUCCESS (0.172s)
[562.509898] [094/132] (458s left) gem_mmap_wc (pf-nonblock)
[562.560082] Subtest pf-nonblock: SKIP (0.000s)
[562.616205] [095/132] (458s left) kms_chamelium_hpd (hdmi-hpd)
[562.981917] Subtest hdmi-hpd: SKIP (0.000s)
[563.747616] [096/132] (457s left) gem_userptr_blits (usage-restrictions)
[563.800036] Starting subtest: usage-restrictions
[563.800934] Subtest usage-restrictions: SUCCESS (0.000s)
[563.921122] [097/132] (457s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[563.971757] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[563.972772] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[564.050512] [098/132] (457s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[564.138727] Starting subtest: fbcpsr-slowdraw
[589.521876] Subtest fbcpsr-slowdraw: SUCCESS (25.383s)
[589.640268] [099/132] (431s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[589.743562] Starting subtest: psr-2p-primscrn-spr-indfb-move
[589.745363] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[589.846940] [100/132] (431s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[589.943462] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[589.945226] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[590.036867] [101/132] (431s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[590.125329] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[590.127113] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[590.217071] [102/132] (431s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[590.314890] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[590.316571] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[590.395345] [103/132] (430s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[590.440845] Subtest tiled-to-tiled: SKIP (0.000s)
[590.504657] [104/132] (430s left) i915_pm_rpm (system-suspend-execbuf)
[592.540842] Starting subtest: system-suspend-execbuf
[651.999708] Subtest system-suspend-execbuf: SUCCESS (44.036s)
[652.374054] [105/132] (369s left) gem_barrier_race (remote-request)
[652.450192] Starting subtest: remote-request
[652.451300] Starting dynamic subtest: rcs0
[657.642025] Dynamic subtest rcs0: SUCCESS (5.187s)
[657.643062] Subtest remote-request: SUCCESS (5.188s)
[657.794594] [106/132] (363s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[657.847002] Subtest writes-after-reads: SKIP (0.000s)
[657.922390] [107/132] (363s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[658.022043] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[662.717933] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.697s)
[663.888843] [108/132] (357s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[663.981136] Starting subtest: 4-tiled-8bpp-rotate-270
[664.003824] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[664.137047] [109/132] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[664.223168] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[664.224836] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[664.320485] [110/132] (357s left) kms_chamelium_edid (dp-edid-read)
[664.686336] Subtest dp-edid-read: SKIP (0.000s)
[665.478657] [111/132] (356s left) kms_plane (plane-panning-bottom-right)
[665.571699] Starting subtest: plane-panning-bottom-right
[665.572589] Starting dynamic subtest: pipe-A
[667.246302] Dynamic subtest pipe-A: SUCCESS (1.673s)
[667.257516] Starting dynamic subtest: pipe-B
[669.556143] Dynamic subtest pipe-B: SUCCESS (2.308s)
[669.556964] Subtest plane-panning-bottom-right: SUCCESS (3.986s)
[670.364205] [112/132] (351s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[670.455978] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[670.456921] Starting dynamic subtest: pipe-A-eDP-1
[670.466562] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[670.475635] Starting dynamic subtest: pipe-B-eDP-1
[670.485663] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[670.494438] Starting dynamic subtest: pipe-C-eDP-1
[670.503897] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[670.511901] Starting dynamic subtest: pipe-D-eDP-1
[670.521650] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[670.523137] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[672.622784] [113/132] (349s left) gem_exec_balancer (bonded-chain)
[672.675298] Starting subtest: bonded-chain
[679.747341] Subtest bonded-chain: SUCCESS (7.064s)
[680.068043] [114/132] (341s left) kms_universal_plane (universal-plane-functional)
[680.169109] Starting subtest: universal-plane-functional
[680.170008] Starting dynamic subtest: pipe-A-eDP-1
[684.110990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.942s)
[684.120070] Starting dynamic subtest: pipe-B-eDP-1
[688.595857] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.485s)
[688.604322] Starting dynamic subtest: pipe-C-eDP-1
[692.926075] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.330s)
[692.937252] Starting dynamic subtest: pipe-D-eDP-1
[697.323903] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.397s)
[697.324645] Subtest universal-plane-functional: SUCCESS (17.161s)
[698.221787] [115/132] (323s left) syncobj_wait (wait-for-submit-snapshot)
[698.282874] Starting subtest: wait-for-submit-snapshot
[698.366376] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[698.451481] [116/132] (323s left) i915_hangman (engine-error-state-capture)
[698.522865] Starting subtest: engine-error-state-capture
[698.523650] Starting dynamic subtest: rcs0
[701.806300] Dynamic subtest rcs0: SUCCESS (3.274s)
[701.814765] Starting dynamic subtest: bcs0
[707.823174] Dynamic subtest bcs0: SUCCESS (6.016s)
[707.834685] Starting dynamic subtest: vcs0
[712.812678] Dynamic subtest vcs0: SUCCESS (4.985s)
[712.824021] Starting dynamic subtest: vcs1
[718.765418] Dynamic subtest vcs1: SUCCESS (5.948s)
[718.776808] Starting dynamic subtest: vecs0
[723.757201] Dynamic subtest vecs0: SUCCESS (4.987s)
[723.768054] Starting dynamic subtest: ccs0
[728.813564] Dynamic subtest ccs0: SUCCESS (5.052s)
[728.814734] Subtest engine-error-state-capture: SUCCESS (30.279s)
[728.938742] [117/132] (292s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[729.044394] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[730.001973] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.957s)
[730.119341] [118/132] (291s left) gem_ctx_shared (exec-single-timeline)
[730.184458] Starting subtest: exec-single-timeline
[730.185396] Starting dynamic subtest: rcs0
[731.243374] Dynamic subtest rcs0: SUCCESS (1.047s)
[731.255192] Starting dynamic subtest: bcs0
[732.332862] Dynamic subtest bcs0: SUCCESS (1.087s)
[732.343297] Starting dynamic subtest: vcs0
[733.420088] Dynamic subtest vcs0: SUCCESS (1.084s)
[733.432065] Starting dynamic subtest: vcs1
[734.508653] Dynamic subtest vcs1: SUCCESS (1.085s)
[734.520339] Starting dynamic subtest: vecs0
[735.597420] Dynamic subtest vecs0: SUCCESS (1.085s)
[735.610443] Starting dynamic subtest: ccs0
[736.684671] Dynamic subtest ccs0: SUCCESS (1.085s)
[736.685950] Subtest exec-single-timeline: SUCCESS (6.491s)
[736.875603] [119/132] (285s left) kms_psr (fbc-psr2-basic)
[736.975159] Starting subtest: fbc-psr2-basic
[736.976164] Starting dynamic subtest: eDP-1
[736.978100] Dynamic subtest eDP-1: SKIP (0.000s)
[736.979802] Subtest fbc-psr2-basic: SKIP (0.001s)
[737.044669] [120/132] (284s left) gem_exec_whisper (basic-contexts-forked)
[737.109160] Starting subtest: basic-contexts-forked
[762.488486] Subtest basic-contexts-forked: SUCCESS (25.331s)
[762.631097] [121/132] (259s left) kms_rotation_crc (sprite-rotation-90)
[762.718099] Starting subtest: sprite-rotation-90
[762.719879] Subtest sprite-rotation-90: SKIP (0.001s)
[762.795920] [122/132] (259s left) kms_cursor_edge_walk (256x256-top-bottom)
[762.887131] Starting subtest: 256x256-top-bottom
[762.888000] Starting dynamic subtest: pipe-A-eDP-1
[766.371640] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[766.382863] Starting dynamic subtest: pipe-D-eDP-1
[769.496760] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[769.497573] Subtest 256x256-top-bottom: SUCCESS (6.611s)
[770.303429] [123/132] (251s left) gem_ringfill (basic-all)
[775.887215] Starting subtest: basic-all
[777.060491] Subtest basic-all: SUCCESS (1.171s)
[777.200004] [124/132] (244s left) gem_exec_balancer (parallel-keep-in-fence)
[777.461400] Starting subtest: parallel-keep-in-fence
[778.623227] Subtest parallel-keep-in-fence: SUCCESS (1.164s)
[778.713890] [125/132] (243s left) prime_self_import (basic-with_fd_dup)
[778.746138] Starting subtest: basic-with_fd_dup
[778.773566] Subtest basic-with_fd_dup: SUCCESS (0.028s)
[778.871563] [126/132] (243s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[778.964432] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[778.966210] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[779.053265] [127/132] (243s left) syncobj_timeline (invalid-query-zero-handles)
[779.107586] Starting subtest: invalid-query-zero-handles
[779.108657] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[779.193908] [128/132] (243s left) gem_eio (in-flight-internal-immediate)
[779.429934] Starting subtest: in-flight-internal-immediate
[780.956828] Subtest in-flight-internal-immediate: SUCCESS (1.527s)
[781.095878] [129/132] (241s left) syncobj_timeline (wait-all-snapshot)
[781.150195] Starting subtest: wait-all-snapshot
[781.231953] Subtest wait-all-snapshot: SUCCESS (0.081s)
[781.304445] [130/132] (241s left) kms_psr (psr2-sprite-plane-move)
[781.388404] Starting subtest: psr2-sprite-plane-move
[781.389247] Starting dynamic subtest: eDP-1
[783.132677] Dynamic subtest eDP-1: SUCCESS (1.744s)
[783.133537] Subtest psr2-sprite-plane-move: SUCCESS (1.745s)
[783.965884] [131/132] (238s left) kms_vrr (max-min)
[784.066064] Starting subtest: max-min
[784.068930] Subtest max-min: SKIP (0.000s)
[784.134531] [132/132] (238s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[784.222535] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[784.224426] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[784.313783] Closing watchdogs
results: parsing output: 0/ for test: prime_mmap
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: api_intel_allocator
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: sriov_basic
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_reg_read
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_render_copy_redux
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: gem_exec_fence
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_pm_rpm
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: gem_mmap_gtt
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_ctx_param
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: gem_softpin
results: parsing output: 39/ for test: gem_wait
results: parsing output: 40/ for test: kms_cdclk
results: parsing output: 41/ for test: kms_content_protection
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: sysfs_preempt_timeout
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_draw_crc
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: kms_async_flips
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_mmap
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_exec_params
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_plane_multiple
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: i915_selftest
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: prime_vgem
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_ctx_exec
results: parsing output: 93/ for test: gem_mmap_wc
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: gem_set_tiling_vs_blt
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: gem_barrier_race
results: parsing output: 105/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_edid
results: parsing output: 110/ for test: kms_plane
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: kms_universal_plane
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: i915_hangman
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: kms_cursor_edge_walk
results: parsing output: 122/ for test: gem_ringfill
results: parsing output: 123/ for test: gem_exec_balancer
results: parsing output: 124/ for test: prime_self_import
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_vrr
results: parsing output: 131/ for test: kms_psr2_sf
Done.