[50.831788] Initializing watchdogs
[50.831842]   /dev/watchdog0
[50.845228] [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]
[50.849412] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[50.851534] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[50.854689] [001/133] (960s left) kms_scaling_modes (scaling-mode-center)
[50.969753] Starting subtest: scaling-mode-center
[50.971737] Starting dynamic subtest: pipe-A-eDP-1
[51.120329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.155s)
[51.129112] Starting dynamic subtest: pipe-B-eDP-1
[52.247684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[52.256686] Starting dynamic subtest: pipe-C-eDP-1
[53.360275] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[53.368745] Starting dynamic subtest: pipe-D-eDP-1
[54.472808] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[54.475301] Subtest scaling-mode-center: SUCCESS (3.568s)
[55.627028] [002/133] (955s left) gem_exec_gttfill (engines)
[55.707062] Starting subtest: engines
[55.709403] Starting dynamic subtest: rcs0
[78.413579] Dynamic subtest rcs0: SUCCESS (22.790s)
[78.423371] Starting dynamic subtest: bcs0
[101.685230] Dynamic subtest bcs0: SUCCESS (23.269s)
[101.696074] Starting dynamic subtest: vcs0
[124.915968] Dynamic subtest vcs0: SUCCESS (23.228s)
[124.928118] Starting dynamic subtest: vcs1
[148.124836] Dynamic subtest vcs1: SUCCESS (23.207s)
[148.132623] Starting dynamic subtest: vecs0
[171.424569] Dynamic subtest vecs0: SUCCESS (23.297s)
[171.432665] Starting dynamic subtest: ccs0
[194.754208] Dynamic subtest ccs0: SUCCESS (23.325s)
[194.757052] Subtest engines: SUCCESS (139.128s)
[194.939752] [003/133] (816s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[195.066626] Starting subtest: plane-primary-overlay-mutable-zpos
[198.557888] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.490s)
[199.730988] [004/133] (811s left) gem_partial_pwrite_pread (write-snoop)
[199.811308] Subtest write-snoop: SKIP (0.000s)
[199.881814] [005/133] (811s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[200.201787] Starting subtest: cursor-rapid-movement-512x170
[200.206195] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[200.330694] [006/133] (811s left) kms_plane_scaling (planes-upscale-20x20)
[200.420465] Starting subtest: planes-upscale-20x20
[200.422657] Starting dynamic subtest: pipe-A
[200.481613] Dynamic subtest pipe-A: SUCCESS (0.063s)
[200.491328] Starting dynamic subtest: pipe-B
[201.660808] Dynamic subtest pipe-B: SUCCESS (1.176s)
[201.670575] Starting dynamic subtest: pipe-C
[202.786743] Dynamic subtest pipe-C: SUCCESS (1.125s)
[202.796704] Starting dynamic subtest: pipe-D
[203.922445] Dynamic subtest pipe-D: SUCCESS (1.138s)
[203.924825] Subtest planes-upscale-20x20: SUCCESS (3.504s)
[205.068584] [007/133] (806s left) kms_cursor_crc (cursor-offscreen-32x32)
[205.240873] Starting subtest: cursor-offscreen-32x32
[205.288700] Subtest cursor-offscreen-32x32: SKIP (0.042s)
[205.599848] [008/133] (806s left) syncobj_wait (invalid-reset-illegal-handle)
[205.654879] Starting subtest: invalid-reset-illegal-handle
[205.657310] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[205.744438] [009/133] (805s left) gen9_exec_parse (basic-rejected)
[205.791207] Subtest basic-rejected: SKIP (0.000s)
[205.854207] [010/133] (805s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[205.912995] Starting subtest: single-wait-all-for-submit-available-submitted
[205.915362] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[206.010734] [011/133] (805s left) gem_pwrite_snooped
[206.140609] [012/133] (805s left) kms_color (ctm-0-25)
[206.220109] Starting subtest: ctm-0-25
[206.222069] Starting dynamic subtest: pipe-A-eDP-1
[209.689090] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[209.698541] Starting dynamic subtest: pipe-B-eDP-1
[213.976718] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.287s)
[213.988564] Starting dynamic subtest: pipe-C-eDP-1
[218.031675] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.056s)
[218.040198] Starting dynamic subtest: pipe-D-eDP-1
[222.111142] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.077s)
[222.113431] Subtest ctm-0-25: SUCCESS (15.889s)
[222.951497] [013/133] (788s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[223.346410] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[224.165865] [014/133] (787s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[224.268665] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[224.271243] Starting dynamic subtest: pipe-A-eDP-1
[224.297192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.308866] Starting dynamic subtest: pipe-B-eDP-1
[224.333686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.342757] Starting dynamic subtest: pipe-C-eDP-1
[224.366746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.374306] Starting dynamic subtest: pipe-D-eDP-1
[224.397995] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.402383] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[226.542201] [015/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[226.639883] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[231.058123] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.422s)
[232.235037] [016/133] (779s left) gem_exec_schedule (promotion)
[232.313123] Starting subtest: promotion
[232.315177] Starting dynamic subtest: rcs0
[232.433819] Dynamic subtest rcs0: SUCCESS (0.123s)
[232.445289] Starting dynamic subtest: vcs0
[232.521825] Dynamic subtest vcs0: SUCCESS (0.088s)
[232.532706] Starting dynamic subtest: vcs1
[232.600960] Dynamic subtest vcs1: SUCCESS (0.079s)
[232.612665] Starting dynamic subtest: vecs0
[232.684448] Dynamic subtest vecs0: SUCCESS (0.082s)
[232.695896] Starting dynamic subtest: ccs0
[232.781582] Dynamic subtest ccs0: SUCCESS (0.097s)
[232.784468] Subtest promotion: SUCCESS (0.472s)
[233.962283] [017/133] (777s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[234.016946] Starting subtest: yf-tiled-to-vebox-y-tiled
[234.021584] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[234.198083] [018/133] (777s left) gem_mmap_gtt (big-copy-xy)
[234.255751] Subtest big-copy-XY: SKIP (0.000s)
[234.311652] [019/133] (777s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[234.368214] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[234.472859] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[234.545678] [020/133] (777s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[234.637702] Starting subtest: psr-rgb565-draw-pwrite
[241.745263] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.111s)
[241.868885] [021/133] (770s left) kms_flip (plain-flip-ts-check-interruptible)
[241.969846] Starting subtest: plain-flip-ts-check-interruptible
[241.972082] Starting dynamic subtest: A-eDP1
[250.851776] Dynamic subtest A-eDP1: SUCCESS (8.881s)
[250.862253] Starting dynamic subtest: B-eDP1
[259.674563] Dynamic subtest B-eDP1: SUCCESS (8.821s)
[259.685131] Starting dynamic subtest: C-eDP1
[268.504125] Dynamic subtest C-eDP1: SUCCESS (8.828s)
[268.513233] Starting dynamic subtest: D-eDP1
[277.333928] Dynamic subtest D-eDP1: SUCCESS (8.828s)
[277.339776] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.367s)
[278.519478] [022/133] (733s left) kms_flip (flip-vs-rmfb-interruptible)
[278.621168] Starting subtest: flip-vs-rmfb-interruptible
[278.623439] Starting dynamic subtest: A-eDP1
[287.310131] Dynamic subtest A-eDP1: SUCCESS (8.687s)
[287.321122] Starting dynamic subtest: B-eDP1
[295.941527] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[295.949390] Starting dynamic subtest: C-eDP1
[304.558051] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[304.567917] Starting dynamic subtest: D-eDP1
[313.194741] Dynamic subtest D-eDP1: SUCCESS (8.635s)
[313.199049] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.577s)
[314.375602] [023/133] (697s left) i915_pm_rps (reset)
[314.465109] Starting subtest: reset
[322.929070] Subtest reset: SUCCESS (8.463s)
[323.038925] [024/133] (689s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[323.133084] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[323.135332] Starting dynamic subtest: pipe-A-eDP-1
[323.155524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[323.166403] Starting dynamic subtest: pipe-B-eDP-1
[323.186065] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[323.193590] Starting dynamic subtest: pipe-C-eDP-1
[323.212732] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[323.222482] Starting dynamic subtest: pipe-D-eDP-1
[323.241450] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[323.243317] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[325.351227] [025/133] (686s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[325.418538] Starting subtest: basic-batch-kernel-default-cmd
[325.423122] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[325.613499] [026/133] (686s left) sysfs_heartbeat_interval (idempotent)
[325.683205] Starting subtest: idempotent
[325.685552] Starting dynamic subtest: vecs0
[325.687880] Dynamic subtest vecs0: SUCCESS (0.001s)
[325.697465] Starting dynamic subtest: ccs0
[325.699633] Dynamic subtest ccs0: SUCCESS (0.001s)
[325.707468] Starting dynamic subtest: vcs0
[325.709680] Dynamic subtest vcs0: SUCCESS (0.000s)
[325.717432] Starting dynamic subtest: bcs0
[325.719674] Dynamic subtest bcs0: SUCCESS (0.001s)
[325.727470] Starting dynamic subtest: rcs0
[325.729706] Dynamic subtest rcs0: SUCCESS (0.001s)
[325.737625] Starting dynamic subtest: vcs1
[325.739556] Dynamic subtest vcs1: SUCCESS (0.000s)
[325.741406] Subtest idempotent: SUCCESS (0.009s)
[325.789448] [027/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[325.893108] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[332.705523] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.814s)
[332.892896] [028/133] (679s left) gem_mmap_gtt (close-race)
[332.974682] Subtest close-race: SKIP (0.000s)
[333.042013] [029/133] (679s left) perf (invalid-remove-userspace-config)
[333.173044] Starting subtest: invalid-remove-userspace-config
[333.180274] Subtest invalid-remove-userspace-config: SUCCESS (0.007s)
[333.218378] [030/133] (679s left) gem_ccs (suspend-resume)
[333.266521] Starting subtest: suspend-resume
[333.270926] Subtest suspend-resume: SKIP (0.000s)
[333.363353] [031/133] (679s left) kms_chamelium_color (ctm-red-to-blue)
[333.459914] Subtest ctm-red-to-blue: SKIP (0.000s)
[333.504599] [032/133] (679s left) gem_mmap_gtt (big-bo-tiledy)
[333.569987] Subtest big-bo-tiledY: SKIP (0.000s)
[333.627507] [033/133] (678s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[333.728694] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[333.730453] Starting dynamic subtest: pipe-A-eDP-1
[339.608965] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.880s)
[339.619949] Starting dynamic subtest: pipe-B-eDP-1
[346.274320] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.665s)
[346.276746] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.549s)
[347.128111] [034/133] (665s left) kms_draw_crc (draw-method-blt)
[347.227449] Starting subtest: draw-method-blt
[347.229703] Starting dynamic subtest: xrgb8888-untiled
[347.447136] Dynamic subtest xrgb8888-untiled: SUCCESS (0.221s)
[347.458021] Starting dynamic subtest: rgb565-untiled
[347.658042] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[347.666599] Starting dynamic subtest: xrgb2101010-untiled
[347.869165] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[347.877974] Starting dynamic subtest: xbgr16161616f-untiled
[348.069157] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[348.087567] Starting dynamic subtest: xrgb8888-xtiled
[348.180535] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.109s)
[348.191647] Starting dynamic subtest: rgb565-xtiled
[348.302308] Dynamic subtest rgb565-xtiled: SUCCESS (0.119s)
[348.313070] Starting dynamic subtest: xrgb2101010-xtiled
[348.402131] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.099s)
[348.412738] Starting dynamic subtest: xbgr16161616f-xtiled
[348.502188] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.098s)
[348.510072] Starting dynamic subtest: xrgb8888-4tiled
[348.624386] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[348.632164] Starting dynamic subtest: rgb565-4tiled
[348.735384] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[348.743235] Starting dynamic subtest: xrgb2101010-4tiled
[348.835486] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.099s)
[348.843299] Starting dynamic subtest: xbgr16161616f-4tiled
[348.935254] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.099s)
[348.937138] Subtest draw-method-blt: SUCCESS (1.711s)
[349.043249] [035/133] (663s left) kms_psr (fbc-psr-no-drrs)
[349.132473] Starting subtest: fbc-psr-no-drrs
[349.134472] Starting dynamic subtest: eDP-1
[349.137996] Dynamic subtest eDP-1: SKIP (0.000s)
[349.141587] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[349.203432] [036/133] (663s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[349.254589] Subtest untiled-to-tiled: SKIP (0.000s)
[349.318229] [037/133] (663s left) gem_ctx_param (invalid-get-no-zeromap)
[349.367566] Starting subtest: invalid-get-no-zeromap
[349.369846] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[349.458882] [038/133] (663s left) i915_drm_fdinfo (virtual-busy-hang-all)
[349.503455] Starting subtest: virtual-busy-hang-all
[349.507216] Subtest virtual-busy-hang-all: SKIP (0.000s)
[349.576348] [039/133] (663s left) syncobj_timeline (invalid-signal-zero-handles)
[349.631144] Starting subtest: invalid-signal-zero-handles
[349.632824] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[349.719928] [040/133] (663s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[349.815035] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[349.819072] Starting dynamic subtest: A-eDP1
[353.361838] Dynamic subtest A-eDP1: SUCCESS (3.542s)
[353.370149] Starting dynamic subtest: B-eDP1
[356.657155] Dynamic subtest B-eDP1: SUCCESS (3.296s)
[356.666179] Starting dynamic subtest: C-eDP1
[359.763552] Dynamic subtest C-eDP1: SUCCESS (3.103s)
[359.774756] Starting dynamic subtest: D-eDP1
[362.858322] Dynamic subtest D-eDP1: SUCCESS (3.095s)
[362.860700] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.044s)
[363.649504] [041/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[363.758087] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[363.762266] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[363.849449] [042/133] (649s left) perf_pmu (most-busy-idle-check-all)
[363.896495] Starting subtest: most-busy-idle-check-all
[363.898732] Starting dynamic subtest: rcs0
[365.908782] Dynamic subtest rcs0: SUCCESS (2.012s)
[365.924819] Starting dynamic subtest: bcs0
[367.893561] Dynamic subtest bcs0: SUCCESS (1.981s)
[367.905854] Starting dynamic subtest: vcs0
[369.877817] Dynamic subtest vcs0: SUCCESS (1.982s)
[369.888776] Starting dynamic subtest: vcs1
[371.861138] Dynamic subtest vcs1: SUCCESS (1.980s)
[371.873376] Starting dynamic subtest: vecs0
[373.909453] Dynamic subtest vecs0: SUCCESS (2.045s)
[373.919289] Starting dynamic subtest: ccs0
[375.894263] Dynamic subtest ccs0: SUCCESS (1.981s)
[375.897104] Subtest most-busy-idle-check-all: SUCCESS (12.000s)
[376.011287] [043/133] (636s left) gem_eio (in-flight-contexts-10ms)
[376.209553] Starting subtest: in-flight-contexts-10ms
[389.934944] Subtest in-flight-contexts-10ms: SUCCESS (13.724s)
[390.066322] [044/133] (622s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[390.163751] Starting subtest: psr-rgb565-draw-mmap-cpu
[396.953367] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.793s)
[397.050875] [045/133] (616s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[397.149211] Starting subtest: fbc-farfromfence-mmap-gtt
[397.153217] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[397.248717] [046/133] (615s left) gem_busy (busy)
[397.306339] Starting subtest: busy
[397.308839] Starting dynamic subtest: all-engines
[397.375117] Dynamic subtest all-engines: SUCCESS (0.069s)
[397.384811] Starting dynamic subtest: rcs0
[398.938643] Dynamic subtest rcs0: SUCCESS (1.562s)
[398.954030] Starting dynamic subtest: bcs0
[398.979673] Dynamic subtest bcs0: SUCCESS (0.039s)
[398.994918] Starting dynamic subtest: vcs0
[399.019638] Dynamic subtest vcs0: SUCCESS (0.038s)
[399.030097] Starting dynamic subtest: vcs1
[400.924717] Dynamic subtest vcs1: SUCCESS (1.900s)
[400.937056] Starting dynamic subtest: vecs0
[402.906371] Dynamic subtest vecs0: SUCCESS (1.982s)
[402.915417] Starting dynamic subtest: ccs0
[404.890263] Dynamic subtest ccs0: SUCCESS (1.984s)
[404.892563] Subtest busy: SUCCESS (7.584s)
[405.233453] [047/133] (607s left) gem_spin_batch (legacy-resubmit)
[405.294108] Starting subtest: legacy-resubmit
[405.296323] Starting dynamic subtest: default
[405.306502] Dynamic subtest default: SUCCESS (0.012s)
[405.318542] Starting dynamic subtest: render
[405.320744] Dynamic subtest render: SUCCESS (0.003s)
[405.329204] Starting dynamic subtest: bsd
[405.331499] Dynamic subtest bsd: SUCCESS (0.005s)
[405.339796] Starting dynamic subtest: bsd1
[405.341642] Dynamic subtest bsd1: SUCCESS (0.004s)
[405.349586] Starting dynamic subtest: bsd2
[405.351440] Dynamic subtest bsd2: SUCCESS (0.001s)
[405.359288] Starting dynamic subtest: blt
[405.361104] Dynamic subtest blt: SUCCESS (0.005s)
[405.369141] Starting dynamic subtest: vebox
[405.370979] Dynamic subtest vebox: SUCCESS (0.003s)
[405.372798] Subtest legacy-resubmit: SUCCESS (0.041s)
[405.569261] [048/133] (607s left) gem_vm_create (invalid-destroy)
[405.617191] Starting subtest: invalid-destroy
[405.619404] Subtest invalid-destroy: SUCCESS (0.002s)
[405.720835] [049/133] (607s left) vgem_basic (setversion)
[405.838417] Starting subtest: setversion
[405.842357] Subtest setversion: SUCCESS (0.000s)
[405.891927] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[405.896066] [050/133] (607s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[405.982053] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[405.984412] Starting dynamic subtest: pipe-A-eDP-1
[405.993686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[406.006944] Starting dynamic subtest: pipe-B-eDP-1
[406.016303] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[406.025118] Starting dynamic subtest: pipe-C-eDP-1
[406.033838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[406.042733] Starting dynamic subtest: pipe-D-eDP-1
[406.051520] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[406.055867] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[408.254553] [051/133] (605s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[408.355673] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[408.359715] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[408.468921] [052/133] (604s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[408.617584] Starting subtest: dp-mst-lic-type-0-hdcp14
[408.622150] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[408.739314] [053/133] (604s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[408.823520] Starting subtest: fbc-psr2-cursor-mmap-cpu
[408.825537] Starting dynamic subtest: eDP-1
[408.829610] Dynamic subtest eDP-1: SKIP (0.000s)
[408.833629] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[408.896083] [054/133] (604s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[408.999422] Starting subtest: yf-tiled-addfb-size-offset-overflow
[409.003376] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[409.090566] [055/133] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[409.186048] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[409.189632] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[409.290196] [056/133] (604s left) dumb_buffer (invalid-bpp)
[409.350344] Starting subtest: invalid-bpp
[409.351956] Subtest invalid-bpp: SUCCESS (0.000s)
[409.430401] [057/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[409.526136] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[409.529614] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[409.633206] [058/133] (603s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[409.688322] Starting subtest: etime-single-wait-all-available-unsubmitted
[409.793061] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.103s)
[409.866984] [059/133] (603s left) gem_reg_read (bad-register)
[409.929636] Starting subtest: bad-register
[409.931622] Subtest bad-register: SUCCESS (0.000s)
[410.016382] [060/133] (603s left) gem_ctx_persistence (legacy-engines-cleanup)
[410.069291] Starting subtest: legacy-engines-cleanup
[410.071592] Starting dynamic subtest: render
[410.135964] Dynamic subtest render: SUCCESS (0.066s)
[410.147461] Starting dynamic subtest: bsd1
[410.174515] Dynamic subtest bsd1: SUCCESS (0.036s)
[410.185919] Starting dynamic subtest: bsd2
[410.211446] Dynamic subtest bsd2: SUCCESS (0.035s)
[410.220075] Starting dynamic subtest: blt
[410.251527] Dynamic subtest blt: SUCCESS (0.038s)
[410.264046] Starting dynamic subtest: vebox
[410.276290] Dynamic subtest vebox: SUCCESS (0.022s)
[410.278493] Subtest legacy-engines-cleanup: SUCCESS (0.208s)
[410.389604] [061/133] (603s left) gem_ctx_shared (q-in-order)
[410.439256] Starting subtest: Q-in-order
[410.441374] Starting dynamic subtest: rcs0
[410.538337] Dynamic subtest rcs0: SUCCESS (0.098s)
[410.553561] Starting dynamic subtest: vcs0
[410.631525] Dynamic subtest vcs0: SUCCESS (0.092s)
[410.647393] Starting dynamic subtest: vcs1
[410.719069] Dynamic subtest vcs1: SUCCESS (0.086s)
[410.735532] Starting dynamic subtest: vecs0
[410.799326] Dynamic subtest vecs0: SUCCESS (0.077s)
[410.814203] Starting dynamic subtest: ccs0
[410.893351] Dynamic subtest ccs0: SUCCESS (0.093s)
[410.895534] Subtest Q-in-order: SUCCESS (0.455s)
[411.997439] [062/133] (601s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[412.100812] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[412.105060] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[412.206693] [063/133] (601s left) kms_properties (connector-properties-legacy)
[412.297886] Starting subtest: connector-properties-legacy
[412.299815] Starting dynamic subtest: pipe-A-eDP-1
[420.340986] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.043s)
[420.352929] Starting dynamic subtest: pipe-None-DP-1
[420.357267] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[420.365925] Starting dynamic subtest: pipe-None-HDMI-A-1
[420.370149] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[420.379341] Starting dynamic subtest: pipe-None-DP-2
[420.383342] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[420.392452] Starting dynamic subtest: pipe-None-HDMI-A-2
[420.396996] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[420.405980] Starting dynamic subtest: pipe-None-DP-3
[420.410487] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[420.419285] Starting dynamic subtest: pipe-None-DP-4
[420.423516] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[420.425658] Subtest connector-properties-legacy: SUCCESS (8.054s)
[421.220333] [064/133] (592s left) kms_dp_link_training (non-uhbr-sst)
[421.308308] Starting subtest: non-uhbr-sst
[421.316640] Subtest non-uhbr-sst: SKIP (0.000s)
[421.391759] [065/133] (592s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[421.477775] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[421.481970] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[421.548371] [066/133] (592s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[421.636243] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[421.638150] Starting dynamic subtest: pipe-A
[421.973297] Dynamic subtest pipe-A: SUCCESS (0.339s)
[421.985171] Starting dynamic subtest: pipe-B
[423.419871] Dynamic subtest pipe-B: SUCCESS (1.446s)
[423.429864] Starting dynamic subtest: pipe-C
[424.875853] Dynamic subtest pipe-C: SUCCESS (1.455s)
[424.885493] Starting dynamic subtest: pipe-D
[426.273334] Dynamic subtest pipe-D: SUCCESS (1.396s)
[426.275580] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.640s)
[427.445989] [067/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[427.555808] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[427.559766] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[427.662077] [068/133] (586s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[427.760289] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[427.764658] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[428.866467] [069/133] (585s left) gem_exec_schedule (u-submit-golden-slice)
[428.948138] Starting subtest: u-submit-golden-slice
[428.950416] Starting dynamic subtest: rcs0
[428.975789] Dynamic subtest rcs0: SUCCESS (0.034s)
[428.990679] Starting dynamic subtest: bcs0
[429.016831] Dynamic subtest bcs0: SUCCESS (0.040s)
[429.026021] Starting dynamic subtest: vcs0
[429.056020] Dynamic subtest vcs0: SUCCESS (0.039s)
[429.065811] Starting dynamic subtest: vcs1
[429.093743] Dynamic subtest vcs1: SUCCESS (0.037s)
[429.103224] Starting dynamic subtest: vecs0
[429.130481] Dynamic subtest vecs0: SUCCESS (0.035s)
[429.139655] Starting dynamic subtest: ccs0
[429.164974] Dynamic subtest ccs0: SUCCESS (0.034s)
[429.167322] Subtest u-submit-golden-slice: SUCCESS (0.225s)
[431.027104] [070/133] (583s left) kms_prime (basic-crc-hybrid)
[431.109050] Subtest basic-crc-hybrid: SKIP (0.000s)
[431.202222] [071/133] (582s left) kms_psr (pr-primary-mmap-gtt)
[431.289735] Starting subtest: pr-primary-mmap-gtt
[431.294302] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[431.363238] [072/133] (582s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[431.433606] Starting subtest: multi-wait-available-unsubmitted-signaled
[431.435788] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[431.539701] [073/133] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[431.638580] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[431.642634] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[431.744666] [074/133] (582s left) gem_exec_flush (basic-wb-ro-before-default)
[431.813308] Starting subtest: basic-wb-ro-before-default
[437.272140] Subtest basic-wb-ro-before-default: SUCCESS (5.459s)
[437.476913] [075/133] (576s left) gem_userptr_blits (dmabuf-unsync)
[437.552122] Subtest dmabuf-unsync: SKIP (0.000s)
[437.663007] [076/133] (576s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[437.781036] Starting subtest: verify-pxp-stale-buf-optout-execution
[438.846238] Subtest verify-pxp-stale-buf-optout-execution: SUCCESS (1.066s)
[438.966912] [077/133] (575s left) prime_self_import (basic-llseek-bad)
[439.001385] Starting subtest: basic-llseek-bad
[439.019025] Subtest basic-llseek-bad: SUCCESS (0.018s)
[439.131408] [078/133] (575s left) kms_plane_multiple (tiling-4)
[439.221834] Starting subtest: tiling-4
[439.223699] Starting dynamic subtest: pipe-A-eDP-1
[443.032215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.809s)
[443.041839] Starting dynamic subtest: pipe-B-eDP-1
[447.504550] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.472s)
[447.513745] Starting dynamic subtest: pipe-C-eDP-1
[451.840967] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.337s)
[451.850859] Starting dynamic subtest: pipe-D-eDP-1
[456.296111] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.451s)
[456.298327] Subtest tiling-4: SUCCESS (17.074s)
[457.104966] [079/133] (557s left) kms_pipe_crc_basic (read-crc)
[457.208246] Starting subtest: read-crc
[457.210438] Starting dynamic subtest: pipe-A-eDP-1
[457.912755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[457.923793] Starting dynamic subtest: pipe-B-eDP-1
[459.286428] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.370s)
[459.296199] Starting dynamic subtest: pipe-C-eDP-1
[460.640522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[460.650332] Starting dynamic subtest: pipe-D-eDP-1
[461.934907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.294s)
[461.937373] Subtest read-crc: SUCCESS (4.729s)
[462.780814] [080/133] (551s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[462.872709] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[470.205412] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.335s)
[470.342371] [081/133] (544s left) gem_exec_reloc (basic-wc-gtt)
[470.417628] Subtest basic-wc-gtt: SKIP (0.000s)
[470.497420] [082/133] (544s left) gem_ppgtt (shrink-vs-evict-pinned)
[470.549459] Starting subtest: shrink-vs-evict-pinned
[475.951535] Subtest shrink-vs-evict-pinned: SUCCESS (5.400s)
[476.036500] [083/133] (538s left) gem_exec_fence (basic-busy)
[476.210293] Starting subtest: basic-busy
[476.212549] Starting dynamic subtest: rcs0
[476.293296] Dynamic subtest rcs0: SUCCESS (0.084s)
[476.305809] Starting dynamic subtest: bcs0
[476.348058] Dynamic subtest bcs0: SUCCESS (0.053s)
[476.359235] Starting dynamic subtest: vcs0
[476.401950] Dynamic subtest vcs0: SUCCESS (0.052s)
[476.412821] Starting dynamic subtest: vcs1
[476.456241] Dynamic subtest vcs1: SUCCESS (0.052s)
[476.467104] Starting dynamic subtest: vecs0
[476.505297] Dynamic subtest vecs0: SUCCESS (0.047s)
[476.515935] Starting dynamic subtest: ccs0
[476.563059] Dynamic subtest ccs0: SUCCESS (0.056s)
[476.565757] Subtest basic-busy: SUCCESS (0.356s)
[478.001115] [084/133] (536s left) kms_invalid_mode (bad-vtotal)
[478.105262] Starting subtest: bad-vtotal
[478.107488] Starting dynamic subtest: pipe-A-eDP-1
[478.396501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[478.406551] Starting dynamic subtest: pipe-B-eDP-1
[478.408545] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[478.417788] Starting dynamic subtest: pipe-C-eDP-1
[478.420096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[478.435638] Starting dynamic subtest: pipe-D-eDP-1
[478.438173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[478.440587] Subtest bad-vtotal: SUCCESS (0.296s)
[479.210627] [085/133] (535s left) kms_vblank (query-idle)
[479.313219] Starting subtest: query-idle
[479.315151] Starting dynamic subtest: pipe-A-eDP-1
[481.070586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[481.084410] Starting dynamic subtest: pipe-D-eDP-1
[483.549086] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s)
[483.551501] Subtest query-idle: SUCCESS (4.237s)
[484.364340] [086/133] (530s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[484.467166] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[484.469434] Starting dynamic subtest: pipe-A-eDP-1
[484.494497] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[484.506157] Starting dynamic subtest: pipe-B-eDP-1
[484.529786] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[484.539306] Starting dynamic subtest: pipe-C-eDP-1
[484.563238] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[484.572410] Starting dynamic subtest: pipe-D-eDP-1
[484.596700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[484.600846] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[486.637472] [087/133] (528s left) sw_sync (sync_multi_consumer)
[486.681228] Starting subtest: sync_multi_consumer
[487.113726] Subtest sync_multi_consumer: SUCCESS (0.437s)
[487.181027] [088/133] (527s left) gem_exec_fence (long-history)
[487.590687] Starting subtest: long-history
[494.590421] Subtest long-history: SUCCESS (7.001s)
[495.294518] [089/133] (519s left) gem_eio (wait-10ms)
[495.533589] Starting subtest: wait-10ms
[495.923381] Subtest wait-10ms: SUCCESS (0.388s)
[496.060915] [090/133] (518s left) gem_exec_reloc (basic-cpu-read-active)
[496.127397] Subtest basic-cpu-read-active: SKIP (0.000s)
[496.191810] [091/133] (518s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[496.278180] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[496.282290] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[496.386973] [092/133] (518s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[496.449740] Starting subtest: invalid-single-wait-all-unsubmitted
[496.452118] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[496.546349] [093/133] (518s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[496.642251] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[496.646719] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[496.716178] [094/133] (518s left) api_intel_bb (crc32)
[496.767522] Starting subtest: crc32
[496.769373] Starting dynamic subtest: rcs0-smem0
[497.048064] Dynamic subtest rcs0-smem0: SUCCESS (0.280s)
[497.060865] Starting dynamic subtest: bcs0-smem0
[497.368348] Dynamic subtest bcs0-smem0: SUCCESS (0.318s)
[497.380731] Starting dynamic subtest: vcs0-smem0
[497.695742] Dynamic subtest vcs0-smem0: SUCCESS (0.325s)
[497.707313] Starting dynamic subtest: vcs1-smem0
[498.034611] Dynamic subtest vcs1-smem0: SUCCESS (0.335s)
[498.047020] Starting dynamic subtest: vecs0-smem0
[498.359379] Dynamic subtest vecs0-smem0: SUCCESS (0.321s)
[498.370711] Starting dynamic subtest: ccs0-smem0
[498.684569] Dynamic subtest ccs0-smem0: SUCCESS (0.322s)
[498.687335] Subtest crc32: SUCCESS (1.919s)
[498.815668] [095/133] (516s left) kms_psr (psr2-dpms)
[498.917255] Starting subtest: psr2-dpms
[498.919513] Starting dynamic subtest: eDP-1
[501.771314] Dynamic subtest eDP-1: SUCCESS (2.854s)
[501.773563] Subtest psr2-dpms: SUCCESS (2.856s)
[502.648155] [096/133] (512s left) kms_cursor_edge_walk (64x64-top-bottom)
[502.745302] Starting subtest: 64x64-top-bottom
[502.747462] Starting dynamic subtest: pipe-A-eDP-1
[506.205299] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[506.215069] Starting dynamic subtest: pipe-D-eDP-1
[509.325409] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[509.327598] Subtest 64x64-top-bottom: SUCCESS (6.582s)
[510.136730] [097/133] (505s left) syncobj_wait (wait-for-submit-delayed-submit)
[510.189141] Starting subtest: wait-for-submit-delayed-submit
[510.292164] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[510.368146] [098/133] (504s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[510.435774] Starting subtest: invalid-bsd1-flag-on-blt
[510.438072] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[510.540556] [099/133] (504s left) perf (whitelisted-registers-userspace-config)
[510.630875] Starting subtest: whitelisted-registers-userspace-config
[510.633283] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[510.672956] [100/133] (504s left) api_intel_bb (delta-check)
[510.741576] Starting subtest: delta-check
[510.746883] Subtest delta-check: SUCCESS (0.005s)
[510.876247] [101/133] (504s left) kms_flip (flip-vs-panning-vs-hang)
[510.965480] Starting subtest: flip-vs-panning-vs-hang
[510.967485] Starting dynamic subtest: A-eDP1
[562.363828] Dynamic subtest A-eDP1: SUCCESS (51.399s)
[562.373577] Starting dynamic subtest: D-eDP1
[602.370408] Dynamic subtest D-eDP1: SUCCESS (40.004s)
[602.372835] Subtest flip-vs-panning-vs-hang: SUCCESS (91.406s)
[603.526499] [102/133] (411s left) kms_rotation_crc (primary-rotation-270)
[603.618511] Starting subtest: primary-rotation-270
[603.622821] Subtest primary-rotation-270: SKIP (0.001s)
[603.690998] [103/133] (411s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[603.799772] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[604.515892] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.717s)
[604.681401] [104/133] (410s left) kms_sequence (queue-busy)
[604.765285] Starting subtest: queue-busy
[604.767438] Starting dynamic subtest: pipe-A-eDP-1
[606.697361] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[606.707302] Starting dynamic subtest: pipe-B-eDP-1
[609.332312] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.632s)
[609.342679] Starting dynamic subtest: pipe-C-eDP-1
[611.939560] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[611.949722] Starting dynamic subtest: pipe-D-eDP-1
[614.557679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[614.560054] Subtest queue-busy: SUCCESS (9.791s)
[615.359999] [105/133] (400s left) i915_drm_fdinfo (virtual-busy-all)
[615.402430] Starting subtest: virtual-busy-all
[615.406960] Subtest virtual-busy-all: SKIP (0.000s)
[615.482465] [106/133] (400s left) gem_exec_whisper (basic-sync-all)
[615.554869] Starting subtest: basic-sync-all
[623.105587] Subtest basic-sync-all: SUCCESS (7.548s)
[623.305341] [107/133] (392s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[623.433703] Starting subtest: pr-cursor-plane-update-sf
[623.438387] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[623.513457] [108/133] (392s left) prime_vgem (sync)
[623.576799] Starting subtest: sync
[623.579132] Starting dynamic subtest: rcs0
[623.629203] Dynamic subtest rcs0: SUCCESS (0.052s)
[623.638401] Starting dynamic subtest: bcs0
[623.687928] Dynamic subtest bcs0: SUCCESS (0.058s)
[623.697260] Starting dynamic subtest: vcs0
[623.732862] Dynamic subtest vcs0: SUCCESS (0.044s)
[623.741926] Starting dynamic subtest: vcs1
[623.781048] Dynamic subtest vcs1: SUCCESS (0.047s)
[623.790275] Starting dynamic subtest: vecs0
[623.828826] Dynamic subtest vecs0: SUCCESS (0.047s)
[623.838113] Starting dynamic subtest: ccs0
[623.874835] Dynamic subtest ccs0: SUCCESS (0.045s)
[623.877210] Subtest sync: SUCCESS (0.299s)
[623.994400] [109/133] (391s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[624.080759] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[624.085174] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[624.173185] [110/133] (391s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[624.277859] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[624.281950] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[624.370911] [111/133] (391s left) gem_exec_schedule (preemptive-hang)
[624.546687] Starting subtest: preemptive-hang
[624.549192] Starting dynamic subtest: rcs0
[634.043057] Dynamic subtest rcs0: SUCCESS (9.497s)
[634.053065] Starting dynamic subtest: bcs0
[643.070825] Dynamic subtest bcs0: SUCCESS (9.029s)
[643.082092] Starting dynamic subtest: vcs0
[652.028636] Dynamic subtest vcs0: SUCCESS (8.953s)
[652.039187] Starting dynamic subtest: vcs1
[661.050072] Dynamic subtest vcs1: SUCCESS (9.023s)
[661.062120] Starting dynamic subtest: vecs0
[670.072385] Dynamic subtest vecs0: SUCCESS (9.019s)
[670.083652] Starting dynamic subtest: ccs0
[679.034760] Dynamic subtest ccs0: SUCCESS (8.959s)
[679.037123] Subtest preemptive-hang: SUCCESS (54.488s)
[679.275433] [112/133] (336s left) gem_exec_suspend (basic-s4-devices)
[679.340370] Starting subtest: basic-S4-devices
[679.342499] Starting dynamic subtest: smem
[690.902765] Dynamic subtest smem: SUCCESS (11.562s)
[690.906549] Subtest basic-S4-devices: SUCCESS (11.565s)
[697.096372] [113/133] (324s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[697.234528] Starting subtest: y-tiled-8bpp-rotate-90
[697.238952] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[697.364185] [114/133] (324s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[697.418693] Starting subtest: single-wait-all-for-submit-unsubmitted
[697.519831] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[697.601049] [115/133] (324s left) perf (gen12-mi-rpc)
[697.694193] Starting subtest: gen12-mi-rpc
[697.696621] Starting dynamic subtest: rcs0
[697.714508] Dynamic subtest rcs0: SUCCESS (0.019s)
[697.716845] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[697.763151] [116/133] (324s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[697.864694] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[701.404320] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.544s)
[702.561024] [117/133] (319s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[704.099518] Starting subtest: dpms-mode-unset-non-lpsp
[705.255681] Subtest dpms-mode-unset-non-lpsp: SKIP (1.153s)
[705.640645] [118/133] (316s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[705.725674] Starting subtest: addfb25-yf-tiled-legacy
[705.728058] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[705.815948] [119/133] (316s left) kms_big_fb (x-tiled-addfb-size-overflow)
[705.911156] Starting subtest: x-tiled-addfb-size-overflow
[705.913294] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[706.013906] [120/133] (316s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[706.120948] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[706.125123] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[706.215452] [121/133] (316s left) kms_big_fb (linear-32bpp-rotate-90)
[706.308201] Starting subtest: linear-32bpp-rotate-90
[706.327674] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[706.430910] [122/133] (315s left) syncobj_wait (single-wait-all-submitted)
[706.480663] Starting subtest: single-wait-all-submitted
[706.584579] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[706.662636] [123/133] (315s left) gem_exec_balancer (full-late)
[706.738606] Starting subtest: full-late
[711.793437] Subtest full-late: SUCCESS (5.058s)
[712.100762] [124/133] (310s left) gem_mmap_gtt (ptrace)
[712.159183] Subtest ptrace: SKIP (0.000s)
[712.220203] [125/133] (310s left) i915_pm_rps (waitboost)
[712.284398] Starting subtest: waitboost
[718.622792] Subtest waitboost: SUCCESS (6.336s)
[718.699549] [126/133] (303s left) prime_vgem (basic-gtt)
[718.769353] Starting subtest: basic-gtt
[718.773692] Subtest basic-gtt: SKIP (0.000s)
[718.872216] [127/133] (303s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[718.973831] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[718.978049] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[719.065306] [128/133] (303s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[719.158901] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[725.644110] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.487s)
[725.768692] [129/133] (296s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[725.877239] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[732.772698] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.898s)
[732.887881] [130/133] (289s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[732.992354] Starting subtest: fbcpsr-slowdraw
[758.086091] Subtest fbcpsr-slowdraw: SUCCESS (25.094s)
[758.226383] [131/133] (264s left) kms_lease (lease-get)
[758.326668] Starting subtest: lease-get
[758.329057] Starting dynamic subtest: pipe-A-eDP-1
[758.331709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[758.345532] Starting dynamic subtest: pipe-B-eDP-1
[758.347377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[758.357251] Starting dynamic subtest: pipe-C-eDP-1
[758.359070] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[758.368981] Starting dynamic subtest: pipe-D-eDP-1
[758.370864] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[758.372728] Subtest lease-get: SUCCESS (0.009s)
[758.458540] [132/133] (264s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[758.557497] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[758.561943] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[758.636715] [133/133] (264s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[758.738513] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[758.742620] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[758.811030] 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.