[91.863998] Initializing watchdogs
[91.864449]   /dev/watchdog0
[91.878490] [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]
[91.883099] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.885537] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.888937] [001/133] (960s left) kms_flip (flip-vs-modeset-vs-hang)
[91.998309] Starting subtest: flip-vs-modeset-vs-hang
[92.000625] Starting dynamic subtest: A-eDP1
[142.750040] Dynamic subtest A-eDP1: SUCCESS (50.752s)
[142.761766] Starting dynamic subtest: D-eDP1
[192.795122] Dynamic subtest D-eDP1: SUCCESS (50.042s)
[192.797570] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.797s)
[193.187289] [002/133] (859s left) gem_ctx_param (invalid-size-set)
[193.252778] Starting subtest: invalid-size-set
[193.255283] Subtest invalid-size-set: SUCCESS (0.001s)
[193.359838] [003/133] (859s left) kms_draw_crc (draw-method-mmap-wc)
[193.456037] Starting subtest: draw-method-mmap-wc
[193.458209] Starting dynamic subtest: xrgb8888-untiled
[193.686723] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[193.695627] Starting dynamic subtest: rgb565-untiled
[193.886649] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[193.894967] Starting dynamic subtest: xrgb2101010-untiled
[194.086627] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.200s)
[194.094755] Starting dynamic subtest: xbgr16161616f-untiled
[194.286486] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[194.293864] Starting dynamic subtest: xrgb8888-xtiled
[194.408555] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[194.416773] Starting dynamic subtest: rgb565-xtiled
[194.541735] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[194.549993] Starting dynamic subtest: xrgb2101010-xtiled
[194.664137] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[194.670999] Starting dynamic subtest: xbgr16161616f-xtiled
[194.797495] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[194.804187] Starting dynamic subtest: xrgb8888-4tiled
[194.963922] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[194.970814] Starting dynamic subtest: rgb565-4tiled
[195.131291] Dynamic subtest rgb565-4tiled: SUCCESS (0.166s)
[195.138698] Starting dynamic subtest: xrgb2101010-4tiled
[195.275393] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[195.283900] Starting dynamic subtest: xbgr16161616f-4tiled
[195.441816] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[195.443707] Subtest draw-method-mmap-wc: SUCCESS (1.987s)
[195.531855] [004/133] (856s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[195.586860] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[195.691441] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[195.775489] [005/133] (856s left) kms_psr (fbc-pr-sprite-plane-move)
[195.870231] Starting subtest: fbc-pr-sprite-plane-move
[195.874464] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[195.941039] [006/133] (856s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[196.201149] Starting subtest: cursor-rapid-movement-512x512
[196.205772] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[196.360184] [007/133] (856s left) sriov_basic (enable-vfs-autoprobe-off)
[196.412629] Starting subtest: enable-vfs-autoprobe-off
[196.414878] Starting dynamic subtest: numvfs-1
[196.487604] Dynamic subtest numvfs-1: FAIL (0.016s)
[196.495210] Starting dynamic subtest: numvfs-2
[196.568892] Dynamic subtest numvfs-2: FAIL (0.004s)
[196.577547] Starting dynamic subtest: numvfs-3
[196.650085] Dynamic subtest numvfs-3: FAIL (0.003s)
[196.658946] Starting dynamic subtest: numvfs-4
[196.728053] Dynamic subtest numvfs-4: FAIL (0.003s)
[196.735262] Starting dynamic subtest: numvfs-5
[196.794636] Dynamic subtest numvfs-5: FAIL (0.004s)
[196.802796] Starting dynamic subtest: numvfs-6
[196.862686] Dynamic subtest numvfs-6: FAIL (0.004s)
[196.870823] Starting dynamic subtest: numvfs-7
[196.932225] Dynamic subtest numvfs-7: FAIL (0.004s)
[196.939374] Starting dynamic subtest: numvfs-random
[196.999706] Dynamic subtest numvfs-random: FAIL (0.003s)
[197.008013] Starting dynamic subtest: numvfs-all
[197.071046] Dynamic subtest numvfs-all: FAIL (0.460s)
[197.073067] Subtest enable-vfs-autoprobe-off: FAIL (0.504s)
[197.114916] [008/133] (855s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[197.219943] Starting subtest: fbcpsr-tiling-linear
[203.729543] Subtest fbcpsr-tiling-linear: SUCCESS (6.514s)
[203.857643] [009/133] (848s left) perf (gen12-group-exclusive-stream-sample-oa)
[203.997306] Starting subtest: gen12-group-exclusive-stream-sample-oa
[204.017838] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[204.064886] [010/133] (848s left) gem_exec_reloc (basic-gtt-noreloc)
[204.120503] Subtest basic-gtt-noreloc: SKIP (0.000s)
[204.194612] [011/133] (848s left) kms_getfb (getfb-handle-zero)
[204.287997] Starting subtest: getfb-handle-zero
[204.290356] Subtest getfb-handle-zero: SUCCESS (0.000s)
[204.384211] [012/133] (848s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[204.478478] Starting subtest: plane-primary-toggle-with-vblank-wait
[204.480801] Starting dynamic subtest: pipe-A-eDP-1
[204.650022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[204.959935] Starting dynamic subtest: pipe-B-eDP-1
[205.895767] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.946s)
[206.206218] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.730s)
[207.057147] [013/133] (845s left) kms_flip (nonblocking-read)
[207.156605] Starting subtest: nonblocking-read
[207.158585] Subtest nonblocking-read: SUCCESS (0.000s)
[207.258312] [014/133] (845s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[207.312176] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[207.418483] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[207.490166] [015/133] (845s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[207.562730] Starting subtest: multi-wait-for-submit-submitted-signaled
[207.564810] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[207.660175] [016/133] (845s left) gem_exec_balancer (bonded-chain)
[207.728876] Starting subtest: bonded-chain
[214.710969] Subtest bonded-chain: SUCCESS (6.982s)
[215.013163] [017/133] (837s left) api_intel_allocator (execbuf-with-allocator)
[215.068191] Starting subtest: execbuf-with-allocator
[215.075665] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[215.190973] [018/133] (837s left) kms_flip (2x-flip-vs-fences)
[215.282083] Starting subtest: 2x-flip-vs-fences
[215.286567] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[215.387610] [019/133] (837s left) gem_exec_fence (nb-await)
[215.574090] Starting subtest: nb-await
[215.576634] Starting dynamic subtest: rcs0
[215.639442] Dynamic subtest rcs0: SUCCESS (0.065s)
[215.650351] Starting dynamic subtest: bcs0
[215.698069] Dynamic subtest bcs0: SUCCESS (0.058s)
[215.708751] Starting dynamic subtest: vcs0
[215.758425] Dynamic subtest vcs0: SUCCESS (0.059s)
[215.768946] Starting dynamic subtest: vcs1
[215.817054] Dynamic subtest vcs1: SUCCESS (0.057s)
[215.827667] Starting dynamic subtest: vecs0
[215.876546] Dynamic subtest vecs0: SUCCESS (0.058s)
[215.887760] Starting dynamic subtest: ccs0
[215.935515] Dynamic subtest ccs0: SUCCESS (0.058s)
[215.938269] Subtest nb-await: SUCCESS (0.362s)
[217.353408] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[217.357399] [020/133] (835s left) perf (non-sampling-read-error)
[217.443604] Starting subtest: non-sampling-read-error
[217.454107] Subtest non-sampling-read-error: SUCCESS (0.008s)
[217.496507] [021/133] (835s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[217.599049] Starting subtest: y-tiled-64bpp-rotate-90
[217.603275] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[217.684588] [022/133] (835s left) drm_read (invalid-buffer)
[217.831719] Starting subtest: invalid-buffer
[217.834407] Subtest invalid-buffer: SUCCESS (0.000s)
[217.957503] [023/133] (835s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[218.055169] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[218.059462] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[218.151706] [024/133] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[218.244662] Starting subtest: fbcpsr-1p-rte
[225.307121] Subtest fbcpsr-1p-rte: SUCCESS (7.067s)
[225.440743] [025/133] (827s left) sysfs_preempt_timeout (idempotent)
[225.496730] Starting subtest: idempotent
[225.499060] Starting dynamic subtest: vecs0
[225.501431] Dynamic subtest vecs0: SUCCESS (0.000s)
[225.509772] Starting dynamic subtest: ccs0
[225.512172] Dynamic subtest ccs0: SUCCESS (0.000s)
[225.519694] Starting dynamic subtest: vcs0
[225.521946] Dynamic subtest vcs0: SUCCESS (0.000s)
[225.529744] Starting dynamic subtest: bcs0
[225.531990] Dynamic subtest bcs0: SUCCESS (0.000s)
[225.539479] Starting dynamic subtest: rcs0
[225.541692] Dynamic subtest rcs0: SUCCESS (0.000s)
[225.549260] Starting dynamic subtest: vcs1
[225.551550] Dynamic subtest vcs1: SUCCESS (0.000s)
[225.553439] Subtest idempotent: SUCCESS (0.005s)
[225.621851] [026/133] (827s left) gem_create (create-clear)
[225.691097] Starting subtest: create-clear
[225.693096] Starting dynamic subtest: smem0
[258.493435] Dynamic subtest smem0: SUCCESS (32.800s)
[258.495464] Subtest create-clear: SUCCESS (32.801s)
[258.685317] [027/133] (794s left) gem_fenced_exec_thrash (no-spare-fences)
[258.754746] Subtest no-spare-fences: SKIP (0.000s)
[258.859515] [028/133] (794s left) dumb_buffer (invalid-bpp)
[258.912534] Starting subtest: invalid-bpp
[258.914644] Subtest invalid-bpp: SUCCESS (0.000s)
[259.009772] [029/133] (794s left) kms_cursor_edge_walk (256x256-right-edge)
[259.118844] Starting subtest: 256x256-right-edge
[259.121163] Starting dynamic subtest: pipe-A-eDP-1
[262.548402] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[262.558282] Starting dynamic subtest: pipe-D-eDP-1
[265.677256] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[265.679158] Subtest 256x256-right-edge: SUCCESS (6.558s)
[266.507221] [030/133] (787s left) gem_ctx_persistence (engines-queued)
[266.563358] Starting subtest: engines-queued
[266.565639] Starting dynamic subtest: rcs0
[266.660040] Dynamic subtest rcs0: SUCCESS (0.096s)
[266.670541] Starting dynamic subtest: bcs0
[266.692671] Dynamic subtest bcs0: SUCCESS (0.032s)
[266.706765] Starting dynamic subtest: vcs0
[268.260671] Dynamic subtest vcs0: SUCCESS (1.565s)
[268.272482] Starting dynamic subtest: vcs1
[270.243469] Dynamic subtest vcs1: SUCCESS (1.981s)
[270.253908] Starting dynamic subtest: vecs0
[272.291437] Dynamic subtest vecs0: SUCCESS (2.046s)
[272.302874] Starting dynamic subtest: ccs0
[272.486708] Dynamic subtest ccs0: SUCCESS (0.195s)
[272.489269] Subtest engines-queued: SUCCESS (5.923s)
[272.562569] [031/133] (781s left) gem_bad_reloc (negative-reloc-lut)
[272.622611] Subtest negative-reloc-lut: SKIP (0.000s)
[272.717438] [032/133] (780s left) gem_exec_schedule (pi-userfault)
[272.893891] Starting subtest: pi-userfault
[272.896340] Starting dynamic subtest: rcs0
[272.906324] Dynamic subtest rcs0: SUCCESS (0.016s)
[272.917443] Starting dynamic subtest: bcs0
[272.919799] Dynamic subtest bcs0: SUCCESS (0.012s)
[272.928367] Starting dynamic subtest: vcs0
[272.932854] Dynamic subtest vcs0: SUCCESS (0.014s)
[272.941289] Starting dynamic subtest: vcs1
[272.947993] Dynamic subtest vcs1: SUCCESS (0.014s)
[272.959748] Starting dynamic subtest: vecs0
[272.961959] Dynamic subtest vecs0: SUCCESS (0.013s)
[272.970439] Starting dynamic subtest: ccs0
[272.976795] Dynamic subtest ccs0: SUCCESS (0.015s)
[272.978988] Subtest pi-userfault: SUCCESS (0.087s)
[273.163408] [033/133] (780s left) prime_mmap (test_map_unmap)
[273.219299] Starting subtest: test_map_unmap
[273.221145] Starting dynamic subtest: test_map_unmap-smem
[273.262868] Dynamic subtest test_map_unmap-smem: SUCCESS (0.046s)
[273.265697] Subtest test_map_unmap: SUCCESS (0.046s)
[273.359971] [034/133] (780s left) kms_invalid_mode (clock-too-high)
[273.456914] Starting subtest: clock-too-high
[273.459355] Starting dynamic subtest: pipe-A-eDP-1
[273.739525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[273.748561] Starting dynamic subtest: pipe-B-eDP-1
[273.753108] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[273.761194] Starting dynamic subtest: pipe-C-eDP-1
[273.765216] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[273.772474] Starting dynamic subtest: pipe-D-eDP-1
[273.776618] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[273.778844] Subtest clock-too-high: SUCCESS (0.287s)
[274.613855] [035/133] (779s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[274.717626] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[274.722064] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[274.786490] [036/133] (779s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[274.879974] Starting subtest: 4-tiled-64bpp-rotate-90
[274.900067] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[275.035860] [037/133] (778s left) prime_vgem (fence-flip-hang)
[275.125862] Subtest fence-flip-hang: SKIP (0.000s)
[275.217629] [038/133] (778s left) syncobj_basic (bad-handle-to-fd)
[275.274663] Starting subtest: bad-handle-to-fd
[275.276757] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[275.404795] [039/133] (778s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[275.457795] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[275.462300] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[275.650214] [040/133] (778s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[275.748990] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[275.751250] Starting dynamic subtest: pipe-A
[275.768222] Dynamic subtest pipe-A: SKIP (0.016s)
[275.776797] Starting dynamic subtest: pipe-B
[275.795829] Dynamic subtest pipe-B: SKIP (0.028s)
[275.804039] Starting dynamic subtest: pipe-C
[275.828228] Dynamic subtest pipe-C: SKIP (0.031s)
[275.836063] Starting dynamic subtest: pipe-D
[275.854851] Dynamic subtest pipe-D: SKIP (0.027s)
[275.859036] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.104s)
[275.969227] [041/133] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[276.062579] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[276.066759] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.157136] [042/133] (777s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[276.245107] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[276.327059] [043/133] (777s left) kms_chamelium_color (ctm-limited-range)
[276.422259] Subtest ctm-limited-range: SKIP (0.000s)
[276.466046] [044/133] (777s left) gem_mmap_gtt (basic-read-write)
[276.513645] Subtest basic-read-write: SKIP (0.000s)
[276.575263] [045/133] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[276.674996] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[276.678318] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[276.779447] [046/133] (777s left) kms_vblank (query-idle-hang)
[276.877598] Starting subtest: query-idle-hang
[276.879289] Starting dynamic subtest: pipe-A-eDP-1
[303.043373] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.163s)
[303.057262] Starting dynamic subtest: pipe-D-eDP-1
[328.070932] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.025s)
[328.073347] Subtest query-idle-hang: SUCCESS (51.193s)
[328.885061] [047/133] (725s left) kms_plane_alpha_blend (coverage-7efc)
[328.983335] Starting subtest: coverage-7efc
[329.260288] Starting dynamic subtest: pipe-A-eDP-1
[329.857898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[329.888919] Starting dynamic subtest: pipe-D-eDP-1
[331.213053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[331.215466] Subtest coverage-7efc: SUCCESS (2.232s)
[332.070737] [048/133] (722s left) kms_psr (fbc-psr-sprite-blt)
[332.180015] Starting subtest: fbc-psr-sprite-blt
[332.182315] Starting dynamic subtest: eDP-1
[332.186685] Dynamic subtest eDP-1: SKIP (0.000s)
[332.191070] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[332.262853] [049/133] (722s left) kms_atomic_interruptible (legacy-dpms)
[332.358641] Starting subtest: legacy-dpms
[332.360896] Starting dynamic subtest: pipe-A-eDP-1
[339.793103] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.434s)
[339.795435] Subtest legacy-dpms: SUCCESS (7.436s)
[340.614214] [050/133] (713s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[340.746530] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[340.750996] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[340.902163] [051/133] (713s left) gen3_render_tiledx_blits
[341.024941] [052/133] (713s left) gem_lmem_swapping (parallel-multi)
[341.062683] Subtest parallel-multi: SKIP (0.000s)
[341.103317] [053/133] (713s left) gem_eio (throttle)
[341.318391] Starting subtest: throttle
[341.606457] Subtest throttle: SUCCESS (0.288s)
[341.768178] [054/133] (712s left) gem_exec_whisper (basic-fds-priority)
[341.833091] Starting subtest: basic-fds-priority
[366.247609] Subtest basic-fds-priority: SUCCESS (24.411s)
[366.435516] [055/133] (688s left) kms_debugfs (display-off-read-all)
[366.525901] Starting subtest: display-off-read-all
[366.821856] Subtest display-off-read-all: SUCCESS (0.297s)
[367.646454] [056/133] (686s left) gem_partial_pwrite_pread (reads-display)
[367.702286] Subtest reads-display: SKIP (0.000s)
[367.792847] [057/133] (686s left) gem_userptr_blits (sync-unmap-cycles)
[367.858993] Starting subtest: sync-unmap-cycles
[373.238903] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[373.365285] [058/133] (681s left) gem_ctx_param (invalid-ctx-get)
[373.420435] Starting subtest: invalid-ctx-get
[373.422490] Subtest invalid-ctx-get: SUCCESS (0.000s)
[373.495485] [059/133] (681s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[373.608108] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[373.611851] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[373.754169] [060/133] (681s left) gem_exec_async (forked-writes)
[373.802298] Starting subtest: forked-writes
[373.804503] Starting dynamic subtest: rcs0
[373.830323] Dynamic subtest rcs0: SUCCESS (0.028s)
[373.842558] Starting dynamic subtest: bcs0
[373.852096] Dynamic subtest bcs0: SUCCESS (0.021s)
[373.861515] Starting dynamic subtest: vcs0
[373.876348] Dynamic subtest vcs0: SUCCESS (0.022s)
[373.891112] Starting dynamic subtest: vcs1
[373.899501] Dynamic subtest vcs1: SUCCESS (0.022s)
[373.909762] Starting dynamic subtest: vecs0
[373.921937] Dynamic subtest vecs0: SUCCESS (0.022s)
[373.934421] Starting dynamic subtest: ccs0
[373.946365] Dynamic subtest ccs0: SUCCESS (0.023s)
[373.948195] Subtest forked-writes: SUCCESS (0.145s)
[374.201464] [061/133] (680s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[374.302215] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[374.306846] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[374.412338] [062/133] (680s left) kms_content_protection (atomic)
[374.552115] Starting subtest: atomic
[374.556823] Subtest atomic: SKIP (0.000s)
[374.681729] [063/133] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[374.787662] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[382.051031] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.267s)
[382.177955] [064/133] (672s left) kms_getfb (getfb2-handle-protection)
[382.271464] Starting subtest: getfb2-handle-protection
[382.290578] Subtest getfb2-handle-protection: SUCCESS (0.021s)
[382.411624] [065/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[382.508270] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[382.512528] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[382.605892] [066/133] (672s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[382.712525] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[386.793186] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.085s)
[387.961411] [067/133] (667s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[388.066278] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[388.071115] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[388.142420] [068/133] (666s left) gem_wait (write-busy)
[388.214069] Starting subtest: write-busy
[388.216490] Starting dynamic subtest: all-engines
[388.833641] Dynamic subtest all-engines: SUCCESS (0.618s)
[388.853060] Starting dynamic subtest: rcs0
[389.387700] Dynamic subtest rcs0: SUCCESS (0.553s)
[389.401697] Starting dynamic subtest: bcs0
[389.939567] Dynamic subtest bcs0: SUCCESS (0.550s)
[389.955854] Starting dynamic subtest: vcs0
[391.302256] Dynamic subtest vcs0: SUCCESS (1.360s)
[391.317848] Starting dynamic subtest: vcs1
[393.285623] Dynamic subtest vcs1: SUCCESS (1.980s)
[393.303474] Starting dynamic subtest: vecs0
[395.269106] Dynamic subtest vecs0: SUCCESS (1.981s)
[395.284773] Starting dynamic subtest: ccs0
[395.817978] Dynamic subtest ccs0: SUCCESS (0.549s)
[395.820411] Subtest write-busy: SUCCESS (7.604s)
[396.055845] [069/133] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[396.163098] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[396.167316] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[396.255397] [070/133] (659s left) gem_exec_balancer (parallel-ordering)
[396.517571] Starting subtest: parallel-ordering
[397.473847] Subtest parallel-ordering: SUCCESS (0.956s)
[397.586212] [071/133] (657s left) kms_flip (2x-flip-vs-panning)
[397.679165] Starting subtest: 2x-flip-vs-panning
[397.688298] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[397.799684] [072/133] (657s left) template (a)
[397.853340] Starting subtest: A
[397.855240] Subtest A: SUCCESS (0.000s)
[397.955279] [073/133] (657s left) perf_pmu (invalid-open)
[397.994266] Starting subtest: invalid-open
[397.996541] Subtest invalid-open: SUCCESS (0.000s)
[398.108182] [074/133] (657s left) gem_spin_batch (spin-all-new)
[398.170463] Starting subtest: spin-all-new
[398.186687] Subtest spin-all-new: SUCCESS (0.016s)
[399.338176] [075/133] (656s left) gem_mmap (bad-offset)
[399.398618] Subtest bad-offset: SKIP (0.000s)
[399.463417] [076/133] (656s left) i915_pm_freq_mult (media-freq)
[399.530519] Starting subtest: media-freq
[399.532691] Starting dynamic subtest: gt0
[399.537128] Dynamic subtest gt0: SKIP (0.000s)
[399.548074] Starting dynamic subtest: gt1
[399.552236] Dynamic subtest gt1: SKIP (0.000s)
[399.556423] Subtest media-freq: SKIP (0.001s)
[399.644551] [077/133] (655s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[399.714159] Starting subtest: wait-all-for-submit-delayed-submit
[399.816272] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[399.895801] [078/133] (655s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[399.993191] Starting subtest: psr-modesetfrombusy
[406.110053] Subtest psr-modesetfrombusy: SUCCESS (6.120s)
[406.259775] [079/133] (649s left) i915_drm_fdinfo (most-busy-idle-check-all)
[406.296689] Starting subtest: most-busy-idle-check-all
[406.298379] Starting dynamic subtest: rcs0
[406.302473] Dynamic subtest rcs0: SKIP (0.003s)
[406.314750] Starting dynamic subtest: bcs0
[406.319034] Dynamic subtest bcs0: SKIP (0.000s)
[406.330433] Starting dynamic subtest: vcs0
[406.333935] Dynamic subtest vcs0: SKIP (0.000s)
[406.341948] Starting dynamic subtest: vcs1
[406.345382] Dynamic subtest vcs1: SKIP (0.000s)
[406.353259] Starting dynamic subtest: vecs0
[406.356591] Dynamic subtest vecs0: SKIP (0.001s)
[406.364569] Starting dynamic subtest: ccs0
[406.367919] Dynamic subtest ccs0: SKIP (0.000s)
[406.371415] Subtest most-busy-idle-check-all: SKIP (0.008s)
[406.407150] [080/133] (649s left) gem_exec_schedule (promotion)
[406.500481] Starting subtest: promotion
[406.502298] Starting dynamic subtest: rcs0
[406.601973] Dynamic subtest rcs0: SUCCESS (0.103s)
[406.611498] Starting dynamic subtest: vcs0
[406.696591] Dynamic subtest vcs0: SUCCESS (0.094s)
[406.706666] Starting dynamic subtest: vcs1
[406.785169] Dynamic subtest vcs1: SUCCESS (0.088s)
[406.796941] Starting dynamic subtest: vecs0
[406.873888] Dynamic subtest vecs0: SUCCESS (0.088s)
[406.883898] Starting dynamic subtest: ccs0
[406.974285] Dynamic subtest ccs0: SUCCESS (0.100s)
[406.976541] Subtest promotion: SUCCESS (0.476s)
[408.428714] [081/133] (647s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[408.532113] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[408.536598] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[408.605299] [082/133] (647s left) gem_exec_reloc (basic-gtt-wc-active)
[408.658743] Subtest basic-gtt-wc-active: SKIP (0.000s)
[408.746082] [083/133] (647s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[408.835317] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[408.837482] Starting dynamic subtest: pipe-A-eDP-1
[425.568877] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.496s)
[425.579886] Starting dynamic subtest: pipe-B-eDP-1
[442.559330] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.448s)
[442.570807] Starting dynamic subtest: pipe-C-eDP-1
[459.519755] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.358s)
[459.530867] Starting dynamic subtest: pipe-D-eDP-1
[476.507145] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.347s)
[476.509539] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.654s)
[477.669582] [084/133] (578s left) gem_fenced_exec_thrash (too-many-fences)
[477.735014] Subtest too-many-fences: SKIP (0.000s)
[477.812434] [085/133] (578s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[477.914743] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[477.918957] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[478.012270] [086/133] (577s left) gem_pipe_control_store_loop (fresh-buffer)
[478.062587] Starting subtest: fresh-buffer
[480.220950] Subtest fresh-buffer: SUCCESS (2.152s)
[480.365224] [087/133] (575s left) kms_color_pipeline (plane-lut1d-lut1d)
[480.487601] Starting subtest: plane-lut1d-lut1d
[480.622570] Starting dynamic subtest: pipe-A-plane-0
[480.813523] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[480.824362] Starting dynamic subtest: pipe-A-plane-1
[480.957328] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[480.967911] Starting dynamic subtest: pipe-A-plane-2
[481.145941] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[482.393603] Starting dynamic subtest: pipe-B-plane-0
[482.584067] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[482.594931] Starting dynamic subtest: pipe-B-plane-1
[482.796280] Dynamic subtest pipe-B-plane-1: SUCCESS (0.209s)
[482.809709] Starting dynamic subtest: pipe-B-plane-2
[482.962528] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[484.134605] Starting dynamic subtest: pipe-C-plane-0
[484.259440] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[484.269552] Starting dynamic subtest: pipe-C-plane-1
[484.392946] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[484.403302] Starting dynamic subtest: pipe-C-plane-2
[484.526471] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[485.768734] Starting dynamic subtest: pipe-D-plane-0
[485.882334] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[485.892654] Starting dynamic subtest: pipe-D-plane-1
[486.049485] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[486.062033] Starting dynamic subtest: pipe-D-plane-2
[486.215906] Dynamic subtest pipe-D-plane-2: SUCCESS (0.164s)
[486.508001] Subtest plane-lut1d-lut1d: SUCCESS (6.013s)
[487.331453] [088/133] (568s left) kms_lease (lease-get)
[487.422199] Starting subtest: lease-get
[487.424628] Starting dynamic subtest: pipe-A-eDP-1
[487.427027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[487.438634] Starting dynamic subtest: pipe-B-eDP-1
[487.440975] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[487.451240] Starting dynamic subtest: pipe-C-eDP-1
[487.453387] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[487.463349] Starting dynamic subtest: pipe-D-eDP-1
[487.465490] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[487.467572] Subtest lease-get: SUCCESS (0.020s)
[487.555995] [089/133] (568s left) kms_psr (fbc-pr-primary-blt)
[487.659897] Starting subtest: fbc-pr-primary-blt
[487.664055] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[487.733346] [090/133] (568s left) kms_chamelium_frames (dp-crc-multiple)
[488.147828] Subtest dp-crc-multiple: SKIP (0.000s)
[488.945979] [091/133] (567s left) syncobj_timeline (invalid-transfer-bad-pad)
[489.004264] Starting subtest: invalid-transfer-bad-pad
[489.006584] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[489.112558] [092/133] (567s left) kms_pm_rpm (modeset-non-lpsp-stress)
[490.642881] Starting subtest: modeset-non-lpsp-stress
[491.814933] Subtest modeset-non-lpsp-stress: SKIP (1.171s)
[492.232598] [093/133] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[492.329659] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[492.334245] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[492.438362] [094/133] (563s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[492.529198] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[492.531348] Starting dynamic subtest: pipe-A-eDP-1
[492.588411] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[492.600472] Starting dynamic subtest: pipe-B-eDP-1
[492.658138] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[492.669383] Starting dynamic subtest: pipe-C-eDP-1
[492.726017] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[492.737517] Starting dynamic subtest: pipe-D-eDP-1
[492.793581] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[492.798136] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[494.773136] [095/133] (561s left) kms_cursor_crc (cursor-onscreen-256x85)
[495.014953] Starting subtest: cursor-onscreen-256x85
[495.057158] Subtest cursor-onscreen-256x85: SKIP (0.040s)
[495.244388] [096/133] (561s left) kms_chamelium_hpd (dp-hpd-storm)
[495.634771] Subtest dp-hpd-storm: SKIP (0.000s)
[496.470827] [097/133] (559s left) kms_psr (fbc-psr-sprite-render)
[496.574068] Starting subtest: fbc-psr-sprite-render
[496.576251] Starting dynamic subtest: eDP-1
[496.580276] Dynamic subtest eDP-1: SKIP (0.000s)
[496.584374] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[496.649260] [098/133] (559s left) gem_ctx_param (root-set)
[496.716253] Starting subtest: root-set
[496.718103] Subtest root-set: SUCCESS (0.001s)
[496.827600] [099/133] (559s left) gem_pxp (create-regular-buffer)
[496.944098] Starting subtest: create-regular-buffer
[496.946433] Subtest create-regular-buffer: SUCCESS (0.000s)
[497.055490] [100/133] (559s left) gem_render_copy (linear-to-vebox-y-tiled)
[497.121796] Starting subtest: linear-to-vebox-y-tiled
[497.126265] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[497.305181] [101/133] (559s left) gem_exec_reloc (basic-wc-noreloc)
[497.362413] Subtest basic-wc-noreloc: SKIP (0.000s)
[497.447017] [102/133] (559s left) gem_mmap_gtt (pf-nonblock)
[497.504986] Subtest pf-nonblock: SKIP (0.000s)
[497.564010] [103/133] (559s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[497.621619] Starting subtest: invalid-multi-wait-all-unsubmitted
[497.623912] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[497.746392] [104/133] (559s left) i915_module_load (reload-no-display)
[497.779662] Starting subtest: reload-no-display
[503.704143] Subtest reload-no-display: SUCCESS (5.922s)
[503.732984] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[503.733678] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[503.737638] [105/133] (553s left) prime_mmap (test_aperture_limit)
[505.257519] Starting subtest: test_aperture_limit
[505.260024] Starting dynamic subtest: test_aperture_limit-smem
[505.272657] Dynamic subtest test_aperture_limit-smem: SKIP (0.014s)
[505.277167] Subtest test_aperture_limit: SKIP (0.015s)
[505.315575] [FACT prime_mmap (test_aperture_limit)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[505.317000] [FACT prime_mmap (test_aperture_limit)] new: kernel.kmod_is_loaded.i915: true
[505.321353] [106/133] (551s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[505.441671] Starting subtest: crc-primary-basic-yf-tiled-ccs
[505.443960] Starting dynamic subtest: pipe-A-eDP-1
[505.466412] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[505.475834] Starting dynamic subtest: pipe-B-eDP-1
[505.497999] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[505.505750] Starting dynamic subtest: pipe-C-eDP-1
[505.527252] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[505.535055] Starting dynamic subtest: pipe-D-eDP-1
[505.556649] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[505.561047] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.007s)
[507.789039] [107/133] (549s left) api_intel_bb (simple-bb-ctx)
[507.849838] Starting subtest: simple-bb-ctx
[507.860449] Subtest simple-bb-ctx: SUCCESS (0.012s)
[507.993528] [108/133] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[508.101276] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[508.105206] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[508.201738] [109/133] (548s left) kms_atomic (plane-immutable-zpos)
[508.292460] Starting subtest: plane-immutable-zpos
[508.294657] Starting dynamic subtest: pipe-A-eDP-1
[508.935823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.644s)
[508.938158] Subtest plane-immutable-zpos: SUCCESS (0.645s)
[509.731228] [110/133] (547s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[509.820804] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[509.823005] Starting dynamic subtest: pipe-A-eDP-1
[510.229749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[510.240456] Starting dynamic subtest: pipe-B-eDP-1
[510.259775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[510.269011] Starting dynamic subtest: pipe-C-eDP-1
[510.286360] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[510.294627] Starting dynamic subtest: pipe-D-eDP-1
[510.313032] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[510.314841] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.425s)
[512.499126] [111/133] (544s left) kms_big_fb (linear-16bpp-rotate-0)
[512.600955] Starting subtest: linear-16bpp-rotate-0
[513.992827] Subtest linear-16bpp-rotate-0: SUCCESS (1.391s)
[514.146576] [112/133] (542s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[514.248934] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[518.090484] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.842s)
[519.213032] [113/133] (537s left) kms_pm_dc (dc6-psr)
[520.307120] Starting subtest: dc6-psr
[523.181299] Subtest dc6-psr: SUCCESS (2.872s)
[524.043815] [114/133] (533s left) gem_exec_parallel (contexts)
[524.117694] Starting subtest: contexts
[524.120188] Starting dynamic subtest: rcs0
[527.023066] Dynamic subtest rcs0: SUCCESS (2.902s)
[527.034903] Starting dynamic subtest: bcs0
[530.635928] Dynamic subtest bcs0: SUCCESS (3.608s)
[530.649171] Starting dynamic subtest: vcs0
[534.807620] Dynamic subtest vcs0: SUCCESS (4.167s)
[534.817575] Starting dynamic subtest: vcs1
[538.809869] Dynamic subtest vcs1: SUCCESS (3.999s)
[538.820927] Starting dynamic subtest: vecs0
[542.728164] Dynamic subtest vecs0: SUCCESS (3.914s)
[542.737823] Starting dynamic subtest: ccs0
[546.258150] Dynamic subtest ccs0: SUCCESS (3.526s)
[546.260722] Subtest contexts: SUCCESS (22.129s)
[546.448264] [115/133] (510s left) kms_big_fb (x-tiled-addfb)
[546.550797] Starting subtest: x-tiled-addfb
[546.553153] Subtest x-tiled-addfb: SUCCESS (0.000s)
[546.644362] [116/133] (510s left) kms_psr (psr-dpms)
[546.741108] Starting subtest: psr-dpms
[546.743394] Starting dynamic subtest: eDP-1
[549.711301] Dynamic subtest eDP-1: SUCCESS (2.967s)
[549.713573] Subtest psr-dpms: SUCCESS (2.968s)
[550.568234] [117/133] (506s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[550.671017] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[550.675686] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[550.745046] [118/133] (506s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[550.844813] Starting subtest: plane-upscale-20x20-with-rotation
[550.847118] Starting dynamic subtest: pipe-A
[551.069927] Dynamic subtest pipe-A: SUCCESS (0.226s)
[551.081603] Starting dynamic subtest: pipe-B
[552.355904] Dynamic subtest pipe-B: SUCCESS (1.285s)
[552.370414] Starting dynamic subtest: pipe-C
[553.697466] Dynamic subtest pipe-C: SUCCESS (1.340s)
[553.708181] Starting dynamic subtest: pipe-D
[555.019737] Dynamic subtest pipe-D: SUCCESS (1.321s)
[555.021931] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.175s)
[556.202723] [119/133] (501s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[556.308566] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[563.155256] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.843s)
[563.269115] [120/133] (494s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[563.360730] Starting subtest: psr-1p-primscrn-spr-indfb-move
[570.833675] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.473s)
[571.008171] [121/133] (486s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[571.109121] Starting subtest: yf-tiled-16bpp-rotate-0
[571.113433] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[571.207026] [122/133] (486s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[571.294825] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[571.306254] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[571.384783] [123/133] (486s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[571.483521] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[571.485792] Starting dynamic subtest: pipe-A-eDP-1
[571.579583] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[571.592318] Starting dynamic subtest: pipe-B-eDP-1
[572.756122] Dynamic subtest pipe-B-eDP-1: SKIP (1.173s)
[572.760690] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.278s)
[573.949357] [124/133] (483s left) gem_ctx_persistence (legacy-engines-hang)
[574.033937] Starting subtest: legacy-engines-hang
[574.035879] Starting dynamic subtest: render
[574.163813] Dynamic subtest render: SUCCESS (0.132s)
[574.179328] Starting dynamic subtest: bsd1
[574.272755] Dynamic subtest bsd1: SUCCESS (0.106s)
[574.285152] Starting dynamic subtest: bsd2
[574.371418] Dynamic subtest bsd2: SUCCESS (0.096s)
[574.384739] Starting dynamic subtest: blt
[574.460583] Dynamic subtest blt: SUCCESS (0.087s)
[574.475576] Starting dynamic subtest: vebox
[574.554723] Dynamic subtest vebox: SUCCESS (0.091s)
[574.557294] Subtest legacy-engines-hang: SUCCESS (0.525s)
[574.637975] [125/133] (482s left) i915_query (test-query-geometry-subslices)
[574.687974] Starting subtest: test-query-geometry-subslices
[574.690123] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[574.795923] [126/133] (482s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[574.886889] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[574.890138] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[574.980224] [127/133] (482s left) prime_mmap_coherency (read)
[575.044292] Starting subtest: read
[580.417772] Subtest read: SUCCESS (5.376s)
[580.532505] [128/133] (477s left) gen7_exec_parse (bitmasks)
[580.595960] Subtest bitmasks: SKIP (0.000s)
[580.653489] [129/133] (477s left) kms_psr (psr2-cursor-mmap-cpu)
[580.758722] Starting subtest: psr2-cursor-mmap-cpu
[580.760996] Starting dynamic subtest: eDP-1
[582.429041] Dynamic subtest eDP-1: SUCCESS (1.673s)
[582.431400] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.674s)
[583.304732] [130/133] (474s left) gem_exec_params (invalid-fence-in-submit)
[583.367828] Starting subtest: invalid-fence-in-submit
[583.373072] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[583.490551] [131/133] (474s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[583.586454] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[583.588921] Starting dynamic subtest: pipe-A-eDP-1
[583.659809] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[583.670991] Starting dynamic subtest: pipe-B-eDP-1
[584.775909] Dynamic subtest pipe-B-eDP-1: SKIP (1.115s)
[584.780280] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.194s)
[585.972544] [132/133] (471s left) gem_mmap (bad-object)
[586.024984] Subtest bad-object: SKIP (0.000s)
[586.082736] [133/133] (471s left) kms_vblank (query-busy)
[586.167672] Starting subtest: query-busy
[586.169444] Starting dynamic subtest: pipe-A-eDP-1
[588.056579] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[588.071681] Starting dynamic subtest: pipe-D-eDP-1
[590.618935] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[590.621258] Subtest query-busy: SUCCESS (4.456s)
[591.411235] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_ctx_param
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: sriov_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: kms_atomic_transition
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: api_intel_allocator
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: drm_read
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: sysfs_preempt_timeout
results: parsing output: 25/ for test: gem_create
results: parsing output: 26/ for test: gem_fenced_exec_thrash
results: parsing output: 27/ for test: dumb_buffer
results: parsing output: 28/ for test: kms_cursor_edge_walk
results: parsing output: 29/ for test: gem_ctx_persistence
results: parsing output: 30/ for test: gem_bad_reloc
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: prime_mmap
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: syncobj_basic
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_chamelium_color
results: parsing output: 43/ for test: gem_mmap_gtt
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_atomic_interruptible
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: gen3_render_tiledx_blits
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_debugfs
results: parsing output: 55/ for test: gem_partial_pwrite_pread
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_ctx_param
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_async
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_getfb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_plane
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_balancer
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: template
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_spin_batch
results: parsing output: 74/ for test: gem_mmap
results: parsing output: 75/ for test: i915_pm_freq_mult
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_drm_fdinfo
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_fenced_exec_thrash
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: gem_pipe_control_store_loop
results: parsing output: 86/ for test: kms_color_pipeline
results: parsing output: 87/ for test: kms_lease
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_chamelium_hpd
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_ctx_param
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: i915_module_load
results: parsing output: 104/ for test: prime_mmap
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_pm_dc
results: parsing output: 113/ for test: gem_exec_parallel
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: i915_query
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: prime_mmap_coherency
results: parsing output: 127/ for test: gen7_exec_parse
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_mmap
results: parsing output: 132/ for test: kms_vblank
Done.