[61.975267] Initializing watchdogs
[61.975311]   /dev/watchdog0
[61.989329] [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.993549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.995769] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.999114] [001/134] (960s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[62.120063] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[62.122399] Starting dynamic subtest: pipe-A
[62.208323] Dynamic subtest pipe-A: SUCCESS (0.090s)
[62.217740] Starting dynamic subtest: pipe-B
[63.393713] Dynamic subtest pipe-B: SUCCESS (1.185s)
[63.401459] Starting dynamic subtest: pipe-C
[64.492259] Dynamic subtest pipe-C: SUCCESS (1.097s)
[64.507273] Starting dynamic subtest: pipe-D
[65.624292] Dynamic subtest pipe-D: SUCCESS (1.131s)
[65.626479] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.507s)
[66.806306] [002/134] (955s left) gem_userptr_blits (forbidden-operations)
[66.893404] Starting subtest: forbidden-operations
[66.897700] Subtest forbidden-operations: SKIP (0.000s)
[67.336597] [003/134] (955s left) gem_mmap_gtt (big-bo)
[67.505956] Subtest big-bo: SKIP (0.000s)
[67.636252] [004/134] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[67.753498] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[75.198939] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.450s)
[75.353350] [005/134] (947s left) kms_fence_pin_leak
[75.536844] [006/134] (947s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[75.634920] Starting subtest: x-tiled-16bpp-rotate-180
[77.016183] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.381s)
[77.161186] [007/134] (945s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[77.210694] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[77.278514] [008/134] (945s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[77.371091] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[77.382492] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[77.524632] [009/134] (945s left) perf_pmu (busy-check-all)
[77.561576] Starting subtest: busy-check-all
[77.563543] Starting dynamic subtest: rcs0
[78.135417] Dynamic subtest rcs0: SUCCESS (0.573s)
[78.145998] Starting dynamic subtest: bcs0
[78.686765] Dynamic subtest bcs0: SUCCESS (0.551s)
[78.696654] Starting dynamic subtest: vcs0
[79.890125] Dynamic subtest vcs0: SUCCESS (1.203s)
[79.900145] Starting dynamic subtest: vcs1
[81.877431] Dynamic subtest vcs1: SUCCESS (1.984s)
[81.887925] Starting dynamic subtest: vecs0
[83.924997] Dynamic subtest vecs0: SUCCESS (2.046s)
[83.936327] Starting dynamic subtest: ccs0
[84.479137] Dynamic subtest ccs0: SUCCESS (0.555s)
[84.481609] Subtest busy-check-all: SUCCESS (6.918s)
[84.613658] [010/134] (938s left) gem_mmap_wc (coherency)
[84.676295] Subtest coherency: SKIP (0.000s)
[84.734187] [011/134] (938s left) kms_big_fb (yf-tiled-addfb)
[84.842570] Starting subtest: yf-tiled-addfb
[84.846775] Subtest yf-tiled-addfb: SKIP (0.000s)
[84.962976] [012/134] (937s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[85.075628] Starting subtest: extended-modeset-hang-oldfb-with-reset
[85.077918] Starting dynamic subtest: pipe-A
[96.706430] Dynamic subtest pipe-A: SUCCESS (11.630s)
[96.715054] Starting dynamic subtest: pipe-D
[108.986512] Dynamic subtest pipe-D: SUCCESS (12.277s)
[108.988809] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.911s)
[109.806166] [013/134] (913s left) kms_plane_alpha_blend (constant-alpha-min)
[109.901871] Starting subtest: constant-alpha-min
[110.184597] Starting dynamic subtest: pipe-A-eDP-1
[110.876992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[110.887322] Starting dynamic subtest: pipe-D-eDP-1
[112.341318] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.468s)
[112.343895] Subtest constant-alpha-min: SUCCESS (2.440s)
[113.164743] [014/134] (909s left) sysfs_timeslice_duration (duration)
[113.218124] Starting subtest: duration
[113.220420] Starting dynamic subtest: vecs0
[126.834560] Dynamic subtest vecs0: SUCCESS (13.613s)
[126.846500] Starting dynamic subtest: ccs0
[139.984360] Dynamic subtest ccs0: SUCCESS (13.150s)
[139.994453] Starting dynamic subtest: vcs0
[153.842944] Dynamic subtest vcs0: SUCCESS (13.854s)
[153.854431] Starting dynamic subtest: bcs0
[167.023560] Dynamic subtest bcs0: SUCCESS (13.180s)
[167.035034] Starting dynamic subtest: rcs0
[180.186579] Dynamic subtest rcs0: SUCCESS (13.161s)
[180.198089] Starting dynamic subtest: vcs1
[193.843677] Dynamic subtest vcs1: SUCCESS (13.654s)
[193.846403] Subtest duration: SUCCESS (80.621s)
[193.941817] [015/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[194.054458] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[197.613518] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.563s)
[198.742593] [016/134] (824s left) kms_cursor_crc (cursor-onscreen-64x64)
[198.935362] Starting subtest: cursor-onscreen-64x64
[198.940167] Starting dynamic subtest: pipe-A-eDP-1
[201.059323] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[201.087257] Starting dynamic subtest: pipe-D-eDP-1
[203.878414] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.798s)
[203.880775] Subtest cursor-onscreen-64x64: SUCCESS (4.941s)
[204.701272] [017/134] (818s left) kms_color (ctm-red-to-blue)
[204.803600] Starting subtest: ctm-red-to-blue
[204.805835] Starting dynamic subtest: pipe-A-eDP-1
[205.515952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.714s)
[205.525676] Starting dynamic subtest: pipe-B-eDP-1
[206.897057] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[206.910865] Starting dynamic subtest: pipe-C-eDP-1
[208.312869] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.416s)
[208.322212] Starting dynamic subtest: pipe-D-eDP-1
[209.718489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[209.720500] Subtest ctm-red-to-blue: SUCCESS (4.914s)
[210.550859] [018/134] (812s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[210.622698] Subtest writes-after-reads-uncached: SKIP (0.000s)
[210.704308] [019/134] (812s left) dumb_buffer (invalid-bpp)
[210.764195] Starting subtest: invalid-bpp
[210.766579] Subtest invalid-bpp: SUCCESS (0.000s)
[210.892079] [020/134] (812s left) gem_mmap_gtt (ptrace)
[210.955062] Subtest ptrace: SKIP (0.000s)
[211.018656] [021/134] (812s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[211.142395] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[211.147032] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[211.310878] [022/134] (812s left) gem_lmem_swapping (verify)
[211.351446] Subtest verify: SKIP (0.000s)
[211.391269] [023/134] (811s left) gem_spin_batch (resubmit-new)
[211.459373] Starting subtest: resubmit-new
[211.461649] Starting dynamic subtest: rcs0
[211.465795] Dynamic subtest rcs0: SUCCESS (0.007s)
[211.475670] Starting dynamic subtest: bcs0
[211.477777] Dynamic subtest bcs0: SUCCESS (0.003s)
[211.486639] Starting dynamic subtest: vcs0
[211.488761] Dynamic subtest vcs0: SUCCESS (0.004s)
[211.496307] Starting dynamic subtest: vcs1
[211.498139] Dynamic subtest vcs1: SUCCESS (0.004s)
[211.505359] Starting dynamic subtest: vecs0
[211.507128] Dynamic subtest vecs0: SUCCESS (0.004s)
[211.514333] Starting dynamic subtest: ccs0
[211.516158] Dynamic subtest ccs0: SUCCESS (0.004s)
[211.517950] Subtest resubmit-new: SUCCESS (0.029s)
[212.945404] [024/134] (810s left) kms_cursor_crc (cursor-random-512x512)
[213.222344] Starting subtest: cursor-random-512x512
[213.226765] Subtest cursor-random-512x512: SKIP (0.002s)
[213.430773] [025/134] (810s left) kms_properties (plane-properties-legacy)
[213.534350] Starting subtest: plane-properties-legacy
[213.536525] Starting dynamic subtest: pipe-A-eDP-1
[214.100469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[214.113602] Starting dynamic subtest: pipe-B-eDP-1
[215.403558] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.302s)
[215.411774] Starting dynamic subtest: pipe-C-eDP-1
[216.631818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[216.641082] Starting dynamic subtest: pipe-D-eDP-1
[217.862548] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[217.869958] Subtest plane-properties-legacy: SUCCESS (4.328s)
[218.686107] [026/134] (804s left) kms_vrr (flipline)
[218.787805] Starting subtest: flipline
[218.795149] Subtest flipline: SKIP (0.000s)
[218.888786] [027/134] (804s left) gem_exec_params (secure-non-master)
[218.959114] Starting subtest: secure-non-master
[218.963745] Subtest secure-non-master: SKIP (0.000s)
[219.097685] [028/134] (804s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[219.357796] Starting subtest: parallel-dmabuf-import-out-fence
[220.484325] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.127s)
[220.618208] [029/134] (802s left) kms_pm_dc (dc5-dpms-negative)
[221.723028] Starting subtest: dc5-dpms-negative
[221.727616] Subtest dc5-dpms-negative: SKIP (0.000s)
[221.832991] [030/134] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[221.936619] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[221.940875] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[222.058141] [031/134] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[222.161391] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[228.959815] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.798s)
[229.105470] [032/134] (794s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-cpu)
[229.201024] Starting subtest: psr-argb161616f-draw-mmap-cpu
[229.205195] Subtest psr-argb161616f-draw-mmap-cpu: SKIP (0.000s)
[229.312818] [033/134] (794s left) gem_exec_whisper (basic-fds-all)
[229.382268] Starting subtest: basic-fds-all
[240.753671] Subtest basic-fds-all: SUCCESS (11.370s)
[240.983593] [034/134] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[241.096627] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[241.100852] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[241.214934] [035/134] (782s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[241.327038] Starting subtest: psr-rgb565-draw-render
[248.335493] Subtest psr-rgb565-draw-render: SUCCESS (7.011s)
[248.481578] [036/134] (775s left) gem_render_copy_redux (flink)
[248.533823] Starting subtest: flink
[249.339165] Subtest flink: SUCCESS (0.806s)
[249.482094] [037/134] (774s left) gem_mmap_wc (bad-offset)
[249.551731] Subtest bad-offset: SKIP (0.000s)
[249.616057] [038/134] (774s left) gem_pxp (reject-modify-context-protection-off-2)
[249.744672] Starting subtest: reject-modify-context-protection-off-2
[249.747089] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[249.886386] [039/134] (774s left) kms_3d (basic)
[249.945083] Starting subtest: basic
[251.929837] Subtest basic: SUCCESS (1.986s)
[252.419994] [040/134] (771s left) gem_ctx_persistence (smoketest)
[252.492457] Starting subtest: smoketest
[292.853179] Subtest smoketest: SUCCESS (40.361s)
[292.955435] [041/134] (731s left) kms_psr (fbc-pr-suspend)
[293.061066] Starting subtest: fbc-pr-suspend
[293.065331] Subtest fbc-pr-suspend: SKIP (0.000s)
[293.156330] [042/134] (731s left) syncobj_timeline (multi-wait-for-submit-signaled)
[293.209995] Starting subtest: multi-wait-for-submit-signaled
[293.212505] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[293.343148] [043/134] (730s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[293.448810] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[293.451125] Starting dynamic subtest: pipe-A-default-mode
[296.162495] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[296.164653] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.714s)
[296.994289] [044/134] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[297.102477] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[297.107498] Starting dynamic subtest: pipe-A-default-mode
[299.878655] Dynamic subtest pipe-A-default-mode: SUCCESS (2.771s)
[299.881200] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.775s)
[300.696094] [045/134] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[300.803705] Starting subtest: psr-rgb565-draw-mmap-cpu
[307.887883] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (7.087s)
[308.054996] [046/134] (716s left) vgem_basic (mmap)
[308.180513] Starting subtest: mmap
[308.185663] Subtest mmap: SUCCESS (0.007s)
[308.259742] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[308.263401] [047/134] (716s left) gem_userptr_blits (sync-unmap-after-close)
[308.345831] Starting subtest: sync-unmap-after-close
[308.354528] Subtest sync-unmap-after-close: SUCCESS (0.008s)
[308.523704] [048/134] (715s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[308.906655] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[309.742317] [049/134] (714s left) kms_frontbuffer_tracking (basic)
[309.852211] Starting subtest: basic
[313.080926] Subtest basic: SUCCESS (3.232s)
[313.245143] [050/134] (711s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[313.349060] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[320.310299] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.962s)
[320.448758] [051/134] (704s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[320.558992] Starting subtest: fbc-rgb101010-draw-blt
[325.120714] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.565s)
[326.288200] [052/134] (698s left) kms_lease (lease-unleased-connector)
[326.380101] Starting subtest: lease-unleased-connector
[326.382399] Starting dynamic subtest: pipe-A-eDP-1
[326.387400] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[326.396805] Starting dynamic subtest: pipe-B-eDP-1
[326.399023] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[326.408357] Starting dynamic subtest: pipe-C-eDP-1
[326.410597] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[326.419377] Starting dynamic subtest: pipe-D-eDP-1
[326.421244] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[326.423039] Subtest lease-unleased-connector: SUCCESS (0.033s)
[326.545703] [053/134] (698s left) gem_tiled_partial_pwrite_pread (reads)
[326.606214] Subtest reads: SKIP (0.000s)
[326.675805] [054/134] (698s left) kms_dp_link_training (uhbr-sst)
[326.764268] Starting subtest: uhbr-sst
[326.772710] Subtest uhbr-sst: SKIP (0.000s)
[326.861030] [055/134] (697s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[326.911318] Starting subtest: etime-multi-wait-all-submitted-signaled
[327.017302] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[327.123854] [056/134] (697s left) kms_invalid_mode (overflow-vrefresh)
[327.224189] Starting subtest: overflow-vrefresh
[327.226380] Starting dynamic subtest: pipe-A-eDP-1
[327.509488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[327.518967] Starting dynamic subtest: pipe-B-eDP-1
[327.520887] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[327.530776] Starting dynamic subtest: pipe-C-eDP-1
[327.533077] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[327.541845] Starting dynamic subtest: pipe-D-eDP-1
[327.544222] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[327.546425] Subtest overflow-vrefresh: SUCCESS (0.291s)
[328.375957] [057/134] (696s left) kms_pm_rpm (i2c)
[330.003056] Starting subtest: i2c
[335.319842] Subtest i2c: SUCCESS (5.318s)
[335.434855] [058/134] (689s left) gem_exec_balancer (busy)
[335.502219] Starting subtest: busy
[336.947729] Subtest busy: SUCCESS (1.446s)
[337.305209] [059/134] (687s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[342.286997] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[342.291268] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[343.167414] [060/134] (681s left) gen9_exec_parse (batch-without-end)
[343.233077] Subtest batch-without-end: SKIP (0.000s)
[343.317590] [061/134] (681s left) gem_ctx_shared (exec-shared-gtt)
[343.369943] Starting subtest: exec-shared-gtt
[343.372283] Starting dynamic subtest: rcs0
[343.377245] Dynamic subtest rcs0: SUCCESS (0.007s)
[343.386178] Starting dynamic subtest: bcs0
[343.388370] Dynamic subtest bcs0: SUCCESS (0.005s)
[343.396774] Starting dynamic subtest: vcs0
[343.399275] Dynamic subtest vcs0: SUCCESS (0.007s)
[343.412835] Starting dynamic subtest: vcs1
[343.415760] Dynamic subtest vcs1: SUCCESS (0.007s)
[343.424477] Starting dynamic subtest: vecs0
[343.426694] Dynamic subtest vecs0: SUCCESS (0.006s)
[343.435289] Starting dynamic subtest: ccs0
[343.437491] Dynamic subtest ccs0: SUCCESS (0.005s)
[343.439717] Subtest exec-shared-gtt: SUCCESS (0.041s)
[343.623187] [062/134] (681s left) perf (invalid-oa-metric-set-id)
[343.758647] Starting subtest: invalid-oa-metric-set-id
[343.768032] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[343.825064] [063/134] (681s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[343.891230] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[343.893521] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[344.013230] [064/134] (681s left) gem_tiled_pread_pwrite
[344.132817] [065/134] (681s left) i915_pm_rps (thresholds-park)
[344.190684] Starting subtest: thresholds-park
[344.194633] Subtest thresholds-park: SKIP (0.001s)
[344.333411] [066/134] (680s left) gem_ctx_engines (invalid-engines)
[344.407821] Starting subtest: invalid-engines
[344.415766] Subtest invalid-engines: SUCCESS (0.008s)
[344.684054] [067/134] (680s left) vgem_basic (create)
[344.735669] Starting subtest: create
[344.737817] Subtest create: SUCCESS (0.000s)
[344.817087] [068/134] (680s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[344.918305] Starting subtest: fbc-psr2-sprite-mmap-cpu
[344.920638] Starting dynamic subtest: eDP-1
[344.925080] Dynamic subtest eDP-1: SKIP (0.000s)
[344.929150] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.003s)
[345.022136] [069/134] (680s left) gem_mmap_gtt (big-copy-odd)
[345.088734] Subtest big-copy-odd: SKIP (0.000s)
[345.144109] [070/134] (680s left) gem_exec_reloc (basic-gtt-cpu-active)
[345.201858] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[345.284585] [071/134] (680s left) prime_busy (before-wait)
[345.334695] Starting subtest: before-wait
[345.337103] Starting dynamic subtest: rcs0
[345.372819] Dynamic subtest rcs0: SUCCESS (0.038s)
[345.384186] Starting dynamic subtest: bcs0
[345.431804] Dynamic subtest bcs0: SUCCESS (0.057s)
[345.442825] Starting dynamic subtest: vcs0
[345.472423] Dynamic subtest vcs0: SUCCESS (0.040s)
[345.483071] Starting dynamic subtest: vcs1
[345.512480] Dynamic subtest vcs1: SUCCESS (0.039s)
[345.521844] Starting dynamic subtest: vecs0
[345.554115] Dynamic subtest vecs0: SUCCESS (0.041s)
[345.563152] Starting dynamic subtest: ccs0
[345.595053] Dynamic subtest ccs0: SUCCESS (0.040s)
[345.704825] Subtest before-wait: SUCCESS (0.371s)
[345.804681] [072/134] (679s left) gem_exec_fence (keep-in-fence)
[345.982526] Starting subtest: keep-in-fence
[345.984644] Starting dynamic subtest: rcs0
[346.054867] Dynamic subtest rcs0: SUCCESS (0.072s)
[346.067048] Starting dynamic subtest: bcs0
[346.108729] Dynamic subtest bcs0: SUCCESS (0.052s)
[346.124623] Starting dynamic subtest: vcs0
[347.860690] Dynamic subtest vcs0: SUCCESS (1.749s)
[347.872227] Starting dynamic subtest: vcs1
[349.909890] Dynamic subtest vcs1: SUCCESS (2.047s)
[349.921420] Starting dynamic subtest: vecs0
[351.893027] Dynamic subtest vecs0: SUCCESS (1.980s)
[351.904642] Starting dynamic subtest: ccs0
[352.124590] Dynamic subtest ccs0: SUCCESS (0.230s)
[352.127265] Subtest keep-in-fence: SUCCESS (6.143s)
[354.073967] [073/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[354.185495] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[357.839907] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.659s)
[359.055437] [074/134] (666s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[359.165818] Starting subtest: 4-tiled-8bpp-rotate-270
[359.185834] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[359.348385] [075/134] (666s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[364.382965] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[364.385394] Starting dynamic subtest: pipe-A-eDP-1
[365.187049] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s)
[365.198611] Starting dynamic subtest: pipe-B-eDP-1
[366.309972] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[366.314454] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.927s)
[367.519366] [076/134] (658s left) gem_ccs (block-multicopy-inplace)
[367.592710] Starting subtest: block-multicopy-inplace
[367.597195] Subtest block-multicopy-inplace: SKIP (0.000s)
[367.733018] [077/134] (657s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[367.836111] Starting subtest: x-tiled-addfb-size-offset-overflow
[367.838472] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[367.976961] [078/134] (657s left) kms_atomic (crtc-invalid-params)
[368.078714] Starting subtest: crtc-invalid-params
[368.080969] Starting dynamic subtest: pipe-A-eDP-1
[368.437072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[368.439627] Subtest crtc-invalid-params: SUCCESS (0.360s)
[369.258230] [079/134] (656s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[369.348037] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[369.350417] Starting dynamic subtest: pipe-A-eDP-1
[369.370529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[369.383995] Starting dynamic subtest: pipe-B-eDP-1
[369.403689] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[369.412972] Starting dynamic subtest: pipe-C-eDP-1
[369.433072] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[369.441780] Starting dynamic subtest: pipe-D-eDP-1
[369.462781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[369.465131] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[371.726863] [080/134] (654s left) gem_lmem_swapping (heavy-verify-multi)
[371.769265] Subtest heavy-verify-multi: SKIP (0.000s)
[371.814747] [081/134] (653s left) kms_chamelium_frames (hdmi-crc-fast)
[372.209110] Subtest hdmi-crc-fast: SKIP (0.000s)
[373.011752] [082/134] (652s left) kms_vblank (query-forked-busy-hang)
[373.114054] Starting subtest: query-forked-busy-hang
[373.116222] Starting dynamic subtest: pipe-A-eDP-1
[399.632398] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.519s)
[399.647071] Starting dynamic subtest: pipe-D-eDP-1
[424.653652] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.018s)
[424.656310] Subtest query-forked-busy-hang: SUCCESS (51.542s)
[425.511481] [083/134] (600s left) kms_big_fb (linear-16bpp-rotate-90)
[425.625862] Starting subtest: linear-16bpp-rotate-90
[425.646890] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[425.796258] [084/134] (600s left) gem_flink_race (flink_close)
[425.835977] Starting subtest: flink_close
[430.947141] Subtest flink_close: SUCCESS (5.111s)
[431.050695] [085/134] (594s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[431.160500] Starting subtest: fbcpsr-modesetfrombusy
[437.349257] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.194s)
[437.523199] [086/134] (588s left) gem_exec_schedule (thriceslice)
[437.601580] Starting subtest: thriceslice
[437.603212] Starting dynamic subtest: rcs0
[437.625172] Dynamic subtest rcs0: SUCCESS (0.030s)
[437.636412] Starting dynamic subtest: bcs0
[437.653909] Dynamic subtest bcs0: SUCCESS (0.028s)
[437.662509] Starting dynamic subtest: vcs0
[437.683702] Dynamic subtest vcs0: SUCCESS (0.029s)
[437.692622] Starting dynamic subtest: vcs1
[437.734073] Dynamic subtest vcs1: SUCCESS (0.049s)
[437.744813] Starting dynamic subtest: vecs0
[437.785751] Dynamic subtest vecs0: SUCCESS (0.050s)
[437.797190] Starting dynamic subtest: ccs0
[437.816446] Dynamic subtest ccs0: SUCCESS (0.029s)
[437.818214] Subtest thriceslice: SUCCESS (0.222s)
[438.146216] [087/134] (587s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[438.233128] Starting subtest: flip-vs-dpms-off-vs-modeset
[438.235500] Starting dynamic subtest: A-eDP1
[441.869196] Dynamic subtest A-eDP1: SUCCESS (3.633s)
[441.879066] Starting dynamic subtest: B-eDP1
[445.083572] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[445.092953] Starting dynamic subtest: C-eDP1
[448.206075] Dynamic subtest C-eDP1: SUCCESS (3.123s)
[448.216128] Starting dynamic subtest: D-eDP1
[451.300630] Dynamic subtest D-eDP1: SUCCESS (3.091s)
[451.302925] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.068s)
[452.156643] [088/134] (573s left) i915_pm_rps (min-max-config-idle)
[452.233731] Starting subtest: min-max-config-idle
[452.238375] Subtest min-max-config-idle: SKIP (0.001s)
[452.361961] [089/134] (573s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[452.470853] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[459.058924] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.589s)
[459.230691] [090/134] (566s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[464.208373] Starting subtest: psr2-overlay-plane-move-continuous-sf
[464.210613] Starting dynamic subtest: pipe-A-eDP-1
[470.930196] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.721s)
[470.940297] Starting dynamic subtest: pipe-B-eDP-1
[477.657243] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.726s)
[477.659470] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.451s)
[478.556017] [091/134] (547s left) kms_concurrent (multi-plane-atomic-lowres)
[478.662774] Starting subtest: multi-plane-atomic-lowres
[478.664615] Starting dynamic subtest: pipe-A-eDP-1
[479.169295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[479.171468] Subtest multi-plane-atomic-lowres: SUCCESS (0.507s)
[479.991274] [092/134] (546s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[480.078536] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[480.082966] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[480.187274] [093/134] (546s left) api_intel_allocator (reopen)
[480.250755] Starting subtest: reopen
[480.253158] Subtest reopen: SUCCESS (0.004s)
[480.389454] [094/134] (545s left) kms_flip (dpms-vs-vblank-race)
[480.483592] Starting subtest: dpms-vs-vblank-race
[480.485892] Starting dynamic subtest: A-eDP1
[485.450539] Dynamic subtest A-eDP1: SUCCESS (4.963s)
[485.460247] Starting dynamic subtest: B-eDP1
[489.052019] Dynamic subtest B-eDP1: SUCCESS (3.600s)
[489.061572] Starting dynamic subtest: C-eDP1
[493.660681] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[493.670349] Starting dynamic subtest: D-eDP1
[498.299693] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[498.301990] Subtest dpms-vs-vblank-race: SUCCESS (17.818s)
[499.206134] [095/134] (527s left) syncobj_timeline (single-wait-all-available-signaled)
[499.266819] Starting subtest: single-wait-all-available-signaled
[499.269092] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[499.400511] [096/134] (527s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[499.493046] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[499.495321] Starting dynamic subtest: pipe-A-eDP-1
[500.823073] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.328s)
[501.104050] Starting dynamic subtest: pipe-B-eDP-1
[502.144036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.050s)
[502.417142] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.925s)
[503.269245] [097/134] (523s left) gem_exec_params (rs-invalid)
[503.331076] Starting subtest: rs-invalid
[503.333352] Subtest rs-invalid: SUCCESS (0.003s)
[503.482466] [098/134] (523s left) kms_scaling_modes (scaling-mode-full-aspect)
[503.578314] Starting subtest: scaling-mode-full-aspect
[503.580287] Starting dynamic subtest: pipe-A-eDP-1
[503.671276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[503.681427] Starting dynamic subtest: pipe-B-eDP-1
[504.861058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.188s)
[504.871738] Starting dynamic subtest: pipe-C-eDP-1
[505.969430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[505.980745] Starting dynamic subtest: pipe-D-eDP-1
[507.089479] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[507.091814] Subtest scaling-mode-full-aspect: SUCCESS (3.514s)
[508.292118] [099/134] (518s left) kms_plane (plane-panning-top-left)
[508.384704] Starting subtest: plane-panning-top-left
[508.387013] Starting dynamic subtest: pipe-A
[510.040859] Dynamic subtest pipe-A: SUCCESS (1.655s)
[510.055066] Starting dynamic subtest: pipe-B
[512.386156] Dynamic subtest pipe-B: SUCCESS (2.343s)
[512.388424] Subtest plane-panning-top-left: SUCCESS (4.002s)
[513.220211] [100/134] (513s left) kms_psr (psr2-sprite-mmap-cpu)
[513.322606] Starting subtest: psr2-sprite-mmap-cpu
[513.324805] Starting dynamic subtest: eDP-1
[515.095179] Dynamic subtest eDP-1: SUCCESS (1.772s)
[515.097415] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.773s)
[515.990332] [101/134] (510s left) gem_exec_params (rel-constants-invalid-ring)
[516.051382] Starting subtest: rel-constants-invalid-ring
[516.053731] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[516.180644] [102/134] (510s left) i915_query (query-garbage)
[516.244755] Starting subtest: query-garbage
[516.247061] Subtest query-garbage: SUCCESS (0.000s)
[516.381324] [103/134] (510s left) kms_psr (psr-cursor-mmap-cpu)
[516.467843] Starting subtest: psr-cursor-mmap-cpu
[516.470325] Starting dynamic subtest: eDP-1
[518.156265] Dynamic subtest eDP-1: SUCCESS (1.689s)
[518.158679] Subtest psr-cursor-mmap-cpu: SUCCESS (1.690s)
[519.045469] [104/134] (507s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[519.150616] Starting subtest: y-tiled-16bpp-rotate-90
[519.155070] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[519.283659] [105/134] (507s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[519.387290] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[519.391809] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[520.567437] [106/134] (506s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[520.688818] Starting subtest: flip-vs-cursor-legacy
[527.690447] Subtest flip-vs-cursor-legacy: SUCCESS (7.001s)
[528.595640] [107/134] (498s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-blt)
[528.691572] Starting subtest: fbcpsr-argb161616f-draw-blt
[528.695680] Subtest fbcpsr-argb161616f-draw-blt: SKIP (0.000s)
[528.806859] [108/134] (498s left) kms_flip (flip-vs-fences)
[528.915787] Starting subtest: flip-vs-fences
[528.919896] Subtest flip-vs-fences: SKIP (0.000s)
[529.048178] [109/134] (497s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[529.111669] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[529.194411] [110/134] (497s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[529.280090] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[529.282258] Starting dynamic subtest: pipe-A-eDP-1
[530.090237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[530.099626] Starting dynamic subtest: pipe-B-eDP-1
[531.607661] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.513s)
[531.623175] Starting dynamic subtest: pipe-C-eDP-1
[533.110138] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.501s)
[533.120624] Starting dynamic subtest: pipe-D-eDP-1
[534.627551] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.515s)
[534.629371] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.340s)
[535.833674] [111/134] (491s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[535.943970] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[535.948615] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[536.086863] [112/134] (491s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[536.187044] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[536.188933] Starting dynamic subtest: pipe-A-eDP-1
[536.904563] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[536.915706] Starting dynamic subtest: pipe-B-eDP-1
[538.649690] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.742s)
[538.664427] Starting dynamic subtest: pipe-C-eDP-1
[540.507705] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.856s)
[540.516801] Starting dynamic subtest: pipe-D-eDP-1
[542.319789] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.812s)
[542.322186] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.126s)
[543.470612] [113/134] (483s left) i915_drm_fdinfo (memory-info-shared)
[543.513825] Starting subtest: memory-info-shared
[543.516238] Starting dynamic subtest: smem0
[543.592478] Dynamic subtest smem0: SUCCESS (0.080s)
[543.595083] Subtest memory-info-shared: SUCCESS (0.081s)
[543.689609] [114/134] (483s left) gem_exec_flush (basic-wb-set-default)
[543.750864] Starting subtest: basic-wb-set-default
[549.204274] Subtest basic-wb-set-default: SUCCESS (5.454s)
[549.416760] [115/134] (477s left) sysfs_timeslice_duration (timeout)
[549.478099] Starting subtest: timeout
[549.480731] Starting dynamic subtest: vecs0
[558.953027] Dynamic subtest vecs0: SUCCESS (9.472s)
[558.964527] Starting dynamic subtest: ccs0
[560.347594] Dynamic subtest ccs0: SUCCESS (1.394s)
[560.361583] Starting dynamic subtest: vcs0
[569.896343] Dynamic subtest vcs0: SUCCESS (9.545s)
[569.908224] Starting dynamic subtest: bcs0
[570.610613] Dynamic subtest bcs0: SUCCESS (0.713s)
[570.623691] Starting dynamic subtest: rcs0
[571.906944] Dynamic subtest rcs0: SUCCESS (1.295s)
[571.919029] Starting dynamic subtest: vcs1
[581.911630] Dynamic subtest vcs1: SUCCESS (10.002s)
[581.914405] Subtest timeout: SUCCESS (32.433s)
[582.016729] [116/134] (445s left) sriov_basic (enable-vfs-bind-unbind-each)
[582.081209] Starting subtest: enable-vfs-bind-unbind-each
[582.083750] Starting dynamic subtest: numvfs-1
[582.156504] Dynamic subtest numvfs-1: FAIL (0.021s)
[582.170273] Starting dynamic subtest: numvfs-2
[582.243767] Dynamic subtest numvfs-2: FAIL (0.004s)
[582.254252] Starting dynamic subtest: numvfs-3
[582.325975] Dynamic subtest numvfs-3: FAIL (0.003s)
[582.335650] Starting dynamic subtest: numvfs-4
[582.403570] Dynamic subtest numvfs-4: FAIL (0.003s)
[582.413022] Starting dynamic subtest: numvfs-5
[582.482744] Dynamic subtest numvfs-5: FAIL (0.003s)
[582.493153] Starting dynamic subtest: numvfs-6
[582.567403] Dynamic subtest numvfs-6: FAIL (0.006s)
[582.577839] Starting dynamic subtest: numvfs-7
[582.650154] Dynamic subtest numvfs-7: FAIL (0.003s)
[582.660532] Starting dynamic subtest: numvfs-random
[582.732282] Dynamic subtest numvfs-random: FAIL (0.003s)
[582.734312] Subtest enable-vfs-bind-unbind-each: FAIL (0.055s)
[582.772186] [117/134] (444s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[582.876693] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[582.880967] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[583.989844] [118/134] (443s left) kms_getfb (getfb-handle-not-fb)
[584.083552] Starting subtest: getfb-handle-not-fb
[584.085701] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[584.212257] [119/134] (443s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[584.282283] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[584.286712] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[584.489171] [120/134] (442s left) gem_workarounds (reset-context)
[584.553493] Starting subtest: reset-context
[584.719077] Subtest reset-context: SUCCESS (0.166s)
[584.888319] [121/134] (442s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[584.979489] Starting subtest: psr-farfromfence-mmap-gtt
[584.983615] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[585.121130] [122/134] (442s left) gem_wait (write-busy)
[585.202860] Starting subtest: write-busy
[585.205199] Starting dynamic subtest: all-engines
[585.825338] Dynamic subtest all-engines: SUCCESS (0.621s)
[585.842392] Starting dynamic subtest: rcs0
[586.381816] Dynamic subtest rcs0: SUCCESS (0.554s)
[586.397102] Starting dynamic subtest: bcs0
[586.932696] Dynamic subtest bcs0: SUCCESS (0.550s)
[586.947928] Starting dynamic subtest: vcs0
[588.883841] Dynamic subtest vcs0: SUCCESS (1.949s)
[588.900250] Starting dynamic subtest: vcs1
[590.932255] Dynamic subtest vcs1: SUCCESS (2.045s)
[590.948409] Starting dynamic subtest: vecs0
[592.915891] Dynamic subtest vecs0: SUCCESS (1.981s)
[592.932108] Starting dynamic subtest: ccs0
[593.467508] Dynamic subtest ccs0: SUCCESS (0.551s)
[593.470039] Subtest write-busy: SUCCESS (8.264s)
[593.688938] [123/134] (433s left) i915_hangman (detector)
[593.762914] Starting subtest: detector
[593.765146] Starting dynamic subtest: rcs0
[604.851643] Dynamic subtest rcs0: SUCCESS (11.088s)
[604.863707] Starting dynamic subtest: bcs0
[616.818727] Dynamic subtest bcs0: SUCCESS (11.964s)
[616.832677] Starting dynamic subtest: vcs0
[628.851309] Dynamic subtest vcs0: SUCCESS (12.029s)
[628.865873] Starting dynamic subtest: vcs1
[640.819240] Dynamic subtest vcs1: SUCCESS (11.965s)
[640.831731] Starting dynamic subtest: vecs0
[651.828084] Dynamic subtest vecs0: SUCCESS (11.005s)
[651.840355] Starting dynamic subtest: ccs0
[663.860000] Dynamic subtest ccs0: SUCCESS (12.029s)
[663.862870] Subtest detector: SUCCESS (70.097s)
[663.967650] [124/134] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[664.079959] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[664.084058] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[664.223355] [125/134] (363s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[664.360844] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[664.365322] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[664.528097] [126/134] (363s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[664.593822] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[664.664824] [127/134] (363s left) gem_exec_schedule (noreorder-corked)
[664.838522] Starting subtest: noreorder-corked
[664.841067] Starting dynamic subtest: rcs0
[665.996529] Dynamic subtest rcs0: SUCCESS (1.158s)
[666.009312] Starting dynamic subtest: vcs0
[667.940774] Dynamic subtest vcs0: SUCCESS (1.941s)
[667.952415] Starting dynamic subtest: vcs1
[669.927693] Dynamic subtest vcs1: SUCCESS (1.984s)
[669.940113] Starting dynamic subtest: vecs0
[671.908541] Dynamic subtest vecs0: SUCCESS (1.979s)
[671.920397] Starting dynamic subtest: ccs0
[673.063457] Dynamic subtest ccs0: SUCCESS (1.153s)
[673.066326] Subtest noreorder-corked: SUCCESS (8.227s)
[673.281178] [128/134] (354s left) kms_psr (pr-cursor-mmap-cpu)
[673.386901] Starting subtest: pr-cursor-mmap-cpu
[673.391295] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[673.483775] [129/134] (354s left) perf (invalid-oa-format-id)
[673.592551] Starting subtest: invalid-oa-format-id
[673.602098] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[673.644703] [130/134] (354s left) gem_eio (in-flight-internal-immediate)
[673.828780] Starting subtest: in-flight-internal-immediate
[674.959361] Subtest in-flight-internal-immediate: SUCCESS (1.130s)
[675.133827] [131/134] (352s left) kms_cursor_edge_walk (256x256-top-edge)
[675.234229] Starting subtest: 256x256-top-edge
[675.236528] Starting dynamic subtest: pipe-A-eDP-1
[678.714535] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[678.726209] Starting dynamic subtest: pipe-D-eDP-1
[681.862948] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.144s)
[681.865304] Subtest 256x256-top-edge: SUCCESS (6.630s)
[682.684038] [132/134] (345s left) gem_ctx_persistence (engines-persistence)
[682.752280] Starting subtest: engines-persistence
[682.754679] Starting dynamic subtest: rcs0
[683.616114] Dynamic subtest rcs0: SUCCESS (0.863s)
[683.628705] Starting dynamic subtest: bcs0
[684.379900] Dynamic subtest bcs0: SUCCESS (0.762s)
[684.392108] Starting dynamic subtest: vcs0
[685.151691] Dynamic subtest vcs0: SUCCESS (0.770s)
[685.163618] Starting dynamic subtest: vcs1
[685.917296] Dynamic subtest vcs1: SUCCESS (0.763s)
[685.929366] Starting dynamic subtest: vecs0
[686.679665] Dynamic subtest vecs0: SUCCESS (0.761s)
[686.691660] Starting dynamic subtest: ccs0
[687.475317] Dynamic subtest ccs0: SUCCESS (0.793s)
[687.478240] Subtest engines-persistence: SUCCESS (4.724s)
[687.579490] [133/134] (340s left) api_intel_bb (render-ccs)
[687.651492] Starting subtest: render-ccs
[688.003794] Subtest render-ccs: SUCCESS (0.352s)
[688.165809] [134/134] (339s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[688.274330] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[688.278328] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[688.405966] 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.