[56.682111] Initializing watchdogs
[56.682157]   /dev/watchdog0
[56.696315] [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.700687] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.702822] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.706148] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[56.832678] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[56.834959] Starting dynamic subtest: pipe-A
[56.929094] Dynamic subtest pipe-A: SUCCESS (0.097s)
[56.939462] Starting dynamic subtest: pipe-B
[58.093782] Dynamic subtest pipe-B: SUCCESS (1.154s)
[58.103213] Starting dynamic subtest: pipe-C
[59.209395] Dynamic subtest pipe-C: SUCCESS (1.107s)
[59.230861] Starting dynamic subtest: pipe-D
[60.349333] Dynamic subtest pipe-D: SUCCESS (1.131s)
[60.351933] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.492s)
[61.535480] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[61.601880] Starting subtest: forbidden-operations
[61.606065] Subtest forbidden-operations: SKIP (0.000s)
[61.754225] [003/134] (955s left) gem_mmap_gtt (big-bo)
[61.816731] Subtest big-bo: SKIP (0.000s)
[61.885587] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[61.988130] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[69.401094] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.394s)
[69.580935] [005/134] (947s left) kms_fence_pin_leak
[69.753574] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[69.859684] Starting subtest: x-tiled-16bpp-rotate-180
[71.206393] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.344s)
[71.370820] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[71.431843] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[71.497019] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[71.601391] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[71.613701] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[71.757588] [009/134] (945s left) perf_pmu (busy-check-all)
[71.794039] Starting subtest: busy-check-all
[71.795992] Starting dynamic subtest: rcs0
[72.345285] Dynamic subtest rcs0: SUCCESS (0.550s)
[72.356682] Starting dynamic subtest: bcs0
[72.894642] Dynamic subtest bcs0: SUCCESS (0.548s)
[72.904924] Starting dynamic subtest: vcs0
[74.901967] Dynamic subtest vcs0: SUCCESS (2.003s)
[74.912665] Starting dynamic subtest: vcs1
[76.885080] Dynamic subtest vcs1: SUCCESS (1.980s)
[76.895780] Starting dynamic subtest: vecs0
[78.868286] Dynamic subtest vecs0: SUCCESS (1.981s)
[78.878467] Starting dynamic subtest: ccs0
[79.422874] Dynamic subtest ccs0: SUCCESS (0.555s)
[79.425328] Subtest busy-check-all: SUCCESS (7.623s)
[79.558764] [010/134] (937s left) gem_mmap_wc (coherency)
[79.614623] Subtest coherency: SKIP (0.000s)
[79.681241] [011/134] (937s left) kms_big_fb (yf-tiled-addfb)
[79.782432] Starting subtest: yf-tiled-addfb
[79.786959] Subtest yf-tiled-addfb: SKIP (0.000s)
[79.919749] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[80.023024] Starting subtest: extended-modeset-hang-oldfb-with-reset
[80.025332] Starting dynamic subtest: pipe-A
[91.555678] Dynamic subtest pipe-A: SUCCESS (11.525s)
[91.566367] Starting dynamic subtest: pipe-D
[103.836339] Dynamic subtest pipe-D: SUCCESS (12.275s)
[103.838592] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.804s)
[104.636019] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[104.746347] Starting subtest: constant-alpha-min
[105.034432] Starting dynamic subtest: pipe-A-eDP-1
[105.745423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[105.754651] Starting dynamic subtest: pipe-D-eDP-1
[107.228179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.483s)
[107.230545] Subtest constant-alpha-min: SUCCESS (2.482s)
[108.083328] [014/134] (909s left) sysfs_timeslice_duration (duration)
[108.137621] Starting subtest: duration
[108.140108] Starting dynamic subtest: vecs0
[121.845415] Dynamic subtest vecs0: SUCCESS (13.703s)
[121.856281] Starting dynamic subtest: ccs0
[135.004329] Dynamic subtest ccs0: SUCCESS (13.157s)
[135.013989] Starting dynamic subtest: vcs0
[149.876098] Dynamic subtest vcs0: SUCCESS (14.869s)
[149.887223] Starting dynamic subtest: bcs0
[163.027519] Dynamic subtest bcs0: SUCCESS (13.152s)
[163.039076] Starting dynamic subtest: rcs0
[176.181621] Dynamic subtest rcs0: SUCCESS (13.153s)
[176.193031] Starting dynamic subtest: vcs1
[189.810994] Dynamic subtest vcs1: SUCCESS (13.626s)
[189.813805] Subtest duration: SUCCESS (81.669s)
[189.909018] [015/134] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[190.024371] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.682266] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.661s)
[194.915688] [016/134] (822s left) kms_cursor_crc (cursor-onscreen-64x64)
[195.097718] Starting subtest: cursor-onscreen-64x64
[195.102796] Starting dynamic subtest: pipe-A-eDP-1
[197.189021] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.087s)
[197.215579] Starting dynamic subtest: pipe-D-eDP-1
[199.911524] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.700s)
[199.913754] Subtest cursor-onscreen-64x64: SUCCESS (4.811s)
[200.742213] [017/134] (817s left) kms_color (ctm-red-to-blue)
[200.847915] Starting subtest: ctm-red-to-blue
[200.850169] Starting dynamic subtest: pipe-A-eDP-1
[201.575027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.727s)
[201.584999] Starting dynamic subtest: pipe-B-eDP-1
[202.953076] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[202.962893] Starting dynamic subtest: pipe-C-eDP-1
[204.337066] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[204.346977] Starting dynamic subtest: pipe-D-eDP-1
[205.676090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[205.678485] Subtest ctm-red-to-blue: SUCCESS (4.828s)
[206.501292] [018/134] (811s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[206.557030] Subtest writes-after-reads-uncached: SKIP (0.000s)
[206.617231] [019/134] (811s left) dumb_buffer (invalid-bpp)
[206.681139] Starting subtest: invalid-bpp
[206.683399] Subtest invalid-bpp: SUCCESS (0.000s)
[206.811374] [020/134] (811s left) gem_mmap_gtt (ptrace)
[206.880448] Subtest ptrace: SKIP (0.000s)
[206.945292] [021/134] (811s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[207.061570] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[207.066202] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[207.227069] [022/134] (810s left) gem_lmem_swapping (verify)
[207.270053] Subtest verify: SKIP (0.000s)
[207.309896] [023/134] (810s left) gem_spin_batch (resubmit-new)
[207.379487] Starting subtest: resubmit-new
[207.381873] Starting dynamic subtest: rcs0
[207.386916] Dynamic subtest rcs0: SUCCESS (0.007s)
[207.397684] Starting dynamic subtest: bcs0
[207.399682] Dynamic subtest bcs0: SUCCESS (0.005s)
[207.411081] Starting dynamic subtest: vcs0
[207.412922] Dynamic subtest vcs0: SUCCESS (0.006s)
[207.421748] Starting dynamic subtest: vcs1
[207.423493] Dynamic subtest vcs1: SUCCESS (0.004s)
[207.431347] Starting dynamic subtest: vecs0
[207.433107] Dynamic subtest vecs0: SUCCESS (0.004s)
[207.440709] Starting dynamic subtest: ccs0
[207.442528] Dynamic subtest ccs0: SUCCESS (0.004s)
[207.444285] Subtest resubmit-new: SUCCESS (0.034s)
[208.977754] [024/134] (809s left) kms_cursor_crc (cursor-random-512x512)
[209.249546] Starting subtest: cursor-random-512x512
[209.254114] Subtest cursor-random-512x512: SKIP (0.001s)
[209.446863] [025/134] (808s left) kms_properties (plane-properties-legacy)
[209.542869] Starting subtest: plane-properties-legacy
[209.545228] Starting dynamic subtest: pipe-A-eDP-1
[210.097935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[210.108366] Starting dynamic subtest: pipe-B-eDP-1
[211.349554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[211.359734] Starting dynamic subtest: pipe-C-eDP-1
[212.586941] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.235s)
[212.596731] Starting dynamic subtest: pipe-D-eDP-1
[213.827239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[213.829651] Subtest plane-properties-legacy: SUCCESS (4.285s)
[214.664754] [026/134] (803s left) kms_vrr (flipline)
[214.756369] Starting subtest: flipline
[214.762999] Subtest flipline: SKIP (0.000s)
[214.853031] [027/134] (803s left) gem_exec_params (secure-non-master)
[214.912319] Starting subtest: secure-non-master
[214.916814] Subtest secure-non-master: SKIP (0.000s)
[215.033643] [028/134] (803s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[215.291978] Starting subtest: parallel-dmabuf-import-out-fence
[216.413363] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.121s)
[216.542517] [029/134] (801s left) kms_pm_dc (dc5-dpms-negative)
[217.648192] Starting subtest: dc5-dpms-negative
[217.652775] Subtest dc5-dpms-negative: SKIP (0.000s)
[217.743061] [030/134] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[217.849153] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[217.853435] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.968299] [031/134] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[218.082889] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[224.857136] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.777s)
[225.025286] [032/134] (793s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[225.136549] Starting subtest: psr-argb161616f-draw-mmap-cpu
[225.141042] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[225.240751] [033/134] (793s left) gem_exec_whisper (basic-fds-all)
[225.315584] Starting subtest: basic-fds-all
[236.854291] Subtest basic-fds-all: SUCCESS (11.535s)
[237.061518] [034/134] (781s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[237.164321] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[237.168299] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[237.295312] [035/134] (781s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[237.407253] Starting subtest: psr-rgb565-draw-render
[244.474971] Subtest psr-rgb565-draw-render: SUCCESS (7.069s)
[244.631178] [036/134] (773s left) gem_render_copy_redux (flink)
[244.696520] Starting subtest: flink
[245.462547] Subtest flink: SUCCESS (0.766s)
[245.617894] [037/134] (773s left) gem_mmap_wc (bad-offset)
[245.675671] Subtest bad-offset: SKIP (0.000s)
[245.744414] [038/134] (772s left) gem_pxp (reject-modify-context-protection-off-2)
[245.875690] Starting subtest: reject-modify-context-protection-off-2
[245.877945] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[246.019909] [039/134] (772s left) kms_3d (basic)
[246.088650] Starting subtest: basic
[248.048526] Subtest basic: SUCCESS (1.961s)
[248.572032] [040/134] (770s left) gem_ctx_persistence (smoketest)
[248.641645] Starting subtest: smoketest
[287.858569] Subtest smoketest: SUCCESS (39.216s)
[287.999341] [041/134] (730s left) kms_psr (fbc-pr-suspend)
[288.103492] Starting subtest: fbc-pr-suspend
[288.108088] Subtest fbc-pr-suspend: SKIP (0.000s)
[288.197649] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[288.256464] Starting subtest: multi-wait-for-submit-signaled
[288.258762] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[288.388790] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[288.486324] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[288.488675] Starting dynamic subtest: pipe-A-default-mode
[291.259501] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[291.261873] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.776s)
[292.122291] [044/134] (726s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[292.215328] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[292.217732] Starting dynamic subtest: pipe-A-default-mode
[294.913309] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[294.915303] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.697s)
[295.805676] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[295.917484] Starting subtest: psr-rgb565-draw-mmap-cpu
[302.697430] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.784s)
[302.812894] [046/134] (716s left) vgem_basic (mmap)
[302.929657] Starting subtest: mmap
[302.934446] Subtest mmap: SUCCESS (0.005s)
[303.006653] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[303.009847] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[303.075535] Starting subtest: sync-unmap-after-close
[303.085208] Subtest sync-unmap-after-close: SUCCESS (0.011s)
[303.236313] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[303.623204] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[304.441978] [049/134] (714s left) kms_frontbuffer_tracking (basic)
[304.546942] Starting subtest: basic
[307.621928] Subtest basic: SUCCESS (3.079s)
[307.762888] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[307.850433] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[314.837430] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.988s)
[314.974297] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[315.083560] Starting subtest: fbc-rgb101010-draw-blt
[319.757913] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.678s)
[320.941927] [052/134] (698s left) kms_lease (lease-unleased-connector)
[321.037217] Starting subtest: lease-unleased-connector
[321.039509] Starting dynamic subtest: pipe-A-eDP-1
[321.045846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[321.059168] Starting dynamic subtest: pipe-B-eDP-1
[321.061419] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[321.071143] Starting dynamic subtest: pipe-C-eDP-1
[321.073303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[321.082272] Starting dynamic subtest: pipe-D-eDP-1
[321.084453] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[321.086680] Subtest lease-unleased-connector: SUCCESS (0.031s)
[321.208421] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[321.275120] Subtest reads: SKIP (0.000s)
[321.354650] [054/134] (697s left) kms_dp_link_training (uhbr-sst)
[321.452679] Starting subtest: uhbr-sst
[321.461129] Subtest uhbr-sst: SKIP (0.000s)
[321.566547] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[321.631555] Starting subtest: etime-multi-wait-all-submitted-signaled
[321.736711] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s)
[321.837322] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[321.935574] Starting subtest: overflow-vrefresh
[321.937972] Starting dynamic subtest: pipe-A-eDP-1
[322.219493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[322.229063] Starting dynamic subtest: pipe-B-eDP-1
[322.231335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[322.240375] Starting dynamic subtest: pipe-C-eDP-1
[322.242326] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[322.251047] Starting dynamic subtest: pipe-D-eDP-1
[322.253029] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[322.255032] Subtest overflow-vrefresh: SUCCESS (0.288s)
[323.058911] [057/134] (696s left) kms_pm_rpm (i2c)
[325.003765] Starting subtest: i2c
[330.333748] Subtest i2c: SUCCESS (5.331s)
[330.445547] [058/134] (689s left) gem_exec_balancer (busy)
[330.512523] Starting subtest: busy
[331.948636] Subtest busy: SUCCESS (1.437s)
[332.293883] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[337.368545] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[337.372877] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[338.233865] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[338.296569] Subtest batch-without-end: SKIP (0.000s)
[338.358527] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[338.426491] Starting subtest: exec-shared-gtt
[338.428489] Starting dynamic subtest: rcs0
[338.431064] Dynamic subtest rcs0: SUCCESS (0.008s)
[338.441761] Starting dynamic subtest: bcs0
[338.443879] Dynamic subtest bcs0: SUCCESS (0.010s)
[338.453344] Starting dynamic subtest: vcs0
[338.455419] Dynamic subtest vcs0: SUCCESS (0.007s)
[338.464026] Starting dynamic subtest: vcs1
[338.466246] Dynamic subtest vcs1: SUCCESS (0.006s)
[338.474990] Starting dynamic subtest: vecs0
[338.476769] Dynamic subtest vecs0: SUCCESS (0.007s)
[338.485014] Starting dynamic subtest: ccs0
[338.486812] Dynamic subtest ccs0: SUCCESS (0.004s)
[338.488709] Subtest exec-shared-gtt: SUCCESS (0.047s)
[338.682118] [062/134] (680s left) perf (invalid-oa-metric-set-id)
[338.829144] Starting subtest: invalid-oa-metric-set-id
[338.839909] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[338.885386] [063/134] (680s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[338.942760] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[338.944863] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[339.080206] [064/134] (680s left) gem_tiled_pread_pwrite
[339.194851] [065/134] (680s left) i915_pm_rps (thresholds-park)
[339.251310] Starting subtest: thresholds-park
[339.255248] Subtest thresholds-park: SKIP (0.001s)
[339.387406] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[339.457900] Starting subtest: invalid-engines
[339.463019] Subtest invalid-engines: SUCCESS (0.008s)
[339.735407] [067/134] (680s left) vgem_basic (create)
[339.776099] Starting subtest: create
[339.778308] Subtest create: SUCCESS (0.000s)
[339.858208] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[339.953847] Starting subtest: fbc-psr2-sprite-mmap-cpu
[339.956022] Starting dynamic subtest: eDP-1
[339.959903] Dynamic subtest eDP-1: SKIP (0.000s)
[339.963750] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[340.052408] [069/134] (679s left) gem_mmap_gtt (big-copy-odd)
[340.114450] Subtest big-copy-odd: SKIP (0.000s)
[340.184066] [070/134] (679s left) gem_exec_reloc (basic-gtt-cpu-active)
[340.242440] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[340.318797] [071/134] (679s left) prime_busy (before-wait)
[340.385331] Starting subtest: before-wait
[340.390594] Starting dynamic subtest: rcs0
[340.434950] Dynamic subtest rcs0: SUCCESS (0.046s)
[340.446070] Starting dynamic subtest: bcs0
[340.497868] Dynamic subtest bcs0: SUCCESS (0.062s)
[340.506976] Starting dynamic subtest: vcs0
[340.538509] Dynamic subtest vcs0: SUCCESS (0.040s)
[340.547118] Starting dynamic subtest: vcs1
[340.579062] Dynamic subtest vcs1: SUCCESS (0.040s)
[340.588019] Starting dynamic subtest: vecs0
[340.618743] Dynamic subtest vecs0: SUCCESS (0.039s)
[340.627584] Starting dynamic subtest: ccs0
[340.658980] Dynamic subtest ccs0: SUCCESS (0.040s)
[340.768324] Subtest before-wait: SUCCESS (0.382s)
[340.867745] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[341.045665] Starting subtest: keep-in-fence
[341.048083] Starting dynamic subtest: rcs0
[341.126343] Dynamic subtest rcs0: SUCCESS (0.080s)
[341.138861] Starting dynamic subtest: bcs0
[341.179063] Dynamic subtest bcs0: SUCCESS (0.051s)
[341.190720] Starting dynamic subtest: vcs0
[342.931333] Dynamic subtest vcs0: SUCCESS (1.749s)
[342.942088] Starting dynamic subtest: vcs1
[344.917622] Dynamic subtest vcs1: SUCCESS (1.984s)
[344.930184] Starting dynamic subtest: vecs0
[346.901434] Dynamic subtest vecs0: SUCCESS (1.981s)
[346.913666] Starting dynamic subtest: ccs0
[347.139663] Dynamic subtest ccs0: SUCCESS (0.237s)
[347.142286] Subtest keep-in-fence: SUCCESS (6.094s)
[349.011470] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[349.124667] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[352.826323] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.705s)
[354.025297] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[354.120117] Starting subtest: 4-tiled-8bpp-rotate-270
[354.139991] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.019s)
[354.279440] [075/134] (665s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[359.259650] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[359.262093] Starting dynamic subtest: pipe-A-eDP-1
[360.059161] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[360.071190] Starting dynamic subtest: pipe-B-eDP-1
[361.182933] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[361.187728] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.920s)
[362.403606] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[362.470805] Starting subtest: block-multicopy-inplace
[362.475392] Subtest block-multicopy-inplace: SKIP (0.000s)
[362.600172] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[362.711459] Starting subtest: x-tiled-addfb-size-offset-overflow
[362.713352] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[362.854450] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[362.948797] Starting subtest: crtc-invalid-params
[362.951185] Starting dynamic subtest: pipe-A-eDP-1
[363.315451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[363.317785] Subtest crtc-invalid-params: SUCCESS (0.370s)
[364.138597] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[364.242838] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[364.244739] Starting dynamic subtest: pipe-A-eDP-1
[364.264540] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[364.276107] Starting dynamic subtest: pipe-B-eDP-1
[364.295771] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[364.311048] Starting dynamic subtest: pipe-C-eDP-1
[364.331625] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[364.342581] Starting dynamic subtest: pipe-D-eDP-1
[364.362685] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[364.364850] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[366.597495] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[366.639054] Subtest heavy-verify-multi: SKIP (0.000s)
[366.680009] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[367.071042] Subtest hdmi-crc-fast: SKIP (0.000s)
[367.919768] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[368.017249] Starting subtest: query-forked-busy-hang
[368.019553] Starting dynamic subtest: pipe-A-eDP-1
[394.643649] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.624s)
[394.658978] Starting dynamic subtest: pipe-D-eDP-1
[409.684876] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s)
[409.687061] Subtest query-forked-busy-hang: SUCCESS (41.666s)
[410.514779] [083/134] (610s left) kms_big_fb (linear-16bpp-rotate-90)
[410.628461] Starting subtest: linear-16bpp-rotate-90
[410.649027] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[410.819784] [084/134] (609s left) gem_flink_race (flink_close)
[410.861675] Starting subtest: flink_close
[415.965693] Subtest flink_close: SUCCESS (5.105s)
[416.068355] [085/134] (604s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[416.208408] Starting subtest: fbcpsr-modesetfrombusy
[422.475067] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.271s)
[422.636630] [086/134] (598s left) gem_exec_schedule (thriceslice)
[422.710583] Starting subtest: thriceslice
[422.712146] Starting dynamic subtest: rcs0
[422.730472] Dynamic subtest rcs0: SUCCESS (0.028s)
[422.739760] Starting dynamic subtest: bcs0
[422.759295] Dynamic subtest bcs0: SUCCESS (0.028s)
[422.768312] Starting dynamic subtest: vcs0
[422.788578] Dynamic subtest vcs0: SUCCESS (0.028s)
[422.797618] Starting dynamic subtest: vcs1
[422.817860] Dynamic subtest vcs1: SUCCESS (0.028s)
[422.826829] Starting dynamic subtest: vecs0
[422.866585] Dynamic subtest vecs0: SUCCESS (0.048s)
[422.877803] Starting dynamic subtest: ccs0
[422.896931] Dynamic subtest ccs0: SUCCESS (0.028s)
[422.898827] Subtest thriceslice: SUCCESS (0.196s)
[423.219013] [087/134] (597s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[423.303073] Starting subtest: flip-vs-dpms-off-vs-modeset
[423.305237] Starting dynamic subtest: A-eDP1
[426.882665] Dynamic subtest A-eDP1: SUCCESS (3.576s)
[426.898435] Starting dynamic subtest: B-eDP1
[430.074087] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[430.084392] Starting dynamic subtest: C-eDP1
[433.164682] Dynamic subtest C-eDP1: SUCCESS (3.091s)
[433.176579] Starting dynamic subtest: D-eDP1
[436.261060] Dynamic subtest D-eDP1: SUCCESS (3.093s)
[436.263224] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.959s)
[437.086023] [088/134] (583s left) i915_pm_rps (min-max-config-idle)
[437.158558] Starting subtest: min-max-config-idle
[437.162779] Subtest min-max-config-idle: SKIP (0.001s)
[437.301504] [089/134] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[437.409539] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[443.871795] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.464s)
[444.047158] [090/134] (576s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[449.080954] Starting subtest: psr2-overlay-plane-move-continuous-sf
[449.083199] Starting dynamic subtest: pipe-A-eDP-1
[455.760824] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.679s)
[455.775164] Starting dynamic subtest: pipe-B-eDP-1
[462.403587] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.641s)
[462.406022] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.324s)
[463.299625] [091/134] (557s left) kms_concurrent (multi-plane-atomic-lowres)
[463.406235] Starting subtest: multi-plane-atomic-lowres
[463.408102] Starting dynamic subtest: pipe-A-eDP-1
[463.909897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[463.912215] Subtest multi-plane-atomic-lowres: SUCCESS (0.502s)
[464.728103] [092/134] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[464.837540] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[464.841595] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[464.976194] [093/134] (555s left) api_intel_allocator (reopen)
[465.028340] Starting subtest: reopen
[465.030633] Subtest reopen: SUCCESS (0.004s)
[465.176211] [094/134] (555s left) kms_flip (dpms-vs-vblank-race)
[465.273330] Starting subtest: dpms-vs-vblank-race
[465.275249] Starting dynamic subtest: A-eDP1
[470.178135] Dynamic subtest A-eDP1: SUCCESS (4.905s)
[470.189588] Starting dynamic subtest: B-eDP1
[474.778391] Dynamic subtest B-eDP1: SUCCESS (4.597s)
[474.788804] Starting dynamic subtest: C-eDP1
[478.291985] Dynamic subtest C-eDP1: SUCCESS (3.512s)
[478.302607] Starting dynamic subtest: D-eDP1
[482.922299] Dynamic subtest D-eDP1: SUCCESS (4.632s)
[482.924618] Subtest dpms-vs-vblank-race: SUCCESS (17.654s)
[483.817651] [095/134] (537s left) syncobj_timeline (single-wait-all-available-signaled)
[483.883396] Starting subtest: single-wait-all-available-signaled
[483.885616] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[484.023201] [096/134] (537s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[484.129201] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[484.131410] Starting dynamic subtest: pipe-A-eDP-1
[485.439897] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.310s)
[485.724068] Starting dynamic subtest: pipe-B-eDP-1
[486.758826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s)
[487.031685] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.904s)
[487.899086] [097/134] (533s left) gem_exec_params (rs-invalid)
[487.975026] Starting subtest: rs-invalid
[487.977350] Subtest rs-invalid: SUCCESS (0.003s)
[488.147895] [098/134] (533s left) kms_scaling_modes (scaling-mode-full-aspect)
[488.271709] Starting subtest: scaling-mode-full-aspect
[488.273987] Starting dynamic subtest: pipe-A-eDP-1
[488.369615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s)
[488.382303] Starting dynamic subtest: pipe-B-eDP-1
[489.515851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[489.525415] Starting dynamic subtest: pipe-C-eDP-1
[490.627380] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[490.637188] Starting dynamic subtest: pipe-D-eDP-1
[491.758090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[491.760392] Subtest scaling-mode-full-aspect: SUCCESS (3.488s)
[492.936637] [099/134] (528s left) kms_plane (plane-panning-top-left)
[493.044205] Starting subtest: plane-panning-top-left
[493.046423] Starting dynamic subtest: pipe-A
[494.676662] Dynamic subtest pipe-A: SUCCESS (1.628s)
[494.686881] Starting dynamic subtest: pipe-B
[497.044435] Dynamic subtest pipe-B: SUCCESS (2.368s)
[497.046788] Subtest plane-panning-top-left: SUCCESS (3.999s)
[497.862935] [100/134] (523s left) kms_psr (psr2-sprite-mmap-cpu)
[497.963462] Starting subtest: psr2-sprite-mmap-cpu
[497.965897] Starting dynamic subtest: eDP-1
[499.653536] Dynamic subtest eDP-1: SUCCESS (1.691s)
[499.655893] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.693s)
[500.545434] [101/134] (520s left) gem_exec_params (rel-constants-invalid-ring)
[500.605267] Starting subtest: rel-constants-invalid-ring
[500.607621] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[500.727483] [102/134] (520s left) i915_query (query-garbage)
[500.784042] Starting subtest: query-garbage
[500.786220] Subtest query-garbage: SUCCESS (0.000s)
[500.918798] [103/134] (520s left) kms_psr (psr-cursor-mmap-cpu)
[501.022048] Starting subtest: psr-cursor-mmap-cpu
[501.024242] Starting dynamic subtest: eDP-1
[502.723818] Dynamic subtest eDP-1: SUCCESS (1.702s)
[502.726052] Subtest psr-cursor-mmap-cpu: SUCCESS (1.703s)
[503.614133] [104/134] (517s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[503.718187] Starting subtest: y-tiled-16bpp-rotate-90
[503.722517] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[503.839507] [105/134] (517s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[503.936217] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[503.940854] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[505.066798] [106/134] (516s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[505.184059] Starting subtest: flip-vs-cursor-legacy
[512.229089] Subtest flip-vs-cursor-legacy: SUCCESS (7.046s)
[513.090283] [107/134] (508s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[513.188394] Starting subtest: fbcpsr-argb161616f-draw-blt
[513.192588] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[513.317076] [108/134] (508s left) kms_flip (flip-vs-fences)
[513.407259] Starting subtest: flip-vs-fences
[513.411196] Subtest flip-vs-fences: SKIP (0.000s)
[513.554380] [109/134] (508s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[513.615713] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[513.679091] [110/134] (507s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[513.779242] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[513.781370] Starting dynamic subtest: pipe-A-eDP-1
[514.660786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.877s)
[514.672140] Starting dynamic subtest: pipe-B-eDP-1
[516.239835] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.576s)
[516.250045] Starting dynamic subtest: pipe-C-eDP-1
[517.775328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[517.785733] Starting dynamic subtest: pipe-D-eDP-1
[519.257257] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s)
[519.259699] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.471s)
[520.434846] [111/134] (501s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[520.535711] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[520.539934] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[520.675717] [112/134] (501s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[520.769476] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[520.771735] Starting dynamic subtest: pipe-A-eDP-1
[521.486807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[521.497846] Starting dynamic subtest: pipe-B-eDP-1
[523.221759] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.734s)
[523.232276] Starting dynamic subtest: pipe-C-eDP-1
[524.994605] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.771s)
[525.003567] Starting dynamic subtest: pipe-D-eDP-1
[526.788657] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.793s)
[526.790778] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.013s)
[527.980249] [113/134] (493s left) i915_drm_fdinfo (memory-info-shared)
[528.022505] Starting subtest: memory-info-shared
[528.024885] Starting dynamic subtest: smem0
[528.096212] Dynamic subtest smem0: SUCCESS (0.074s)
[528.098778] Subtest memory-info-shared: SUCCESS (0.075s)
[528.194628] [114/134] (493s left) gem_exec_flush (basic-wb-set-default)
[528.270029] Starting subtest: basic-wb-set-default
[533.739472] Subtest basic-wb-set-default: SUCCESS (5.472s)
[533.948559] [115/134] (487s left) sysfs_timeslice_duration (timeout)
[534.018509] Starting subtest: timeout
[534.020799] Starting dynamic subtest: vecs0
[543.915589] Dynamic subtest vecs0: SUCCESS (9.892s)
[543.928470] Starting dynamic subtest: ccs0
[545.272020] Dynamic subtest ccs0: SUCCESS (1.356s)
[545.283337] Starting dynamic subtest: vcs0
[554.932064] Dynamic subtest vcs0: SUCCESS (9.657s)
[554.943921] Starting dynamic subtest: bcs0
[555.620503] Dynamic subtest bcs0: SUCCESS (0.688s)
[555.633239] Starting dynamic subtest: rcs0
[557.011264] Dynamic subtest rcs0: SUCCESS (1.389s)
[557.023243] Starting dynamic subtest: vcs1
[566.944760] Dynamic subtest vcs1: SUCCESS (9.930s)
[566.947299] Subtest timeout: SUCCESS (32.923s)
[567.049391] [116/134] (454s left) sriov_basic (enable-vfs-bind-unbind-each)
[567.103577] Starting subtest: enable-vfs-bind-unbind-each
[567.105640] Starting dynamic subtest: numvfs-1
[567.183505] Dynamic subtest numvfs-1: FAIL (0.026s)
[567.193771] Starting dynamic subtest: numvfs-2
[567.264894] Dynamic subtest numvfs-2: FAIL (0.003s)
[567.276758] Starting dynamic subtest: numvfs-3
[567.350274] Dynamic subtest numvfs-3: FAIL (0.003s)
[567.361502] Starting dynamic subtest: numvfs-4
[567.435651] Dynamic subtest numvfs-4: FAIL (0.003s)
[567.446438] Starting dynamic subtest: numvfs-5
[567.517863] Dynamic subtest numvfs-5: FAIL (0.003s)
[567.528508] Starting dynamic subtest: numvfs-6
[567.600359] Dynamic subtest numvfs-6: FAIL (0.003s)
[567.610387] Starting dynamic subtest: numvfs-7
[567.682600] Dynamic subtest numvfs-7: FAIL (0.003s)
[567.693351] Starting dynamic subtest: numvfs-random
[567.764392] Dynamic subtest numvfs-random: FAIL (0.006s)
[567.766292] Subtest enable-vfs-bind-unbind-each: FAIL (0.058s)
[567.809246] [117/134] (454s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[567.902970] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[567.907487] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[569.014083] [118/134] (452s left) kms_getfb (getfb-handle-not-fb)
[569.113295] Starting subtest: getfb-handle-not-fb
[569.115571] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[569.258191] [119/134] (452s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[569.315736] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[569.320252] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[569.520810] [120/134] (452s left) gem_workarounds (reset-context)
[569.601686] Starting subtest: reset-context
[569.764208] Subtest reset-context: SUCCESS (0.163s)
[569.917425] [121/134] (452s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[570.016513] Starting subtest: psr-farfromfence-mmap-gtt
[570.020718] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[570.144127] [122/134] (452s left) gem_wait (write-busy)
[570.212621] Starting subtest: write-busy
[570.214928] Starting dynamic subtest: all-engines
[570.822901] Dynamic subtest all-engines: SUCCESS (0.609s)
[570.839594] Starting dynamic subtest: rcs0
[571.376382] Dynamic subtest rcs0: SUCCESS (0.552s)
[571.392518] Starting dynamic subtest: bcs0
[571.926533] Dynamic subtest bcs0: SUCCESS (0.549s)
[571.942708] Starting dynamic subtest: vcs0
[573.908276] Dynamic subtest vcs0: SUCCESS (1.980s)
[573.928555] Starting dynamic subtest: vcs1
[575.891904] Dynamic subtest vcs1: SUCCESS (1.981s)
[575.908587] Starting dynamic subtest: vecs0
[577.876030] Dynamic subtest vecs0: SUCCESS (1.982s)
[577.890954] Starting dynamic subtest: ccs0
[578.429523] Dynamic subtest ccs0: SUCCESS (0.552s)
[578.432425] Subtest write-busy: SUCCESS (8.218s)
[578.654618] [123/134] (443s left) i915_hangman (detector)
[578.736984] Starting subtest: detector
[578.739063] Starting dynamic subtest: rcs0
[589.875572] Dynamic subtest rcs0: SUCCESS (11.137s)
[589.888708] Starting dynamic subtest: bcs0
[600.883419] Dynamic subtest bcs0: SUCCESS (11.004s)
[600.896304] Starting dynamic subtest: vcs0
[612.848644] Dynamic subtest vcs0: SUCCESS (11.964s)
[612.858114] Starting dynamic subtest: vcs1
[624.819440] Dynamic subtest vcs1: SUCCESS (11.966s)
[624.832607] Starting dynamic subtest: vecs0
[635.891989] Dynamic subtest vecs0: SUCCESS (11.069s)
[635.904705] Starting dynamic subtest: ccs0
[647.859460] Dynamic subtest ccs0: SUCCESS (11.964s)
[647.862511] Subtest detector: SUCCESS (69.121s)
[647.964215] [124/134] (374s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[648.066628] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[648.071089] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[648.200659] [125/134] (374s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[648.326237] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[648.330637] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[648.497690] [126/134] (373s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[648.559551] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[648.623050] [127/134] (373s left) gem_exec_schedule (noreorder-corked)
[648.810505] Starting subtest: noreorder-corked
[648.812785] Starting dynamic subtest: rcs0
[649.941976] Dynamic subtest rcs0: SUCCESS (1.134s)
[649.954496] Starting dynamic subtest: vcs0
[651.952110] Dynamic subtest vcs0: SUCCESS (2.007s)
[651.963478] Starting dynamic subtest: vcs1
[653.923094] Dynamic subtest vcs1: SUCCESS (1.968s)
[653.940256] Starting dynamic subtest: vecs0
[655.907092] Dynamic subtest vecs0: SUCCESS (1.981s)
[655.919112] Starting dynamic subtest: ccs0
[657.070220] Dynamic subtest ccs0: SUCCESS (1.161s)
[657.073090] Subtest noreorder-corked: SUCCESS (8.264s)
[657.283123] [128/134] (365s left) kms_psr (pr-cursor-mmap-cpu)
[657.390988] Starting subtest: pr-cursor-mmap-cpu
[657.395018] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[657.494094] [129/134] (364s left) perf (invalid-oa-format-id)
[657.595609] Starting subtest: invalid-oa-format-id
[657.605486] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[657.648765] [130/134] (364s left) gem_eio (in-flight-internal-immediate)
[657.831875] Starting subtest: in-flight-internal-immediate
[658.955728] Subtest in-flight-internal-immediate: SUCCESS (1.121s)
[659.137655] [131/134] (363s left) kms_cursor_edge_walk (256x256-top-edge)
[659.246140] Starting subtest: 256x256-top-edge
[659.248425] Starting dynamic subtest: pipe-A-eDP-1
[662.738379] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.492s)
[662.748651] Starting dynamic subtest: pipe-D-eDP-1
[665.846529] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[665.848793] Subtest 256x256-top-edge: SUCCESS (6.602s)
[666.685947] [132/134] (355s left) gem_ctx_persistence (engines-persistence)
[666.760434] Starting subtest: engines-persistence
[666.762811] Starting dynamic subtest: rcs0
[667.631725] Dynamic subtest rcs0: SUCCESS (0.875s)
[667.646631] Starting dynamic subtest: bcs0
[668.466026] Dynamic subtest bcs0: SUCCESS (0.831s)
[668.480979] Starting dynamic subtest: vcs0
[669.278452] Dynamic subtest vcs0: SUCCESS (0.809s)
[669.291420] Starting dynamic subtest: vcs1
[670.042974] Dynamic subtest vcs1: SUCCESS (0.762s)
[670.057322] Starting dynamic subtest: vecs0
[670.814053] Dynamic subtest vecs0: SUCCESS (0.768s)
[670.825956] Starting dynamic subtest: ccs0
[671.547749] Dynamic subtest ccs0: SUCCESS (0.731s)
[671.550268] Subtest engines-persistence: SUCCESS (4.792s)
[671.713743] [133/134] (350s left) api_intel_bb (render-ccs)
[671.773819] Starting subtest: render-ccs
[672.130675] Subtest render-ccs: SUCCESS (0.356s)
[672.295376] [134/134] (350s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[672.415975] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[672.420436] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[672.547305] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_fence_pin_leak
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: kms_plane_alpha_blend
results: parsing output: 13/ for test: sysfs_timeslice_duration
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_partial_pwrite_pread
results: parsing output: 18/ for test: dumb_buffer
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: gem_spin_batch
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_exec_balancer
results: parsing output: 28/ for test: kms_pm_dc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_render_copy_redux
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: kms_3d
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: vgem_basic
results: parsing output: 46/ for test: gem_userptr_blits
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 53/ for test: kms_dp_link_training
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gen9_exec_parse
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_tiled_pread_pwrite
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: gem_exec_fence
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: gem_lmem_swapping
results: parsing output: 80/ for test: kms_chamelium_frames
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_flink_race
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: i915_pm_rps
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_concurrent
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_scaling_modes
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_ccs
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: sriov_basic
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_getfb
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: gem_workarounds
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_wait
results: parsing output: 122/ for test: i915_hangman
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: kms_cursor_edge_walk
results: parsing output: 131/ for test: gem_ctx_persistence
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.