[56.361032] Initializing watchdogs
[56.361087]   /dev/watchdog0
[56.375241] [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]
[56.379541] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.382333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.385235] [001/130] (960s left) gem_exec_schedule (noreorder)
[56.623690] Starting subtest: noreorder
[56.626315] Starting dynamic subtest: rcs0
[56.699083] Dynamic subtest rcs0: SUCCESS (0.075s)
[56.706902] Starting dynamic subtest: vcs0
[57.925334] Dynamic subtest vcs0: SUCCESS (1.207s)
[57.937090] Starting dynamic subtest: vcs1
[60.015965] Dynamic subtest vcs1: SUCCESS (2.017s)
[60.025388] Starting dynamic subtest: vecs0
[61.960877] Dynamic subtest vecs0: SUCCESS (1.979s)
[61.970720] Starting dynamic subtest: ccs0
[62.038885] Dynamic subtest ccs0: SUCCESS (0.080s)
[62.041395] Subtest noreorder: SUCCESS (5.360s)
[62.215862] [002/130] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[62.335370] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[62.339459] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[62.435384] [003/130] (954s left) kms_async_flips (async-flip-suspend-resume)
[62.529809] Starting subtest: async-flip-suspend-resume
[62.904121] Starting dynamic subtest: pipe-A-eDP-1
[80.393756] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.998s)
[80.764236] Starting dynamic subtest: pipe-B-eDP-1
[83.566941] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.698s)
[83.877956] Starting dynamic subtest: pipe-C-eDP-1
[86.605047] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.694s)
[86.974830] Starting dynamic subtest: pipe-D-eDP-1
[89.833293] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[89.835888] Subtest async-flip-suspend-resume: SUCCESS (12.611s)
[90.978414] [004/130] (940s left) gem_exec_create (basic)
[91.039088] Starting subtest: basic
[91.041519] Starting dynamic subtest: smem
[94.393724] Dynamic subtest smem: SUCCESS (3.333s)
[94.396355] Subtest basic: SUCCESS (3.333s)
[94.568491] [005/130] (937s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[94.674078] Starting subtest: fbcpsr-tiling-y
[94.678576] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[94.755516] [006/130] (937s left) kms_flip (wf_vblank-ts-check)
[94.854614] Starting subtest: wf_vblank-ts-check
[94.856874] Starting dynamic subtest: A-eDP1
[103.870830] Dynamic subtest A-eDP1: SUCCESS (8.990s)
[103.880296] Starting dynamic subtest: B-eDP1
[112.833171] Dynamic subtest B-eDP1: SUCCESS (8.918s)
[112.842910] Starting dynamic subtest: C-eDP1
[121.756757] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[121.766506] Starting dynamic subtest: D-eDP1
[130.691894] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[130.694321] Subtest wf_vblank-ts-check: SUCCESS (35.753s)
[131.855568] [007/130] (899s left) syncobj_eventfd (timeline-wait)
[131.915059] Starting subtest: timeline-wait
[131.925716] Subtest timeline-wait: SUCCESS (0.010s)
[131.992561] [008/130] (899s left) gem_exec_fence (syncobj-timeline-signal)
[132.571548] Starting subtest: syncobj-timeline-signal
[132.577783] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[134.483277] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[134.486229] [009/130] (897s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[134.589407] Starting subtest: plane-upscale-factor-0-25-with-rotation
[134.591841] Starting dynamic subtest: pipe-A
[134.817813] Dynamic subtest pipe-A: SUCCESS (0.228s)
[134.827623] Starting dynamic subtest: pipe-B
[136.132837] Dynamic subtest pipe-B: SUCCESS (1.314s)
[136.140946] Starting dynamic subtest: pipe-C
[137.462210] Dynamic subtest pipe-C: SUCCESS (1.329s)
[137.471955] Starting dynamic subtest: pipe-D
[138.793851] Dynamic subtest pipe-D: SUCCESS (1.330s)
[138.796197] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.202s)
[139.958301] [010/130] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[140.060833] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[140.065194] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[140.152682] [011/130] (891s left) kms_addfb_basic (basic-x-tiled-legacy)
[140.210915] Starting subtest: basic-x-tiled-legacy
[140.215417] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[140.333628] [012/130] (891s left) i915_pm_freq_api (freq-suspend)
[140.396176] Starting subtest: freq-suspend
[140.398338] Starting dynamic subtest: gt0
[156.351998] Dynamic subtest gt0: SUCCESS (1.224s)
[156.367235] Starting dynamic subtest: gt1
[172.303750] Dynamic subtest gt1: SUCCESS (1.127s)
[172.307255] Subtest freq-suspend: SUCCESS (2.352s)
[173.376291] [013/130] (889s left) kms_psr (pr-sprite-plane-onoff)
[173.483127] Starting subtest: pr-sprite-plane-onoff
[173.487768] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[173.555327] [014/130] (889s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[173.664775] Starting subtest: fbc-psr-sprite-mmap-gtt
[173.667158] Starting dynamic subtest: eDP-1
[173.671679] Dynamic subtest eDP-1: SKIP (0.000s)
[173.676246] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[173.734626] [015/130] (888s left) kms_chamelium_hpd (common-hpd-after-suspend)
[174.148325] Subtest common-hpd-after-suspend: SKIP (0.000s)
[174.974642] [016/130] (887s left) gem_ctx_shared (q-out-order)
[175.045345] Starting subtest: Q-out-order
[175.047815] Starting dynamic subtest: rcs0
[175.141562] Dynamic subtest rcs0: SUCCESS (0.094s)
[175.157247] Starting dynamic subtest: vcs0
[175.219460] Dynamic subtest vcs0: SUCCESS (0.076s)
[175.235556] Starting dynamic subtest: vcs1
[175.298394] Dynamic subtest vcs1: SUCCESS (0.077s)
[175.314818] Starting dynamic subtest: vecs0
[175.369678] Dynamic subtest vecs0: SUCCESS (0.069s)
[175.385582] Starting dynamic subtest: ccs0
[175.457390] Dynamic subtest ccs0: SUCCESS (0.086s)
[175.460236] Subtest Q-out-order: SUCCESS (0.404s)
[177.028316] [017/130] (885s left) gen9_exec_parse (bb-large)
[177.098886] Subtest bb-large: SKIP (0.000s)
[177.170927] [018/130] (885s left) gem_pipe_control_store_loop (reused-buffer)
[177.235469] Starting subtest: reused-buffer
[179.418620] Subtest reused-buffer: SUCCESS (2.152s)
[179.545453] [019/130] (883s left) gem_ctx_persistence (engines-queued)
[179.618150] Starting subtest: engines-queued
[179.620678] Starting dynamic subtest: rcs0
[179.750039] Dynamic subtest rcs0: SUCCESS (0.129s)
[179.761280] Starting dynamic subtest: bcs0
[179.790106] Dynamic subtest bcs0: SUCCESS (0.040s)
[179.799514] Starting dynamic subtest: vcs0
[180.931444] Dynamic subtest vcs0: SUCCESS (1.127s)
[180.940331] Starting dynamic subtest: vcs1
[182.913812] Dynamic subtest vcs1: SUCCESS (1.964s)
[182.922315] Starting dynamic subtest: vecs0
[184.950281] Dynamic subtest vecs0: SUCCESS (1.970s)
[184.960929] Starting dynamic subtest: ccs0
[185.082880] Dynamic subtest ccs0: SUCCESS (0.184s)
[185.085555] Subtest engines-queued: SUCCESS (5.419s)
[185.204393] [020/130] (877s left) kms_flip (2x-flip-vs-panning)
[185.296739] Starting subtest: 2x-flip-vs-panning
[185.308032] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[185.385323] [021/130] (877s left) vgem_basic (create)
[185.430461] Starting subtest: create
[185.432339] Subtest create: SUCCESS (0.000s)
[185.482385] [022/130] (877s left) gem_ctx_isolation (dirty-switch)
[185.551017] Starting subtest: dirty-switch
[185.553418] Starting dynamic subtest: rcs0
[185.982182] Dynamic subtest rcs0: SUCCESS (0.429s)
[185.991885] Starting dynamic subtest: bcs0
[186.440956] Dynamic subtest bcs0: SUCCESS (0.457s)
[186.450153] Starting dynamic subtest: vcs0
[186.918110] Dynamic subtest vcs0: SUCCESS (0.474s)
[186.926032] Starting dynamic subtest: vcs1
[188.405728] Dynamic subtest vcs1: SUCCESS (1.480s)
[188.416123] Starting dynamic subtest: vecs0
[190.454280] Dynamic subtest vecs0: SUCCESS (2.042s)
[190.465075] Starting dynamic subtest: ccs0
[192.437296] Dynamic subtest ccs0: SUCCESS (1.977s)
[192.439912] Subtest dirty-switch: SUCCESS (6.860s)
[192.713856] [023/130] (870s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[192.823702] Starting subtest: fb-8bpc-vs-panel-6bpc
[192.826072] Starting dynamic subtest: pipe-A-eDP-1
[194.191608] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.363s)
[194.194243] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.364s)
[194.983411] [024/130] (868s left) gem_exec_balancer (bonded-true-hang)
[195.227686] Starting subtest: bonded-true-hang
[195.232942] Subtest bonded-true-hang: SKIP (0.000s)
[195.334568] [025/130] (867s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[195.432707] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[195.435134] Starting dynamic subtest: pipe-A-eDP-1
[195.460085] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[195.467881] Starting dynamic subtest: pipe-B-eDP-1
[195.491686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[195.499061] Starting dynamic subtest: pipe-C-eDP-1
[195.523087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[195.530470] Starting dynamic subtest: pipe-D-eDP-1
[195.554698] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[195.559082] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.002s)
[197.657858] [026/130] (865s left) gem_lmem_swapping (verify-random)
[197.703921] Subtest verify-random: SKIP (0.000s)
[197.742259] [027/130] (865s left) gem_softpin (evict-active)
[197.805020] Starting subtest: evict-active
[197.811203] Subtest evict-active: SUCCESS (0.006s)
[197.943887] [028/130] (865s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[198.057250] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[200.819886] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.763s)
[200.987296] [029/130] (862s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[201.089247] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[201.091227] Starting dynamic subtest: pipe-A-default-mode
[202.241181] Dynamic subtest pipe-A-default-mode: SKIP (1.145s)
[202.245614] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.146s)
[202.381054] [030/130] (861s left) kms_lease (lease-invalid-connector)
[202.481541] Starting subtest: lease-invalid-connector
[202.483864] Starting dynamic subtest: pipe-A-eDP-1
[202.486042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[202.494149] Starting dynamic subtest: pipe-B-eDP-1
[202.496026] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[202.503811] Starting dynamic subtest: pipe-C-eDP-1
[202.505940] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[202.513842] Starting dynamic subtest: pipe-D-eDP-1
[202.515742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[202.517654] Subtest lease-invalid-connector: SUCCESS (0.003s)
[202.549566] [031/130] (860s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[202.657948] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[202.662208] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[202.745373] [032/130] (860s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[202.844690] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[202.847074] Starting dynamic subtest: pipe-A-eDP-1
[202.870598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[202.880803] Starting dynamic subtest: pipe-B-eDP-1
[202.902836] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[202.910673] Starting dynamic subtest: pipe-C-eDP-1
[202.932014] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[202.939855] Starting dynamic subtest: pipe-D-eDP-1
[202.962457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[202.966731] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[204.975896] [033/130] (858s left) kms_sequence (get-idle)
[205.065608] Starting subtest: get-idle
[205.067924] Starting dynamic subtest: pipe-A-eDP-1
[206.879097] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[206.887550] Starting dynamic subtest: pipe-B-eDP-1
[209.336136] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.456s)
[209.345794] Starting dynamic subtest: pipe-C-eDP-1
[211.745227] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.409s)
[211.753733] Starting dynamic subtest: pipe-D-eDP-1
[214.171852] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[214.174328] Subtest get-idle: SUCCESS (9.106s)
[214.977309] [034/130] (848s left) syncobj_basic (bad-pad-fd-to-handle)
[215.038376] Starting subtest: bad-pad-fd-to-handle
[215.040725] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[215.144897] [035/130] (848s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[215.251156] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[215.255613] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[215.355339] [036/130] (848s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[215.463964] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[215.476904] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[215.591362] [037/130] (848s left) kms_addfb_basic (basic)
[215.653030] Starting subtest: basic
[215.655424] Subtest basic: SUCCESS (0.000s)
[215.798999] [038/130] (847s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[215.907688] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[215.911248] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.021384] [039/130] (847s left) kms_big_fb (linear-16bpp-rotate-270)
[216.133789] Starting subtest: linear-16bpp-rotate-270
[216.152667] Subtest linear-16bpp-rotate-270: SKIP (0.018s)
[216.284418] [040/130] (847s left) syncobj_wait (single-wait-all-signaled)
[216.344057] Starting subtest: single-wait-all-signaled
[216.345694] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[216.422287] [041/130] (847s left) gem_spin_batch (resubmit-new-all)
[216.482345] Starting subtest: resubmit-new-all
[216.484441] Starting dynamic subtest: rcs0
[216.494759] Dynamic subtest rcs0: SUCCESS (0.012s)
[216.504788] Starting dynamic subtest: bcs0
[216.506659] Dynamic subtest bcs0: SUCCESS (0.009s)
[216.514355] Starting dynamic subtest: vcs0
[216.516173] Dynamic subtest vcs0: SUCCESS (0.008s)
[216.523832] Starting dynamic subtest: vcs1
[216.525481] Dynamic subtest vcs1: SUCCESS (0.008s)
[216.533209] Starting dynamic subtest: vecs0
[216.535096] Dynamic subtest vecs0: SUCCESS (0.011s)
[216.543315] Starting dynamic subtest: ccs0
[216.545186] Dynamic subtest ccs0: SUCCESS (0.010s)
[216.546804] Subtest resubmit-new-all: SUCCESS (0.060s)
[217.990204] [042/130] (845s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[218.109146] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[234.816103] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (16.704s)
[235.620317] [043/130] (828s left) gem_exec_reloc (basic-cpu-read)
[235.692840] Subtest basic-cpu-read: SKIP (0.000s)
[235.761132] [044/130] (828s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[235.819002] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[235.821319] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[235.919145] [045/130] (828s left) syncobj_timeline (invalid-wait-bad-flags)
[235.982794] Starting subtest: invalid-wait-bad-flags
[235.984983] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[236.081179] [046/130] (827s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[236.185136] Starting subtest: x-tiled-16bpp-rotate-270
[236.203958] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[236.333999] [047/130] (827s left) syncobj_timeline (multi-wait-signaled)
[236.391849] Starting subtest: multi-wait-signaled
[236.394270] Subtest multi-wait-signaled: SUCCESS (0.000s)
[236.500803] [048/130] (827s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[236.628989] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[237.601964] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.972s)
[238.446255] [049/130] (825s left) kms_color (ctm-red-to-blue)
[238.545756] Starting subtest: ctm-red-to-blue
[238.548156] Starting dynamic subtest: pipe-A-eDP-1
[239.241270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[239.249757] Starting dynamic subtest: pipe-B-eDP-1
[240.627912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[240.637419] Starting dynamic subtest: pipe-C-eDP-1
[241.995748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[242.005288] Starting dynamic subtest: pipe-D-eDP-1
[243.319695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[243.322254] Subtest ctm-red-to-blue: SUCCESS (4.770s)
[244.152586] [050/130] (819s left) kms_psr (fbc-psr2-no-drrs)
[244.256966] Starting subtest: fbc-psr2-no-drrs
[244.259348] Starting dynamic subtest: eDP-1
[244.263957] Dynamic subtest eDP-1: SKIP (0.000s)
[244.268563] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[244.326289] [051/130] (819s left) gem_ctx_param (basic)
[244.375450] Starting subtest: basic
[244.377857] Subtest basic: SUCCESS (0.001s)
[244.475925] [052/130] (819s left) syncobj_wait (multi-wait-for-submit-submitted)
[244.527006] Starting subtest: multi-wait-for-submit-submitted
[244.632452] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[244.703868] [053/130] (819s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[244.828931] Starting subtest: basic-busy-flip-before-cursor-atomic
[244.833286] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[244.957435] [054/130] (819s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[249.997717] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[250.000144] Starting dynamic subtest: pipe-A-eDP-1
[250.806720] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[250.819644] Starting dynamic subtest: pipe-B-eDP-1
[252.035992] Dynamic subtest pipe-B-eDP-1: SKIP (1.226s)
[252.040668] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.033s)
[253.212923] [055/130] (811s left) perf_pmu (busy-no-semaphores)
[253.252369] Starting subtest: busy-no-semaphores
[253.254679] Starting dynamic subtest: rcs0
[253.828019] Dynamic subtest rcs0: SUCCESS (0.573s)
[253.839301] Starting dynamic subtest: bcs0
[254.375459] Dynamic subtest bcs0: SUCCESS (0.545s)
[254.386396] Starting dynamic subtest: vcs0
[254.925483] Dynamic subtest vcs0: SUCCESS (0.549s)
[254.936797] Starting dynamic subtest: vcs1
[256.488266] Dynamic subtest vcs1: SUCCESS (1.560s)
[256.499692] Starting dynamic subtest: vecs0
[258.473213] Dynamic subtest vecs0: SUCCESS (1.983s)
[258.484526] Starting dynamic subtest: ccs0
[260.455119] Dynamic subtest ccs0: SUCCESS (1.979s)
[260.458374] Subtest busy-no-semaphores: SUCCESS (7.198s)
[260.583419] [056/130] (803s left) kms_psr (fbc-pr-dpms)
[260.696542] Starting subtest: fbc-pr-dpms
[260.700776] Subtest fbc-pr-dpms: SKIP (0.000s)
[260.763141] [057/130] (803s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[260.870845] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[265.390171] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.521s)
[265.543216] [058/130] (798s left) gem_exec_whisper (basic-forked)
[265.626149] Starting subtest: basic-forked
[272.870006] Subtest basic-forked: SUCCESS (7.243s)
[273.050396] [059/130] (791s left) kms_cursor_crc (cursor-random-512x512)
[273.315481] Starting subtest: cursor-random-512x512
[273.319874] Subtest cursor-random-512x512: SKIP (0.001s)
[273.486133] [060/130] (790s left) gem_exec_balancer (parallel)
[273.723116] Starting subtest: parallel
[274.503159] Subtest parallel: SUCCESS (0.780s)
[275.017292] [061/130] (789s left) perf_pmu (rc6)
[275.058321] Starting subtest: rc6
[275.060350] Starting dynamic subtest: gt0
[281.486403] Dynamic subtest gt0: SUCCESS (6.377s)
[281.497974] Starting dynamic subtest: runtime-pm-gt0
[289.141920] Dynamic subtest runtime-pm-gt0: SUCCESS (7.706s)
[289.153483] Starting dynamic subtest: runtime-pm-long-gt0
[301.565224] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.423s)
[301.577214] Starting dynamic subtest: other-idle-gt0
[307.958677] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[307.970059] Starting dynamic subtest: gt1
[314.250353] Dynamic subtest gt1: SUCCESS (6.339s)
[314.265939] Starting dynamic subtest: runtime-pm-gt1
[321.685693] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[321.697845] Starting dynamic subtest: runtime-pm-long-gt1
[334.130690] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.441s)
[334.141463] Starting dynamic subtest: other-idle-gt1
[340.526687] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[340.529580] Subtest rc6: SUCCESS (65.413s)
[341.606100] [062/130] (722s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[341.709002] Starting subtest: fbc-modesetfrombusy
[344.540176] Subtest fbc-modesetfrombusy: SUCCESS (2.836s)
[344.638789] [063/130] (719s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[344.731402] Starting subtest: disable-crc-after-crtc
[344.733426] Starting dynamic subtest: pipe-A-eDP-1
[346.387684] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.653s)
[346.397175] Starting dynamic subtest: pipe-B-eDP-1
[348.662271] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.274s)
[348.671203] Starting dynamic subtest: pipe-C-eDP-1
[350.897091] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.230s)
[350.906445] Starting dynamic subtest: pipe-D-eDP-1
[353.157550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[353.159927] Subtest disable-crc-after-crtc: SUCCESS (8.423s)
[353.958933] [064/130] (710s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[354.075853] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[354.080092] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[354.154922] [065/130] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[354.261216] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[354.266056] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[354.341482] [066/130] (710s left) kms_psr (psr-primary-mmap-gtt)
[354.435009] Starting subtest: psr-primary-mmap-gtt
[354.437384] Starting dynamic subtest: eDP-1
[355.876394] Dynamic subtest eDP-1: SKIP (1.436s)
[355.880683] Subtest psr-primary-mmap-gtt: SKIP (1.438s)
[355.984260] [067/130] (708s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[356.099209] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[356.103686] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[356.170624] [068/130] (708s left) kms_writeback (writeback-fb-id)
[356.280684] Subtest writeback-fb-id: SKIP (0.000s)
[356.324886] [069/130] (708s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[356.414083] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[356.416431] Starting dynamic subtest: pipe-A-eDP-1
[357.752007] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.335s)
[358.030198] Starting dynamic subtest: pipe-B-eDP-1
[359.072081] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[359.335980] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.921s)
[360.152850] [070/130] (704s left) perf_pmu (multi-client)
[360.193188] Starting subtest: multi-client
[360.195502] Starting dynamic subtest: rcs0
[361.282943] Dynamic subtest rcs0: SUCCESS (1.087s)
[361.294484] Starting dynamic subtest: bcs0
[362.333058] Dynamic subtest bcs0: SUCCESS (1.048s)
[362.344364] Starting dynamic subtest: vcs0
[363.387470] Dynamic subtest vcs0: SUCCESS (1.051s)
[363.397887] Starting dynamic subtest: vcs1
[364.955698] Dynamic subtest vcs1: SUCCESS (1.567s)
[364.967143] Starting dynamic subtest: vecs0
[366.999994] Dynamic subtest vecs0: SUCCESS (2.042s)
[367.009687] Starting dynamic subtest: ccs0
[368.985348] Dynamic subtest ccs0: SUCCESS (1.982s)
[368.987985] Subtest multi-client: SUCCESS (8.789s)
[369.075914] [071/130] (695s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[369.183700] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[369.186010] Starting dynamic subtest: pipe-A
[370.750985] Dynamic subtest pipe-A: SUCCESS (1.567s)
[370.761272] Starting dynamic subtest: pipe-B
[373.380549] Dynamic subtest pipe-B: SUCCESS (2.628s)
[373.389310] Starting dynamic subtest: pipe-C
[374.604092] Dynamic subtest pipe-C: SUCCESS (1.221s)
[374.614516] Starting dynamic subtest: pipe-D
[375.811686] Dynamic subtest pipe-D: SUCCESS (1.207s)
[375.814113] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (6.626s)
[376.974139] [072/130] (687s left) gem_mmap_wc (write-cpu-read-wc)
[377.036986] Subtest write-cpu-read-wc: SKIP (0.000s)
[377.106032] [073/130] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[377.203888] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[377.208204] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[377.303064] [074/130] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[377.402450] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[377.406748] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[377.462143] [075/130] (687s left) kms_flip (flip-vs-suspend)
[377.554790] Starting subtest: flip-vs-suspend
[377.557041] Starting dynamic subtest: A-eDP1
[426.319171] Dynamic subtest A-eDP1: SUCCESS (4.482s)
[426.328972] Starting dynamic subtest: B-eDP1
[475.326316] Dynamic subtest B-eDP1: SUCCESS (4.285s)
[475.341049] Starting dynamic subtest: C-eDP1
[524.329516] Dynamic subtest C-eDP1: SUCCESS (4.285s)
[524.343553] Starting dynamic subtest: D-eDP1
[573.318878] Dynamic subtest D-eDP1: SUCCESS (4.302s)
[573.337154] Subtest flip-vs-suspend: SUCCESS (17.363s)
[574.563715] [076/130] (668s left) drm_fdinfo (busy-idle-check-all)
[574.607016] Starting subtest: busy-idle-check-all
[574.609150] Starting dynamic subtest: rcs0
[574.614080] Dynamic subtest rcs0: SKIP (0.004s)
[574.624929] Starting dynamic subtest: bcs0
[574.629033] Dynamic subtest bcs0: SKIP (0.000s)
[574.637748] Starting dynamic subtest: vcs0
[574.641997] Dynamic subtest vcs0: SKIP (0.000s)
[574.650522] Starting dynamic subtest: vcs1
[574.654795] Dynamic subtest vcs1: SKIP (0.000s)
[574.663322] Starting dynamic subtest: vecs0
[574.667740] Dynamic subtest vecs0: SKIP (0.000s)
[574.676086] Starting dynamic subtest: ccs0
[574.680281] Dynamic subtest ccs0: SKIP (0.000s)
[574.684491] Subtest busy-idle-check-all: SKIP (0.008s)
[574.719229] [077/130] (668s left) gem_partial_pwrite_pread (writes-after-reads)
[574.820339] Subtest writes-after-reads: SKIP (0.000s)
[574.892893] [078/130] (668s left) core_auth (many-magics)
[574.956393] Starting subtest: many-magics
[575.568638] Subtest many-magics: SUCCESS (0.602s)
[575.629206] [079/130] (667s left) gem_mmap_offset (mmap-boundaries)
[575.714381] Starting subtest: mmap-boundaries
[575.716313] Starting dynamic subtest: smem0
[576.781399] Dynamic subtest smem0: SUCCESS (1.046s)
[576.784190] Subtest mmap-boundaries: SUCCESS (1.047s)
[576.944007] [080/130] (666s left) prime_self_import (export-vs-gem_close-race)
[576.984785] Starting subtest: export-vs-gem_close-race
[582.099164] Subtest export-vs-gem_close-race: SUCCESS (5.041s)
[582.141668] [081/130] (661s left) kms_cursor_crc (cursor-offscreen-128x128)
[582.349560] Starting subtest: cursor-offscreen-128x128
[582.354423] Starting dynamic subtest: pipe-A-eDP-1
[584.321040] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.950s)
[584.346457] Starting dynamic subtest: pipe-D-eDP-1
[586.971051] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[586.973049] Subtest cursor-offscreen-128x128: SUCCESS (4.588s)
[587.778510] [082/130] (656s left) kms_vblank (ts-continuation-idle-hang)
[587.877052] Starting subtest: ts-continuation-idle-hang
[587.879275] Starting dynamic subtest: pipe-A-eDP-1
[613.868984] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.957s)
[613.884353] Starting dynamic subtest: pipe-D-eDP-1
[628.856170] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[628.858880] Subtest ts-continuation-idle-hang: SUCCESS (40.944s)
[629.651792] [083/130] (614s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[634.652305] Starting subtest: pr-plane-move-sf-dmg-area
[634.657025] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s)
[635.464475] [084/130] (608s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[635.519744] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[635.524196] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[635.674753] [085/130] (608s left) api_intel_allocator (standalone)
[635.732598] Starting subtest: standalone
[635.751826] Subtest standalone: SUCCESS (0.023s)
[635.842020] [086/130] (608s left) gem_exec_reloc (basic-wc-cpu)
[635.909481] Subtest basic-wc-cpu: SKIP (0.000s)
[635.987850] [087/130] (608s left) kms_plane (plane-position-hole)
[636.085071] Starting subtest: plane-position-hole
[636.586501] Starting dynamic subtest: pipe-A-plane-1
[637.834602] Dynamic subtest pipe-A-plane-1: SUCCESS (1.246s)
[637.844724] Starting dynamic subtest: pipe-A-plane-2
[639.063329] Dynamic subtest pipe-A-plane-2: SUCCESS (1.229s)
[639.072511] Starting dynamic subtest: pipe-A-plane-3
[640.286457] Dynamic subtest pipe-A-plane-3: SUCCESS (1.222s)
[640.295490] Starting dynamic subtest: pipe-A-plane-4
[641.528738] Dynamic subtest pipe-A-plane-4: SUCCESS (1.240s)
[641.539423] Starting dynamic subtest: pipe-A-plane-5
[641.567813] Dynamic subtest pipe-A-plane-5: SUCCESS (0.039s)
[642.667120] Starting dynamic subtest: pipe-B-plane-1
[643.884811] Dynamic subtest pipe-B-plane-1: SUCCESS (1.223s)
[643.894424] Starting dynamic subtest: pipe-B-plane-2
[645.109780] Dynamic subtest pipe-B-plane-2: SUCCESS (1.225s)
[645.120966] Starting dynamic subtest: pipe-B-plane-3
[646.326092] Dynamic subtest pipe-B-plane-3: SUCCESS (1.214s)
[646.336158] Starting dynamic subtest: pipe-B-plane-4
[647.552379] Dynamic subtest pipe-B-plane-4: SUCCESS (1.225s)
[647.561808] Starting dynamic subtest: pipe-B-plane-5
[647.590620] Dynamic subtest pipe-B-plane-5: SUCCESS (0.038s)
[647.593024] Subtest plane-position-hole: SUCCESS (11.500s)
[648.329959] [088/130] (595s left) gem_vm_create (invalid-create)
[648.393542] Starting subtest: invalid-create
[648.395879] Subtest invalid-create: SUCCESS (0.001s)
[648.487058] [089/130] (595s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[648.587169] Starting subtest: flip-vs-dpms-off-vs-modeset
[648.589518] Starting dynamic subtest: A-eDP1
[652.153931] Dynamic subtest A-eDP1: SUCCESS (3.563s)
[652.164031] Starting dynamic subtest: B-eDP1
[655.342635] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[655.351940] Starting dynamic subtest: C-eDP1
[658.410033] Dynamic subtest C-eDP1: SUCCESS (3.064s)
[658.420293] Starting dynamic subtest: D-eDP1
[661.481406] Dynamic subtest D-eDP1: SUCCESS (3.067s)
[661.483699] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.891s)
[662.256518] [090/130] (581s left) i915_query (engine-info-invalid)
[662.316436] Starting subtest: engine-info-invalid
[662.318638] Subtest engine-info-invalid: SUCCESS (0.000s)
[662.393001] [091/130] (581s left) kms_chamelium_edid (vga-edid-read)
[662.785903] Subtest vga-edid-read: SKIP (0.000s)
[663.582756] [092/130] (580s left) api_intel_bb (reset-bb)
[663.643733] Starting subtest: reset-bb
[663.646508] Subtest reset-bb: SUCCESS (0.004s)
[663.742816] [093/130] (580s left) core_auth (basic-auth)
[663.809304] Starting subtest: basic-auth
[663.811688] Subtest basic-auth: SUCCESS (0.001s)
[663.882721] [094/130] (580s left) drm_fdinfo (memory-info-shared)
[663.922023] Starting subtest: memory-info-shared
[663.924034] Starting dynamic subtest: smem0
[663.996840] Dynamic subtest smem0: SUCCESS (0.076s)
[663.999551] Subtest memory-info-shared: SUCCESS (0.077s)
[664.041855] [095/130] (580s left) kms_pm_rpm (modeset-lpsp-stress)
[666.293479] Starting subtest: modeset-lpsp-stress
[682.256865] Subtest modeset-lpsp-stress: SUCCESS (15.967s)
[682.351406] [096/130] (562s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[682.453142] Starting subtest: extended-pageflip-modeset-hang-oldfb
[682.455475] Starting dynamic subtest: pipe-A
[690.356657] Dynamic subtest pipe-A: SUCCESS (7.902s)
[690.370805] Starting dynamic subtest: pipe-D
[698.998614] Dynamic subtest pipe-D: SUCCESS (8.641s)
[699.001152] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.548s)
[699.822869] [097/130] (544s left) prime_vgem (fence-write-hang)
[699.902362] Subtest fence-write-hang: SKIP (0.000s)
[699.978797] [098/130] (544s left) syncobj_timeline (wait-any-interrupted)
[700.042968] Starting subtest: wait-any-interrupted
[700.148376] Subtest wait-any-interrupted: SUCCESS (0.107s)
[700.198852] [099/130] (544s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[700.302706] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[707.683520] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.384s)
[707.806652] [100/130] (536s left) sysfs_timeslice_duration (invalid)
[707.867638] Starting subtest: invalid
[707.870141] Starting dynamic subtest: vecs0
[707.872560] Dynamic subtest vecs0: SUCCESS (0.000s)
[707.883618] Starting dynamic subtest: ccs0
[707.885503] Dynamic subtest ccs0: SUCCESS (0.000s)
[707.894092] Starting dynamic subtest: vcs0
[707.895977] Dynamic subtest vcs0: SUCCESS (0.000s)
[707.904365] Starting dynamic subtest: bcs0
[707.906266] Dynamic subtest bcs0: SUCCESS (0.000s)
[707.914586] Starting dynamic subtest: rcs0
[707.916548] Dynamic subtest rcs0: SUCCESS (0.000s)
[707.924995] Starting dynamic subtest: vcs1
[707.926883] Dynamic subtest vcs1: SUCCESS (0.000s)
[707.928796] Subtest invalid: SUCCESS (0.005s)
[707.963465] [101/130] (536s left) gem_create (create-valid-nonaligned)
[708.028123] Starting subtest: create-valid-nonaligned
[708.030543] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[708.196885] [102/130] (536s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[708.302839] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[708.305415] Starting dynamic subtest: pipe-A-eDP-1
[708.329465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[708.340760] Starting dynamic subtest: pipe-B-eDP-1
[708.362884] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[708.371640] Starting dynamic subtest: pipe-C-eDP-1
[708.393657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[708.402345] Starting dynamic subtest: pipe-D-eDP-1
[708.424245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[708.428688] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[710.467736] [103/130] (534s left) kms_addfb_basic (unused-handle)
[710.533666] Starting subtest: unused-handle
[710.535953] Subtest unused-handle: SUCCESS (0.000s)
[710.658786] [104/130] (534s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[710.766522] Starting subtest: 4-tiled-8bpp-rotate-0
[711.914873] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.148s)
[712.080340] [105/130] (532s left) gem_partial_pwrite_pread (write-display)
[712.149279] Subtest write-display: SKIP (0.000s)
[712.212674] [106/130] (532s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[712.273791] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[712.277410] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[712.432298] [107/130] (532s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[712.499881] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[712.603469] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[712.654575] [108/130] (532s left) gem_ccs (block-copy-uncompressed)
[712.712264] Starting subtest: block-copy-uncompressed
[712.714610] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[712.736830] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.024s)
[712.748160] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[712.755823] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[712.764858] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[712.773635] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[712.783570] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[712.792028] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[712.794236] Subtest block-copy-uncompressed: SUCCESS (0.080s)
[712.889511] [109/130] (531s left) gem_ctx_create (basic)
[712.943427] Starting subtest: basic
[712.945825] Subtest basic: SUCCESS (0.000s)
[713.099079] [110/130] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[713.196430] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[713.200559] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[713.290806] [111/130] (531s left) gem_pxp (create-valid-protected-context)
[713.415542] Starting subtest: create-valid-protected-context
[713.418138] Subtest create-valid-protected-context: SUCCESS (0.002s)
[713.509844] [112/130] (531s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[713.621046] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[713.623347] Starting dynamic subtest: pipe-A-eDP-1
[713.682448] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[713.693413] Starting dynamic subtest: pipe-B-eDP-1
[713.752497] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[713.762731] Starting dynamic subtest: pipe-C-eDP-1
[713.820025] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[713.829804] Starting dynamic subtest: pipe-D-eDP-1
[713.889076] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[713.893493] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.008s)
[715.722847] [113/130] (529s left) gem_mmap_gtt (pf-nonblock)
[715.785009] Subtest pf-nonblock: SKIP (0.000s)
[715.856179] [114/130] (529s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[715.969003] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[715.973106] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[716.053555] [115/130] (529s left) gem_mmap_gtt (big-copy-xy)
[716.099094] Subtest big-copy-XY: SKIP (0.000s)
[716.165851] [116/130] (528s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[716.276650] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[717.478963] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.202s)
[717.620208] [117/130] (527s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[717.746040] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[717.749420] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[717.853941] [118/130] (527s left) gem_exec_params (invalid-bsd2-flag-on-render)
[717.912056] Starting subtest: invalid-bsd2-flag-on-render
[717.913984] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[718.005449] [119/130] (527s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[718.099428] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[718.103097] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[718.177631] [120/130] (527s left) gem_fenced_exec_thrash (too-many-fences)
[718.243976] Subtest too-many-fences: SKIP (0.000s)
[718.330312] [121/130] (526s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[718.430689] Starting subtest: yf-tiled-addfb-size-overflow
[718.434341] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[718.521207] [122/130] (526s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[718.622578] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[718.625936] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[718.672132] [123/130] (526s left) gem_exec_schedule (preempt-queue)
[718.738848] Subtest preempt-queue: SKIP (0.000s)
[719.003721] [124/130] (526s left) gem_exec_capture (pi)
[719.070998] Starting subtest: pi
[719.073318] Starting dynamic subtest: rcs0
[724.224837] Dynamic subtest rcs0: SUCCESS (5.153s)
[724.236740] Starting dynamic subtest: bcs0
[729.067226] Dynamic subtest bcs0: SUCCESS (4.841s)
[729.079404] Starting dynamic subtest: vcs0
[733.958524] Dynamic subtest vcs0: SUCCESS (4.887s)
[733.970708] Starting dynamic subtest: vcs1
[738.727379] Dynamic subtest vcs1: SUCCESS (4.767s)
[738.739890] Starting dynamic subtest: vecs0
[743.744808] Dynamic subtest vecs0: SUCCESS (5.015s)
[743.756623] Starting dynamic subtest: ccs0
[748.605249] Dynamic subtest ccs0: SUCCESS (4.857s)
[748.608703] Subtest pi: SUCCESS (29.530s)
[748.660033] [125/130] (496s left) gem_flink_basic (bad-flink)
[748.760575] Starting subtest: bad-flink
[748.762892] Subtest bad-flink: SUCCESS (0.000s)
[748.841791] [126/130] (496s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[749.043219] Starting subtest: cursor-rapid-movement-128x128
[749.048151] Starting dynamic subtest: pipe-A-eDP-1
[749.627084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[749.656152] Starting dynamic subtest: pipe-D-eDP-1
[750.855954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.208s)
[750.858179] Subtest cursor-rapid-movement-128x128: SUCCESS (1.811s)
[751.681153] [127/130] (493s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[751.801531] Starting subtest: psr-rgb565-draw-blt
[756.733299] Subtest psr-rgb565-draw-blt: SUCCESS (4.933s)
[756.846028] [128/130] (488s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[756.945117] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[756.949211] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[757.015672] [129/130] (488s left) sw_sync (sync_expired_merge)
[757.065235] Starting subtest: sync_expired_merge
[758.141229] Subtest sync_expired_merge: SUCCESS (1.074s)
[758.174733] [130/130] (487s left) gem_exec_schedule (u-submit-early-slice)
[758.252539] Starting subtest: u-submit-early-slice
[758.254840] Starting dynamic subtest: rcs0
[758.291824] Dynamic subtest rcs0: SUCCESS (0.039s)
[758.303991] Starting dynamic subtest: bcs0
[758.320011] Dynamic subtest bcs0: SUCCESS (0.028s)
[758.329888] Starting dynamic subtest: vcs0
[758.352645] Dynamic subtest vcs0: SUCCESS (0.032s)
[758.363677] Starting dynamic subtest: vcs1
[758.385470] Dynamic subtest vcs1: SUCCESS (0.032s)
[758.402157] Starting dynamic subtest: vecs0
[758.422777] Dynamic subtest vecs0: SUCCESS (0.037s)
[758.432169] Starting dynamic subtest: ccs0
[758.461481] Dynamic subtest ccs0: SUCCESS (0.038s)
[758.463878] Subtest u-submit-early-slice: SUCCESS (0.209s)
[760.134056] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_async_flips
results: parsing output: 3/ for test: gem_exec_create
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: syncobj_eventfd
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: i915_pm_freq_api
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_chamelium_hpd
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: gen9_exec_parse
results: parsing output: 17/ for test: gem_pipe_control_store_loop
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: vgem_basic
results: parsing output: 21/ for test: gem_ctx_isolation
results: parsing output: 22/ for test: kms_dither
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_sequence
results: parsing output: 33/ for test: syncobj_basic
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_spin_batch
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_ctx_param
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_whisper
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: gem_exec_balancer
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pipe_crc_basic
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_writeback
results: parsing output: 68/ for test: kms_atomic_transition
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: gem_mmap_wc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: drm_fdinfo
results: parsing output: 76/ for test: gem_partial_pwrite_pread
results: parsing output: 77/ for test: core_auth
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: prime_self_import
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: gem_vm_create
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: core_auth
results: parsing output: 93/ for test: drm_fdinfo
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_busy
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: sysfs_timeslice_duration
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_partial_pwrite_pread
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: gem_ccs
results: parsing output: 108/ for test: gem_ctx_create
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_pxp
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: gem_mmap_gtt
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: gem_exec_params
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_fenced_exec_thrash
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_joiner
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_exec_capture
results: parsing output: 124/ for test: gem_flink_basic
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: gem_exec_schedule
Done.