[60.593502] Initializing watchdogs
[60.593553]   /dev/watchdog0
[60.608372] [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]
[60.613348] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.615499] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.618927] [001/133] (960s left) kms_scaling_modes (scaling-mode-center)
[60.743809] Starting subtest: scaling-mode-center
[60.746038] Starting dynamic subtest: pipe-A-eDP-1
[60.860852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.118s)
[60.870478] Starting dynamic subtest: pipe-B-eDP-1
[62.019825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[62.029056] Starting dynamic subtest: pipe-C-eDP-1
[63.131557] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[63.140533] Starting dynamic subtest: pipe-D-eDP-1
[64.264480] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[64.266891] Subtest scaling-mode-center: SUCCESS (3.526s)
[65.424989] [002/133] (955s left) gem_exec_gttfill (engines)
[65.486470] Starting subtest: engines
[65.488908] Starting dynamic subtest: rcs0
[88.275471] Dynamic subtest rcs0: SUCCESS (22.798s)
[88.284513] Starting dynamic subtest: bcs0
[111.508579] Dynamic subtest bcs0: SUCCESS (23.234s)
[111.516667] Starting dynamic subtest: vcs0
[134.825239] Dynamic subtest vcs0: SUCCESS (23.314s)
[134.834237] Starting dynamic subtest: vcs1
[158.096997] Dynamic subtest vcs1: SUCCESS (23.270s)
[158.104538] Starting dynamic subtest: vecs0
[181.390112] Dynamic subtest vecs0: SUCCESS (23.291s)
[181.397785] Starting dynamic subtest: ccs0
[204.719754] Dynamic subtest ccs0: SUCCESS (23.328s)
[204.722121] Subtest engines: SUCCESS (139.242s)
[204.906473] [003/133] (816s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[205.042967] Starting subtest: plane-primary-overlay-mutable-zpos
[208.540259] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.495s)
[209.721797] [004/133] (811s left) gem_partial_pwrite_pread (write-snoop)
[209.795538] Subtest write-snoop: SKIP (0.000s)
[209.869443] [005/133] (811s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[210.163720] Starting subtest: cursor-rapid-movement-512x170
[210.167759] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[210.349196] [006/133] (810s left) kms_plane_scaling (planes-upscale-20x20)
[210.454238] Starting subtest: planes-upscale-20x20
[210.456641] Starting dynamic subtest: pipe-A
[210.515542] Dynamic subtest pipe-A: SUCCESS (0.061s)
[210.526263] Starting dynamic subtest: pipe-B
[211.663334] Dynamic subtest pipe-B: SUCCESS (1.147s)
[211.671431] Starting dynamic subtest: pipe-C
[212.781490] Dynamic subtest pipe-C: SUCCESS (1.117s)
[212.790901] Starting dynamic subtest: pipe-D
[213.912433] Dynamic subtest pipe-D: SUCCESS (1.131s)
[213.914760] Subtest planes-upscale-20x20: SUCCESS (3.459s)
[215.060989] [007/133] (806s left) kms_cursor_crc (cursor-offscreen-32x32)
[215.200505] Starting subtest: cursor-offscreen-32x32
[215.253061] Subtest cursor-offscreen-32x32: SKIP (0.049s)
[215.529348] [008/133] (805s left) syncobj_wait (invalid-reset-illegal-handle)
[215.588341] Starting subtest: invalid-reset-illegal-handle
[215.590756] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[215.683358] [009/133] (805s left) gen9_exec_parse (basic-rejected)
[215.752604] Subtest basic-rejected: SKIP (0.000s)
[215.831068] [010/133] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[215.888824] Starting subtest: single-wait-all-for-submit-available-submitted
[215.891201] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[215.999232] [011/133] (805s left) gem_pwrite_snooped
[216.133101] [012/133] (805s left) kms_color (ctm-0-25)
[216.225074] Starting subtest: ctm-0-25
[216.226872] Starting dynamic subtest: pipe-A-eDP-1
[219.672806] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[219.683230] Starting dynamic subtest: pipe-B-eDP-1
[223.888358] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.214s)
[223.897513] Starting dynamic subtest: pipe-C-eDP-1
[227.872199] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.984s)
[227.881566] Starting dynamic subtest: pipe-D-eDP-1
[231.862870] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.990s)
[231.865145] Subtest ctm-0-25: SUCCESS (15.638s)
[232.714550] [013/133] (788s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[233.095390] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[233.913915] [014/133] (787s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[234.013139] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[234.015416] Starting dynamic subtest: pipe-A-eDP-1
[234.042146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[234.052652] Starting dynamic subtest: pipe-B-eDP-1
[234.077166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[234.084669] Starting dynamic subtest: pipe-C-eDP-1
[234.108744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[234.116370] Starting dynamic subtest: pipe-D-eDP-1
[234.140578] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[234.144673] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[236.217435] [015/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[236.306057] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[240.770634] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.468s)
[241.908342] [016/133] (779s left) gem_exec_schedule (promotion)
[241.979592] Starting subtest: promotion
[241.981969] Starting dynamic subtest: rcs0
[242.081419] Dynamic subtest rcs0: SUCCESS (0.109s)
[242.093906] Starting dynamic subtest: vcs0
[242.166933] Dynamic subtest vcs0: SUCCESS (0.086s)
[242.177279] Starting dynamic subtest: vcs1
[242.247645] Dynamic subtest vcs1: SUCCESS (0.080s)
[242.257820] Starting dynamic subtest: vecs0
[242.328867] Dynamic subtest vecs0: SUCCESS (0.081s)
[242.340764] Starting dynamic subtest: ccs0
[242.422935] Dynamic subtest ccs0: SUCCESS (0.094s)
[242.425238] Subtest promotion: SUCCESS (0.452s)
[244.012442] [017/133] (777s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[244.088868] Starting subtest: yf-tiled-to-vebox-y-tiled
[244.093531] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[244.274691] [018/133] (777s left) gem_mmap_gtt (big-copy-xy)
[244.336085] Subtest big-copy-XY: SKIP (0.000s)
[244.392431] [019/133] (777s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[244.455981] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[244.562380] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[244.652200] [020/133] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[244.753283] Starting subtest: psr-rgb565-draw-pwrite
[251.747761] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.998s)
[251.850006] [021/133] (770s left) kms_flip (plain-flip-ts-check-interruptible)
[251.954896] Starting subtest: plain-flip-ts-check-interruptible
[251.957323] Starting dynamic subtest: A-eDP1
[260.843255] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[260.859889] Starting dynamic subtest: B-eDP1
[269.672205] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[269.682472] Starting dynamic subtest: C-eDP1
[278.495840] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[278.505197] Starting dynamic subtest: D-eDP1
[287.336011] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[287.341537] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.384s)
[288.522631] [022/133] (733s left) kms_flip (flip-vs-rmfb-interruptible)
[288.628583] Starting subtest: flip-vs-rmfb-interruptible
[288.630946] Starting dynamic subtest: A-eDP1
[297.309039] Dynamic subtest A-eDP1: SUCCESS (8.679s)
[297.319245] Starting dynamic subtest: B-eDP1
[305.947646] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[305.958977] Starting dynamic subtest: C-eDP1
[314.563040] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[314.570947] Starting dynamic subtest: D-eDP1
[323.197743] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[323.202478] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.573s)
[324.403184] [023/133] (697s left) i915_pm_rps (reset)
[324.458194] Starting subtest: reset
[332.926741] Subtest reset: SUCCESS (8.468s)
[333.043202] [024/133] (689s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[333.129762] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[333.131974] Starting dynamic subtest: pipe-A-eDP-1
[333.151421] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[333.161774] Starting dynamic subtest: pipe-B-eDP-1
[333.179147] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[333.187171] Starting dynamic subtest: pipe-C-eDP-1
[333.205896] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[333.215507] Starting dynamic subtest: pipe-D-eDP-1
[333.234600] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[333.236480] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[335.433428] [025/133] (686s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[335.504649] Starting subtest: basic-batch-kernel-default-cmd
[335.509049] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[335.686737] [026/133] (686s left) sysfs_heartbeat_interval (idempotent)
[335.745506] Starting subtest: idempotent
[335.747777] Starting dynamic subtest: vecs0
[335.750145] Dynamic subtest vecs0: SUCCESS (0.001s)
[335.763958] Starting dynamic subtest: ccs0
[335.765890] Dynamic subtest ccs0: SUCCESS (0.001s)
[335.773516] Starting dynamic subtest: vcs0
[335.775448] Dynamic subtest vcs0: SUCCESS (0.000s)
[335.782794] Starting dynamic subtest: bcs0
[335.784693] Dynamic subtest bcs0: SUCCESS (0.001s)
[335.792837] Starting dynamic subtest: rcs0
[335.795067] Dynamic subtest rcs0: SUCCESS (0.000s)
[335.802773] Starting dynamic subtest: vcs1
[335.804695] Dynamic subtest vcs1: SUCCESS (0.000s)
[335.806597] Subtest idempotent: SUCCESS (0.008s)
[335.846791] [027/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[335.943842] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[343.027250] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.085s)
[343.193656] [028/133] (679s left) gem_mmap_gtt (close-race)
[343.252253] Subtest close-race: SKIP (0.000s)
[343.307718] [029/133] (678s left) perf (invalid-remove-userspace-config)
[343.445781] Starting subtest: invalid-remove-userspace-config
[343.454655] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[343.493917] [030/133] (678s left) gem_ccs (suspend-resume)
[343.546086] Starting subtest: suspend-resume
[343.550517] Subtest suspend-resume: SKIP (0.000s)
[343.638214] [031/133] (678s left) kms_chamelium_color (ctm-red-to-blue)
[343.733481] Subtest ctm-red-to-blue: SKIP (0.000s)
[343.775697] [032/133] (678s left) gem_mmap_gtt (big-bo-tiledy)
[343.832378] Subtest big-bo-tiledY: SKIP (0.000s)
[343.891952] [033/133] (678s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[343.994882] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[343.997130] Starting dynamic subtest: pipe-A-eDP-1
[349.925148] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.933s)
[349.934027] Starting dynamic subtest: pipe-B-eDP-1
[356.600545] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.673s)
[356.602758] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.609s)
[357.476555] [034/133] (664s left) kms_draw_crc (draw-method-blt)
[357.581229] Starting subtest: draw-method-blt
[357.583122] Starting dynamic subtest: xrgb8888-untiled
[357.834854] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[357.843077] Starting dynamic subtest: rgb565-untiled
[358.045851] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[358.056294] Starting dynamic subtest: xrgb2101010-untiled
[358.246113] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[358.254522] Starting dynamic subtest: xbgr16161616f-untiled
[358.445648] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[358.454146] Starting dynamic subtest: xrgb8888-xtiled
[358.556725] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s)
[358.565086] Starting dynamic subtest: rgb565-xtiled
[358.656709] Dynamic subtest rgb565-xtiled: SUCCESS (0.099s)
[358.664954] Starting dynamic subtest: xrgb2101010-xtiled
[358.756808] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[358.764969] Starting dynamic subtest: xbgr16161616f-xtiled
[358.856741] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.099s)
[358.864878] Starting dynamic subtest: xrgb8888-4tiled
[358.967797] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[358.975804] Starting dynamic subtest: rgb565-4tiled
[359.079662] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[359.087711] Starting dynamic subtest: xrgb2101010-4tiled
[359.179085] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[359.190397] Starting dynamic subtest: xbgr16161616f-4tiled
[359.289999] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[359.291933] Subtest draw-method-blt: SUCCESS (1.713s)
[359.408436] [035/133] (663s left) kms_psr (fbc-psr-no-drrs)
[359.497313] Starting subtest: fbc-psr-no-drrs
[359.499253] Starting dynamic subtest: eDP-1
[359.502808] Dynamic subtest eDP-1: SKIP (0.000s)
[359.506412] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[359.579360] [036/133] (662s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[359.637645] Subtest untiled-to-tiled: SKIP (0.000s)
[359.701692] [037/133] (662s left) gem_ctx_param (invalid-get-no-zeromap)
[359.761817] Starting subtest: invalid-get-no-zeromap
[359.763917] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[359.886242] [038/133] (662s left) i915_drm_fdinfo (virtual-busy-hang-all)
[359.939212] Starting subtest: virtual-busy-hang-all
[359.942891] Subtest virtual-busy-hang-all: SKIP (0.000s)
[360.023457] [039/133] (662s left) syncobj_timeline (invalid-signal-zero-handles)
[360.084875] Starting subtest: invalid-signal-zero-handles
[360.087155] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[360.201122] [040/133] (662s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[360.284623] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[360.288494] Starting dynamic subtest: A-eDP1
[363.909824] Dynamic subtest A-eDP1: SUCCESS (3.619s)
[363.918918] Starting dynamic subtest: B-eDP1
[367.104841] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[367.113516] Starting dynamic subtest: C-eDP1
[370.203745] Dynamic subtest C-eDP1: SUCCESS (3.098s)
[370.213209] Starting dynamic subtest: D-eDP1
[373.315133] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[373.317392] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.029s)
[374.123887] [041/133] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[374.231121] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[374.235261] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.318607] [042/133] (648s left) perf_pmu (most-busy-idle-check-all)
[374.364589] Starting subtest: most-busy-idle-check-all
[374.366642] Starting dynamic subtest: rcs0
[375.893638] Dynamic subtest rcs0: SUCCESS (1.528s)
[375.904776] Starting dynamic subtest: bcs0
[377.941073] Dynamic subtest bcs0: SUCCESS (2.045s)
[377.952785] Starting dynamic subtest: vcs0
[379.925600] Dynamic subtest vcs0: SUCCESS (1.981s)
[379.937726] Starting dynamic subtest: vcs1
[381.909589] Dynamic subtest vcs1: SUCCESS (1.981s)
[381.922974] Starting dynamic subtest: vecs0
[383.895723] Dynamic subtest vecs0: SUCCESS (1.983s)
[383.907936] Starting dynamic subtest: ccs0
[385.878357] Dynamic subtest ccs0: SUCCESS (1.979s)
[385.881355] Subtest most-busy-idle-check-all: SUCCESS (11.514s)
[385.986720] [043/133] (636s left) gem_eio (in-flight-contexts-10ms)
[386.181532] Starting subtest: in-flight-contexts-10ms
[399.849902] Subtest in-flight-contexts-10ms: SUCCESS (13.670s)
[400.014908] [044/133] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[400.109898] Starting subtest: psr-rgb565-draw-mmap-cpu
[406.972385] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.866s)
[407.093910] [045/133] (615s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[407.202256] Starting subtest: fbc-farfromfence-mmap-gtt
[407.206503] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[407.302846] [046/133] (615s left) gem_busy (busy)
[407.366917] Starting subtest: busy
[407.369449] Starting dynamic subtest: all-engines
[407.434483] Dynamic subtest all-engines: SUCCESS (0.068s)
[407.444343] Starting dynamic subtest: rcs0
[408.860570] Dynamic subtest rcs0: SUCCESS (1.423s)
[408.871356] Starting dynamic subtest: bcs0
[408.900148] Dynamic subtest bcs0: SUCCESS (0.038s)
[408.909483] Starting dynamic subtest: vcs0
[408.939525] Dynamic subtest vcs0: SUCCESS (0.038s)
[408.948726] Starting dynamic subtest: vcs1
[410.907462] Dynamic subtest vcs1: SUCCESS (1.965s)
[410.918171] Starting dynamic subtest: vecs0
[412.891545] Dynamic subtest vecs0: SUCCESS (1.982s)
[412.901973] Starting dynamic subtest: ccs0
[414.939063] Dynamic subtest ccs0: SUCCESS (2.046s)
[414.941274] Subtest busy: SUCCESS (7.569s)
[415.299455] [047/133] (607s left) gem_spin_batch (legacy-resubmit)
[415.378684] Starting subtest: legacy-resubmit
[415.381061] Starting dynamic subtest: default
[415.388466] Dynamic subtest default: SUCCESS (0.009s)
[415.399066] Starting dynamic subtest: render
[415.401279] Dynamic subtest render: SUCCESS (0.002s)
[415.410196] Starting dynamic subtest: bsd
[415.412555] Dynamic subtest bsd: SUCCESS (0.003s)
[415.421202] Starting dynamic subtest: bsd1
[415.423359] Dynamic subtest bsd1: SUCCESS (0.001s)
[415.431839] Starting dynamic subtest: bsd2
[415.434059] Dynamic subtest bsd2: SUCCESS (0.004s)
[415.442720] Starting dynamic subtest: blt
[415.444988] Dynamic subtest blt: SUCCESS (0.004s)
[415.453564] Starting dynamic subtest: vebox
[415.455806] Dynamic subtest vebox: SUCCESS (0.004s)
[415.458082] Subtest legacy-resubmit: SUCCESS (0.032s)
[415.644644] [048/133] (607s left) gem_vm_create (invalid-destroy)
[415.701076] Starting subtest: invalid-destroy
[415.703352] Subtest invalid-destroy: SUCCESS (0.002s)
[415.804418] [049/133] (607s left) vgem_basic (setversion)
[415.902072] Starting subtest: setversion
[415.906561] Subtest setversion: SUCCESS (0.000s)
[415.964783] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[415.968085] [050/133] (607s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[416.062102] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[416.064235] Starting dynamic subtest: pipe-A-eDP-1
[416.072598] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[416.082259] Starting dynamic subtest: pipe-B-eDP-1
[416.091148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[416.100680] Starting dynamic subtest: pipe-C-eDP-1
[416.109691] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[416.118748] Starting dynamic subtest: pipe-D-eDP-1
[416.126052] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[416.130072] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.015s)
[418.402265] [051/133] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[418.504529] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[418.508682] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[418.612534] [052/133] (604s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[418.747839] Starting subtest: dp-mst-lic-type-0-hdcp14
[418.752285] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[418.855720] [053/133] (604s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[418.949072] Starting subtest: fbc-psr2-cursor-mmap-cpu
[418.951230] Starting dynamic subtest: eDP-1
[418.955131] Dynamic subtest eDP-1: SKIP (0.000s)
[418.959086] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.002s)
[419.026310] [054/133] (604s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[419.125320] Starting subtest: yf-tiled-addfb-size-offset-overflow
[419.129742] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[419.217208] [055/133] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[419.327080] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[419.330326] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[419.419923] [056/133] (603s left) dumb_buffer (invalid-bpp)
[419.474243] Starting subtest: invalid-bpp
[419.475945] Subtest invalid-bpp: SUCCESS (0.000s)
[419.574108] [057/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[419.676426] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[419.680211] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[419.769542] [058/133] (603s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[419.822943] Starting subtest: etime-single-wait-all-available-unsubmitted
[419.930238] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[420.007822] [059/133] (603s left) gem_reg_read (bad-register)
[420.083967] Starting subtest: bad-register
[420.086468] Subtest bad-register: SUCCESS (0.000s)
[420.206318] [060/133] (603s left) gem_ctx_persistence (legacy-engines-cleanup)
[420.264780] Starting subtest: legacy-engines-cleanup
[420.267171] Starting dynamic subtest: render
[420.337991] Dynamic subtest render: SUCCESS (0.072s)
[420.349905] Starting dynamic subtest: bsd1
[420.387956] Dynamic subtest bsd1: SUCCESS (0.047s)
[420.399163] Starting dynamic subtest: bsd2
[420.427682] Dynamic subtest bsd2: SUCCESS (0.038s)
[420.442493] Starting dynamic subtest: blt
[420.466530] Dynamic subtest blt: SUCCESS (0.037s)
[420.482548] Starting dynamic subtest: vebox
[420.518775] Dynamic subtest vebox: SUCCESS (0.049s)
[420.521278] Subtest legacy-engines-cleanup: SUCCESS (0.255s)
[420.598069] [061/133] (603s left) gem_ctx_shared (q-in-order)
[420.658059] Starting subtest: Q-in-order
[420.660639] Starting dynamic subtest: rcs0
[420.771837] Dynamic subtest rcs0: SUCCESS (0.113s)
[420.791529] Starting dynamic subtest: vcs0
[420.860091] Dynamic subtest vcs0: SUCCESS (0.087s)
[420.878583] Starting dynamic subtest: vcs1
[420.940078] Dynamic subtest vcs1: SUCCESS (0.079s)
[420.957024] Starting dynamic subtest: vecs0
[421.018431] Dynamic subtest vecs0: SUCCESS (0.077s)
[421.034310] Starting dynamic subtest: ccs0
[421.113822] Dynamic subtest ccs0: SUCCESS (0.094s)
[421.116066] Subtest Q-in-order: SUCCESS (0.456s)
[422.007361] [062/133] (601s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[422.108578] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[422.112697] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[422.206556] [063/133] (601s left) kms_properties (connector-properties-legacy)
[422.304860] Starting subtest: connector-properties-legacy
[422.306839] Starting dynamic subtest: pipe-A-eDP-1
[430.177260] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.876s)
[430.186695] Starting dynamic subtest: pipe-None-DP-1
[430.191147] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s)
[430.199316] Starting dynamic subtest: pipe-None-HDMI-A-1
[430.203247] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[430.211997] Starting dynamic subtest: pipe-None-DP-2
[430.216326] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[430.225042] Starting dynamic subtest: pipe-None-HDMI-A-2
[430.229289] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[430.237900] Starting dynamic subtest: pipe-None-DP-3
[430.242252] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[430.251064] Starting dynamic subtest: pipe-None-DP-4
[430.255045] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[430.256942] Subtest connector-properties-legacy: SUCCESS (7.891s)
[431.033990] [064/133] (592s left) kms_dp_link_training (non-uhbr-sst)
[431.143318] Starting subtest: non-uhbr-sst
[431.151495] Subtest non-uhbr-sst: SKIP (0.000s)
[431.216808] [065/133] (592s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[431.306477] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[431.310595] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[431.375443] [066/133] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[431.467215] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[431.469353] Starting dynamic subtest: pipe-A
[431.815974] Dynamic subtest pipe-A: SUCCESS (0.351s)
[431.825275] Starting dynamic subtest: pipe-B
[433.222074] Dynamic subtest pipe-B: SUCCESS (1.405s)
[433.231591] Starting dynamic subtest: pipe-C
[434.645470] Dynamic subtest pipe-C: SUCCESS (1.421s)
[434.655442] Starting dynamic subtest: pipe-D
[436.077596] Dynamic subtest pipe-D: SUCCESS (1.431s)
[436.079904] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.614s)
[437.250759] [067/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[437.346332] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[437.350885] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[437.433121] [068/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[437.533886] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[437.538197] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[438.701935] [069/133] (585s left) gem_exec_schedule (u-submit-golden-slice)
[438.781844] Starting subtest: u-submit-golden-slice
[438.783836] Starting dynamic subtest: rcs0
[438.814416] Dynamic subtest rcs0: SUCCESS (0.041s)
[438.824094] Starting dynamic subtest: bcs0
[438.850454] Dynamic subtest bcs0: SUCCESS (0.035s)
[438.865380] Starting dynamic subtest: vcs0
[438.895610] Dynamic subtest vcs0: SUCCESS (0.043s)
[438.905348] Starting dynamic subtest: vcs1
[438.928266] Dynamic subtest vcs1: SUCCESS (0.032s)
[438.937826] Starting dynamic subtest: vecs0
[438.960986] Dynamic subtest vecs0: SUCCESS (0.032s)
[438.970660] Starting dynamic subtest: ccs0
[439.003150] Dynamic subtest ccs0: SUCCESS (0.041s)
[439.005481] Subtest u-submit-golden-slice: SUCCESS (0.230s)
[439.980138] [070/133] (584s left) kms_prime (basic-crc-hybrid)
[440.093180] Subtest basic-crc-hybrid: SKIP (0.000s)
[440.210560] [071/133] (583s left) kms_psr (pr-primary-mmap-gtt)
[440.314759] Starting subtest: pr-primary-mmap-gtt
[440.319129] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[440.389607] [072/133] (583s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[440.453392] Starting subtest: multi-wait-available-unsubmitted-signaled
[440.455734] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[440.560911] [073/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[440.654468] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[440.658809] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[440.768293] [074/133] (583s left) gem_exec_flush (basic-wb-ro-before-default)
[440.842695] Starting subtest: basic-wb-ro-before-default
[446.300430] Subtest basic-wb-ro-before-default: SUCCESS (5.460s)
[446.485523] [075/133] (577s left) gem_userptr_blits (dmabuf-unsync)
[446.556141] Subtest dmabuf-unsync: SKIP (0.000s)
[446.673197] [076/133] (577s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[446.787098] Starting subtest: verify-pxp-stale-buf-optout-execution
[447.855016] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.071s)
[447.994579] [077/133] (576s left) prime_self_import (basic-llseek-bad)
[448.034136] Starting subtest: basic-llseek-bad
[448.050450] Subtest basic-llseek-bad: SUCCESS (0.015s)
[448.155611] [078/133] (576s left) kms_plane_multiple (tiling-4)
[448.244953] Starting subtest: tiling-4
[448.247225] Starting dynamic subtest: pipe-A-eDP-1
[451.964195] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.718s)
[451.973312] Starting dynamic subtest: pipe-B-eDP-1
[456.383925] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.420s)
[456.393246] Starting dynamic subtest: pipe-C-eDP-1
[460.787887] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.402s)
[460.797522] Starting dynamic subtest: pipe-D-eDP-1
[465.137526] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.349s)
[465.139917] Subtest tiling-4: SUCCESS (16.894s)
[465.958053] [079/133] (558s left) kms_pipe_crc_basic (read-crc)
[466.052483] Starting subtest: read-crc
[466.054699] Starting dynamic subtest: pipe-A-eDP-1
[466.755938] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[466.766628] Starting dynamic subtest: pipe-B-eDP-1
[468.123989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[468.134600] Starting dynamic subtest: pipe-C-eDP-1
[469.487940] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s)
[469.499847] Starting dynamic subtest: pipe-D-eDP-1
[470.826868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[470.829327] Subtest read-crc: SUCCESS (4.777s)
[471.682409] [080/133] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[471.784676] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[479.066565] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.284s)
[479.179469] [081/133] (545s left) gem_exec_reloc (basic-wc-gtt)
[479.243747] Subtest basic-wc-gtt: SKIP (0.000s)
[479.326818] [082/133] (545s left) gem_ppgtt (shrink-vs-evict-pinned)
[479.383396] Starting subtest: shrink-vs-evict-pinned
[484.908231] Subtest shrink-vs-evict-pinned: SUCCESS (5.523s)
[484.993756] [083/133] (539s left) gem_exec_fence (basic-busy)
[485.174267] Starting subtest: basic-busy
[485.176444] Starting dynamic subtest: rcs0
[485.229830] Dynamic subtest rcs0: SUCCESS (0.055s)
[485.240831] Starting dynamic subtest: bcs0
[485.285204] Dynamic subtest bcs0: SUCCESS (0.054s)
[485.296099] Starting dynamic subtest: vcs0
[485.344334] Dynamic subtest vcs0: SUCCESS (0.057s)
[485.356353] Starting dynamic subtest: vcs1
[485.399773] Dynamic subtest vcs1: SUCCESS (0.053s)
[485.413415] Starting dynamic subtest: vecs0
[485.462346] Dynamic subtest vecs0: SUCCESS (0.061s)
[485.473611] Starting dynamic subtest: ccs0
[485.519072] Dynamic subtest ccs0: SUCCESS (0.055s)
[485.521703] Subtest basic-busy: SUCCESS (0.346s)
[487.010435] [084/133] (537s left) kms_invalid_mode (bad-vtotal)
[487.097238] Starting subtest: bad-vtotal
[487.099457] Starting dynamic subtest: pipe-A-eDP-1
[487.378679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[487.387994] Starting dynamic subtest: pipe-B-eDP-1
[487.390162] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[487.398776] Starting dynamic subtest: pipe-C-eDP-1
[487.400953] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[487.409648] Starting dynamic subtest: pipe-D-eDP-1
[487.411938] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[487.414143] Subtest bad-vtotal: SUCCESS (0.288s)
[488.205983] [085/133] (536s left) kms_vblank (query-idle)
[488.306199] Starting subtest: query-idle
[488.308403] Starting dynamic subtest: pipe-A-eDP-1
[490.053619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.749s)
[490.067858] Starting dynamic subtest: pipe-D-eDP-1
[492.458276] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.400s)
[492.460768] Subtest query-idle: SUCCESS (4.153s)
[493.288710] [086/133] (531s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[493.386900] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[493.389687] Starting dynamic subtest: pipe-A-eDP-1
[493.416835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.428005] Starting dynamic subtest: pipe-B-eDP-1
[493.450111] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[493.459175] Starting dynamic subtest: pipe-C-eDP-1
[493.482022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[493.490599] Starting dynamic subtest: pipe-D-eDP-1
[493.513727] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[493.517591] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[495.651468] [087/133] (529s left) sw_sync (sync_multi_consumer)
[495.695015] Starting subtest: sync_multi_consumer
[496.122641] Subtest sync_multi_consumer: SUCCESS (0.429s)
[496.185022] [088/133] (528s left) gem_exec_fence (long-history)
[496.599967] Starting subtest: long-history
[503.577278] Subtest long-history: SUCCESS (6.978s)
[504.098609] [089/133] (520s left) gem_eio (wait-10ms)
[504.347583] Starting subtest: wait-10ms
[504.777219] Subtest wait-10ms: SUCCESS (0.430s)
[504.945700] [090/133] (519s left) gem_exec_reloc (basic-cpu-read-active)
[505.002213] Subtest basic-cpu-read-active: SKIP (0.000s)
[505.078135] [091/133] (519s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[505.177386] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[505.181841] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[505.276594] [092/133] (519s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[505.344356] Starting subtest: invalid-single-wait-all-unsubmitted
[505.346616] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[505.449265] [093/133] (519s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[505.539608] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[505.543375] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[505.611471] [094/133] (519s left) api_intel_bb (crc32)
[505.669502] Starting subtest: crc32
[505.671452] Starting dynamic subtest: rcs0-smem0
[505.987948] Dynamic subtest rcs0-smem0: SUCCESS (0.317s)
[506.001031] Starting dynamic subtest: bcs0-smem0
[506.339058] Dynamic subtest bcs0-smem0: SUCCESS (0.348s)
[506.351304] Starting dynamic subtest: vcs0-smem0
[506.721439] Dynamic subtest vcs0-smem0: SUCCESS (0.379s)
[506.735613] Starting dynamic subtest: vcs1-smem0
[507.066063] Dynamic subtest vcs1-smem0: SUCCESS (0.342s)
[507.078748] Starting dynamic subtest: vecs0-smem0
[507.484657] Dynamic subtest vecs0-smem0: SUCCESS (0.416s)
[507.497057] Starting dynamic subtest: ccs0-smem0
[507.841058] Dynamic subtest ccs0-smem0: SUCCESS (0.354s)
[507.843870] Subtest crc32: SUCCESS (2.172s)
[507.965469] [095/133] (517s left) kms_psr (psr2-dpms)
[508.055385] Starting subtest: psr2-dpms
[508.057723] Starting dynamic subtest: eDP-1
[510.873607] Dynamic subtest eDP-1: SUCCESS (2.816s)
[510.875859] Subtest psr2-dpms: SUCCESS (2.817s)
[511.759292] [096/133] (513s left) kms_cursor_edge_walk (64x64-top-bottom)
[511.862536] Starting subtest: 64x64-top-bottom
[511.864992] Starting dynamic subtest: pipe-A-eDP-1
[515.317582] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[515.327322] Starting dynamic subtest: pipe-D-eDP-1
[518.438432] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[518.440744] Subtest 64x64-top-bottom: SUCCESS (6.579s)
[519.262796] [097/133] (505s left) syncobj_wait (wait-for-submit-delayed-submit)
[519.320985] Starting subtest: wait-for-submit-delayed-submit
[519.424884] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[519.518406] [098/133] (505s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[519.571220] Starting subtest: invalid-bsd1-flag-on-blt
[519.573582] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[519.687440] [099/133] (505s left) perf (whitelisted-registers-userspace-config)
[519.775826] Starting subtest: whitelisted-registers-userspace-config
[519.778180] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s)
[519.820424] [100/133] (505s left) api_intel_bb (delta-check)
[519.886713] Starting subtest: delta-check
[519.891744] Subtest delta-check: SUCCESS (0.006s)
[520.017342] [101/133] (505s left) kms_flip (flip-vs-panning-vs-hang)
[520.116315] Starting subtest: flip-vs-panning-vs-hang
[520.118262] Starting dynamic subtest: A-eDP1
[571.389842] Dynamic subtest A-eDP1: SUCCESS (51.276s)
[571.400227] Starting dynamic subtest: D-eDP1
[620.415663] Dynamic subtest D-eDP1: SUCCESS (49.023s)
[620.421199] Subtest flip-vs-panning-vs-hang: SUCCESS (100.307s)
[621.653496] [102/133] (403s left) kms_rotation_crc (primary-rotation-270)
[621.750265] Starting subtest: primary-rotation-270
[621.754860] Subtest primary-rotation-270: SKIP (0.001s)
[621.821416] [103/133] (403s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[621.933126] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[622.579154] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[622.759200] [104/133] (402s left) kms_sequence (queue-busy)
[622.862822] Starting subtest: queue-busy
[622.865229] Starting dynamic subtest: pipe-A-eDP-1
[624.792238] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[624.802872] Starting dynamic subtest: pipe-B-eDP-1
[627.362054] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.570s)
[627.372079] Starting dynamic subtest: pipe-C-eDP-1
[629.977223] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s)
[629.997037] Starting dynamic subtest: pipe-D-eDP-1
[632.587116] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[632.589504] Subtest queue-busy: SUCCESS (9.729s)
[633.388474] [105/133] (392s left) i915_drm_fdinfo (virtual-busy-all)
[633.430266] Starting subtest: virtual-busy-all
[633.434758] Subtest virtual-busy-all: SKIP (0.000s)
[633.511124] [106/133] (392s left) gem_exec_whisper (basic-sync-all)
[633.577465] Starting subtest: basic-sync-all
[641.040060] Subtest basic-sync-all: SUCCESS (7.462s)
[641.239041] [107/133] (384s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[641.355592] Starting subtest: pr-cursor-plane-update-sf
[641.359773] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[641.423158] [108/133] (384s left) prime_vgem (sync)
[641.513411] Starting subtest: sync
[641.515370] Starting dynamic subtest: rcs0
[641.572550] Dynamic subtest rcs0: SUCCESS (0.062s)
[641.581980] Starting dynamic subtest: bcs0
[641.619638] Dynamic subtest bcs0: SUCCESS (0.045s)
[641.628607] Starting dynamic subtest: vcs0
[641.665175] Dynamic subtest vcs0: SUCCESS (0.043s)
[641.674485] Starting dynamic subtest: vcs1
[641.709851] Dynamic subtest vcs1: SUCCESS (0.044s)
[641.718843] Starting dynamic subtest: vecs0
[641.756923] Dynamic subtest vecs0: SUCCESS (0.046s)
[641.766105] Starting dynamic subtest: ccs0
[641.802625] Dynamic subtest ccs0: SUCCESS (0.044s)
[641.804870] Subtest sync: SUCCESS (0.293s)
[641.942444] [109/133] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[642.035457] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[642.039770] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[642.122580] [110/133] (383s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[642.233730] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[642.237368] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[642.334851] [111/133] (383s left) gem_exec_schedule (preemptive-hang)
[642.511211] Starting subtest: preemptive-hang
[642.513543] Starting dynamic subtest: rcs0
[652.031191] Dynamic subtest rcs0: SUCCESS (9.523s)
[652.042371] Starting dynamic subtest: bcs0
[661.060636] Dynamic subtest bcs0: SUCCESS (9.024s)
[661.071053] Starting dynamic subtest: vcs0
[670.075679] Dynamic subtest vcs0: SUCCESS (9.014s)
[670.087070] Starting dynamic subtest: vcs1
[679.105720] Dynamic subtest vcs1: SUCCESS (9.028s)
[679.116844] Starting dynamic subtest: vecs0
[687.994024] Dynamic subtest vecs0: SUCCESS (8.886s)
[688.004685] Starting dynamic subtest: ccs0
[697.024778] Dynamic subtest ccs0: SUCCESS (9.027s)
[697.027184] Subtest preemptive-hang: SUCCESS (54.515s)
[697.267244] [112/133] (328s left) gem_exec_suspend (basic-s4-devices)
[697.325188] Starting subtest: basic-S4-devices
[697.327605] Starting dynamic subtest: smem
[709.908364] Dynamic subtest smem: SUCCESS (12.581s)
[709.911598] Subtest basic-S4-devices: SUCCESS (12.583s)
[718.111672] [113/133] (315s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[718.231937] Starting subtest: y-tiled-8bpp-rotate-90
[718.236454] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[718.332653] [114/133] (315s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[718.388231] Starting subtest: single-wait-all-for-submit-unsubmitted
[718.488704] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[718.567596] [115/133] (315s left) perf (gen12-mi-rpc)
[718.663486] Starting subtest: gen12-mi-rpc
[718.665721] Starting dynamic subtest: rcs0
[718.681271] Dynamic subtest rcs0: SUCCESS (0.018s)
[718.683562] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[718.723240] [116/133] (315s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[718.846701] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[722.471224] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.628s)
[723.590319] [117/133] (310s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[725.121075] Starting subtest: dpms-mode-unset-non-lpsp
[726.266169] Subtest dpms-mode-unset-non-lpsp: SKIP (1.146s)
[726.643295] [118/133] (307s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[726.733411] Starting subtest: addfb25-yf-tiled-legacy
[726.735662] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[726.826420] [119/133] (307s left) kms_big_fb (x-tiled-addfb-size-overflow)
[726.929295] Starting subtest: x-tiled-addfb-size-overflow
[726.931536] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[727.030488] [120/133] (307s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[727.140432] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[727.144340] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[727.244886] [121/133] (306s left) kms_big_fb (linear-32bpp-rotate-90)
[727.350700] Starting subtest: linear-32bpp-rotate-90
[727.370606] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[727.475503] [122/133] (306s left) syncobj_wait (single-wait-all-submitted)
[727.531803] Starting subtest: single-wait-all-submitted
[727.633821] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[727.723422] [123/133] (306s left) gem_exec_balancer (full-late)
[727.801418] Starting subtest: full-late
[732.785618] Subtest full-late: SUCCESS (4.984s)
[733.131867] [124/133] (301s left) gem_mmap_gtt (ptrace)
[733.189910] Subtest ptrace: SKIP (0.000s)
[733.261408] [125/133] (301s left) i915_pm_rps (waitboost)
[733.314569] Starting subtest: waitboost
[739.665396] Subtest waitboost: SUCCESS (6.349s)
[739.762142] [126/133] (294s left) prime_vgem (basic-gtt)
[739.834854] Starting subtest: basic-gtt
[739.839890] Subtest basic-gtt: SKIP (0.000s)
[739.943051] [127/133] (294s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[740.039372] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[740.043674] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[740.146578] [128/133] (294s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[740.243538] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[746.670551] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.431s)
[746.808337] [129/133] (287s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[746.908084] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[753.891187] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.984s)
[754.024801] [130/133] (280s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[754.125522] Starting subtest: fbcpsr-slowdraw
[779.201373] Subtest fbcpsr-slowdraw: SUCCESS (25.078s)
[779.331574] [131/133] (255s left) kms_lease (lease-get)
[779.429379] Starting subtest: lease-get
[779.431707] Starting dynamic subtest: pipe-A-eDP-1
[779.434043] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[779.444738] Starting dynamic subtest: pipe-B-eDP-1
[779.446790] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[779.456508] Starting dynamic subtest: pipe-C-eDP-1
[779.458589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[779.468339] Starting dynamic subtest: pipe-D-eDP-1
[779.470276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[779.472225] Subtest lease-get: SUCCESS (0.009s)
[779.569500] [132/133] (255s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[779.671422] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[779.675853] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[779.746273] [133/133] (254s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[779.837827] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[779.841979] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[779.936753] Closing watchdogs
results: parsing output: 0/ for test: kms_scaling_modes
results: parsing output: 1/ for test: gem_exec_gttfill
results: parsing output: 2/ for test: kms_atomic
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pwrite_snooped
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: gem_render_copy
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_exec_flush
results: parsing output: 25/ for test: sysfs_heartbeat_interval
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_ccs
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_draw_crc
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_set_tiling_vs_blt
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_busy
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: gem_vm_create
results: parsing output: 48/ for test: vgem_basic
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: dumb_buffer
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_reg_read
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_dp_link_training
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_prime
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_flush
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: prime_self_import
results: parsing output: 77/ for test: kms_plane_multiple
results: parsing output: 78/ for test: kms_pipe_crc_basic
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_ppgtt
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_invalid_mode
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: sw_sync
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_cursor_edge_walk
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_sequence
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_exec_schedule
results: parsing output: 111/ for test: gem_exec_suspend
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pm_rpm
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: i915_pm_rps
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.