[61.054360] Initializing watchdogs
[61.054413]   /dev/watchdog0
[61.068798] [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]
[61.072921] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.075075] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.078242] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[61.192775] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[61.195088] Starting dynamic subtest: pipe-A
[61.279816] Dynamic subtest pipe-A: SUCCESS (0.089s)
[61.289562] Starting dynamic subtest: pipe-B
[62.387665] Dynamic subtest pipe-B: SUCCESS (1.113s)
[62.397274] Starting dynamic subtest: pipe-C
[63.499058] Dynamic subtest pipe-C: SUCCESS (1.116s)
[63.508084] Starting dynamic subtest: pipe-D
[64.617662] Dynamic subtest pipe-D: SUCCESS (1.123s)
[64.620140] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.442s)
[65.794192] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[65.872889] Starting subtest: forbidden-operations
[65.877456] Subtest forbidden-operations: SKIP (0.000s)
[66.040390] [003/134] (955s left) gem_mmap_gtt (big-bo)
[66.105311] Subtest big-bo: SKIP (0.000s)
[66.171780] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[66.280984] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[73.631255] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.365s)
[73.794807] [005/134] (947s left) kms_fence_pin_leak
[73.993060] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[74.103285] Starting subtest: x-tiled-16bpp-rotate-180
[75.402980] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[75.571750] [007/134] (946s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[75.634447] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[75.703296] [008/134] (946s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[75.803762] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[75.814784] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[75.911997] [009/134] (945s left) perf_pmu (busy-check-all)
[75.952613] Starting subtest: busy-check-all
[75.954677] Starting dynamic subtest: rcs0
[76.535547] Dynamic subtest rcs0: SUCCESS (0.583s)
[76.546622] Starting dynamic subtest: bcs0
[77.086645] Dynamic subtest bcs0: SUCCESS (0.548s)
[77.095124] Starting dynamic subtest: vcs0
[78.937687] Dynamic subtest vcs0: SUCCESS (1.850s)
[78.951343] Starting dynamic subtest: vcs1
[80.857243] Dynamic subtest vcs1: SUCCESS (1.918s)
[80.868177] Starting dynamic subtest: vecs0
[82.903635] Dynamic subtest vecs0: SUCCESS (2.044s)
[82.914844] Starting dynamic subtest: ccs0
[83.461176] Dynamic subtest ccs0: SUCCESS (0.558s)
[83.463609] Subtest busy-check-all: SUCCESS (7.507s)
[83.586177] [010/134] (938s left) gem_mmap_wc (coherency)
[83.644726] Subtest coherency: SKIP (0.000s)
[83.703056] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[83.822391] Starting subtest: yf-tiled-addfb
[83.827048] Subtest yf-tiled-addfb: SKIP (0.000s)
[83.940598] [012/134] (938s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[84.059285] Starting subtest: extended-modeset-hang-oldfb-with-reset
[84.061167] Starting dynamic subtest: pipe-A
[95.652852] Dynamic subtest pipe-A: SUCCESS (11.591s)
[95.663618] Starting dynamic subtest: pipe-D
[107.929056] Dynamic subtest pipe-D: SUCCESS (12.272s)
[107.931468] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.867s)
[108.837374] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[108.931222] Starting subtest: constant-alpha-min
[109.224625] Starting dynamic subtest: pipe-A-eDP-1
[109.966858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[109.976944] Starting dynamic subtest: pipe-D-eDP-1
[111.396306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[111.398715] Subtest constant-alpha-min: SUCCESS (2.465s)
[112.299699] [014/134] (909s left) sysfs_timeslice_duration (duration)
[112.377732] Starting subtest: duration
[112.379644] Starting dynamic subtest: vecs0
[125.817226] Dynamic subtest vecs0: SUCCESS (13.438s)
[125.828599] Starting dynamic subtest: ccs0
[138.980806] Dynamic subtest ccs0: SUCCESS (13.155s)
[138.997465] Starting dynamic subtest: vcs0
[152.820885] Dynamic subtest vcs0: SUCCESS (13.846s)
[152.833343] Starting dynamic subtest: bcs0
[165.985913] Dynamic subtest bcs0: SUCCESS (13.165s)
[165.996875] Starting dynamic subtest: rcs0
[179.152353] Dynamic subtest rcs0: SUCCESS (13.165s)
[179.163837] Starting dynamic subtest: vcs1
[192.821076] Dynamic subtest vcs1: SUCCESS (13.666s)
[192.824072] Subtest duration: SUCCESS (80.444s)
[192.919213] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[193.039050] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[196.691039] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.657s)
[197.894637] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[198.077843] Starting subtest: cursor-onscreen-64x64
[198.080229] Starting dynamic subtest: pipe-A-eDP-1
[200.190924] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[200.220034] Starting dynamic subtest: pipe-D-eDP-1
[202.926708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.712s)
[202.929036] Subtest cursor-onscreen-64x64: SUCCESS (4.849s)
[203.745616] [017/134] (818s left) kms_color (ctm-red-to-blue)
[203.849099] Starting subtest: ctm-red-to-blue
[203.851053] Starting dynamic subtest: pipe-A-eDP-1
[204.557592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[204.568028] Starting dynamic subtest: pipe-B-eDP-1
[205.928063] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[205.936812] Starting dynamic subtest: pipe-C-eDP-1
[207.299811] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[207.309059] Starting dynamic subtest: pipe-D-eDP-1
[208.627331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[208.629316] Subtest ctm-red-to-blue: SUCCESS (4.779s)
[209.459959] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[209.533066] Subtest writes-after-reads-uncached: SKIP (0.000s)
[209.594508] [019/134] (812s left) dumb_buffer (invalid-bpp)
[209.657297] Starting subtest: invalid-bpp
[209.659230] Subtest invalid-bpp: SUCCESS (0.000s)
[209.762495] [020/134] (812s left) gem_mmap_gtt (ptrace)
[209.830813] Subtest ptrace: SKIP (0.000s)
[209.890828] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[210.004355] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[210.008933] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[210.173375] [022/134] (812s left) gem_lmem_swapping (verify)
[210.221625] Subtest verify: SKIP (0.000s)
[210.257728] [023/134] (812s left) gem_spin_batch (resubmit-new)
[210.318658] Starting subtest: resubmit-new
[210.321079] Starting dynamic subtest: rcs0
[210.326298] Dynamic subtest rcs0: SUCCESS (0.007s)
[210.335411] Starting dynamic subtest: bcs0
[210.337307] Dynamic subtest bcs0: SUCCESS (0.003s)
[210.346193] Starting dynamic subtest: vcs0
[210.348556] Dynamic subtest vcs0: SUCCESS (0.004s)
[210.356889] Starting dynamic subtest: vcs1
[210.359108] Dynamic subtest vcs1: SUCCESS (0.004s)
[210.367233] Starting dynamic subtest: vecs0
[210.369421] Dynamic subtest vecs0: SUCCESS (0.004s)
[210.377228] Starting dynamic subtest: ccs0
[210.379048] Dynamic subtest ccs0: SUCCESS (0.004s)
[210.380896] Subtest resubmit-new: SUCCESS (0.029s)
[211.991367] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[212.283824] Starting subtest: cursor-random-512x512
[212.288451] Subtest cursor-random-512x512: SKIP (0.001s)
[212.462514] [025/134] (810s left) kms_properties (plane-properties-legacy)
[212.556623] Starting subtest: plane-properties-legacy
[212.558844] Starting dynamic subtest: pipe-A-eDP-1
[213.113210] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[213.122798] Starting dynamic subtest: pipe-B-eDP-1
[214.414639] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.299s)
[214.424684] Starting dynamic subtest: pipe-C-eDP-1
[215.652905] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[215.662554] Starting dynamic subtest: pipe-D-eDP-1
[216.900580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[216.902530] Subtest plane-properties-legacy: SUCCESS (4.344s)
[217.721460] [026/134] (804s left) kms_vrr (flipline)
[217.834998] Starting subtest: flipline
[217.841385] Subtest flipline: SKIP (0.000s)
[217.930883] [027/134] (804s left) gem_exec_params (secure-non-master)
[217.997333] Starting subtest: secure-non-master
[218.001698] Subtest secure-non-master: SKIP (0.000s)
[218.134599] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[218.389382] Starting subtest: parallel-dmabuf-import-out-fence
[219.528043] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.138s)
[219.675258] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[220.779953] Starting subtest: dc5-dpms-negative
[220.784463] Subtest dc5-dpms-negative: SKIP (0.000s)
[220.877088] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[220.984732] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[220.989073] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[221.124124] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[221.220342] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[228.030804] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.812s)
[228.207314] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[228.301316] Starting subtest: psr-argb161616f-draw-mmap-cpu
[228.305268] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[228.431896] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[228.497286] Starting subtest: basic-fds-all
[239.933058] Subtest basic-fds-all: SUCCESS (11.438s)
[240.138222] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[240.241432] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[240.245621] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[240.352851] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[240.458582] Starting subtest: psr-rgb565-draw-render
[247.483363] Subtest psr-rgb565-draw-render: SUCCESS (7.027s)
[247.632570] [036/134] (775s left) gem_render_copy_redux (flink)
[247.696754] Starting subtest: flink
[248.471470] Subtest flink: SUCCESS (0.776s)
[248.618372] [037/134] (774s left) gem_mmap_wc (bad-offset)
[248.687693] Subtest bad-offset: SKIP (0.000s)
[248.755709] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[248.894972] Starting subtest: reject-modify-context-protection-off-2
[248.897051] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[249.047835] [039/134] (773s left) kms_3d (basic)
[249.111278] Starting subtest: basic
[251.194348] Subtest basic: SUCCESS (2.083s)
[251.696718] [040/134] (771s left) gem_ctx_persistence (smoketest)
[251.764476] Starting subtest: smoketest
[291.831108] Subtest smoketest: SUCCESS (40.066s)
[291.935493] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[292.054710] Starting subtest: fbc-pr-suspend
[292.058590] Subtest fbc-pr-suspend: SKIP (0.000s)
[292.147347] [042/134] (730s left) syncobj_timeline (multi-wait-for-submit-signaled)
[292.209329] Starting subtest: multi-wait-for-submit-signaled
[292.211235] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[292.324194] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[292.422190] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[292.424519] Starting dynamic subtest: pipe-A-default-mode
[295.169677] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[295.171985] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.748s)
[296.019537] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[296.122785] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[296.124991] Starting dynamic subtest: pipe-A-default-mode
[298.876422] Dynamic subtest pipe-A-default-mode: SUCCESS (2.752s)
[298.878648] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.754s)
[299.706965] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[299.812138] Starting subtest: psr-rgb565-draw-mmap-cpu
[306.550316] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.739s)
[306.707506] [046/134] (716s left) vgem_basic (mmap)
[306.816209] Starting subtest: mmap
[306.820645] Subtest mmap: SUCCESS (0.005s)
[306.895305] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[306.898751] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[306.976197] Starting subtest: sync-unmap-after-close
[306.986962] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[307.148205] [048/134] (716s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[307.563075] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[308.369990] [049/134] (715s left) kms_frontbuffer_tracking (basic)
[308.466101] Starting subtest: basic
[311.842750] Subtest basic: SUCCESS (3.380s)
[311.964978] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[312.065789] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[319.058430] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.994s)
[319.205890] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[319.315928] Starting subtest: fbc-rgb101010-draw-blt
[323.864456] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.548s)
[325.026247] [052/134] (698s left) kms_lease (lease-unleased-connector)
[325.136045] Starting subtest: lease-unleased-connector
[325.138369] Starting dynamic subtest: pipe-A-eDP-1
[325.143380] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[325.152945] Starting dynamic subtest: pipe-B-eDP-1
[325.155115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[325.165968] Starting dynamic subtest: pipe-C-eDP-1
[325.168192] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[325.176423] Starting dynamic subtest: pipe-D-eDP-1
[325.178232] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[325.180065] Subtest lease-unleased-connector: SUCCESS (0.032s)
[325.307433] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[325.376390] Subtest reads: SKIP (0.000s)
[325.445598] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[325.542140] Starting subtest: uhbr-sst
[325.550928] Subtest uhbr-sst: SKIP (0.000s)
[325.640824] [055/134] (698s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[325.704450] Starting subtest: etime-multi-wait-all-submitted-signaled
[325.812122] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[325.911417] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[326.015297] Starting subtest: overflow-vrefresh
[326.017642] Starting dynamic subtest: pipe-A-eDP-1
[326.300747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[326.310605] Starting dynamic subtest: pipe-B-eDP-1
[326.312904] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[326.321559] Starting dynamic subtest: pipe-C-eDP-1
[326.323547] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[326.332176] Starting dynamic subtest: pipe-D-eDP-1
[326.334109] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[326.336041] Subtest overflow-vrefresh: SUCCESS (0.291s)
[327.123916] [057/134] (696s left) kms_pm_rpm (i2c)
[329.054238] Starting subtest: i2c
[334.112727] Subtest i2c: SUCCESS (5.057s)
[334.224946] [058/134] (689s left) gem_exec_balancer (busy)
[334.288142] Starting subtest: busy
[335.910059] Subtest busy: SUCCESS (1.619s)
[336.270381] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[341.331408] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[341.335971] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[342.204382] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[342.274710] Subtest batch-without-end: SKIP (0.000s)
[342.349490] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[342.430666] Starting subtest: exec-shared-gtt
[342.432978] Starting dynamic subtest: rcs0
[342.439771] Dynamic subtest rcs0: SUCCESS (0.008s)
[342.450101] Starting dynamic subtest: bcs0
[342.451923] Dynamic subtest bcs0: SUCCESS (0.006s)
[342.460844] Starting dynamic subtest: vcs0
[342.463120] Dynamic subtest vcs0: SUCCESS (0.007s)
[342.472079] Starting dynamic subtest: vcs1
[342.474321] Dynamic subtest vcs1: SUCCESS (0.007s)
[342.483152] Starting dynamic subtest: vecs0
[342.485274] Dynamic subtest vecs0: SUCCESS (0.005s)
[342.493990] Starting dynamic subtest: ccs0
[342.496210] Dynamic subtest ccs0: SUCCESS (0.005s)
[342.498369] Subtest exec-shared-gtt: SUCCESS (0.043s)
[342.684116] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[342.827115] Starting subtest: invalid-oa-metric-set-id
[342.840243] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[342.880019] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[342.941607] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[342.943580] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[343.079189] [064/134] (680s left) gem_tiled_pread_pwrite
[343.194534] [065/134] (680s left) i915_pm_rps (thresholds-park)
[343.262858] Starting subtest: thresholds-park
[343.266800] Subtest thresholds-park: SKIP (0.001s)
[343.397262] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[343.459174] Starting subtest: invalid-engines
[343.464181] Subtest invalid-engines: SUCCESS (0.008s)
[343.741894] [067/134] (680s left) vgem_basic (create)
[343.787775] Starting subtest: create
[343.790072] Subtest create: SUCCESS (0.000s)
[343.868436] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[343.964029] Starting subtest: fbc-psr2-sprite-mmap-cpu
[343.966312] Starting dynamic subtest: eDP-1
[343.970664] Dynamic subtest eDP-1: SKIP (0.000s)
[343.975049] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[344.062536] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[344.127703] Subtest big-copy-odd: SKIP (0.000s)
[344.192376] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[344.247622] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[344.329147] [071/134] (679s left) prime_busy (before-wait)
[344.384361] Starting subtest: before-wait
[344.389263] Starting dynamic subtest: rcs0
[344.433070] Dynamic subtest rcs0: SUCCESS (0.045s)
[344.443865] Starting dynamic subtest: bcs0
[344.510700] Dynamic subtest bcs0: SUCCESS (0.076s)
[344.521452] Starting dynamic subtest: vcs0
[344.550316] Dynamic subtest vcs0: SUCCESS (0.039s)
[344.559390] Starting dynamic subtest: vcs1
[344.590899] Dynamic subtest vcs1: SUCCESS (0.040s)
[344.599836] Starting dynamic subtest: vecs0
[344.631615] Dynamic subtest vecs0: SUCCESS (0.040s)
[344.640048] Starting dynamic subtest: ccs0
[344.672249] Dynamic subtest ccs0: SUCCESS (0.040s)
[344.781321] Subtest before-wait: SUCCESS (0.395s)
[344.880375] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[345.058724] Starting subtest: keep-in-fence
[345.061327] Starting dynamic subtest: rcs0
[345.124688] Dynamic subtest rcs0: SUCCESS (0.066s)
[345.136708] Starting dynamic subtest: bcs0
[345.178709] Dynamic subtest bcs0: SUCCESS (0.052s)
[345.190540] Starting dynamic subtest: vcs0
[346.905323] Dynamic subtest vcs0: SUCCESS (1.723s)
[346.917527] Starting dynamic subtest: vcs1
[348.888048] Dynamic subtest vcs1: SUCCESS (1.980s)
[348.900681] Starting dynamic subtest: vecs0
[350.998742] Dynamic subtest vecs0: SUCCESS (2.045s)
[351.010206] Starting dynamic subtest: ccs0
[351.175265] Dynamic subtest ccs0: SUCCESS (0.239s)
[351.178061] Subtest keep-in-fence: SUCCESS (6.117s)
[353.045581] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[353.144741] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[356.931207] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.790s)
[358.111452] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[358.227862] Starting subtest: 4-tiled-8bpp-rotate-270
[358.251861] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.023s)
[358.405590] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[363.477515] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[363.479556] Starting dynamic subtest: pipe-A-eDP-1
[364.263132] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[364.273221] Starting dynamic subtest: pipe-B-eDP-1
[365.395326] Dynamic subtest pipe-B-eDP-1: SKIP (1.130s)
[365.399571] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.916s)
[366.604324] [076/134] (657s left) gem_ccs (block-multicopy-inplace)
[366.667991] Starting subtest: block-multicopy-inplace
[366.672365] Subtest block-multicopy-inplace: SKIP (0.000s)
[366.815340] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[366.919704] Starting subtest: x-tiled-addfb-size-offset-overflow
[366.921975] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[367.050975] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[367.152057] Starting subtest: crtc-invalid-params
[367.154210] Starting dynamic subtest: pipe-A-eDP-1
[367.520780] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s)
[367.523061] Subtest crtc-invalid-params: SUCCESS (0.368s)
[368.351061] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[368.444412] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[368.446688] Starting dynamic subtest: pipe-A-eDP-1
[368.465966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[368.475619] Starting dynamic subtest: pipe-B-eDP-1
[368.494745] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[368.504203] Starting dynamic subtest: pipe-C-eDP-1
[368.523627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[368.533100] Starting dynamic subtest: pipe-D-eDP-1
[368.553254] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[368.555394] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[370.723098] [080/134] (653s left) gem_lmem_swapping (heavy-verify-multi)
[370.777474] Subtest heavy-verify-multi: SKIP (0.000s)
[370.828761] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[371.221195] Subtest hdmi-crc-fast: SKIP (0.000s)
[372.010571] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[372.111229] Starting subtest: query-forked-busy-hang
[372.113578] Starting dynamic subtest: pipe-A-eDP-1
[398.698082] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.584s)
[398.715518] Starting dynamic subtest: pipe-D-eDP-1
[424.669032] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.970s)
[424.671312] Subtest query-forked-busy-hang: SUCCESS (52.558s)
[425.529985] [083/134] (599s left) kms_big_fb (linear-16bpp-rotate-90)
[425.648344] Starting subtest: linear-16bpp-rotate-90
[425.668649] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[425.842825] [084/134] (599s left) gem_flink_race (flink_close)
[425.883282] Starting subtest: flink_close
[431.000149] Subtest flink_close: SUCCESS (5.115s)
[431.107990] [085/134] (593s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[431.219737] Starting subtest: fbcpsr-modesetfrombusy
[437.382068] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.168s)
[437.566671] [086/134] (587s left) gem_exec_schedule (thriceslice)
[437.633823] Starting subtest: thriceslice
[437.635833] Starting dynamic subtest: rcs0
[437.655518] Dynamic subtest rcs0: SUCCESS (0.029s)
[437.666119] Starting dynamic subtest: bcs0
[437.685031] Dynamic subtest bcs0: SUCCESS (0.029s)
[437.697463] Starting dynamic subtest: vcs0
[437.735060] Dynamic subtest vcs0: SUCCESS (0.048s)
[437.746169] Starting dynamic subtest: vcs1
[437.764146] Dynamic subtest vcs1: SUCCESS (0.028s)
[437.775620] Starting dynamic subtest: vecs0
[437.812648] Dynamic subtest vecs0: SUCCESS (0.047s)
[437.823297] Starting dynamic subtest: ccs0
[437.843180] Dynamic subtest ccs0: SUCCESS (0.029s)
[437.845100] Subtest thriceslice: SUCCESS (0.218s)
[438.165589] [087/134] (586s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[438.273336] Starting subtest: flip-vs-dpms-off-vs-modeset
[438.275621] Starting dynamic subtest: A-eDP1
[441.889301] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[441.899550] Starting dynamic subtest: B-eDP1
[445.095517] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[445.105415] Starting dynamic subtest: C-eDP1
[448.219590] Dynamic subtest C-eDP1: SUCCESS (3.123s)
[448.229818] Starting dynamic subtest: D-eDP1
[451.320647] Dynamic subtest D-eDP1: SUCCESS (3.100s)
[451.322765] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.050s)
[452.136179] [088/134] (572s left) i915_pm_rps (min-max-config-idle)
[452.205074] Starting subtest: min-max-config-idle
[452.209973] Subtest min-max-config-idle: SKIP (0.000s)
[452.339889] [089/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[452.431500] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[458.948868] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.519s)
[459.099925] [090/134] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[464.128148] Starting subtest: psr2-overlay-plane-move-continuous-sf
[464.130540] Starting dynamic subtest: pipe-A-eDP-1
[470.824154] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.694s)
[470.834562] Starting dynamic subtest: pipe-B-eDP-1
[477.555095] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.728s)
[477.557339] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.426s)
[478.455416] [091/134] (546s left) kms_concurrent (multi-plane-atomic-lowres)
[478.549987] Starting subtest: multi-plane-atomic-lowres
[478.552272] Starting dynamic subtest: pipe-A-eDP-1
[479.063803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.511s)
[479.066215] Subtest multi-plane-atomic-lowres: SUCCESS (0.513s)
[479.890311] [092/134] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[479.997449] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[480.001581] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.124635] [093/134] (545s left) api_intel_allocator (reopen)
[480.178682] Starting subtest: reopen
[480.181291] Subtest reopen: SUCCESS (0.006s)
[480.349369] [094/134] (544s left) kms_flip (dpms-vs-vblank-race)
[480.453438] Starting subtest: dpms-vs-vblank-race
[480.455364] Starting dynamic subtest: A-eDP1
[485.463639] Dynamic subtest A-eDP1: SUCCESS (5.009s)
[485.473989] Starting dynamic subtest: B-eDP1
[490.093126] Dynamic subtest B-eDP1: SUCCESS (4.629s)
[490.102821] Starting dynamic subtest: C-eDP1
[494.704524] Dynamic subtest C-eDP1: SUCCESS (4.610s)
[494.714101] Starting dynamic subtest: D-eDP1
[499.336743] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[499.339053] Subtest dpms-vs-vblank-race: SUCCESS (18.887s)
[500.237654] [095/134] (525s left) syncobj_timeline (single-wait-all-available-signaled)
[500.304608] Starting subtest: single-wait-all-available-signaled
[500.306863] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[500.450957] [096/134] (524s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[500.557377] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[500.559578] Starting dynamic subtest: pipe-A-eDP-1
[501.865072] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.306s)
[502.158599] Starting dynamic subtest: pipe-B-eDP-1
[503.195860] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.045s)
[503.464278] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.907s)
[504.326478] [097/134] (521s left) gem_exec_params (rs-invalid)
[504.380109] Starting subtest: rs-invalid
[504.385734] Subtest rs-invalid: SUCCESS (0.003s)
[504.544296] [098/134] (520s left) kms_scaling_modes (scaling-mode-full-aspect)
[504.639972] Starting subtest: scaling-mode-full-aspect
[504.642100] Starting dynamic subtest: pipe-A-eDP-1
[504.732853] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[504.742795] Starting dynamic subtest: pipe-B-eDP-1
[505.930997] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.196s)
[505.949749] Starting dynamic subtest: pipe-C-eDP-1
[507.050375] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[507.062087] Starting dynamic subtest: pipe-D-eDP-1
[508.191949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[508.194228] Subtest scaling-mode-full-aspect: SUCCESS (3.554s)
[509.469123] [099/134] (516s left) kms_plane (plane-panning-top-left)
[509.571240] Starting subtest: plane-panning-top-left
[509.573481] Starting dynamic subtest: pipe-A
[511.288596] Dynamic subtest pipe-A: SUCCESS (1.718s)
[511.298363] Starting dynamic subtest: pipe-B
[513.681323] Dynamic subtest pipe-B: SUCCESS (2.389s)
[513.683690] Subtest plane-panning-top-left: SUCCESS (4.111s)
[514.587182] [100/134] (510s left) kms_psr (psr2-sprite-mmap-cpu)
[514.683318] Starting subtest: psr2-sprite-mmap-cpu
[514.685677] Starting dynamic subtest: eDP-1
[516.369298] Dynamic subtest eDP-1: SUCCESS (1.686s)
[516.371619] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.687s)
[517.255511] [101/134] (508s left) gem_exec_params (rel-constants-invalid-ring)
[517.310485] Starting subtest: rel-constants-invalid-ring
[517.312795] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[517.443167] [102/134] (508s left) i915_query (query-garbage)
[517.498616] Starting subtest: query-garbage
[517.500995] Subtest query-garbage: SUCCESS (0.000s)
[517.619557] [103/134] (508s left) kms_psr (psr-cursor-mmap-cpu)
[517.720269] Starting subtest: psr-cursor-mmap-cpu
[517.722568] Starting dynamic subtest: eDP-1
[519.430673] Dynamic subtest eDP-1: SUCCESS (1.709s)
[519.433065] Subtest psr-cursor-mmap-cpu: SUCCESS (1.710s)
[520.327433] [104/134] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[520.441885] Starting subtest: y-tiled-16bpp-rotate-90
[520.446516] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[520.557390] [105/134] (505s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[520.665422] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[520.670057] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[521.860166] [106/134] (503s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[521.987393] Starting subtest: flip-vs-cursor-legacy
[529.084037] Subtest flip-vs-cursor-legacy: SUCCESS (7.093s)
[529.978282] [107/134] (495s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[530.079326] Starting subtest: fbcpsr-argb161616f-draw-blt
[530.083624] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[530.201591] [108/134] (495s left) kms_flip (flip-vs-fences)
[530.293112] Starting subtest: flip-vs-fences
[530.297199] Subtest flip-vs-fences: SKIP (0.000s)
[530.447566] [109/134] (495s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[530.509689] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[530.596951] [110/134] (495s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[530.685188] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[530.687115] Starting dynamic subtest: pipe-A-eDP-1
[531.520339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[531.530463] Starting dynamic subtest: pipe-B-eDP-1
[533.138234] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.613s)
[533.148955] Starting dynamic subtest: pipe-C-eDP-1
[534.669884] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.533s)
[534.680497] Starting dynamic subtest: pipe-D-eDP-1
[536.209998] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[536.212354] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.519s)
[537.427581] [111/134] (488s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[537.541423] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[537.545730] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.665099] [112/134] (488s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[537.766081] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[537.768315] Starting dynamic subtest: pipe-A-eDP-1
[538.510760] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[538.519532] Starting dynamic subtest: pipe-B-eDP-1
[540.338124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.826s)
[540.348909] Starting dynamic subtest: pipe-C-eDP-1
[542.175226] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.836s)
[542.185494] Starting dynamic subtest: pipe-D-eDP-1
[544.009022] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.832s)
[544.011388] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.236s)
[545.164181] [113/134] (480s left) i915_drm_fdinfo (memory-info-shared)
[545.203295] Starting subtest: memory-info-shared
[545.205643] Starting dynamic subtest: smem0
[545.274233] Dynamic subtest smem0: SUCCESS (0.070s)
[545.276896] Subtest memory-info-shared: SUCCESS (0.071s)
[545.372721] [114/134] (480s left) gem_exec_flush (basic-wb-set-default)
[545.437787] Starting subtest: basic-wb-set-default
[550.918897] Subtest basic-wb-set-default: SUCCESS (5.453s)
[551.101076] [115/134] (475s left) sysfs_timeslice_duration (timeout)
[551.162250] Starting subtest: timeout
[551.164493] Starting dynamic subtest: vecs0
[560.919952] Dynamic subtest vecs0: SUCCESS (9.754s)
[560.933858] Starting dynamic subtest: ccs0
[562.306589] Dynamic subtest ccs0: SUCCESS (1.385s)
[562.318290] Starting dynamic subtest: vcs0
[571.944591] Dynamic subtest vcs0: SUCCESS (9.636s)
[571.955778] Starting dynamic subtest: bcs0
[572.657030] Dynamic subtest bcs0: SUCCESS (0.710s)
[572.668577] Starting dynamic subtest: rcs0
[573.987666] Dynamic subtest rcs0: SUCCESS (1.327s)
[574.000274] Starting dynamic subtest: vcs1
[583.887595] Dynamic subtest vcs1: SUCCESS (9.898s)
[583.890104] Subtest timeout: SUCCESS (32.723s)
[583.989986] [116/134] (442s left) sriov_basic (enable-vfs-bind-unbind-each)
[584.061412] Starting subtest: enable-vfs-bind-unbind-each
[584.064146] Starting dynamic subtest: numvfs-1
[584.149276] Dynamic subtest numvfs-1: FAIL (0.036s)
[584.160676] Starting dynamic subtest: numvfs-2
[584.231776] Dynamic subtest numvfs-2: FAIL (0.004s)
[584.243193] Starting dynamic subtest: numvfs-3
[584.316083] Dynamic subtest numvfs-3: FAIL (0.004s)
[584.326706] Starting dynamic subtest: numvfs-4
[584.399688] Dynamic subtest numvfs-4: FAIL (0.004s)
[584.411420] Starting dynamic subtest: numvfs-5
[584.484069] Dynamic subtest numvfs-5: FAIL (0.004s)
[584.494137] Starting dynamic subtest: numvfs-6
[584.565582] Dynamic subtest numvfs-6: FAIL (0.003s)
[584.577107] Starting dynamic subtest: numvfs-7
[584.649157] Dynamic subtest numvfs-7: FAIL (0.003s)
[584.659164] Starting dynamic subtest: numvfs-random
[584.730964] Dynamic subtest numvfs-random: FAIL (0.004s)
[584.733079] Subtest enable-vfs-bind-unbind-each: FAIL (0.069s)
[584.773363] [117/134] (441s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[584.862875] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[584.867337] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[586.010974] [118/134] (440s left) kms_getfb (getfb-handle-not-fb)
[586.111201] Starting subtest: getfb-handle-not-fb
[586.113470] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[586.246686] [119/134] (440s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[586.297107] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[586.301485] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[586.515380] [120/134] (439s left) gem_workarounds (reset-context)
[586.579848] Starting subtest: reset-context
[586.751617] Subtest reset-context: SUCCESS (0.170s)
[586.898775] [121/134] (439s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[586.998945] Starting subtest: psr-farfromfence-mmap-gtt
[587.003290] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[587.144867] [122/134] (439s left) gem_wait (write-busy)
[587.211789] Starting subtest: write-busy
[587.214061] Starting dynamic subtest: all-engines
[587.852930] Dynamic subtest all-engines: SUCCESS (0.640s)
[587.870220] Starting dynamic subtest: rcs0
[588.409050] Dynamic subtest rcs0: SUCCESS (0.554s)
[588.426138] Starting dynamic subtest: bcs0
[588.958712] Dynamic subtest bcs0: SUCCESS (0.549s)
[588.975546] Starting dynamic subtest: vcs0
[590.934070] Dynamic subtest vcs0: SUCCESS (1.973s)
[590.950524] Starting dynamic subtest: vcs1
[592.919930] Dynamic subtest vcs1: SUCCESS (1.984s)
[592.936783] Starting dynamic subtest: vecs0
[594.903470] Dynamic subtest vecs0: SUCCESS (1.981s)
[594.920943] Starting dynamic subtest: ccs0
[595.455628] Dynamic subtest ccs0: SUCCESS (0.550s)
[595.458309] Subtest write-busy: SUCCESS (8.244s)
[595.674515] [123/134] (430s left) i915_hangman (detector)
[595.740101] Starting subtest: detector
[595.741987] Starting dynamic subtest: rcs0
[606.899310] Dynamic subtest rcs0: SUCCESS (11.160s)
[606.914136] Starting dynamic subtest: bcs0
[618.870244] Dynamic subtest bcs0: SUCCESS (11.966s)
[618.882556] Starting dynamic subtest: vcs0
[629.878558] Dynamic subtest vcs0: SUCCESS (11.005s)
[629.891108] Starting dynamic subtest: vcs1
[640.821756] Dynamic subtest vcs1: SUCCESS (10.940s)
[640.834890] Starting dynamic subtest: vecs0
[651.830660] Dynamic subtest vecs0: SUCCESS (11.005s)
[651.843916] Starting dynamic subtest: ccs0
[663.863507] Dynamic subtest ccs0: SUCCESS (12.029s)
[663.866219] Subtest detector: SUCCESS (68.121s)
[663.970150] [124/134] (362s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[664.076143] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[664.080415] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[664.204396] [125/134] (362s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[664.325683] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[664.330258] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[664.493526] [126/134] (362s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[664.554876] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[664.616952] [127/134] (362s left) gem_exec_schedule (noreorder-corked)
[664.794970] Starting subtest: noreorder-corked
[664.797710] Starting dynamic subtest: rcs0
[665.935021] Dynamic subtest rcs0: SUCCESS (1.141s)
[665.945855] Starting dynamic subtest: vcs0
[667.877211] Dynamic subtest vcs0: SUCCESS (1.938s)
[667.889711] Starting dynamic subtest: vcs1
[669.933297] Dynamic subtest vcs1: SUCCESS (2.054s)
[669.945756] Starting dynamic subtest: vecs0
[671.909291] Dynamic subtest vecs0: SUCCESS (1.973s)
[671.921237] Starting dynamic subtest: ccs0
[673.072093] Dynamic subtest ccs0: SUCCESS (1.162s)
[673.074855] Subtest noreorder-corked: SUCCESS (8.279s)
[673.284914] [128/134] (353s left) kms_psr (pr-cursor-mmap-cpu)
[673.395268] Starting subtest: pr-cursor-mmap-cpu
[673.399745] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[673.492177] [129/134] (353s left) perf (invalid-oa-format-id)
[673.593839] Starting subtest: invalid-oa-format-id
[673.600456] Subtest invalid-oa-format-id: SUCCESS (0.008s)
[673.650356] [130/134] (353s left) gem_eio (in-flight-internal-immediate)
[673.851605] Starting subtest: in-flight-internal-immediate
[674.965488] Subtest in-flight-internal-immediate: SUCCESS (1.113s)
[675.143081] [131/134] (351s left) kms_cursor_edge_walk (256x256-top-edge)
[675.243023] Starting subtest: 256x256-top-edge
[675.245386] Starting dynamic subtest: pipe-A-eDP-1
[678.717343] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[678.727964] Starting dynamic subtest: pipe-D-eDP-1
[681.844414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[681.846323] Subtest 256x256-top-edge: SUCCESS (6.602s)
[682.676757] [132/134] (344s left) gem_ctx_persistence (engines-persistence)
[682.739058] Starting subtest: engines-persistence
[682.741380] Starting dynamic subtest: rcs0
[683.555262] Dynamic subtest rcs0: SUCCESS (0.815s)
[683.567899] Starting dynamic subtest: bcs0
[684.331777] Dynamic subtest bcs0: SUCCESS (0.775s)
[684.343873] Starting dynamic subtest: vcs0
[685.164756] Dynamic subtest vcs0: SUCCESS (0.831s)
[685.176867] Starting dynamic subtest: vcs1
[685.955862] Dynamic subtest vcs1: SUCCESS (0.789s)
[685.967344] Starting dynamic subtest: vecs0
[686.827271] Dynamic subtest vecs0: SUCCESS (0.869s)
[686.839871] Starting dynamic subtest: ccs0
[687.665854] Dynamic subtest ccs0: SUCCESS (0.837s)
[687.668345] Subtest engines-persistence: SUCCESS (4.928s)
[687.770366] [133/134] (339s left) api_intel_bb (render-ccs)
[687.836160] Starting subtest: render-ccs
[688.193331] Subtest render-ccs: SUCCESS (0.357s)
[688.353355] [134/134] (338s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[688.466655] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[688.470774] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[688.602885] 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.