[57.861817] Initializing watchdogs
[57.861960]   /dev/watchdog0
[57.878118] [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]
[57.882805] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.885417] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.888848] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[58.011788] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[61.803929] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.768s)
[62.951859] [002/133] (955s left) gem_exec_async (concurrent-writes)
[63.022975] Starting subtest: concurrent-writes
[63.025349] Starting dynamic subtest: rcs0
[63.046883] Dynamic subtest rcs0: SUCCESS (0.023s)
[63.064502] Starting dynamic subtest: bcs0
[63.066981] Dynamic subtest bcs0: SUCCESS (0.014s)
[63.083555] Starting dynamic subtest: vcs0
[63.085774] Dynamic subtest vcs0: SUCCESS (0.005s)
[63.094570] Starting dynamic subtest: vcs1
[63.096669] Dynamic subtest vcs1: SUCCESS (0.008s)
[63.104516] Starting dynamic subtest: vecs0
[63.106647] Dynamic subtest vecs0: SUCCESS (0.006s)
[63.114001] Starting dynamic subtest: ccs0
[63.116151] Dynamic subtest ccs0: SUCCESS (0.008s)
[63.118296] Subtest concurrent-writes: SUCCESS (0.067s)
[63.310933] [003/133] (955s left) kms_psr (pr-primary-blt)
[63.401743] Starting subtest: pr-primary-blt
[63.406211] Subtest pr-primary-blt: SKIP (0.000s)
[63.474878] [004/133] (955s left) kms_chamelium_frames (dp-crc-fast)
[63.862062] Subtest dp-crc-fast: SKIP (0.000s)
[64.653356] [005/133] (953s left) gem_exec_schedule (pi-shared-iova)
[64.841232] Starting subtest: pi-shared-iova
[64.843683] Starting dynamic subtest: rcs0
[64.922747] Dynamic subtest rcs0: SUCCESS (0.084s)
[64.930718] Starting dynamic subtest: vcs0
[64.985811] Dynamic subtest vcs0: SUCCESS (0.061s)
[64.998084] Starting dynamic subtest: vcs1
[65.038972] Dynamic subtest vcs1: SUCCESS (0.054s)
[65.049096] Starting dynamic subtest: vecs0
[65.095277] Dynamic subtest vecs0: SUCCESS (0.055s)
[65.107198] Starting dynamic subtest: ccs0
[65.152949] Dynamic subtest ccs0: SUCCESS (0.057s)
[65.155501] Subtest pi-shared-iova: SUCCESS (0.315s)
[67.204613] [006/133] (951s left) kms_busy (basic-hang)
[67.435155] Starting subtest: basic-hang
[67.437701] Starting dynamic subtest: flip-pipe-A
[68.112371] Dynamic subtest flip-pipe-A: SUCCESS (0.673s)
[68.122220] Starting dynamic subtest: modeset-pipe-A
[71.522532] Dynamic subtest modeset-pipe-A: SUCCESS (3.404s)
[71.532900] Starting dynamic subtest: flip-pipe-D
[72.719161] Dynamic subtest flip-pipe-D: SUCCESS (1.192s)
[72.728350] Starting dynamic subtest: modeset-pipe-D
[76.146431] Dynamic subtest modeset-pipe-D: SUCCESS (3.424s)
[76.148818] Subtest basic-hang: SUCCESS (8.699s)
[76.944065] [007/133] (941s left) kms_flip (basic-flip-vs-dpms)
[77.046426] Starting subtest: basic-flip-vs-dpms
[77.048939] Starting dynamic subtest: A-eDP1
[79.654968] Dynamic subtest A-eDP1: SUCCESS (2.603s)
[79.665465] Starting dynamic subtest: B-eDP1
[81.818761] Dynamic subtest B-eDP1: SUCCESS (2.162s)
[81.828478] Starting dynamic subtest: C-eDP1
[83.903577] Dynamic subtest C-eDP1: SUCCESS (2.081s)
[83.912082] Starting dynamic subtest: D-eDP1
[85.986286] Dynamic subtest D-eDP1: SUCCESS (2.081s)
[85.990857] Subtest basic-flip-vs-dpms: SUCCESS (8.938s)
[86.771790] [008/133] (931s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[86.893294] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[86.895690] Starting dynamic subtest: pipe-A-default-mode
[89.587881] Dynamic subtest pipe-A-default-mode: SUCCESS (2.691s)
[89.590279] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.694s)
[90.456052] [009/133] (928s left) gem_tiled_swapping (non-threaded)
[90.517263] Subtest non-threaded: SKIP (0.000s)
[90.571221] [010/133] (928s left) kms_legacy_colorkey (invalid-plane)
[90.668421] Starting subtest: invalid-plane
[90.670596] Starting dynamic subtest: zero-id
[90.672493] Dynamic subtest zero-id: SUCCESS (0.000s)
[90.680633] Starting dynamic subtest: outrange-id
[90.682836] Dynamic subtest outrange-id: SUCCESS (0.000s)
[90.684978] Subtest invalid-plane: SUCCESS (0.001s)
[90.743134] [011/133] (928s left) gem_mmap_wc (write-wc-read-gtt)
[90.810690] Subtest write-wc-read-gtt: SKIP (0.000s)
[90.865707] [012/133] (927s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[90.926221] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[90.985828] [013/133] (927s left) kms_big_fb (linear-32bpp-rotate-0)
[91.083724] Starting subtest: linear-32bpp-rotate-0
[92.695442] Subtest linear-32bpp-rotate-0: SUCCESS (1.613s)
[92.814490] [014/133] (926s left) gen9_exec_parse (bb-start-far)
[92.874062] Subtest bb-start-far: SKIP (0.000s)
[92.934564] [015/133] (926s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[93.049309] Starting subtest: cursorB-vs-flipA-varying-size
[93.053194] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[93.188643] [016/133] (925s left) gem_lmem_swapping (verify)
[93.228484] Subtest verify: SKIP (0.000s)
[93.266574] [017/133] (925s left) gem_userptr_blits (mmap-offset-banned)
[93.333517] Starting subtest: mmap-offset-banned
[93.335417] Starting dynamic subtest: wb
[93.337399] Dynamic subtest wb: SUCCESS (0.000s)
[93.345871] Starting dynamic subtest: wc
[93.347457] Dynamic subtest wc: SUCCESS (0.000s)
[93.354541] Starting dynamic subtest: uc
[93.356121] Dynamic subtest uc: SUCCESS (0.000s)
[93.357676] Subtest mmap-offset-banned: SUCCESS (0.002s)
[93.442068] [018/133] (925s left) gem_softpin (evict-snoop-interruptible)
[93.505172] Starting subtest: evict-snoop-interruptible
[93.508854] Subtest evict-snoop-interruptible: SKIP (0.000s)
[93.611172] [019/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process)
[93.670256] Starting subtest: legacy-engines-mixed-process
[93.671939] Starting dynamic subtest: render
[94.938135] Dynamic subtest render: SUCCESS (1.269s)
[94.949246] Starting dynamic subtest: bsd1
[96.930871] Dynamic subtest bsd1: SUCCESS (1.989s)
[96.942363] Starting dynamic subtest: bsd2
[98.921857] Dynamic subtest bsd2: SUCCESS (1.989s)
[98.932537] Starting dynamic subtest: blt
[100.893017] Dynamic subtest blt: SUCCESS (1.969s)
[100.902055] Starting dynamic subtest: vebox
[102.885833] Dynamic subtest vebox: SUCCESS (1.991s)
[102.888320] Subtest legacy-engines-mixed-process: SUCCESS (9.215s)
[102.965911] [020/133] (916s left) gem_eio (hibernate)
[103.209722] Starting subtest: hibernate
[118.720554] Subtest hibernate: SUCCESS (15.507s)
[127.900513] [021/133] (900s left) i915_pm_rps (fence-order)
[127.997705] Starting subtest: fence-order
[130.923123] Subtest fence-order: SUCCESS (2.923s)
[131.056074] [022/133] (897s left) kms_vblank (ts-continuation-idle-hang)
[131.177828] Starting subtest: ts-continuation-idle-hang
[131.179894] Starting dynamic subtest: pipe-A-eDP-1
[157.663244] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.485s)
[157.678755] Starting dynamic subtest: pipe-D-eDP-1
[182.701420] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.032s)
[182.703729] Subtest ts-continuation-idle-hang: SUCCESS (51.521s)
[183.565246] [023/133] (844s left) perf (unprivileged-single-ctx-counters)
[183.703038] Starting subtest: unprivileged-single-ctx-counters
[183.706859] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[183.744659] [024/133] (844s left) kms_frontbuffer_tracking (fbc-tiling-4)
[183.842524] Starting subtest: fbc-tiling-4
[188.110523] Subtest fbc-tiling-4: SUCCESS (4.271s)
[189.295400] [025/133] (839s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[189.402375] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[196.083091] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.682s)
[196.206673] [026/133] (832s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[196.310039] Starting subtest: crc-primary-suspend-y-tiled-ccs
[196.312361] Starting dynamic subtest: pipe-A-eDP-1
[196.321529] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.332917] Starting dynamic subtest: pipe-B-eDP-1
[196.341851] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.351928] Starting dynamic subtest: pipe-C-eDP-1
[196.360930] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.370513] Starting dynamic subtest: pipe-D-eDP-1
[196.379064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.383338] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[198.556457] [027/133] (829s left) gem_spin_batch (engines)
[198.616263] Starting subtest: engines
[198.618663] Starting dynamic subtest: rcs0
[201.851744] Dynamic subtest rcs0: SUCCESS (3.231s)
[201.861943] Starting dynamic subtest: bcs0
[205.089704] Dynamic subtest bcs0: SUCCESS (3.235s)
[205.099695] Starting dynamic subtest: vcs0
[208.326295] Dynamic subtest vcs0: SUCCESS (3.235s)
[208.338510] Starting dynamic subtest: vcs1
[211.565885] Dynamic subtest vcs1: SUCCESS (3.237s)
[211.577626] Starting dynamic subtest: vecs0
[214.802799] Dynamic subtest vecs0: SUCCESS (3.235s)
[214.814048] Starting dynamic subtest: ccs0
[218.037998] Dynamic subtest ccs0: SUCCESS (3.233s)
[218.040167] Subtest engines: SUCCESS (19.417s)
[218.276469] [028/133] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[218.381160] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[225.475238] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.095s)
[225.632014] [029/133] (802s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[225.741467] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[225.745881] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[225.841964] [030/133] (802s left) gem_partial_pwrite_pread (reads-snoop)
[225.906862] Subtest reads-snoop: SKIP (0.000s)
[225.971808] [031/133] (802s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[226.074452] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[227.075560] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.001s)
[227.222409] [032/133] (801s left) kms_getfb (getfb-reject-nv12)
[227.317491] Starting subtest: getfb-reject-nv12
[227.319479] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[227.433524] [033/133] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[227.536503] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[231.728269] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.194s)
[232.912392] [034/133] (795s left) perf_pmu (render-node-busy-idle)
[232.983079] Starting subtest: render-node-busy-idle
[232.985677] Starting dynamic subtest: rcs0
[233.645505] Dynamic subtest rcs0: SUCCESS (0.661s)
[233.659095] Starting dynamic subtest: bcs0
[234.316691] Dynamic subtest bcs0: SUCCESS (0.670s)
[234.329308] Starting dynamic subtest: vcs0
[235.927351] Dynamic subtest vcs0: SUCCESS (1.607s)
[235.939768] Starting dynamic subtest: vcs1
[237.912060] Dynamic subtest vcs1: SUCCESS (1.982s)
[237.925838] Starting dynamic subtest: vecs0
[239.896069] Dynamic subtest vecs0: SUCCESS (1.981s)
[239.908660] Starting dynamic subtest: ccs0
[240.566723] Dynamic subtest ccs0: SUCCESS (0.669s)
[240.569613] Subtest render-node-busy-idle: SUCCESS (7.584s)
[240.644168] [035/133] (788s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[240.750422] Starting subtest: yf-tiled-16bpp-rotate-90
[240.754636] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[240.837449] [036/133] (787s left) kms_content_protection (atomic)
[240.980337] Starting subtest: atomic
[240.984659] Subtest atomic: SKIP (0.000s)
[241.104175] [037/133] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[241.192136] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[241.196354] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[241.281728] [038/133] (787s left) kms_pm_rpm (fences-dpms)
[243.021654] Starting subtest: fences-dpms
[243.026691] Subtest fences-dpms: SKIP (0.000s)
[243.544540] [039/133] (785s left) gem_mmap_gtt (basic-write-read)
[243.603687] Subtest basic-write-read: SKIP (0.000s)
[243.655147] [040/133] (785s left) gem_exec_reloc (basic-write-cpu-active)
[243.718061] Subtest basic-write-cpu-active: SKIP (0.000s)
[243.793195] [041/133] (785s left) gem_eio (unwedge-stress)
[243.996755] Starting subtest: unwedge-stress
[243.999287] Starting dynamic subtest: render
[248.374944] Dynamic subtest render: SUCCESS (4.374s)
[248.392662] Starting dynamic subtest: bsd1
[266.408109] Dynamic subtest bsd1: SUCCESS (18.029s)
[266.424467] Starting dynamic subtest: bsd2
[284.398102] Dynamic subtest bsd2: SUCCESS (17.987s)
[284.415797] Starting dynamic subtest: blt
[284.420547] Dynamic subtest blt: SKIP (0.000s)
[284.430194] Starting dynamic subtest: vebox
[302.402941] Dynamic subtest vebox: SUCCESS (18.002s)
[302.405063] Subtest unwedge-stress: SUCCESS (58.398s)
[303.943995] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[303.947678] [042/133] (725s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[304.046338] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[304.050649] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[304.145220] [043/133] (724s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[304.248061] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[304.250360] Starting dynamic subtest: pipe-A-default-mode
[306.988633] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[306.990934] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.739s)
[307.835126] [044/133] (721s left) gem_exec_store (pages)
[307.912351] Starting subtest: pages
[307.914364] Starting dynamic subtest: rcs0
[307.998843] Dynamic subtest rcs0: SUCCESS (0.088s)
[308.011496] Starting dynamic subtest: bcs0
[308.077062] Dynamic subtest bcs0: SUCCESS (0.078s)
[308.087646] Starting dynamic subtest: vcs0
[308.169750] Dynamic subtest vcs0: SUCCESS (0.090s)
[308.181896] Starting dynamic subtest: vcs1
[308.231857] Dynamic subtest vcs1: SUCCESS (0.061s)
[308.242102] Starting dynamic subtest: vecs0
[308.296821] Dynamic subtest vecs0: SUCCESS (0.064s)
[308.307534] Starting dynamic subtest: ccs0
[308.373845] Dynamic subtest ccs0: SUCCESS (0.076s)
[308.376399] Subtest pages: SUCCESS (0.464s)
[308.559575] [045/133] (720s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[308.663782] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[308.668232] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[308.760825] [046/133] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[308.854976] Starting subtest: psr-1p-primscrn-cur-indfb-move
[316.355997] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.505s)
[316.493701] [047/133] (712s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[316.598749] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[316.601035] Starting dynamic subtest: pipe-A-eDP-1
[316.623846] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.636065] Starting dynamic subtest: pipe-B-eDP-1
[316.657092] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.667152] Starting dynamic subtest: pipe-C-eDP-1
[316.688481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.698591] Starting dynamic subtest: pipe-D-eDP-1
[316.720549] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.724614] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[318.920799] [048/133] (710s left) kms_pm_rpm (basic-rte)
[318.965639] Starting subtest: basic-rte
[322.513765] Subtest basic-rte: SUCCESS (3.551s)
[324.343229] [049/133] (705s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[324.461336] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[324.465416] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[324.582499] [050/133] (704s left) gem_exec_schedule (submit-golden-slice)
[324.668254] Starting subtest: submit-golden-slice
[324.670246] Starting dynamic subtest: rcs0
[324.700418] Dynamic subtest rcs0: SUCCESS (0.040s)
[324.713418] Starting dynamic subtest: bcs0
[324.735618] Dynamic subtest bcs0: SUCCESS (0.034s)
[324.746212] Starting dynamic subtest: vcs0
[324.775746] Dynamic subtest vcs0: SUCCESS (0.039s)
[324.793057] Starting dynamic subtest: vcs1
[324.818798] Dynamic subtest vcs1: SUCCESS (0.043s)
[324.831727] Starting dynamic subtest: vecs0
[324.856448] Dynamic subtest vecs0: SUCCESS (0.037s)
[324.867628] Starting dynamic subtest: ccs0
[324.893856] Dynamic subtest ccs0: SUCCESS (0.037s)
[324.896104] Subtest submit-golden-slice: SUCCESS (0.234s)
[326.019427] [051/133] (703s left) kms_async_flips (async-flip-hang)
[326.112623] Starting subtest: async-flip-hang
[326.485688] Starting dynamic subtest: pipe-A-eDP-1
[342.453544] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.963s)
[342.837906] Starting dynamic subtest: pipe-B-eDP-1
[358.389756] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.555s)
[358.761101] Starting dynamic subtest: pipe-C-eDP-1
[374.383360] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.626s)
[374.763022] Starting dynamic subtest: pipe-D-eDP-1
[390.385541] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.629s)
[390.388318] Subtest async-flip-hang: SUCCESS (64.267s)
[391.579463] [052/133] (637s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[391.803850] Starting subtest: cursor-rapid-movement-128x128
[391.808927] Starting dynamic subtest: pipe-A-eDP-1
[392.347276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[392.379024] Starting dynamic subtest: pipe-D-eDP-1
[393.581107] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[393.582992] Subtest cursor-rapid-movement-128x128: SUCCESS (1.775s)
[394.448436] [053/133] (635s left) syncobj_timeline (invalid-query-bad-pad)
[394.510652] Starting subtest: invalid-query-bad-pad
[394.512979] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[394.626830] [054/133] (635s left) kms_tiled_display (basic-test-pattern)
[394.746775] Subtest basic-test-pattern: SKIP (0.000s)
[394.794623] [055/133] (634s left) perf (gen12-invalid-class-instance)
[394.889625] Starting subtest: gen12-invalid-class-instance
[394.899336] Subtest gen12-invalid-class-instance: SUCCESS (0.011s)
[394.942871] [056/133] (634s left) kms_invalid_mode (uint-max-clock)
[395.034089] Starting subtest: uint-max-clock
[395.036242] Starting dynamic subtest: pipe-A-eDP-1
[395.313816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[395.323801] Starting dynamic subtest: pipe-B-eDP-1
[395.325689] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[395.334894] Starting dynamic subtest: pipe-C-eDP-1
[395.337224] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[395.346515] Starting dynamic subtest: pipe-D-eDP-1
[395.348695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[395.350826] Subtest uint-max-clock: SUCCESS (0.288s)
[396.165491] [057/133] (633s left) kms_psr (fbc-psr-cursor-plane-move)
[396.265153] Starting subtest: fbc-psr-cursor-plane-move
[396.267469] Starting dynamic subtest: eDP-1
[396.271862] Dynamic subtest eDP-1: SKIP (0.000s)
[396.276294] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[396.338177] [058/133] (633s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[396.435583] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[396.440047] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[396.532428] [059/133] (633s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[396.654308] Starting subtest: cursorB-vs-flipB-varying-size
[396.658675] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[396.800823] [060/133] (633s left) gem_exec_reloc (basic-gtt)
[396.859985] Subtest basic-gtt: SKIP (0.000s)
[396.942230] [061/133] (632s left) gem_lmem_swapping (basic)
[396.981620] Subtest basic: SKIP (0.000s)
[397.035483] [062/133] (632s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[397.152078] Starting subtest: basic-flip-before-cursor-varying-size
[398.083839] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.929s)
[398.917758] [063/133] (631s left) kms_cursor_crc (cursor-onscreen-512x512)
[399.204057] Starting subtest: cursor-onscreen-512x512
[399.208623] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[399.362457] [064/133] (630s left) gem_exec_params (larger-than-life-batch)
[399.423772] Starting subtest: larger-than-life-batch
[401.695671] Subtest larger-than-life-batch: SUCCESS (2.271s)
[402.972649] [065/133] (627s left) gem_close_race (multigpu-basic-process)
[403.074740] Starting subtest: multigpu-basic-process
[403.079045] Subtest multigpu-basic-process: SKIP (0.000s)
[403.301186] [066/133] (626s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[403.422216] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[404.880970] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.457s)
[405.681507] [067/133] (624s left) kms_feature_discovery (display-4x)
[405.784219] Starting subtest: display-4x
[405.788115] Subtest display-4x: SKIP (0.000s)
[405.859235] [068/133] (624s left) prime_mmap (test_refcounting)
[405.918548] Starting subtest: test_refcounting
[405.920468] Starting dynamic subtest: test_refcounting-smem
[405.948955] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[405.951423] Subtest test_refcounting: SUCCESS (0.034s)
[406.062840] [069/133] (624s left) kms_dp_aux_dev (basic)
[406.120497] Starting subtest: basic
[406.341590] Subtest basic: SUCCESS (0.221s)
[406.418223] [070/133] (623s left) syncobj_wait (invalid-reset-one-illegal-handle)
[406.484213] Starting subtest: invalid-reset-one-illegal-handle
[406.486702] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[406.563927] [071/133] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[406.667106] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[406.671041] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[406.769969] [072/133] (623s left) gem_exec_reloc (basic-cpu)
[406.832024] Subtest basic-cpu: SKIP (0.000s)
[406.911167] [073/133] (623s left) gem_exec_balancer (sliced)
[406.973814] Starting subtest: sliced
[406.978261] Subtest sliced: SKIP (0.000s)
[407.281982] [074/133] (623s left) kms_plane_scaling (2x-scaler-multi-pipe)
[407.389998] Starting subtest: 2x-scaler-multi-pipe
[407.394422] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[407.500246] [075/133] (623s left) gem_ctx_persistence (engines-hang)
[407.555999] Starting subtest: engines-hang
[407.558166] Starting dynamic subtest: rcs0
[407.670753] Dynamic subtest rcs0: SUCCESS (0.117s)
[407.684787] Starting dynamic subtest: bcs0
[407.766611] Dynamic subtest bcs0: SUCCESS (0.094s)
[407.781062] Starting dynamic subtest: vcs0
[407.859779] Dynamic subtest vcs0: SUCCESS (0.091s)
[407.872606] Starting dynamic subtest: vcs1
[407.954324] Dynamic subtest vcs1: SUCCESS (0.093s)
[407.965305] Starting dynamic subtest: vecs0
[408.046686] Dynamic subtest vecs0: SUCCESS (0.090s)
[408.059825] Starting dynamic subtest: ccs0
[408.148549] Dynamic subtest ccs0: SUCCESS (0.100s)
[408.150668] Subtest engines-hang: SUCCESS (0.597s)
[408.242773] [076/133] (622s left) core_setmaster (master-drop-set-root)
[408.309705] Starting subtest: master-drop-set-root
[408.333944] Subtest master-drop-set-root: SUCCESS (0.024s)
[408.385543] [077/133] (622s left) gem_exec_flush (basic-uc-pro-default)
[408.441758] Starting subtest: basic-uc-pro-default
[413.905336] Subtest basic-uc-pro-default: SUCCESS (5.464s)
[414.095402] [078/133] (616s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[414.197660] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[414.202026] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[414.288473] [079/133] (616s left) gem_userptr_blits (forbidden-operations)
[414.351679] Starting subtest: forbidden-operations
[414.356058] Subtest forbidden-operations: SKIP (0.000s)
[414.468215] [080/133] (616s left) core_getclient (basic)
[414.520323] Starting subtest: basic
[414.522277] Subtest basic: SUCCESS (0.000s)
[414.630237] [081/133] (616s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[414.720894] Starting subtest: fbc-pr-sprite-mmap-gtt
[414.725308] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[414.817502] [082/133] (616s left) kms_flip (2x-plain-flip-fb-recreate)
[414.905533] Starting subtest: 2x-plain-flip-fb-recreate
[414.914000] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[414.996450] [083/133] (615s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[415.090934] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[415.094628] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[416.217638] [084/133] (614s left) syncobj_timeline (wait-all-delayed-signal)
[416.271529] Starting subtest: wait-all-delayed-signal
[416.373100] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[416.454817] [085/133] (614s left) gem_render_copy (linear-to-vebox-yf-tiled)
[416.519085] Starting subtest: linear-to-vebox-yf-tiled
[416.523305] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[416.704737] [086/133] (614s left) kms_cursor_crc (cursor-tearing-position-change)
[416.823672] Starting subtest: cursor-tearing-position-change
[416.825844] Starting dynamic subtest: pipe-A-eDP-1
[417.410733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.586s)
[417.427809] Starting dynamic subtest: pipe-D-eDP-1
[418.641894] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[418.644218] Subtest cursor-tearing-position-change: SUCCESS (1.819s)
[419.472226] [087/133] (611s left) syncobj_timeline (wait-for-submit-delayed-submit)
[419.534433] Starting subtest: wait-for-submit-delayed-submit
[419.638483] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[419.744377] [088/133] (611s left) gem_exec_params (invalid-ring)
[419.802017] Starting subtest: invalid-ring
[419.804228] Subtest invalid-ring: SUCCESS (0.000s)
[419.900157] [089/133] (611s left) gem_tiled_blits (interruptible)
[419.956127] Subtest interruptible: SKIP (0.000s)
[420.029667] [090/133] (611s left) gem_eio (banned)
[420.247631] Starting subtest: banned
[420.878237] Subtest banned: SUCCESS (0.632s)
[421.050734] [091/133] (610s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[421.151424] Starting subtest: plane-primary-overlay-mutable-zpos
[424.594436] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.441s)
[425.803905] [092/133] (605s left) kms_psr (fbc-pr-dpms)
[425.900169] Starting subtest: fbc-pr-dpms
[425.904763] Subtest fbc-pr-dpms: SKIP (0.000s)
[425.974536] [093/133] (605s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[426.070858] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[426.074844] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[426.139701] [094/133] (605s left) kms_plane_alpha_blend (alpha-transparent-fb)
[426.237918] Starting subtest: alpha-transparent-fb
[426.540076] Starting dynamic subtest: pipe-A-eDP-1
[427.139881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[427.151832] Starting dynamic subtest: pipe-D-eDP-1
[428.570799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.428s)
[428.573336] Subtest alpha-transparent-fb: SUCCESS (2.334s)
[429.462326] [095/133] (601s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[429.553343] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[429.555696] Starting dynamic subtest: pipe-A
[430.600716] Dynamic subtest pipe-A: SUCCESS (1.050s)
[430.612082] Starting dynamic subtest: pipe-B
[432.753709] Dynamic subtest pipe-B: SUCCESS (2.151s)
[432.771648] Starting dynamic subtest: pipe-C
[433.953127] Dynamic subtest pipe-C: SUCCESS (1.197s)
[433.964791] Starting dynamic subtest: pipe-D
[435.181135] Dynamic subtest pipe-D: SUCCESS (1.227s)
[435.183385] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.632s)
[436.373927] [096/133] (595s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[436.469154] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[436.471450] Starting dynamic subtest: pipe-A-eDP-1
[436.725685] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.227s)
[436.737209] Starting dynamic subtest: pipe-B-eDP-1
[437.990699] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[438.003810] Starting dynamic subtest: pipe-C-eDP-1
[439.264361] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.273s)
[439.277238] Starting dynamic subtest: pipe-D-eDP-1
[440.503218] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.238s)
[440.505139] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.005s)
[441.631721] [097/133] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[441.747148] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[441.751509] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[441.841558] [098/133] (589s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[441.948138] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[441.952526] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[442.035493] [099/133] (589s left) kms_flip (blocking-absolute-wf_vblank)
[442.134103] Starting subtest: blocking-absolute-wf_vblank
[442.136434] Starting dynamic subtest: A-eDP1
[450.883141] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[450.896381] Starting dynamic subtest: B-eDP1
[459.613304] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[459.634274] Starting dynamic subtest: C-eDP1
[468.334291] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[468.354960] Starting dynamic subtest: D-eDP1
[477.069798] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[477.074894] Subtest blocking-absolute-wf_vblank: SUCCESS (34.944s)
[478.304182] [100/133] (553s left) tools_test (sysfs_l3_parity)
[478.380159] Starting subtest: sysfs_l3_parity
[478.451061] Subtest sysfs_l3_parity: SKIP (0.084s)
[478.507951] [101/133] (553s left) kms_psr (psr-sprite-plane-onoff)
[478.597995] Starting subtest: psr-sprite-plane-onoff
[478.600266] Starting dynamic subtest: eDP-1
[480.326793] Dynamic subtest eDP-1: SUCCESS (1.729s)
[480.329371] Subtest psr-sprite-plane-onoff: SUCCESS (1.730s)
[481.154428] [102/133] (550s left) api_intel_allocator (default-alignment)
[481.214856] Starting subtest: default-alignment
[481.217286] Subtest default-alignment: SUCCESS (0.003s)
[481.329508] [103/133] (550s left) sriov_basic (bind-unbind-vf)
[481.383797] Starting subtest: bind-unbind-vf
[481.386109] Starting dynamic subtest: vf-1
[481.465086] Dynamic subtest vf-1: FAIL (0.029s)
[481.477184] Starting dynamic subtest: vf-2
[481.547254] Dynamic subtest vf-2: FAIL (0.004s)
[481.559082] Starting dynamic subtest: vf-3
[481.631662] Dynamic subtest vf-3: FAIL (0.004s)
[481.644372] Starting dynamic subtest: vf-4
[481.715974] Dynamic subtest vf-4: FAIL (0.004s)
[481.727687] Starting dynamic subtest: vf-5
[481.798634] Dynamic subtest vf-5: FAIL (0.004s)
[481.810395] Starting dynamic subtest: vf-6
[481.883080] Dynamic subtest vf-6: FAIL (0.004s)
[481.894581] Starting dynamic subtest: vf-7
[481.965466] Dynamic subtest vf-7: FAIL (0.004s)
[481.975810] Starting dynamic subtest: vf-random
[482.045166] Dynamic subtest vf-random: FAIL (0.004s)
[482.056279] Starting dynamic subtest: vf-last
[482.118090] Dynamic subtest vf-last: FAIL (0.004s)
[482.119866] Subtest bind-unbind-vf: FAIL (0.579s)
[482.157341] [104/133] (549s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[482.213912] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[482.324561] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[482.403694] [105/133] (549s left) perf_pmu (rc6)
[482.451898] Starting subtest: rc6
[482.454120] Starting dynamic subtest: gt0
[488.820537] Dynamic subtest gt0: SUCCESS (6.368s)
[488.835657] Starting dynamic subtest: runtime-pm-gt0
[496.541887] Dynamic subtest runtime-pm-gt0: SUCCESS (7.717s)
[496.555322] Starting dynamic subtest: runtime-pm-long-gt0
[509.032441] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.489s)
[509.049973] Starting dynamic subtest: other-idle-gt0
[515.378562] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[515.392730] Starting dynamic subtest: gt1
[521.721828] Dynamic subtest gt1: SUCCESS (6.340s)
[521.735643] Starting dynamic subtest: runtime-pm-gt1
[529.205557] Dynamic subtest runtime-pm-gt1: SUCCESS (7.480s)
[529.219203] Starting dynamic subtest: runtime-pm-long-gt1
[541.645725] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.438s)
[541.659732] Starting dynamic subtest: other-idle-gt1
[547.989538] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[547.992649] Subtest rc6: SUCCESS (65.538s)
[549.129393] [106/133] (482s left) gem_exec_fence (syncobj-timeline-repeat)
[549.730628] Starting subtest: syncobj-timeline-repeat
[549.975699] Subtest syncobj-timeline-repeat: SUCCESS (0.245s)
[551.005891] [107/133] (480s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[551.114495] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[555.998053] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.886s)
[557.104515] [108/133] (474s left) kms_color (legacy-gamma-reset)
[557.224233] Starting subtest: legacy-gamma-reset
[557.226120] Starting dynamic subtest: pipe-A-eDP-1
[557.612551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s)
[557.623695] Starting dynamic subtest: pipe-B-eDP-1
[557.626205] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[557.638676] Starting dynamic subtest: pipe-C-eDP-1
[557.640827] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[557.651669] Starting dynamic subtest: pipe-D-eDP-1
[557.653847] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[557.656126] Subtest legacy-gamma-reset: SUCCESS (0.430s)
[558.444621] [109/133] (473s left) gem_exec_balancer (indices)
[558.507142] Starting subtest: indices
[560.821220] Subtest indices: SUCCESS (2.312s)
[561.115485] [110/133] (470s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[561.180214] Starting subtest: yf-tiled-to-vebox-yf-tiled
[561.184689] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[561.342882] [111/133] (470s left) gem_barrier_race (remote-request)
[561.413414] Starting subtest: remote-request
[561.415740] Starting dynamic subtest: rcs0
[566.572172] Dynamic subtest rcs0: SUCCESS (5.157s)
[566.579256] Subtest remote-request: SUCCESS (5.159s)
[566.693160] [112/133] (465s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[566.750737] Starting subtest: etime-multi-wait-for-submit-submitted
[566.860334] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[566.913822] [113/133] (465s left) syncobj_timeline (multi-wait-signaled)
[566.980350] Starting subtest: multi-wait-signaled
[566.982753] Subtest multi-wait-signaled: SUCCESS (0.001s)
[567.056371] [114/133] (465s left) kms_chamelium_hpd (vga-hpd-fast)
[567.439520] Subtest vga-hpd-fast: SKIP (0.000s)
[568.266312] [115/133] (464s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[568.359205] Starting subtest: fbc-modesetfrombusy
[572.169911] Subtest fbc-modesetfrombusy: SUCCESS (3.814s)
[573.322673] [116/133] (459s left) kms_psr (psr-cursor-plane-onoff)
[573.420250] Starting subtest: psr-cursor-plane-onoff
[573.422540] Starting dynamic subtest: eDP-1
[575.130853] Dynamic subtest eDP-1: SUCCESS (1.710s)
[575.133066] Subtest psr-cursor-plane-onoff: SUCCESS (1.711s)
[575.976171] [117/133] (456s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[576.078081] Starting subtest: y-tiled-32bpp-rotate-90
[576.082563] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[576.170974] [118/133] (456s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[576.263292] Starting subtest: psr-rgb565-draw-mmap-gtt
[576.267704] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[576.336725] [119/133] (456s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[576.435242] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[576.439370] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[576.499661] [120/133] (456s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[576.597884] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[576.600145] Starting dynamic subtest: pipe-A-eDP-1
[576.619617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[576.631937] Starting dynamic subtest: pipe-B-eDP-1
[576.650510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[576.663486] Starting dynamic subtest: pipe-C-eDP-1
[576.682338] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[576.692633] Starting dynamic subtest: pipe-D-eDP-1
[576.711836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[576.713763] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[578.835228] [121/133] (453s left) kms_plane_multiple (2x-tiling-none)
[578.927259] Starting subtest: 2x-tiling-none
[578.931196] Subtest 2x-tiling-none: SKIP (0.000s)
[578.978895] [122/133] (453s left) syncobj_wait (wait-any-interrupted)
[579.025602] Starting subtest: wait-any-interrupted
[579.129234] Subtest wait-any-interrupted: SUCCESS (0.101s)
[579.186722] [123/133] (453s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[579.282343] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[579.286721] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[579.346963] [124/133] (453s left) i915_hangman (engine-error-state-capture)
[579.411721] Starting subtest: engine-error-state-capture
[579.414140] Starting dynamic subtest: rcs0
[582.838078] Dynamic subtest rcs0: SUCCESS (3.425s)
[582.854253] Starting dynamic subtest: bcs0
[588.854779] Dynamic subtest bcs0: SUCCESS (6.014s)
[588.870659] Starting dynamic subtest: vcs0
[594.805985] Dynamic subtest vcs0: SUCCESS (5.949s)
[594.819066] Starting dynamic subtest: vcs1
[599.862898] Dynamic subtest vcs1: SUCCESS (5.053s)
[599.876788] Starting dynamic subtest: vecs0
[605.814078] Dynamic subtest vecs0: SUCCESS (5.948s)
[605.828582] Starting dynamic subtest: ccs0
[610.870511] Dynamic subtest ccs0: SUCCESS (5.053s)
[610.873575] Subtest engine-error-state-capture: SUCCESS (31.457s)
[610.930261] [125/133] (421s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[611.035359] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[611.039535] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[611.113845] [126/133] (421s left) i915_drm_fdinfo (virtual-busy)
[611.162403] Starting subtest: virtual-busy
[611.166653] Subtest virtual-busy: SKIP (0.000s)
[611.212539] [127/133] (421s left) gem_ctx_param (invalid-param-set)
[611.269134] Starting subtest: invalid-param-set
[611.271479] Subtest invalid-param-set: SUCCESS (0.000s)
[611.327481] [128/133] (421s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[611.436393] Starting subtest: short-flip-after-cursor-atomic-transitions
[612.395811] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[613.174851] [129/133] (419s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[613.231470] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[613.339755] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[613.394960] [130/133] (419s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[613.494268] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[613.496484] Starting dynamic subtest: pipe-A-eDP-1
[613.579426] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[613.591133] Starting dynamic subtest: pipe-B-eDP-1
[614.768524] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s)
[614.773253] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.279s)
[615.948585] [131/133] (417s left) i915_query (query-regions-sanity-check)
[616.014266] Starting subtest: query-regions-sanity-check
[616.025229] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[616.117510] [132/133] (416s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[616.217319] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[622.729971] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.516s)
[622.833395] [133/133] (410s left) gem_mmap_gtt (ptrace)
[622.889593] Subtest ptrace: SKIP (0.000s)
[622.952745] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_async
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_chamelium_frames
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: kms_busy
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_legacy_colorkey
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_lmem_swapping
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: gem_ctx_persistence
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_partial_pwrite_pread
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_getfb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: gem_exec_store
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_pm_rpm
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: kms_invalid_mode
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_close_race
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_feature_discovery
results: parsing output: 67/ for test: prime_mmap
results: parsing output: 68/ for test: kms_dp_aux_dev
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: gem_exec_balancer
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: core_setmaster
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_userptr_blits
results: parsing output: 79/ for test: core_getclient
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_tiled_blits
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: tools_test
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: api_intel_allocator
results: parsing output: 102/ for test: sriov_basic
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_color
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: gem_barrier_race
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_chamelium_hpd
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_multiple
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: gem_ctx_param
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: i915_query
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
Done.