[60.853797] Initializing watchdogs
[60.853857]   /dev/watchdog0
[60.868370] [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]
[60.872594] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.874901] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.878668] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[61.006087] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[61.010204] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.109764] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[61.211323] Starting subtest: seamless-rr-switch-virtual
[61.217908] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[61.301477] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[61.364528] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[61.425436] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[61.563723] Starting subtest: dp-mst-type-1
[61.568303] Subtest dp-mst-type-1: SKIP (0.000s)
[61.738246] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[61.832598] Starting subtest: master-drop-set-shared-fd
[61.854517] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[61.887183] [006/132] (959s left) i915_selftest (mock)
[65.378565] Starting subtest: mock
[65.380978] Starting dynamic subtest: sanitycheck
[66.125452] Dynamic subtest sanitycheck: SUCCESS (0.750s)
[66.137407] Starting dynamic subtest: shmem
[67.242410] Dynamic subtest shmem: SUCCESS (1.116s)
[67.250308] Starting dynamic subtest: fence
[75.128413] Dynamic subtest fence: SUCCESS (7.887s)
[75.137481] Starting dynamic subtest: scatterlist
[76.905421] Dynamic subtest scatterlist: SUCCESS (1.776s)
[76.914593] Starting dynamic subtest: syncmap
[80.188373] Dynamic subtest syncmap: SUCCESS (3.283s)
[80.197103] Starting dynamic subtest: uncore
[80.911269] Dynamic subtest uncore: SUCCESS (0.723s)
[80.920283] Starting dynamic subtest: ring
[81.621180] Dynamic subtest ring: SUCCESS (0.709s)
[81.630256] Starting dynamic subtest: engine
[82.391183] Dynamic subtest engine: SUCCESS (0.769s)
[82.400041] Starting dynamic subtest: timelines
[86.364571] Dynamic subtest timelines: SUCCESS (3.972s)
[86.373529] Starting dynamic subtest: requests
[89.837060] Dynamic subtest requests: SUCCESS (3.472s)
[89.845699] Starting dynamic subtest: objects
[90.669277] Dynamic subtest objects: SUCCESS (0.832s)
[90.677898] Starting dynamic subtest: phys
[91.552601] Dynamic subtest phys: SUCCESS (0.883s)
[91.560849] Starting dynamic subtest: dmabuf
[92.397489] Dynamic subtest dmabuf: SUCCESS (0.844s)
[92.406044] Starting dynamic subtest: vma
[97.990340] Dynamic subtest vma: SUCCESS (5.593s)
[97.999034] Starting dynamic subtest: evict
[99.522313] Dynamic subtest evict: SUCCESS (1.530s)
[99.531315] Starting dynamic subtest: gtt
[102.806008] Dynamic subtest gtt: SUCCESS (3.283s)
[102.814060] Starting dynamic subtest: hugepages
[103.840056] Dynamic subtest hugepages: SUCCESS (1.033s)
[103.851462] Starting dynamic subtest: memory_region
[106.499583] Dynamic subtest memory_region: SUCCESS (2.657s)
[106.502318] Subtest mock: SUCCESS (41.130s)
[106.531376] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[106.534261] [007/132] (915s left) kms_psr (psr-sprite-plane-onoff)
[108.117780] Starting subtest: psr-sprite-plane-onoff
[108.120139] Starting dynamic subtest: eDP-1
[109.875086] Dynamic subtest eDP-1: SUCCESS (1.758s)
[109.877528] Subtest psr-sprite-plane-onoff: SUCCESS (1.760s)
[110.775377] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[110.778946] [008/132] (910s left) kms_psr (fbc-psr2-basic)
[110.893411] Starting subtest: fbc-psr2-basic
[110.895799] Starting dynamic subtest: eDP-1
[110.900505] Dynamic subtest eDP-1: SKIP (0.000s)
[110.904986] Subtest fbc-psr2-basic: SKIP (0.001s)
[110.987601] [009/132] (910s left) kms_atomic_transition (plane-all-transition-nonblocking)
[111.086732] Starting subtest: plane-all-transition-nonblocking
[111.089107] Starting dynamic subtest: pipe-A-eDP-1
[113.580892] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[113.886236] Starting dynamic subtest: pipe-B-eDP-1
[117.121211] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.243s)
[117.430775] Subtest plane-all-transition-nonblocking: SUCCESS (6.343s)
[118.275089] [010/132] (903s left) kms_fence_pin_leak
[118.446642] [011/132] (903s left) gem_partial_pwrite_pread (writes-after-reads-display)
[118.509531] Subtest writes-after-reads-display: SKIP (0.000s)
[118.572463] [012/132] (903s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[123.525911] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[123.528276] Starting dynamic subtest: pipe-A-eDP-1
[134.974252] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.446s)
[134.982334] Starting dynamic subtest: pipe-B-eDP-1
[146.391059] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.413s)
[146.393422] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.863s)
[147.266244] [013/132] (874s left) gem_mmap_gtt (big-bo-tiledx)
[147.332642] Subtest big-bo-tiledX: SKIP (0.000s)
[147.391686] [014/132] (874s left) kms_fbcon_fbt (psr)
[147.456249] Starting subtest: psr
[154.776282] Subtest psr: SUCCESS (7.316s)
[154.849960] [015/132] (867s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[154.957145] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[154.959464] Starting dynamic subtest: pipe-A-eDP-1
[157.208519] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.252s)
[157.216886] Starting dynamic subtest: pipe-B-eDP-1
[159.646362] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.438s)
[159.654157] Starting dynamic subtest: pipe-C-eDP-1
[161.824697] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.177s)
[161.838433] Starting dynamic subtest: pipe-D-eDP-1
[164.099375] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.274s)
[164.101364] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.145s)
[165.280181] [016/132] (856s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[165.392542] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[165.396760] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[165.506294] [017/132] (856s left) gem_exec_whisper (basic-contexts-all)
[165.569777] Starting subtest: basic-contexts-all
[176.434308] Subtest basic-contexts-all: SUCCESS (10.865s)
[176.637515] [018/132] (845s left) kms_cursor_crc (cursor-size-change)
[176.747206] Starting subtest: cursor-size-change
[176.749438] Starting dynamic subtest: pipe-A-eDP-1
[177.564899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[177.574476] Starting dynamic subtest: pipe-D-eDP-1
[178.997408] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s)
[178.999336] Subtest cursor-size-change: SUCCESS (2.251s)
[179.826943] [019/132] (842s left) kms_lease (lease-revoke)
[179.931039] Starting subtest: lease-revoke
[179.933284] Starting dynamic subtest: pipe-A-eDP-1
[179.960297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[179.970452] Starting dynamic subtest: pipe-B-eDP-1
[179.987692] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[179.996449] Starting dynamic subtest: pipe-C-eDP-1
[180.015291] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[180.024414] Starting dynamic subtest: pipe-D-eDP-1
[180.045377] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[180.047626] Subtest lease-revoke: SUCCESS (0.117s)
[180.203982] [020/132] (841s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[180.269320] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[180.273975] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[180.474381] [021/132] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[180.589830] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[180.594266] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[180.745366] [022/132] (841s left) kms_flip (2x-blocking-wf_vblank)
[180.843355] Starting subtest: 2x-blocking-wf_vblank
[180.852807] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[180.958045] [023/132] (841s left) syncobj_timeline (single-wait-available-submitted)
[181.016605] Starting subtest: single-wait-available-submitted
[181.018881] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[181.161117] [024/132] (841s left) sriov_basic (enable-vfs-bind-unbind-each)
[181.221468] Starting subtest: enable-vfs-bind-unbind-each
[181.223588] Starting dynamic subtest: numvfs-1
[181.303697] Dynamic subtest numvfs-1: FAIL (0.030s)
[181.312135] Starting dynamic subtest: numvfs-2
[181.386769] Dynamic subtest numvfs-2: FAIL (0.004s)
[181.395835] Starting dynamic subtest: numvfs-3
[181.455272] Dynamic subtest numvfs-3: FAIL (0.003s)
[181.463786] Starting dynamic subtest: numvfs-4
[181.524753] Dynamic subtest numvfs-4: FAIL (0.003s)
[181.534233] Starting dynamic subtest: numvfs-5
[181.593868] Dynamic subtest numvfs-5: FAIL (0.004s)
[181.603159] Starting dynamic subtest: numvfs-6
[181.662586] Dynamic subtest numvfs-6: FAIL (0.003s)
[181.672106] Starting dynamic subtest: numvfs-7
[181.734305] Dynamic subtest numvfs-7: FAIL (0.004s)
[181.743138] Starting dynamic subtest: numvfs-random
[181.802337] Dynamic subtest numvfs-random: FAIL (0.003s)
[181.804038] Subtest enable-vfs-bind-unbind-each: FAIL (0.060s)
[181.838297] [025/132] (840s left) api_intel_bb (object-reloc-keep-cache)
[181.901718] Starting subtest: object-reloc-keep-cache
[181.905511] Subtest object-reloc-keep-cache: SKIP (0.003s)
[182.063507] [026/132] (840s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[182.166822] Starting subtest: fbc-psr2-sprite-mmap-gtt
[182.168452] Starting dynamic subtest: eDP-1
[182.171756] Dynamic subtest eDP-1: SKIP (0.000s)
[182.175105] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[182.260292] [027/132] (840s left) gem_exec_nop (basic-parallel)
[182.333653] Starting subtest: basic-parallel
[198.872650] Subtest basic-parallel: SUCCESS (16.546s)
[199.138625] [028/132] (823s left) i915_hangman (gt-engine-error)
[199.202142] Starting subtest: gt-engine-error
[199.204311] Starting dynamic subtest: rcs0
[200.887210] Dynamic subtest rcs0: SUCCESS (1.685s)
[200.899891] Starting dynamic subtest: bcs0
[202.870729] Dynamic subtest bcs0: SUCCESS (1.981s)
[202.884057] Starting dynamic subtest: vcs0
[204.854418] Dynamic subtest vcs0: SUCCESS (1.980s)
[204.865952] Starting dynamic subtest: vcs1
[206.838285] Dynamic subtest vcs1: SUCCESS (1.981s)
[206.850215] Starting dynamic subtest: vecs0
[208.886434] Dynamic subtest vecs0: SUCCESS (2.045s)
[208.897861] Starting dynamic subtest: ccs0
[210.869428] Dynamic subtest ccs0: SUCCESS (1.980s)
[210.872490] Subtest gt-engine-error: SUCCESS (11.669s)
[210.972880] [029/132] (811s left) kms_getfb (getfb-handle-protection)
[211.085998] Starting subtest: getfb-handle-protection
[211.109092] Subtest getfb-handle-protection: SUCCESS (0.023s)
[211.252811] [030/132] (811s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[211.346304] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[211.348672] Starting dynamic subtest: pipe-A-eDP-1
[211.368338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[211.378461] Starting dynamic subtest: pipe-B-eDP-1
[211.397421] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[211.405515] Starting dynamic subtest: pipe-C-eDP-1
[211.424065] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[211.431944] Starting dynamic subtest: pipe-D-eDP-1
[211.450803] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[211.452652] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[213.674644] [031/132] (808s left) gem_pxp (reject-modify-context-protection-off-1)
[213.812056] Starting subtest: reject-modify-context-protection-off-1
[213.814511] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[213.963158] [032/132] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[214.058176] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[221.131165] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.075s)
[221.307397] [033/132] (801s left) api_intel_allocator (alloc-simple)
[221.386710] Starting subtest: alloc-simple
[221.389188] Subtest alloc-simple: SUCCESS (0.004s)
[221.544617] [034/132] (801s left) perf (blocking)
[221.689042] Starting subtest: blocking
[221.691325] Starting dynamic subtest: 0-rcs0
[231.701920] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[231.710812] Starting dynamic subtest: 1-vcs1
[241.723135] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[241.725784] Subtest blocking: SUCCESS (20.033s)
[241.769856] [035/132] (781s left) kms_frontbuffer_tracking (psr-slowdraw)
[241.878260] Starting subtest: psr-slowdraw
[267.123893] Subtest psr-slowdraw: SUCCESS (25.246s)
[267.312797] [036/132] (755s left) gem_mmap (short-mmap)
[267.388097] Subtest short-mmap: SKIP (0.000s)
[267.455720] [037/132] (755s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[267.553256] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[267.555616] Starting dynamic subtest: pipe-A-default-mode
[267.848171] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[267.852782] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.295s)
[268.727212] [038/132] (754s left) kms_invalid_mode (bad-htotal)
[268.826684] Starting subtest: bad-htotal
[268.828925] Starting dynamic subtest: pipe-A-eDP-1
[269.121929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[269.131011] Starting dynamic subtest: pipe-B-eDP-1
[269.132971] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[269.140896] Starting dynamic subtest: pipe-C-eDP-1
[269.143364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[269.151912] Starting dynamic subtest: pipe-D-eDP-1
[269.154273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[269.156619] Subtest bad-htotal: SUCCESS (0.303s)
[269.963313] [039/132] (752s left) gem_exec_alignment (forked)
[270.030376] Starting subtest: forked
[307.454713] Subtest forked: SUCCESS (37.424s)
[307.678035] [040/132] (715s left) kms_psr (pr-cursor-mmap-gtt)
[307.809939] Starting subtest: pr-cursor-mmap-gtt
[307.814165] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[307.902123] [041/132] (715s left) gem_mmap_wc (read-write)
[307.967245] Subtest read-write: SKIP (0.000s)
[308.027492] [042/132] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[308.141167] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[315.570759] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.432s)
[315.718116] [043/132] (707s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[315.818657] Starting subtest: fbc-rgb565-draw-pwrite
[320.485930] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.670s)
[321.690954] [044/132] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[321.800091] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[325.409950] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.614s)
[326.598549] [045/132] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[326.698186] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[326.702642] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[326.837318] [046/132] (696s left) kms_cursor_crc (cursor-offscreen-128x42)
[327.058109] Starting subtest: cursor-offscreen-128x42
[327.094066] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[327.310258] [047/132] (695s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[327.470099] Starting subtest: cursor-rapid-movement-32x10
[327.515791] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[327.811698] [048/132] (695s left) gem_ctx_persistence (legacy-engines-persistence)
[327.873018] Starting subtest: legacy-engines-persistence
[327.875038] Starting dynamic subtest: render
[328.693063] Dynamic subtest render: SUCCESS (0.818s)
[328.706332] Starting dynamic subtest: bsd1
[329.497882] Dynamic subtest bsd1: SUCCESS (0.802s)
[329.509839] Starting dynamic subtest: bsd2
[330.270991] Dynamic subtest bsd2: SUCCESS (0.770s)
[330.283669] Starting dynamic subtest: blt
[331.061224] Dynamic subtest blt: SUCCESS (0.787s)
[331.073788] Starting dynamic subtest: vebox
[331.843967] Dynamic subtest vebox: SUCCESS (0.780s)
[331.846789] Subtest legacy-engines-persistence: SUCCESS (3.971s)
[332.001090] [049/132] (691s left) syncobj_wait (wait-any-complex)
[332.064185] Starting subtest: wait-any-complex
[332.127018] Subtest wait-any-complex: SUCCESS (0.061s)
[332.227930] [050/132] (691s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[332.333816] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[332.338573] Starting dynamic subtest: pipe-A-default-mode
[333.525442] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[333.529850] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.190s)
[333.727631] [051/132] (689s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[333.832961] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[333.835249] Starting dynamic subtest: pipe-A
[333.855025] Dynamic subtest pipe-A: SKIP (0.019s)
[333.866593] Starting dynamic subtest: pipe-B
[333.889072] Dynamic subtest pipe-B: SKIP (0.033s)
[333.901293] Starting dynamic subtest: pipe-C
[333.926246] Dynamic subtest pipe-C: SKIP (0.036s)
[333.935199] Starting dynamic subtest: pipe-D
[333.959805] Dynamic subtest pipe-D: SKIP (0.033s)
[333.963486] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.124s)
[334.088193] [052/132] (689s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[334.184327] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[334.186635] Starting dynamic subtest: pipe-A-eDP-1
[334.209039] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[334.220188] Starting dynamic subtest: pipe-B-eDP-1
[334.241625] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[334.250616] Starting dynamic subtest: pipe-C-eDP-1
[334.272531] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[334.281580] Starting dynamic subtest: pipe-D-eDP-1
[334.304787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[334.308886] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[336.461497] [053/132] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[336.565070] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[336.569348] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[336.696632] [054/132] (686s left) drm_read (empty-nonblock)
[336.870544] Starting subtest: empty-nonblock
[336.872891] Subtest empty-nonblock: SUCCESS (0.000s)
[337.017895] [055/132] (686s left) gem_partial_pwrite_pread (write-display)
[337.084429] Subtest write-display: SKIP (0.000s)
[337.155649] [056/132] (686s left) gem_ctx_param (invalid-size-set)
[337.209761] Starting subtest: invalid-size-set
[337.212067] Subtest invalid-size-set: SUCCESS (0.001s)
[337.354486] [057/132] (686s left) gem_close_race (multigpu-basic-threads)
[337.416918] Starting subtest: multigpu-basic-threads
[337.420622] Subtest multigpu-basic-threads: SKIP (0.000s)
[337.685235] [058/132] (685s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[337.780233] Starting subtest: psr-dirtyfb-ioctl
[337.782103] Starting dynamic subtest: A-eDP-1
[341.736430] Dynamic subtest A-eDP-1: SUCCESS (3.955s)
[341.738727] Subtest psr-dirtyfb-ioctl: SUCCESS (3.957s)
[342.559188] [059/132] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[342.671995] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[343.262581] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[343.477514] [060/132] (680s left) gem_mmap_gtt (zero-extend)
[343.541984] Subtest zero-extend: SKIP (0.000s)
[343.603336] [061/132] (680s left) gem_lmem_swapping (massive-random)
[343.649404] Subtest massive-random: SKIP (0.000s)
[343.693295] [062/132] (680s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[343.792253] Starting subtest: 4-tiled-32bpp-rotate-270
[343.813106] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[343.960055] [063/132] (679s left) kms_plane_alpha_blend (alpha-basic)
[344.060539] Starting subtest: alpha-basic
[344.354571] Starting dynamic subtest: pipe-A-eDP-1
[346.278615] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.923s)
[346.306182] Starting dynamic subtest: pipe-D-eDP-1
[348.950417] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s)
[348.952790] Subtest alpha-basic: SUCCESS (4.888s)
[349.830239] [064/132] (674s left) kms_sequence (get-idle)
[349.939036] Starting subtest: get-idle
[349.941347] Starting dynamic subtest: pipe-A-eDP-1
[351.755699] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.818s)
[351.765442] Starting dynamic subtest: pipe-B-eDP-1
[354.265471] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[354.275540] Starting dynamic subtest: pipe-C-eDP-1
[356.698501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.435s)
[356.709679] Starting dynamic subtest: pipe-D-eDP-1
[359.117836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[359.120256] Subtest get-idle: SUCCESS (9.181s)
[359.937424] [065/132] (664s left) syncobj_wait (multi-wait-all-submitted)
[359.999324] Starting subtest: multi-wait-all-submitted
[360.107996] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[360.204957] [066/132] (663s left) gem_exec_reloc (basic-cpu-read)
[360.265045] Subtest basic-cpu-read: SKIP (0.000s)
[360.354506] [067/132] (663s left) gem_exec_suspend (basic)
[360.415483] Starting subtest: basic
[360.417752] Starting dynamic subtest: smem
[361.881044] Dynamic subtest smem: SUCCESS (1.463s)
[361.883931] Subtest basic: SUCCESS (1.466s)
[362.087298] [068/132] (661s left) gem_exec_balancer (bonded-chain)
[362.154889] Starting subtest: bonded-chain
[369.145043] Subtest bonded-chain: SUCCESS (6.991s)
[369.504530] [069/132] (654s left) gem_ppgtt (shrink-vs-evict-any)
[369.561502] Starting subtest: shrink-vs-evict-any
[374.907557] Subtest shrink-vs-evict-any: SUCCESS (5.344s)
[375.004846] [070/132] (649s left) syncobj_basic (bad-create-flags)
[375.058080] Starting subtest: bad-create-flags
[375.059967] Subtest bad-create-flags: SUCCESS (0.000s)
[375.169228] [071/132] (649s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[375.228877] Starting subtest: etime-single-wait-all-for-submit-submitted
[375.332085] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[375.437862] [072/132] (648s left) kms_flip (2x-flip-vs-fences-interruptible)
[375.551659] Starting subtest: 2x-flip-vs-fences-interruptible
[375.556646] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[375.696559] [073/132] (648s left) gem_softpin (allocator-nopin)
[375.773718] Starting subtest: allocator-nopin
[375.871625] Subtest allocator-nopin: SUCCESS (0.100s)
[376.031798] [074/132] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[376.143643] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[376.147601] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[376.266790] [075/132] (648s left) prime_busy (before)
[376.327088] Starting subtest: before
[376.331914] Starting dynamic subtest: rcs0
[376.376577] Dynamic subtest rcs0: SUCCESS (0.046s)
[376.387477] Starting dynamic subtest: bcs0
[376.440638] Dynamic subtest bcs0: SUCCESS (0.063s)
[376.450750] Starting dynamic subtest: vcs0
[376.480601] Dynamic subtest vcs0: SUCCESS (0.040s)
[376.489734] Starting dynamic subtest: vcs1
[376.520437] Dynamic subtest vcs1: SUCCESS (0.039s)
[376.529567] Starting dynamic subtest: vecs0
[376.560965] Dynamic subtest vecs0: SUCCESS (0.040s)
[376.570071] Starting dynamic subtest: ccs0
[376.602494] Dynamic subtest ccs0: SUCCESS (0.041s)
[376.711861] Subtest before: SUCCESS (0.383s)
[376.810399] [076/132] (647s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[376.920807] Starting subtest: fbc-indfb-scaledprimary
[379.920552] Subtest fbc-indfb-scaledprimary: SUCCESS (3.002s)
[381.134876] [077/132] (643s left) gem_readwrite (read-write)
[381.191751] Subtest read-write: SKIP (0.000s)
[381.256562] [078/132] (643s left) gem_exec_reloc (basic-scanout)
[381.322841] Subtest basic-scanout: SKIP (0.000s)
[381.399664] [079/132] (643s left) gem_ctx_param (invalid-ctx-set)
[381.455042] Starting subtest: invalid-ctx-set
[381.457288] Subtest invalid-ctx-set: SUCCESS (0.001s)
[381.587347] [080/132] (642s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[381.646057] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[381.648332] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[381.776851] [081/132] (642s left) gem_readwrite (beyond-eob)
[381.840607] Subtest beyond-EOB: SKIP (0.000s)
[381.909182] [082/132] (642s left) kms_big_fb (linear-32bpp-rotate-0)
[382.018539] Starting subtest: linear-32bpp-rotate-0
[383.585048] Subtest linear-32bpp-rotate-0: SUCCESS (1.568s)
[383.748943] [083/132] (640s left) gem_mmap_gtt (basic-write)
[383.811432] Subtest basic-write: SKIP (0.000s)
[383.877119] [084/132] (640s left) fbdev (nullptr)
[383.921290] Starting subtest: nullptr
[383.923377] Subtest nullptr: SUCCESS (0.000s)
[384.002724] [085/132] (640s left) syncobj_wait (wait-all-complex)
[384.065539] Starting subtest: wait-all-complex
[384.278486] Subtest wait-all-complex: SUCCESS (0.212s)
[384.378218] [086/132] (640s left) gem_tiled_partial_pwrite_pread (reads)
[384.447827] Subtest reads: SKIP (0.000s)
[384.520874] [087/132] (640s left) syncobj_wait (wait-zero-handles)
[384.577660] Starting subtest: wait-zero-handles
[384.579956] Subtest wait-zero-handles: SUCCESS (0.000s)
[384.705394] [088/132] (640s left) kms_properties (crtc-properties-atomic)
[384.799115] Starting subtest: crtc-properties-atomic
[384.801071] Starting dynamic subtest: pipe-A-eDP-1
[385.243050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[385.254055] Starting dynamic subtest: pipe-B-eDP-1
[386.365420] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s)
[386.375669] Starting dynamic subtest: pipe-C-eDP-1
[387.490409] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[387.501316] Starting dynamic subtest: pipe-D-eDP-1
[388.611056] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[388.613419] Subtest crtc-properties-atomic: SUCCESS (3.814s)
[389.442939] [089/132] (635s left) gem_ctx_persistence (engines-hostile-preempt)
[389.513138] Starting subtest: engines-hostile-preempt
[389.515082] Starting dynamic subtest: rcs0
[389.616189] Dynamic subtest rcs0: SUCCESS (0.105s)
[389.627598] Starting dynamic subtest: bcs0
[389.647426] Dynamic subtest bcs0: SUCCESS (0.030s)
[389.656473] Starting dynamic subtest: vcs0
[390.949353] Dynamic subtest vcs0: SUCCESS (1.299s)
[390.960077] Starting dynamic subtest: vcs1
[392.898688] Dynamic subtest vcs1: SUCCESS (1.947s)
[392.910996] Starting dynamic subtest: vecs0
[394.918506] Dynamic subtest vecs0: SUCCESS (2.018s)
[394.930698] Starting dynamic subtest: ccs0
[394.959408] Dynamic subtest ccs0: SUCCESS (0.039s)
[394.961788] Subtest engines-hostile-preempt: SUCCESS (5.449s)
[395.145755] [090/132] (629s left) syncobj_timeline (multi-wait-all-available-submitted)
[395.202503] Starting subtest: multi-wait-all-available-submitted
[395.204830] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[395.347572] [091/132] (629s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[395.447772] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[395.452313] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[395.584175] [092/132] (629s left) syncobj_wait (single-wait-submitted)
[395.653442] Starting subtest: single-wait-submitted
[395.755094] Subtest single-wait-submitted: SUCCESS (0.103s)
[395.862280] [093/132] (629s left) gem_exec_schedule (preempt-self)
[395.930970] Starting subtest: preempt-self
[395.932939] Starting dynamic subtest: rcs0
[395.943721] Dynamic subtest rcs0: SUCCESS (0.020s)
[395.954696] Starting dynamic subtest: bcs0
[395.961392] Dynamic subtest bcs0: SUCCESS (0.017s)
[395.970108] Starting dynamic subtest: vcs0
[395.978116] Dynamic subtest vcs0: SUCCESS (0.016s)
[395.986979] Starting dynamic subtest: vcs1
[395.994887] Dynamic subtest vcs1: SUCCESS (0.016s)
[396.004040] Starting dynamic subtest: vecs0
[396.012502] Dynamic subtest vecs0: SUCCESS (0.017s)
[396.021451] Starting dynamic subtest: ccs0
[396.033738] Dynamic subtest ccs0: SUCCESS (0.021s)
[396.035621] Subtest preempt-self: SUCCESS (0.111s)
[398.047259] [094/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[398.180597] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[404.861495] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.685s)
[405.038996] [095/132] (620s left) sysfs_preempt_timeout (idempotent)
[405.102662] Starting subtest: idempotent
[405.105331] Starting dynamic subtest: vecs0
[405.107916] Dynamic subtest vecs0: SUCCESS (0.000s)
[405.119703] Starting dynamic subtest: ccs0
[405.121890] Dynamic subtest ccs0: SUCCESS (0.000s)
[405.131072] Starting dynamic subtest: vcs0
[405.133252] Dynamic subtest vcs0: SUCCESS (0.000s)
[405.142233] Starting dynamic subtest: bcs0
[405.144420] Dynamic subtest bcs0: SUCCESS (0.000s)
[405.153621] Starting dynamic subtest: rcs0
[405.156048] Dynamic subtest rcs0: SUCCESS (0.000s)
[405.166712] Starting dynamic subtest: vcs1
[405.168872] Dynamic subtest vcs1: SUCCESS (0.000s)
[405.171062] Subtest idempotent: SUCCESS (0.007s)
[405.239434] [096/132] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[405.336543] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[405.340968] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[405.465310] [097/132] (619s left) kms_atomic (crtc-invalid-params-fence)
[405.560361] Starting subtest: crtc-invalid-params-fence
[405.562816] Starting dynamic subtest: pipe-A-eDP-1
[405.976422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.414s)
[405.978349] Subtest crtc-invalid-params-fence: SUCCESS (0.416s)
[406.816205] [098/132] (618s left) gem_fence_thrash (bo-write-verify-threaded-x)
[406.852365] Starting subtest: bo-write-verify-threaded-x
[406.882052] Subtest bo-write-verify-threaded-x: SKIP (0.026s)
[406.955679] [099/132] (618s left) gem_wait (busy)
[407.028195] Starting subtest: busy
[407.030648] Starting dynamic subtest: all-engines
[408.919587] Dynamic subtest all-engines: SUCCESS (1.889s)
[408.932048] Starting dynamic subtest: rcs0
[409.462306] Dynamic subtest rcs0: SUCCESS (0.541s)
[409.473681] Starting dynamic subtest: bcs0
[410.001992] Dynamic subtest bcs0: SUCCESS (0.539s)
[410.014530] Starting dynamic subtest: vcs0
[411.928092] Dynamic subtest vcs0: SUCCESS (1.923s)
[411.939810] Starting dynamic subtest: vcs1
[413.911058] Dynamic subtest vcs1: SUCCESS (1.981s)
[413.922459] Starting dynamic subtest: vecs0
[415.895963] Dynamic subtest vecs0: SUCCESS (1.983s)
[415.906947] Starting dynamic subtest: ccs0
[416.437147] Dynamic subtest ccs0: SUCCESS (0.540s)
[416.439771] Subtest busy: SUCCESS (9.410s)
[416.658638] [100/132] (608s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[416.765857] Starting subtest: x-tiled-64bpp-rotate-180
[418.365029] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[418.568049] [101/132] (606s left) kms_force_connector_basic (force-edid)
[418.642061] Starting subtest: force-edid
[419.009591] Subtest force-edid: SUCCESS (0.370s)
[419.171977] [102/132] (606s left) gem_ctx_param (basic-default)
[419.236754] Starting subtest: basic-default
[419.239271] Subtest basic-default: SUCCESS (0.000s)
[419.332557] [103/132] (606s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[419.442698] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[419.445373] Starting dynamic subtest: pipe-A-eDP-1
[436.190232] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.326s)
[436.206635] Starting dynamic subtest: pipe-B-eDP-1
[453.175050] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s)
[453.186277] Starting dynamic subtest: pipe-C-eDP-1
[470.140797] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[470.151784] Starting dynamic subtest: pipe-D-eDP-1
[487.118046] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.320s)
[487.120542] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.486s)
[488.345815] [104/132] (537s left) kms_pm_rpm (modeset-stress-extra-wait)
[490.282673] Starting subtest: modeset-stress-extra-wait
[544.590900] Subtest modeset-stress-extra-wait: SUCCESS (54.349s)
[544.702226] [105/132] (480s left) kms_flip (2x-flip-vs-suspend)
[544.800255] Starting subtest: 2x-flip-vs-suspend
[544.811767] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[544.921347] [106/132] (480s left) kms_chamelium_frames (dp-crc-fast)
[545.304007] Subtest dp-crc-fast: SKIP (0.000s)
[546.144645] [107/132] (479s left) intel_hwmon (hwmon-write)
[546.215142] Subtest hwmon-write: SKIP (0.000s)
[546.283215] [108/132] (479s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[546.374831] Starting subtest: psr-rgb101010-draw-render
[553.606373] Subtest psr-rgb101010-draw-render: SUCCESS (7.237s)
[553.742516] [109/132] (472s left) gem_exec_flush (basic-wb-pro-default)
[553.812931] Starting subtest: basic-wb-pro-default
[559.261099] Subtest basic-wb-pro-default: SUCCESS (5.451s)
[559.474870] [110/132] (466s left) kms_prop_blob (invalid-get-prop)
[559.539660] Starting subtest: invalid-get-prop
[559.542060] Subtest invalid-get-prop: SUCCESS (0.000s)
[559.672397] [111/132] (466s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[559.781435] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[566.352353] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.577s)
[566.514070] [112/132] (459s left) kms_plane (plane-position-hole-dpms)
[566.611281] Starting subtest: plane-position-hole-dpms
[567.144269] Starting dynamic subtest: pipe-A-plane-1
[569.477709] Dynamic subtest pipe-A-plane-1: SUCCESS (2.335s)
[569.489502] Starting dynamic subtest: pipe-A-plane-2
[571.873811] Dynamic subtest pipe-A-plane-2: SUCCESS (2.396s)
[571.885144] Starting dynamic subtest: pipe-A-plane-3
[574.281420] Dynamic subtest pipe-A-plane-3: SUCCESS (2.407s)
[574.293056] Starting dynamic subtest: pipe-A-plane-4
[576.691303] Dynamic subtest pipe-A-plane-4: SUCCESS (2.411s)
[576.701568] Starting dynamic subtest: pipe-A-plane-5
[576.716838] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[577.938204] Starting dynamic subtest: pipe-B-plane-1
[580.283570] Dynamic subtest pipe-B-plane-1: SUCCESS (2.354s)
[580.293961] Starting dynamic subtest: pipe-B-plane-2
[582.673516] Dynamic subtest pipe-B-plane-2: SUCCESS (2.390s)
[582.684796] Starting dynamic subtest: pipe-B-plane-3
[585.062535] Dynamic subtest pipe-B-plane-3: SUCCESS (2.380s)
[585.073857] Starting dynamic subtest: pipe-B-plane-4
[587.403428] Dynamic subtest pipe-B-plane-4: SUCCESS (2.332s)
[587.415059] Starting dynamic subtest: pipe-B-plane-5
[587.430178] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[587.432148] Subtest plane-position-hole-dpms: SUCCESS (20.810s)
[588.301108] [113/132] (437s left) perf_pmu (busy-start)
[588.365709] Starting subtest: busy-start
[588.367592] Starting dynamic subtest: rcs0
[590.915193] Dynamic subtest rcs0: SUCCESS (2.544s)
[590.927427] Starting dynamic subtest: bcs0
[593.466297] Dynamic subtest bcs0: SUCCESS (2.544s)
[593.479044] Starting dynamic subtest: vcs0
[597.108235] Dynamic subtest vcs0: SUCCESS (3.631s)
[597.122018] Starting dynamic subtest: vcs1
[601.138861] Dynamic subtest vcs1: SUCCESS (4.023s)
[601.150067] Starting dynamic subtest: vecs0
[605.107204] Dynamic subtest vecs0: SUCCESS (3.961s)
[605.120581] Starting dynamic subtest: ccs0
[607.656162] Dynamic subtest ccs0: SUCCESS (2.546s)
[607.658647] Subtest busy-start: SUCCESS (19.264s)
[607.794268] [114/132] (418s left) kms_color_pipeline (plane-lut1d)
[607.893943] Starting subtest: plane-lut1d
[607.906963] Starting dynamic subtest: pipe-A-eDP-1
[608.626807] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[609.339217] Starting dynamic subtest: pipe-B-eDP-1
[610.160937] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[610.748293] Starting dynamic subtest: pipe-C-eDP-1
[611.565296] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[612.045497] Starting dynamic subtest: pipe-D-eDP-1
[612.861241] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[612.863443] Subtest plane-lut1d: FAIL (4.676s)
[613.429359] [115/132] (412s left) gen9_exec_parse (batch-zero-length)
[613.510554] Subtest batch-zero-length: SKIP (0.000s)
[613.593409] [116/132] (412s left) i915_drm_fdinfo (context-close-stress)
[613.634972] Starting subtest: context-close-stress
[624.381883] Subtest context-close-stress: SUCCESS (10.744s)
[624.478431] [117/132] (401s left) kms_chamelium_hpd (hdmi-hpd-storm)
[625.108839] Subtest hdmi-hpd-storm: SKIP (0.000s)
[625.883725] [118/132] (400s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[625.977329] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[625.979749] Starting dynamic subtest: pipe-A-eDP-1
[626.005164] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[626.021072] Starting dynamic subtest: pipe-B-eDP-1
[626.044384] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[626.054415] Starting dynamic subtest: pipe-C-eDP-1
[626.077808] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[626.090168] Starting dynamic subtest: pipe-D-eDP-1
[626.113773] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[626.117824] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[628.223534] [119/132] (397s left) syncobj_timeline (invalid-signal-bad-pad)
[628.299569] Starting subtest: invalid-signal-bad-pad
[628.301979] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[628.438132] [120/132] (397s left) gem_exec_fence (submit67)
[628.613036] Starting subtest: submit67
[628.618514] Subtest submit67: SKIP (0.000s)
[630.257586] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[630.261198] [121/132] (396s left) gem_eio (in-flight-internal-10ms)
[630.501909] Starting subtest: in-flight-internal-10ms
[632.205320] Subtest in-flight-internal-10ms: SUCCESS (1.702s)
[632.373247] [122/132] (393s left) gem_exec_schedule (preempt-contexts)
[632.441820] Starting subtest: preempt-contexts
[632.443821] Starting dynamic subtest: rcs0
[632.487428] Dynamic subtest rcs0: SUCCESS (0.053s)
[632.498595] Starting dynamic subtest: bcs0
[632.540287] Dynamic subtest bcs0: SUCCESS (0.052s)
[632.551174] Starting dynamic subtest: vcs0
[632.586458] Dynamic subtest vcs0: SUCCESS (0.046s)
[632.597525] Starting dynamic subtest: vcs1
[632.629417] Dynamic subtest vcs1: SUCCESS (0.042s)
[632.640209] Starting dynamic subtest: vecs0
[632.672371] Dynamic subtest vecs0: SUCCESS (0.041s)
[632.682557] Starting dynamic subtest: ccs0
[632.724347] Dynamic subtest ccs0: SUCCESS (0.053s)
[632.726636] Subtest preempt-contexts: SUCCESS (0.290s)
[634.238835] [123/132] (392s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[639.274962] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[639.279641] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[640.126324] [124/132] (386s left) kms_chamelium_audio (dp-audio)
[640.506520] Subtest dp-audio: SKIP (0.000s)
[641.283043] [125/132] (385s left) kms_psr (psr2-cursor-plane-onoff)
[641.370283] Starting subtest: psr2-cursor-plane-onoff
[641.372680] Starting dynamic subtest: eDP-1
[643.044393] Dynamic subtest eDP-1: SUCCESS (1.675s)
[643.047173] Subtest psr2-cursor-plane-onoff: SUCCESS (1.676s)
[643.919938] [126/132] (382s left) kms_plane_scaling (planes-downscale-factor-0-75)
[644.022288] Starting subtest: planes-downscale-factor-0-75
[644.024471] Starting dynamic subtest: pipe-A
[644.045296] Dynamic subtest pipe-A: SKIP (0.019s)
[644.060797] Starting dynamic subtest: pipe-B
[644.083323] Dynamic subtest pipe-B: SKIP (0.037s)
[644.096585] Starting dynamic subtest: pipe-C
[644.118555] Dynamic subtest pipe-C: SKIP (0.034s)
[644.129959] Starting dynamic subtest: pipe-D
[644.154113] Dynamic subtest pipe-D: SKIP (0.034s)
[644.158094] Subtest planes-downscale-factor-0-75: SKIP (0.128s)
[644.276256] [127/132] (382s left) kms_vblank (ts-continuation-modeset)
[644.373737] Starting subtest: ts-continuation-modeset
[644.376050] Starting dynamic subtest: pipe-A-eDP-1
[645.824041] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.450s)
[645.841165] Starting dynamic subtest: pipe-D-eDP-1
[648.041806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.214s)
[648.044260] Subtest ts-continuation-modeset: SUCCESS (3.668s)
[648.928245] [128/132] (377s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[648.981487] Starting subtest: framebuffer-vs-set-tiling
[648.985692] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[649.154843] [129/132] (377s left) kms_cursor_crc (cursor-sliding-512x170)
[649.447944] Starting subtest: cursor-sliding-512x170
[649.451784] Subtest cursor-sliding-512x170: SKIP (0.001s)
[649.637309] [130/132] (377s left) gem_exec_capture (capture)
[649.698062] Starting subtest: capture
[649.700344] Starting dynamic subtest: rcs0-smem
[650.535002] Dynamic subtest rcs0-smem: SUCCESS (0.836s)
[650.551920] Starting dynamic subtest: bcs0-smem
[651.408436] Dynamic subtest bcs0-smem: SUCCESS (0.874s)
[651.418371] Starting dynamic subtest: vcs0-smem
[652.244292] Dynamic subtest vcs0-smem: SUCCESS (0.834s)
[652.256440] Starting dynamic subtest: vcs1-smem
[653.067275] Dynamic subtest vcs1-smem: SUCCESS (0.821s)
[653.077886] Starting dynamic subtest: vecs0-smem
[654.456865] Dynamic subtest vecs0-smem: FAIL (1.317s)
[654.469233] Starting dynamic subtest: ccs0-smem
[655.714165] Dynamic subtest ccs0-smem: SUCCESS (1.328s)
[655.716637] Subtest capture: FAIL (6.016s)
[655.866160] [131/132] (370s left) i915_pm_rps (min-max-config-idle)
[655.932151] Starting subtest: min-max-config-idle
[655.936825] Subtest min-max-config-idle: SKIP (0.001s)
[656.061502] [132/132] (370s left) kms_flip (2x-plain-flip)
[656.158065] Starting subtest: 2x-plain-flip
[656.167359] Subtest 2x-plain-flip: SKIP (0.011s)
[656.267465] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: core_setmaster
results: parsing output: 5/ for test: i915_selftest
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_fence_pin_leak
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_fbcon_fbt
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: sriov_basic
results: parsing output: 24/ for test: api_intel_bb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_nop
results: parsing output: 27/ for test: i915_hangman
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_invalid_mode
results: parsing output: 38/ for test: gem_exec_alignment
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_partial_pwrite_pread
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: gem_close_race
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_plane_alpha_blend
results: parsing output: 63/ for test: kms_sequence
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_busy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_readwrite
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_readwrite
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_properties
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: sysfs_preempt_timeout
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: gem_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_force_connector_basic
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: intel_hwmon
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_capture
results: parsing output: 130/ for test: i915_pm_rps
results: parsing output: 131/ for test: kms_flip
Done.