[62.707721] Initializing watchdogs
[62.707772]   /dev/watchdog0
[62.723312] [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]
[62.727827] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.730209] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.733530] [001/133] (960s left) gen9_exec_parse (cmd-crossing-page)
[62.819942] Subtest cmd-crossing-page: SKIP (0.000s)
[62.879371] [002/133] (960s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[62.999106] Starting subtest: basic-flip-after-cursor-atomic
[63.976225] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.977s)
[64.819760] [003/133] (958s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[64.923344] Starting subtest: extended-modeset-hang-newfb-with-reset
[64.925587] Starting dynamic subtest: pipe-A
[79.524857] Dynamic subtest pipe-A: SUCCESS (14.610s)
[79.534404] Starting dynamic subtest: pipe-D
[93.874724] Dynamic subtest pipe-D: SUCCESS (14.346s)
[93.877094] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.959s)
[94.668906] [004/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[94.775713] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[101.710842] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.937s)
[101.837919] [005/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[101.953132] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[108.714035] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.765s)
[108.848515] [006/133] (914s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[108.935389] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[108.963672] Starting dynamic subtest: pipe-A-plane-0
[109.261233] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[109.269541] Starting dynamic subtest: pipe-A-plane-3
[109.494981] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[110.608054] Starting dynamic subtest: pipe-B-plane-0
[110.899873] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[110.909075] Starting dynamic subtest: pipe-B-plane-3
[111.144025] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[111.454910] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.519s)
[112.307924] [007/133] (911s left) perf_pmu (pmu-read)
[112.346941] Starting subtest: pmu-read
[112.349626] Subtest pmu-read: SUCCESS (0.002s)
[112.457187] [008/133] (911s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[112.523842] Starting subtest: invalid-bsd1-flag-on-vebox
[112.526293] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[112.613229] [009/133] (910s left) gem_mmap_offset (bad-flags)
[112.665498] Starting subtest: bad-flags
[112.667755] Subtest bad-flags: SUCCESS (0.000s)
[112.748407] [010/133] (910s left) syncobj_wait (invalid-signal-illegal-handle)
[112.810966] Starting subtest: invalid-signal-illegal-handle
[112.813411] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[112.892908] [011/133] (910s left) kms_psr (fbc-psr2-primary-render)
[112.994738] Starting subtest: fbc-psr2-primary-render
[112.997133] Starting dynamic subtest: eDP-1
[113.001608] Dynamic subtest eDP-1: SKIP (0.000s)
[113.006192] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[113.074980] [012/133] (910s left) syncobj_wait (wait-any-snapshot)
[113.127044] Starting subtest: wait-any-snapshot
[113.206999] Subtest wait-any-snapshot: SUCCESS (0.081s)
[113.277420] [013/133] (910s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[113.334595] Starting subtest: yf-tiled-ccs-to-x-tiled
[113.338506] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[113.515703] [014/133] (910s left) gem_ctx_exec (basic-nohangcheck)
[113.568244] Starting subtest: basic-nohangcheck
[113.820563] Subtest basic-nohangcheck: SUCCESS (0.253s)
[113.932181] [015/133] (909s left) gem_exec_reloc (basic-write-read)
[113.993079] Subtest basic-write-read: SKIP (0.000s)
[114.064321] [016/133] (909s left) core_debugfs (read-all-entries)
[114.110645] Starting subtest: read-all-entries
[114.193857] Subtest read-all-entries: SUCCESS (0.084s)
[114.257514] [017/133] (909s left) kms_psr (psr-cursor-plane-onoff)
[114.345887] Starting subtest: psr-cursor-plane-onoff
[114.348199] Starting dynamic subtest: eDP-1
[116.084071] Dynamic subtest eDP-1: SUCCESS (1.739s)
[116.086333] Subtest psr-cursor-plane-onoff: SUCCESS (1.739s)
[116.954640] [018/133] (906s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[117.010652] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[117.114059] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[117.198747] [019/133] (906s left) gem_ctx_param (invalid-ctx-get)
[117.258887] Starting subtest: invalid-ctx-get
[117.261570] Subtest invalid-ctx-get: SUCCESS (0.000s)
[117.330527] [020/133] (906s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[117.426104] Starting subtest: random-ccs-data-yf-tiled-ccs
[117.428438] Starting dynamic subtest: pipe-A-eDP-1
[117.453308] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[117.462891] Starting dynamic subtest: pipe-B-eDP-1
[117.486487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[117.494728] Starting dynamic subtest: pipe-C-eDP-1
[117.520100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[117.529616] Starting dynamic subtest: pipe-D-eDP-1
[117.554007] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[117.558073] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[119.623371] [021/133] (904s left) gem_ppgtt (blt-vs-render-ctx0)
[119.686501] Starting subtest: blt-vs-render-ctx0
[152.558037] Subtest blt-vs-render-ctx0: SUCCESS (32.868s)
[152.669701] [022/133] (871s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[152.818053] Starting subtest: fbc-pr-cursor-plane-update-sf
[152.822154] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[152.898016] [023/133] (871s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[152.990043] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[152.994228] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[153.059802] [024/133] (871s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[153.155763] Starting subtest: primary-4-tiled-reflect-x-0
[160.172097] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.018s)
[161.398898] [025/133] (862s left) api_intel_allocator (reserve-simple)
[161.448870] Starting subtest: reserve-simple
[161.451133] Subtest reserve-simple: SUCCESS (0.004s)
[161.589837] [026/133] (862s left) kms_big_fb (linear-32bpp-rotate-0)
[161.683830] Starting subtest: linear-32bpp-rotate-0
[163.266067] Subtest linear-32bpp-rotate-0: SUCCESS (1.582s)
[163.383348] [027/133] (860s left) kms_setmode (invalid-clone-exclusive-crtc)
[163.440609] Starting subtest: invalid-clone-exclusive-crtc
[163.446238] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[163.536809] [028/133] (860s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[163.603258] Starting subtest: yf-tiled-ccs-to-y-tiled
[163.606941] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[163.782697] [029/133] (860s left) gem_exec_params (no-vebox)
[163.840804] Starting subtest: no-vebox
[163.843232] Subtest no-vebox: SUCCESS (0.002s)
[165.989604] [030/133] (858s left) kms_dsc (dsc-with-bpc-formats)
[166.086928] Starting subtest: dsc-with-bpc-formats
[166.200047] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[166.239445] [031/133] (858s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[166.341094] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[166.345038] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[166.424349] [032/133] (858s left) gem_exec_fence (syncobj-signal)
[166.936532] Starting subtest: syncobj-signal
[166.943743] Subtest syncobj-signal: SUCCESS (0.007s)
[169.004542] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[169.010447] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[169.106221] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[169.110274] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[169.214434] [034/133] (855s left) i915_pm_rpm (debugfs-read)
[171.043043] Starting subtest: debugfs-read
[172.202692] Subtest debugfs-read: SUCCESS (1.157s)
[172.587044] [035/133] (852s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[172.692488] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[172.701061] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[172.776951] [036/133] (851s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[172.871571] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[177.188637] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.320s)
[178.407110] [037/133] (846s left) kms_invalid_mode (uint-max-clock)
[178.522850] Starting subtest: uint-max-clock
[178.525252] Starting dynamic subtest: pipe-A-eDP-1
[178.809263] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[178.818679] Starting dynamic subtest: pipe-B-eDP-1
[178.820894] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[178.828699] Starting dynamic subtest: pipe-C-eDP-1
[178.831056] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[178.838949] Starting dynamic subtest: pipe-D-eDP-1
[178.841301] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[178.843632] Subtest uint-max-clock: SUCCESS (0.290s)
[179.623317] [038/133] (845s left) i915_query (query-regions-garbage-items)
[179.676799] Starting subtest: query-regions-garbage-items
[179.678694] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[179.771242] [039/133] (845s left) kms_pm_dc (dc5-dpms)
[180.862192] Starting subtest: dc5-dpms
[182.898705] Subtest dc5-dpms: SUCCESS (2.036s)
[182.987337] [040/133] (841s left) gem_eio (wait-wedge-immediate)
[183.213654] Starting subtest: wait-wedge-immediate
[185.004187] Subtest wait-wedge-immediate: SUCCESS (1.790s)
[185.147995] [041/133] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[185.250428] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[189.765387] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.518s)
[190.984980] [042/133] (833s left) gem_exec_schedule (fifo)
[191.071125] Starting subtest: fifo
[191.073427] Starting dynamic subtest: rcs0
[191.171677] Dynamic subtest rcs0: SUCCESS (0.108s)
[191.183705] Starting dynamic subtest: vcs0
[191.253629] Dynamic subtest vcs0: SUCCESS (0.081s)
[191.264568] Starting dynamic subtest: vcs1
[191.331249] Dynamic subtest vcs1: SUCCESS (0.077s)
[191.342832] Starting dynamic subtest: vecs0
[191.406802] Dynamic subtest vecs0: SUCCESS (0.075s)
[191.420072] Starting dynamic subtest: ccs0
[191.501857] Dynamic subtest ccs0: SUCCESS (0.095s)
[191.504446] Subtest fifo: SUCCESS (0.439s)
[193.004926] [043/133] (831s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[193.391099] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[194.170264] [044/133] (830s left) kms_cursor_legacy (single-bo)
[194.285514] Starting subtest: single-bo
[194.287556] Starting dynamic subtest: pipe-A
[199.667756] Dynamic subtest pipe-A: SUCCESS (5.379s)
[199.678643] Starting dynamic subtest: pipe-B
[205.049951] Dynamic subtest pipe-B: SUCCESS (5.380s)
[205.059557] Starting dynamic subtest: pipe-C
[210.433071] Dynamic subtest pipe-C: SUCCESS (5.381s)
[210.442717] Starting dynamic subtest: pipe-D
[215.816081] Dynamic subtest pipe-D: SUCCESS (5.380s)
[215.824933] Starting dynamic subtest: all-pipes
[221.203399] Dynamic subtest all-pipes: SUCCESS (5.387s)
[221.205574] Subtest single-bo: SUCCESS (26.918s)
[221.360510] [045/133] (803s left) kms_color (gamma)
[221.454053] Starting subtest: gamma
[221.456114] Starting dynamic subtest: pipe-A-eDP-1
[222.175677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[222.184297] Starting dynamic subtest: pipe-B-eDP-1
[223.602525] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[223.613839] Starting dynamic subtest: pipe-C-eDP-1
[224.976153] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[224.985294] Starting dynamic subtest: pipe-D-eDP-1
[226.318702] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[226.321098] Subtest gamma: SUCCESS (4.866s)
[227.121881] [046/133] (797s left) kms_rotation_crc (primary-rotation-180)
[227.223289] Starting subtest: primary-rotation-180
[234.123956] Subtest primary-rotation-180: SUCCESS (6.902s)
[235.288659] [047/133] (789s left) kms_legacy_colorkey (invalid-plane)
[235.381416] Starting subtest: invalid-plane
[235.383682] Starting dynamic subtest: zero-id
[235.385616] Dynamic subtest zero-id: SUCCESS (0.000s)
[235.396996] Starting dynamic subtest: outrange-id
[235.399215] Dynamic subtest outrange-id: SUCCESS (0.000s)
[235.401353] Subtest invalid-plane: SUCCESS (0.001s)
[235.453368] [048/133] (789s left) kms_psr (fbc-psr-sprite-blt)
[235.543055] Starting subtest: fbc-psr-sprite-blt
[235.545363] Starting dynamic subtest: eDP-1
[235.549551] Dynamic subtest eDP-1: SKIP (0.000s)
[235.553716] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[235.616445] [049/133] (789s left) gem_exec_balancer (waits)
[235.673895] Starting subtest: waits
[242.224985] Subtest waits: SUCCESS (6.549s)
[242.535215] [050/133] (782s left) i915_drm_fdinfo (all-busy-check-all)
[242.575542] Starting subtest: all-busy-check-all
[242.580536] Subtest all-busy-check-all: SKIP (0.004s)
[242.661334] [051/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[242.770443] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[249.877423] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.110s)
[249.977333] [052/133] (775s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[250.082570] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[250.087105] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[250.184826] [053/133] (775s left) gem_userptr_blits (nohangcheck)
[250.253483] Starting subtest: nohangcheck
[250.494856] Subtest nohangcheck: SUCCESS (0.239s)
[250.605295] [054/133] (774s left) vgem_basic (bad-pad)
[250.653291] Starting subtest: bad-pad
[250.655362] Subtest bad-pad: SUCCESS (0.000s)
[250.710236] [055/133] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[250.815711] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[250.819797] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[250.921749] [056/133] (774s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[251.037566] Starting subtest: cursorB-vs-flipB-toggle
[251.042066] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[251.194080] [057/133] (774s left) sw_sync (sync_random_merge)
[251.235163] Starting subtest: sync_random_merge
[251.278733] Subtest sync_random_merge: SUCCESS (0.045s)
[251.353564] [058/133] (774s left) kms_cursor_crc (cursor-onscreen-max-size)
[251.666333] Starting subtest: cursor-onscreen-max-size
[251.672037] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[251.787219] [059/133] (773s left) gem_exec_params (secure-non-master)
[251.853725] Starting subtest: secure-non-master
[251.858120] Subtest secure-non-master: SKIP (0.000s)
[251.963499] [060/133] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[252.050798] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[275.010382] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.962s)
[275.145526] [061/133] (750s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[275.252552] Starting subtest: x-tiled-32bpp-rotate-180
[276.733989] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.480s)
[276.867209] [062/133] (748s left) dmabuf_sync_file (export-multiwait)
[276.920245] Starting subtest: export-multiwait
[276.922059] Subtest export-multiwait: SUCCESS (0.001s)
[276.991194] [063/133] (748s left) gem_eio (execbuf)
[277.231846] Starting subtest: execbuf
[277.578584] Subtest execbuf: SUCCESS (0.348s)
[277.690378] [064/133] (748s left) perf (global-sseu-config-invalid)
[277.840105] Starting subtest: global-sseu-config-invalid
[277.843489] Subtest global-sseu-config-invalid: SKIP (0.000s)
[277.881111] [065/133] (748s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[277.978656] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[277.982240] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[279.083422] [066/133] (746s left) gem_lmem_swapping (parallel-random-engines)
[279.132235] Subtest parallel-random-engines: SKIP (0.000s)
[279.182189] [067/133] (746s left) kms_atomic_interruptible (legacy-cursor)
[279.280969] Starting subtest: legacy-cursor
[279.283147] Starting dynamic subtest: pipe-A-eDP-1
[286.701091] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.417s)
[286.703044] Subtest legacy-cursor: SUCCESS (7.418s)
[287.540270] [068/133] (738s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[287.587841] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[287.590067] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[287.690668] [069/133] (738s left) gem_mmap_wc (bad-object)
[287.741110] Subtest bad-object: SKIP (0.000s)
[287.799539] [070/133] (738s left) gem_lmem_swapping (verify-random)
[287.842889] Subtest verify-random: SKIP (0.000s)
[287.887054] [071/133] (738s left) kms_frontbuffer_tracking (psr-1p-rte)
[287.977060] Starting subtest: psr-1p-rte
[293.371797] Subtest psr-1p-rte: SUCCESS (5.398s)
[293.532027] [072/133] (732s left) gem_exec_balancer (bonded-chain)
[293.599784] Starting subtest: bonded-chain
[300.617078] Subtest bonded-chain: SUCCESS (7.017s)
[300.932979] [073/133] (725s left) perf (missing-sample-flags)
[301.033345] Starting subtest: missing-sample-flags
[301.039473] Subtest missing-sample-flags: SUCCESS (0.000s)
[301.079889] [074/133] (725s left) gem_ctx_shared (exec-shared-gtt)
[301.140615] Starting subtest: exec-shared-gtt
[301.142941] Starting dynamic subtest: rcs0
[301.157465] Dynamic subtest rcs0: SUCCESS (0.016s)
[301.165904] Starting dynamic subtest: bcs0
[301.168430] Dynamic subtest bcs0: SUCCESS (0.007s)
[301.176831] Starting dynamic subtest: vcs0
[301.179054] Dynamic subtest vcs0: SUCCESS (0.010s)
[301.186994] Starting dynamic subtest: vcs1
[301.189232] Dynamic subtest vcs1: SUCCESS (0.010s)
[301.197552] Starting dynamic subtest: vecs0
[301.199686] Dynamic subtest vecs0: SUCCESS (0.010s)
[301.207255] Starting dynamic subtest: ccs0
[301.211904] Dynamic subtest ccs0: SUCCESS (0.011s)
[301.213956] Subtest exec-shared-gtt: SUCCESS (0.070s)
[301.400427] [075/133] (724s left) kms_cursor_crc (cursor-random-128x128)
[301.597737] Starting subtest: cursor-random-128x128
[301.599946] Starting dynamic subtest: pipe-A-eDP-1
[304.961616] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.362s)
[304.996321] Starting dynamic subtest: pipe-D-eDP-1
[309.022180] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.037s)
[309.024297] Subtest cursor-random-128x128: SUCCESS (7.425s)
[309.878067] [076/133] (716s left) kms_atomic (plane-invalid-params-fence)
[309.973968] Starting subtest: plane-invalid-params-fence
[309.976202] Starting dynamic subtest: pipe-A-eDP-1
[310.340895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.366s)
[310.343070] Subtest plane-invalid-params-fence: SUCCESS (0.367s)
[311.207195] [077/133] (715s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[311.306773] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[311.311207] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[311.398886] [078/133] (715s left) kms_pm_rpm (system-suspend-modeset)
[313.121568] Starting subtest: system-suspend-modeset
[333.294442] Subtest system-suspend-modeset: SUCCESS (5.098s)
[342.684695] [079/133] (692s left) gem_exec_schedule (u-submit-golden-slice)
[342.779791] Starting subtest: u-submit-golden-slice
[342.782253] Starting dynamic subtest: rcs0
[342.828641] Dynamic subtest rcs0: SUCCESS (0.054s)
[342.840153] Starting dynamic subtest: bcs0
[342.871928] Dynamic subtest bcs0: SUCCESS (0.043s)
[342.881668] Starting dynamic subtest: vcs0
[342.924260] Dynamic subtest vcs0: SUCCESS (0.051s)
[342.933713] Starting dynamic subtest: vcs1
[342.976892] Dynamic subtest vcs1: SUCCESS (0.052s)
[342.987242] Starting dynamic subtest: vecs0
[343.020896] Dynamic subtest vecs0: SUCCESS (0.044s)
[343.030972] Starting dynamic subtest: ccs0
[343.076542] Dynamic subtest ccs0: SUCCESS (0.055s)
[343.079025] Subtest u-submit-golden-slice: SUCCESS (0.306s)
[344.093731] [080/133] (691s left) sriov_basic (enable-vfs-autoprobe-on)
[344.150093] Starting subtest: enable-vfs-autoprobe-on
[344.152505] Starting dynamic subtest: numvfs-1
[344.231885] Dynamic subtest numvfs-1: FAIL (0.029s)
[344.242028] Starting dynamic subtest: numvfs-2
[344.312429] Dynamic subtest numvfs-2: FAIL (0.004s)
[344.323441] Starting dynamic subtest: numvfs-3
[344.394142] Dynamic subtest numvfs-3: FAIL (0.004s)
[344.405716] Starting dynamic subtest: numvfs-4
[344.476361] Dynamic subtest numvfs-4: FAIL (0.004s)
[344.486776] Starting dynamic subtest: numvfs-5
[344.558738] Dynamic subtest numvfs-5: FAIL (0.004s)
[344.569237] Starting dynamic subtest: numvfs-6
[344.640690] Dynamic subtest numvfs-6: FAIL (0.004s)
[344.651068] Starting dynamic subtest: numvfs-7
[344.723024] Dynamic subtest numvfs-7: FAIL (0.004s)
[344.734033] Starting dynamic subtest: numvfs-random
[344.804213] Dynamic subtest numvfs-random: FAIL (0.004s)
[344.814998] Starting dynamic subtest: numvfs-all
[344.887213] Dynamic subtest numvfs-all: FAIL (0.510s)
[344.889203] Subtest enable-vfs-autoprobe-on: FAIL (0.572s)
[344.928421] [081/133] (690s left) gem_partial_pwrite_pread (write-display)
[344.984610] Subtest write-display: SKIP (0.000s)
[345.051364] [082/133] (690s left) gem_exec_schedule (preempt-engines)
[345.112460] Starting subtest: preempt-engines
[345.114102] Starting dynamic subtest: rcs0
[347.447399] Dynamic subtest rcs0: SUCCESS (2.361s)
[347.459145] Starting dynamic subtest: bcs0
[349.764157] Dynamic subtest bcs0: SUCCESS (2.334s)
[349.775109] Starting dynamic subtest: vcs0
[352.040986] Dynamic subtest vcs0: SUCCESS (2.289s)
[352.050765] Starting dynamic subtest: vcs1
[354.319121] Dynamic subtest vcs1: SUCCESS (2.286s)
[354.328448] Starting dynamic subtest: vecs0
[356.588788] Dynamic subtest vecs0: SUCCESS (2.276s)
[356.598713] Starting dynamic subtest: ccs0
[358.903457] Dynamic subtest ccs0: SUCCESS (2.319s)
[358.905858] Subtest preempt-engines: SUCCESS (13.877s)
[359.205304] [083/133] (676s left) i915_getparams_basic (basic-subslice-total)
[359.265045] Starting subtest: basic-subslice-total
[359.269528] Subtest basic-subslice-total: SUCCESS (0.000s)
[359.358600] [084/133] (676s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[359.416224] Starting subtest: etime-multi-wait-all-available-unsubmitted
[359.520617] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[359.600425] [085/133] (676s left) gem_exec_reloc (basic-write-gtt)
[359.664447] Subtest basic-write-gtt: SKIP (0.000s)
[359.739442] [086/133] (676s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[359.837927] Starting subtest: plane-upscale-20x20-with-pixel-format
[359.840248] Starting dynamic subtest: pipe-A
[360.882999] Dynamic subtest pipe-A: SUCCESS (1.050s)
[360.891969] Starting dynamic subtest: pipe-B
[363.035464] Dynamic subtest pipe-B: SUCCESS (2.155s)
[363.045624] Starting dynamic subtest: pipe-C
[364.233834] Dynamic subtest pipe-C: SUCCESS (1.198s)
[364.243979] Starting dynamic subtest: pipe-D
[365.390775] Dynamic subtest pipe-D: SUCCESS (1.155s)
[365.393071] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.565s)
[366.603147] [087/133] (669s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[366.709686] Starting subtest: psr-shrfb-scaledprimary
[372.487973] Subtest psr-shrfb-scaledprimary: SUCCESS (5.784s)
[372.607567] [088/133] (663s left) kms_selftest (drm_cmdline_parser)
[372.651701] Starting subtest: drm_cmdline_parser
[372.692621] Starting dynamic subtest: drm_test_cmdline_force_d_only
[372.789254] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.098s)
[372.800039] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[372.872358] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.081s)
[372.883070] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[372.965025] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.092s)
[372.976113] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[373.065138] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.101s)
[373.076047] Starting dynamic subtest: drm_test_cmdline_force_e_only
[373.148252] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.080s)
[373.158546] Starting dynamic subtest: drm_test_cmdline_res
[373.237867] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.090s)
[373.248398] Starting dynamic subtest: drm_test_cmdline_res_vesa
[373.338027] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.099s)
[373.347835] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[373.428538] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.091s)
[373.437264] Starting dynamic subtest: drm_test_cmdline_res_rblank
[373.516479] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.086s)
[373.526279] Starting dynamic subtest: drm_test_cmdline_res_bpp
[373.595459] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.079s)
[373.605947] Starting dynamic subtest: drm_test_cmdline_res_refresh
[373.707528] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.111s)
[373.717141] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[373.799466] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.092s)
[373.808155] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[373.899305] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.099s)
[373.909579] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[373.992382] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.092s)
[374.002539] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[374.071256] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.078s)
[374.081356] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[374.163554] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.092s)
[374.173740] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[374.242972] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.079s)
[374.253499] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[374.326421] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.082s)
[374.336007] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[374.411386] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.084s)
[374.421367] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[374.488808] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.077s)
[374.497679] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[374.580459] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.090s)
[374.590597] Starting dynamic subtest: drm_test_cmdline_name
[374.668334] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.088s)
[374.678120] Starting dynamic subtest: drm_test_cmdline_name_bpp
[374.750186] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.082s)
[374.760442] Starting dynamic subtest: drm_test_cmdline_name_option
[374.834566] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.082s)
[374.844548] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[374.914869] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.080s)
[374.924693] Starting dynamic subtest: drm_test_cmdline_rotate_0
[375.008570] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.092s)
[375.019002] Starting dynamic subtest: drm_test_cmdline_rotate_90
[375.108421] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.098s)
[375.118568] Starting dynamic subtest: drm_test_cmdline_rotate_180
[375.182287] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.073s)
[375.192290] Starting dynamic subtest: drm_test_cmdline_rotate_270
[375.267739] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.084s)
[375.277924] Starting dynamic subtest: drm_test_cmdline_hmirror
[375.357947] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.090s)
[375.367859] Starting dynamic subtest: drm_test_cmdline_vmirror
[375.450485] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.093s)
[375.459366] Starting dynamic subtest: drm_test_cmdline_margin_options
[375.542342] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.091s)
[375.551090] Starting dynamic subtest: drm_test_cmdline_multiple_options
[375.645431] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.101s)
[375.659203] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[375.751680] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.105s)
[375.762221] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[375.844816] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.093s)
[375.853792] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[375.933062] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.085s)
[375.943160] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[376.022597] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.089s)
[376.035211] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[376.117146] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s)
[376.125769] Starting dynamic subtest: drm_test_cmdline_invalid
[376.205024] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.089s)
[376.213681] Starting dynamic subtest: drm_test_cmdline_tv_options
[376.292632] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.086s)
[376.294680] Subtest drm_cmdline_parser: SUCCESS (3.646s)
[376.436138] [089/133] (659s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[376.540617] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[376.542704] Starting dynamic subtest: pipe-A-eDP-1
[382.403007] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.868s)
[382.413363] Starting dynamic subtest: pipe-B-eDP-1
[389.057385] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.654s)
[389.059677] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.525s)
[389.920489] [090/133] (646s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[390.032595] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[390.034739] Starting dynamic subtest: pipe-A-default-mode
[392.776552] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s)
[392.778592] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.748s)
[393.632578] [091/133] (642s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[393.740769] Starting subtest: cursor-tearing-framebuffer-change
[393.743095] Starting dynamic subtest: pipe-A-eDP-1
[394.306865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[394.318030] Starting dynamic subtest: pipe-D-eDP-1
[395.563229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s)
[395.565057] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.820s)
[396.395019] [092/133] (639s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[396.513553] Starting subtest: flip-vs-cursor-toggle
[405.134623] Subtest flip-vs-cursor-toggle: SUCCESS (8.625s)
[406.016364] [093/133] (630s left) kms_chamelium_edid (vga-edid-read)
[406.407278] Subtest vga-edid-read: SKIP (0.000s)
[407.237390] [094/133] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[407.348746] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[407.353144] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[407.441478] [095/133] (628s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[407.525327] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[407.527647] Starting dynamic subtest: pipe-A
[408.672512] Dynamic subtest pipe-A: SUCCESS (1.150s)
[408.683790] Starting dynamic subtest: pipe-B
[410.894128] Dynamic subtest pipe-B: SUCCESS (2.221s)
[410.902667] Starting dynamic subtest: pipe-C
[412.053601] Dynamic subtest pipe-C: SUCCESS (1.159s)
[412.063521] Starting dynamic subtest: pipe-D
[413.288393] Dynamic subtest pipe-D: SUCCESS (1.235s)
[413.290715] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.769s)
[414.463028] [096/133] (621s left) kms_plane_multiple (2x-tiling-x)
[414.558294] Starting subtest: 2x-tiling-x
[414.562567] Subtest 2x-tiling-x: SKIP (0.000s)
[414.631701] [097/133] (621s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[414.678650] Starting subtest: single-wait-for-submit-available-signaled
[414.680764] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[414.764824] [098/133] (621s left) kms_plane_alpha_blend (constant-alpha-mid)
[414.856206] Starting subtest: constant-alpha-mid
[415.143886] Starting dynamic subtest: pipe-A-eDP-1
[416.109573] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.967s)
[416.119462] Starting dynamic subtest: pipe-D-eDP-1
[417.712658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.602s)
[417.714489] Subtest constant-alpha-mid: SUCCESS (2.860s)
[418.522655] [099/133] (617s left) gem_ctx_engines (invalid-engines)
[418.587111] Starting subtest: invalid-engines
[418.593246] Subtest invalid-engines: SUCCESS (0.009s)
[418.817800] [100/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[418.916626] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[418.920999] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[419.015287] [101/133] (617s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[419.127858] Starting subtest: 4-tiled-64bpp-rotate-0
[420.783773] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.657s)
[420.966869] [102/133] (615s left) intel_hwmon (hwmon-write)
[421.032073] Subtest hwmon-write: SKIP (0.000s)
[421.088825] [103/133] (615s left) kms_hdr (invalid-hdr)
[421.175285] Starting subtest: invalid-hdr
[423.325036] Starting dynamic subtest: pipe-A-eDP-1
[426.310675] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.988s)
[426.312931] Subtest invalid-hdr: SUCCESS (5.141s)
[426.452054] [104/133] (610s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[426.563629] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[426.567865] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[426.632822] [105/133] (609s left) gem_userptr_blits (process-exit)
[426.690207] Starting subtest: process-exit
[426.696486] Subtest process-exit: SUCCESS (0.008s)
[426.814065] [106/133] (609s left) gem_exec_params (invalid-fence-in)
[426.863332] Starting subtest: invalid-fence-in
[426.865573] Subtest invalid-fence-in: SUCCESS (0.000s)
[426.963278] [107/133] (609s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[427.072582] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[427.078582] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[427.216385] [108/133] (609s left) gem_spin_batch (legacy-resubmit)
[427.272119] Starting subtest: legacy-resubmit
[427.274556] Starting dynamic subtest: default
[427.280059] Dynamic subtest default: SUCCESS (0.006s)
[427.290561] Starting dynamic subtest: render
[427.292778] Dynamic subtest render: SUCCESS (0.001s)
[427.301755] Starting dynamic subtest: bsd
[427.303679] Dynamic subtest bsd: SUCCESS (0.002s)
[427.312431] Starting dynamic subtest: bsd1
[427.314016] Dynamic subtest bsd1: SUCCESS (0.003s)
[427.322367] Starting dynamic subtest: bsd2
[427.324017] Dynamic subtest bsd2: SUCCESS (0.002s)
[427.332509] Starting dynamic subtest: blt
[427.334177] Dynamic subtest blt: SUCCESS (0.004s)
[427.342489] Starting dynamic subtest: vebox
[427.344146] Dynamic subtest vebox: SUCCESS (0.004s)
[427.345728] Subtest legacy-resubmit: SUCCESS (0.032s)
[427.535169] [109/133] (609s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[427.626022] Starting subtest: x-tiled-addfb-size-offset-overflow
[427.627932] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[427.725135] [110/133] (609s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[427.814215] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[427.816191] Starting dynamic subtest: pipe-A-eDP-1
[429.795987] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.974s)
[429.806118] Starting dynamic subtest: pipe-B-eDP-1
[431.467562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.665s)
[431.487530] Starting dynamic subtest: pipe-C-eDP-1
[433.025340] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.558s)
[433.034971] Starting dynamic subtest: pipe-D-eDP-1
[434.610047] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.581s)
[434.611999] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.783s)
[435.830403] [111/133] (600s left) gem_ctx_bad_destroy (invalid-ctx)
[435.891770] Starting subtest: invalid-ctx
[435.894122] Subtest invalid-ctx: SUCCESS (0.000s)
[435.965914] [112/133] (600s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[436.085240] Starting subtest: cursor-vs-flip-atomic-transitions
[466.063019] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.970s)
[466.861641] [113/133] (570s left) gem_ctx_persistence (legacy-engines-mixed)
[466.923634] Starting subtest: legacy-engines-mixed
[466.926064] Starting dynamic subtest: render
[467.002640] Dynamic subtest render: SUCCESS (0.078s)
[467.017688] Starting dynamic subtest: bsd1
[467.059614] Dynamic subtest bsd1: SUCCESS (0.054s)
[467.071277] Starting dynamic subtest: bsd2
[467.109529] Dynamic subtest bsd2: SUCCESS (0.047s)
[467.122554] Starting dynamic subtest: blt
[467.160581] Dynamic subtest blt: SUCCESS (0.048s)
[467.174224] Starting dynamic subtest: vebox
[467.207548] Dynamic subtest vebox: SUCCESS (0.044s)
[467.209975] Subtest legacy-engines-mixed: SUCCESS (0.285s)
[467.287792] [114/133] (569s left) gem_exec_flush (basic-batch-kernel-default-uc)
[467.344107] Starting subtest: basic-batch-kernel-default-uc
[474.549248] Subtest basic-batch-kernel-default-uc: SUCCESS (7.207s)
[474.738805] [115/133] (562s left) gem_exec_schedule (u-semaphore-noskip)
[474.804584] Starting subtest: u-semaphore-noskip
[475.239235] Subtest u-semaphore-noskip: SUCCESS (0.443s)
[475.594930] [116/133] (561s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[475.687221] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[475.691100] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[475.802369] [117/133] (561s left) kms_psr (pr-primary-page-flip)
[475.889263] Starting subtest: pr-primary-page-flip
[475.893570] Subtest pr-primary-page-flip: SKIP (0.000s)
[475.961553] [118/133] (561s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[476.047753] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[476.050032] Starting dynamic subtest: pipe-A-eDP-1
[476.520923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[476.530674] Starting dynamic subtest: pipe-B-eDP-1
[478.018941] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.490s)
[478.029943] Starting dynamic subtest: pipe-C-eDP-1
[479.413214] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[479.425626] Starting dynamic subtest: pipe-D-eDP-1
[480.846704] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.433s)
[480.849156] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.772s)
[482.008466] [119/133] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[482.101443] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[482.105506] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[482.188450] [120/133] (555s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[482.285464] Starting subtest: y-tiled-8bpp-rotate-180
[482.289625] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[482.472262] [121/133] (554s left) kms_pwrite_crc
[484.149127] [122/133] (553s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[484.245345] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[484.249790] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[484.315647] [123/133] (553s left) syncobj_timeline (reset-unsignaled)
[484.368303] Starting subtest: reset-unsignaled
[484.371070] Subtest reset-unsignaled: SUCCESS (0.000s)
[484.455210] [124/133] (552s left) gem_ccs (block-copy-uncompressed)
[484.505946] Starting subtest: block-copy-uncompressed
[484.508166] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[484.528580] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[484.538319] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[484.546317] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[484.555289] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[484.563670] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[484.572731] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[484.580573] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s)
[484.582781] Subtest block-copy-uncompressed: SUCCESS (0.075s)
[484.701080] [125/133] (552s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[484.848269] Starting subtest: dp-mst-type-0-suspend-resume
[484.852593] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[484.977241] [126/133] (552s left) gem_exec_params (dr1-dirt)
[485.031579] Starting subtest: DR1-dirt
[485.033695] Subtest DR1-dirt: SUCCESS (0.000s)
[485.127886] [127/133] (552s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[485.232214] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[485.235548] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[485.344823] [128/133] (552s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[485.406590] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[485.471291] [129/133] (552s left) gem_workarounds (reset-fd)
[485.528377] Starting subtest: reset-fd
[485.709432] Subtest reset-fd: SUCCESS (0.180s)
[485.837075] [130/133] (551s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[485.933350] Starting subtest: bad-aux-stride-y-tiled-ccs
[485.935279] Starting dynamic subtest: pipe-A-eDP-1
[485.954251] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[485.965598] Starting dynamic subtest: pipe-B-eDP-1
[485.982857] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[485.991420] Starting dynamic subtest: pipe-C-eDP-1
[486.009831] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.019832] Starting dynamic subtest: pipe-D-eDP-1
[486.037930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.041551] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[488.118198] [131/133] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[488.218772] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[488.223056] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.328911] [132/133] (549s left) kms_vblank (ts-continuation-modeset-hang)
[488.415819] Starting subtest: ts-continuation-modeset-hang
[488.417707] Starting dynamic subtest: pipe-A-eDP-1
[514.815009] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.404s)
[514.830151] Starting dynamic subtest: pipe-D-eDP-1
[539.765519] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[539.767444] Subtest ts-continuation-modeset-hang: SUCCESS (51.363s)
[540.619996] [133/133] (497s left) kms_flip (flip-vs-panning-interruptible)
[540.716746] Starting subtest: flip-vs-panning-interruptible
[540.719252] Starting dynamic subtest: A-eDP1
[549.419076] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[549.437526] Starting dynamic subtest: B-eDP1
[558.148009] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[558.160010] Starting dynamic subtest: C-eDP1
[566.875433] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[566.887330] Starting dynamic subtest: D-eDP1
[575.613509] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[575.617932] Subtest flip-vs-panning-interruptible: SUCCESS (34.888s)
[576.774060] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: gem_exec_params
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_ctx_exec
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: core_debugfs
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_ppgtt
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_rotation_crc
results: parsing output: 24/ for test: api_intel_allocator
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_setmode
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_dsc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rpm
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_invalid_mode
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_pm_dc
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_legacy_colorkey
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_userptr_blits
results: parsing output: 53/ for test: vgem_basic
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: sw_sync
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: dmabuf_sync_file
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_ccs
results: parsing output: 65/ for test: gem_lmem_swapping
results: parsing output: 66/ for test: kms_atomic_interruptible
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: sriov_basic
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: i915_getparams_basic
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane_scaling
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_selftest
results: parsing output: 88/ for test: kms_psr2_sf
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_chamelium_edid
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_plane_alpha_blend
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: intel_hwmon
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_spin_batch
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_ctx_bad_destroy
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_pwrite_crc
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_ccs
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: gem_exec_params
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: gem_workarounds
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: kms_flip
Done.