[57.973802] Initializing watchdogs
[57.973849]   /dev/watchdog0
[57.988171] [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.993148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.995597] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.999251] [001/133] (960s left) gem_reg_read (bad-register)
[58.078297] Starting subtest: bad-register
[58.080274] Subtest bad-register: SUCCESS (0.000s)
[58.177378] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[58.274450] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[58.278573] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[58.360151] [003/133] (960s left) gem_tiled_blits (basic)
[58.435512] Subtest basic: SKIP (0.000s)
[58.496521] [004/133] (960s left) gem_eio (banned)
[58.648949] Starting subtest: banned
[59.011064] Subtest banned: SUCCESS (0.360s)
[59.166812] [005/133] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[59.259134] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[59.262935] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[59.346350] [006/133] (959s left) kms_atomic (plane-primary-legacy)
[59.450092] Starting subtest: plane-primary-legacy
[59.452125] Starting dynamic subtest: pipe-A-eDP-1
[59.934656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[59.937089] Subtest plane-primary-legacy: SUCCESS (0.481s)
[60.791934] [007/133] (957s left) kms_getfb (getfb2-handle-not-fb)
[60.879957] Starting subtest: getfb2-handle-not-fb
[60.882289] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[60.978846] [008/133] (957s left) gen9_exec_parse (unaligned-jump)
[61.046594] Subtest unaligned-jump: SKIP (0.000s)
[61.113956] [009/133] (957s left) i915_getparams_basic (basic-eu-total)
[61.175871] Starting subtest: basic-eu-total
[61.180582] Subtest basic-eu-total: SUCCESS (0.000s)
[61.276667] [010/133] (957s left) api_intel_bb (blit-reloc-purge-cache)
[61.326748] Starting subtest: blit-reloc-purge-cache
[61.331276] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[61.443907] [011/133] (957s left) kms_psr (psr2-primary-mmap-gtt)
[61.539816] Starting subtest: psr2-primary-mmap-gtt
[61.542221] Starting dynamic subtest: eDP-1
[63.007060] Dynamic subtest eDP-1: SKIP (1.455s)
[63.012165] Subtest psr2-primary-mmap-gtt: SKIP (1.456s)
[63.147998] [012/133] (955s left) gem_lmem_swapping (parallel-random)
[63.191209] Subtest parallel-random: SKIP (0.000s)
[63.234687] [013/133] (955s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[63.354648] Starting subtest: 2x-cursor-vs-flip-atomic
[63.359067] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[63.509166] [014/133] (955s left) i915_suspend (basic-s3-without-i915)
[63.544342] Starting subtest: basic-s3-without-i915
[66.938677] Subtest basic-s3-without-i915: SKIP (3.375s)
[68.570322] [015/133] (950s left) syncobj_wait (invalid-reset-illegal-handle)
[68.639890] Starting subtest: invalid-reset-illegal-handle
[68.642322] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[68.735894] [016/133] (950s left) gem_exec_fence (syncobj-invalid-flags)
[69.178870] Starting subtest: syncobj-invalid-flags
[69.181399] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[71.004507] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[71.007686] [017/133] (948s left) gem_ctx_isolation (dirty-switch)
[71.068845] Starting subtest: dirty-switch
[71.071382] Starting dynamic subtest: rcs0
[71.320753] Dynamic subtest rcs0: SUCCESS (0.251s)
[71.331329] Starting dynamic subtest: bcs0
[71.595376] Dynamic subtest bcs0: SUCCESS (0.274s)
[71.605668] Starting dynamic subtest: vcs0
[71.821869] Dynamic subtest vcs0: SUCCESS (0.226s)
[71.834634] Starting dynamic subtest: vcs1
[73.119857] Dynamic subtest vcs1: SUCCESS (1.296s)
[73.129760] Starting dynamic subtest: vecs0
[75.115765] Dynamic subtest vecs0: SUCCESS (1.993s)
[75.128866] Starting dynamic subtest: ccs0
[77.109315] Dynamic subtest ccs0: SUCCESS (1.991s)
[77.111656] Subtest dirty-switch: SUCCESS (6.033s)
[77.337554] [018/133] (941s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[77.432944] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[77.435391] Starting dynamic subtest: pipe-A-default-mode
[80.140943] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[80.143309] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.707s)
[80.995227] [019/133] (938s left) kms_flip (flip-vs-blocking-wf-vblank)
[81.092594] Starting subtest: flip-vs-blocking-wf-vblank
[81.095194] Starting dynamic subtest: A-eDP1
[90.055910] Dynamic subtest A-eDP1: SUCCESS (8.958s)
[90.067652] Starting dynamic subtest: B-eDP1
[98.983513] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[98.991055] Starting dynamic subtest: C-eDP1
[107.913443] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[107.922276] Starting dynamic subtest: D-eDP1
[116.845635] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[116.848068] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.740s)
[118.069756] [020/133] (901s left) gem_exec_reloc (basic-wc-active)
[118.129079] Subtest basic-wc-active: SKIP (0.000s)
[118.199355] [021/133] (901s left) gem_userptr_blits (vma-merge)
[118.275719] Starting subtest: vma-merge
[118.318799] Subtest vma-merge: SUCCESS (0.045s)
[118.440987] [022/133] (900s left) kms_cursor_edge_walk (256x256-top-bottom)
[118.533639] Starting subtest: 256x256-top-bottom
[118.536697] Starting dynamic subtest: pipe-A-eDP-1
[122.043448] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[122.055283] Starting dynamic subtest: pipe-D-eDP-1
[125.188099] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.142s)
[125.190439] Subtest 256x256-top-bottom: SUCCESS (6.654s)
[125.982256] [023/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[126.081520] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[133.403945] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.324s)
[133.561085] [024/133] (885s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[133.658533] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[133.662980] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[133.758741] [025/133] (885s left) kms_plane_cursor (overlay)
[133.855104] Starting subtest: overlay
[133.860447] Starting dynamic subtest: pipe-A-eDP-1-size-64
[136.396206] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.542s)
[136.455725] Starting dynamic subtest: pipe-A-eDP-1-size-128
[139.077241] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.627s)
[139.135766] Starting dynamic subtest: pipe-A-eDP-1-size-256
[141.666752] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[142.016573] Starting dynamic subtest: pipe-B-eDP-1-size-64
[145.264350] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.257s)
[145.324309] Starting dynamic subtest: pipe-B-eDP-1-size-128
[147.843032] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.526s)
[147.900722] Starting dynamic subtest: pipe-B-eDP-1-size-256
[150.454869] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.560s)
[150.824638] Starting dynamic subtest: pipe-C-eDP-1-size-64
[153.757358] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.944s)
[153.792938] Starting dynamic subtest: pipe-C-eDP-1-size-128
[156.024377] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s)
[156.061140] Starting dynamic subtest: pipe-C-eDP-1-size-256
[158.279395] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[158.617481] Starting dynamic subtest: pipe-D-eDP-1-size-64
[161.479471] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.872s)
[161.516786] Starting dynamic subtest: pipe-D-eDP-1-size-128
[163.680961] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[163.716784] Starting dynamic subtest: pipe-D-eDP-1-size-256
[165.946603] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.236s)
[166.268166] Subtest overlay: SUCCESS (32.413s)
[167.143344] [026/133] (852s left) gem_workarounds (suspend-resume-fd)
[167.216419] Starting subtest: suspend-resume-fd
[183.287450] Subtest suspend-resume-fd: SUCCESS (2.058s)
[184.457821] [027/133] (836s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[184.695013] Starting subtest: cursor-rapid-movement-128x42
[184.745979] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[184.963159] [028/133] (835s left) perf (whitelisted-registers-userspace-config)
[185.101121] Starting subtest: whitelisted-registers-userspace-config
[185.103342] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[185.142972] [029/133] (835s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[185.209921] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[185.272932] [030/133] (835s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[185.367312] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[185.369240] Starting dynamic subtest: pipe-A-eDP-1
[186.139440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[186.147676] Starting dynamic subtest: pipe-B-eDP-1
[187.953769] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.755s)
[187.963565] Starting dynamic subtest: pipe-C-eDP-1
[189.844577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.841s)
[189.854522] Starting dynamic subtest: pipe-D-eDP-1
[191.726079] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.842s)
[191.728084] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.179s)
[192.958095] [031/133] (827s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[193.071308] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[193.076044] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[193.168537] [032/133] (827s left) kms_vrr (lobf)
[193.267327] Starting subtest: lobf
[193.271604] Subtest lobf: SKIP (0.000s)
[193.340536] [033/133] (827s left) kms_big_fb (y-tiled-addfb)
[193.448817] Starting subtest: y-tiled-addfb
[193.453257] Subtest y-tiled-addfb: SKIP (0.000s)
[193.561040] [034/133] (827s left) kms_vblank (ts-continuation-modeset-hang)
[193.652314] Starting subtest: ts-continuation-modeset-hang
[193.654242] Starting dynamic subtest: pipe-A-eDP-1
[219.706739] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.945s)
[219.722069] Starting dynamic subtest: pipe-D-eDP-1
[244.709267] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.981s)
[244.711591] Subtest ts-continuation-modeset-hang: SUCCESS (50.936s)
[245.515832] [035/133] (775s left) kms_psr (pr-primary-page-flip)
[245.620068] Starting subtest: pr-primary-page-flip
[245.624254] Subtest pr-primary-page-flip: SKIP (0.000s)
[245.692925] [036/133] (775s left) gem_exec_reloc (basic-concurrent0)
[245.755476] Subtest basic-concurrent0: SKIP (0.000s)
[245.821231] [037/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[245.926230] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[245.930176] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[246.015505] [038/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[246.110691] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[246.114970] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[246.200686] [039/133] (774s left) gen7_exec_parse (batch-without-end)
[246.260435] Subtest batch-without-end: SKIP (0.000s)
[246.331215] [040/133] (774s left) kms_invalid_mode (bad-vtotal)
[246.430464] Starting subtest: bad-vtotal
[246.432762] Starting dynamic subtest: pipe-A-eDP-1
[246.718243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[246.727224] Starting dynamic subtest: pipe-B-eDP-1
[246.729351] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[246.737529] Starting dynamic subtest: pipe-C-eDP-1
[246.739639] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[246.747833] Starting dynamic subtest: pipe-D-eDP-1
[246.750403] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[246.752755] Subtest bad-vtotal: SUCCESS (0.293s)
[247.552720] [041/133] (773s left) kms_async_flips (alternate-sync-async-flip)
[247.653120] Starting subtest: alternate-sync-async-flip
[248.031579] Starting dynamic subtest: pipe-A-eDP-1
[250.834406] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.803s)
[251.221660] Starting dynamic subtest: pipe-B-eDP-1
[253.965782] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.753s)
[254.352583] Starting dynamic subtest: pipe-C-eDP-1
[257.102426] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.755s)
[257.466294] Starting dynamic subtest: pipe-D-eDP-1
[260.235896] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[260.237988] Subtest alternate-sync-async-flip: SUCCESS (12.580s)
[261.418688] [042/133] (759s left) kms_addfb_basic (tile-pitch-mismatch)
[261.481988] Starting subtest: tile-pitch-mismatch
[261.486729] Subtest tile-pitch-mismatch: SKIP (0.000s)
[261.610133] [043/133] (759s left) gem_ctx_persistence (userptr)
[261.675691] Starting subtest: userptr
[261.841658] Subtest userptr: SUCCESS (0.166s)
[261.933334] [044/133] (759s left) gem_exec_params (sol-reset-not-gen7)
[261.981048] Starting subtest: sol-reset-not-gen7
[261.985866] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[262.108521] [045/133] (759s left) syncobj_timeline (wait-all-for-submit-snapshot)
[262.161486] Starting subtest: wait-all-for-submit-snapshot
[262.242940] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[262.332377] [046/133] (758s left) perf_pmu (init-busy)
[262.372273] Starting subtest: init-busy
[262.374087] Starting dynamic subtest: rcs0
[262.375993] Dynamic subtest rcs0: SUCCESS (0.001s)
[262.385523] Starting dynamic subtest: bcs0
[262.387139] Dynamic subtest bcs0: SUCCESS (0.000s)
[262.395597] Starting dynamic subtest: vcs0
[262.397419] Dynamic subtest vcs0: SUCCESS (0.001s)
[262.405355] Starting dynamic subtest: vcs1
[262.407198] Dynamic subtest vcs1: SUCCESS (0.001s)
[262.415046] Starting dynamic subtest: vecs0
[262.416797] Dynamic subtest vecs0: SUCCESS (0.001s)
[262.424608] Starting dynamic subtest: ccs0
[262.426452] Dynamic subtest ccs0: SUCCESS (0.000s)
[262.428329] Subtest init-busy: SUCCESS (0.007s)
[262.488671] [047/133] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[262.582816] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[262.586352] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[262.673271] [048/133] (758s left) kms_debugfs (display-on-read-all)
[262.757627] Starting subtest: display-on-read-all
[262.937921] Subtest display-on-read-all: SUCCESS (0.181s)
[263.048048] [049/133] (758s left) gem_mmap_gtt (basic-read)
[263.109537] Subtest basic-read: SKIP (0.000s)
[263.173727] [050/133] (758s left) kms_universal_plane (disable-primary-vs-flip)
[263.285456] Starting subtest: disable-primary-vs-flip
[263.287095] Starting dynamic subtest: pipe-A-eDP-1
[264.866619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.578s)
[264.876104] Starting dynamic subtest: pipe-B-eDP-1
[267.059595] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.191s)
[267.071483] Starting dynamic subtest: pipe-C-eDP-1
[269.304277] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[269.314772] Starting dynamic subtest: pipe-D-eDP-1
[271.469562] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.165s)
[271.471939] Subtest disable-primary-vs-flip: SUCCESS (8.182s)
[272.275782] [051/133] (749s left) gem_softpin (evict-prime)
[272.334934] Starting subtest: evict-prime
[272.337342] Starting dynamic subtest: rcs0
[273.474775] Dynamic subtest rcs0: SUCCESS (1.139s)
[273.486762] Starting dynamic subtest: bcs0
[274.590318] Dynamic subtest bcs0: SUCCESS (1.113s)
[274.605004] Starting dynamic subtest: vcs0
[275.926259] Dynamic subtest vcs0: SUCCESS (1.332s)
[275.938452] Starting dynamic subtest: vcs1
[277.919726] Dynamic subtest vcs1: SUCCESS (1.990s)
[277.933361] Starting dynamic subtest: vecs0
[279.898855] Dynamic subtest vecs0: SUCCESS (1.977s)
[279.910974] Starting dynamic subtest: ccs0
[281.015500] Dynamic subtest ccs0: SUCCESS (1.116s)
[281.024618] Starting dynamic subtest: all
[282.903334] Dynamic subtest all: SUCCESS (1.886s)
[282.906182] Subtest evict-prime: SUCCESS (10.567s)
[282.984979] [052/133] (738s left) gem_mmap (big-bo)
[283.038480] Subtest big-bo: SKIP (0.000s)
[283.095117] [053/133] (738s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[283.183645] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[283.185780] Starting dynamic subtest: pipe-A-eDP-1
[283.208607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[283.219235] Starting dynamic subtest: pipe-B-eDP-1
[283.238339] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[283.246707] Starting dynamic subtest: pipe-C-eDP-1
[283.266270] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[283.274079] Starting dynamic subtest: pipe-D-eDP-1
[283.293525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[283.295493] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[285.430629] [054/133] (736s left) prime_busy (after-wait)
[285.493727] Starting subtest: after-wait
[285.499366] Starting dynamic subtest: rcs0
[285.529083] Dynamic subtest rcs0: SUCCESS (0.033s)
[285.540510] Starting dynamic subtest: bcs0
[285.568743] Dynamic subtest bcs0: SUCCESS (0.039s)
[285.577577] Starting dynamic subtest: vcs0
[285.609929] Dynamic subtest vcs0: SUCCESS (0.040s)
[285.619675] Starting dynamic subtest: vcs1
[285.651467] Dynamic subtest vcs1: SUCCESS (0.040s)
[285.665927] Starting dynamic subtest: vecs0
[285.691435] Dynamic subtest vecs0: SUCCESS (0.038s)
[285.701514] Starting dynamic subtest: ccs0
[285.734354] Dynamic subtest ccs0: SUCCESS (0.041s)
[285.841728] Subtest after-wait: SUCCESS (0.348s)
[285.941914] [055/133] (735s left) template (b)
[286.003037] Starting subtest: B
[286.005573] Subtest B: SUCCESS (0.000s)
[286.112787] [056/133] (735s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[286.219442] Starting subtest: crc-primary-suspend-y-tiled-ccs
[286.221788] Starting dynamic subtest: pipe-A-eDP-1
[286.230973] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.245085] Starting dynamic subtest: pipe-B-eDP-1
[286.255333] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.266168] Starting dynamic subtest: pipe-C-eDP-1
[286.274876] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.283673] Starting dynamic subtest: pipe-D-eDP-1
[286.292376] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.296796] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[288.471826] [057/133] (733s left) gem_eio (wait-wedge-1us)
[288.719924] Starting subtest: wait-wedge-1us
[290.021458] Subtest wait-wedge-1us: SUCCESS (1.301s)
[290.152992] [058/133] (731s left) kms_pm_backlight (brightness-with-dpms)
[290.249060] Starting subtest: brightness-with-dpms
[290.299706] Starting dynamic subtest: eDP-1
[292.761887] Dynamic subtest eDP-1: SUCCESS (2.461s)
[292.764043] Subtest brightness-with-dpms: SUCCESS (2.515s)
[293.609199] [059/133] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[293.704522] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[293.708648] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[293.811624] [060/133] (728s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[293.908201] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[298.043378] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.139s)
[299.209999] [061/133] (722s left) kms_color (ctm-0-50)
[299.307921] Starting subtest: ctm-0-50
[299.310075] Starting dynamic subtest: pipe-A-eDP-1
[302.839036] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.533s)
[302.848645] Starting dynamic subtest: pipe-B-eDP-1
[307.062347] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.223s)
[307.072987] Starting dynamic subtest: pipe-C-eDP-1
[311.105606] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.040s)
[311.114580] Starting dynamic subtest: pipe-D-eDP-1
[315.084488] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[315.086845] Subtest ctm-0-50: SUCCESS (15.777s)
[315.920594] [062/133] (706s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[316.011269] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[316.013540] Starting dynamic subtest: pipe-A-eDP-1
[316.036772] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[316.047365] Starting dynamic subtest: pipe-B-eDP-1
[316.069185] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[316.078094] Starting dynamic subtest: pipe-C-eDP-1
[316.099735] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[316.108631] Starting dynamic subtest: pipe-D-eDP-1
[316.130491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[316.134550] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[318.267940] [063/133] (703s left) kms_chamelium_color (degamma)
[318.373497] Subtest degamma: SKIP (0.000s)
[318.422398] [064/133] (703s left) gem_exec_store (pages)
[318.482543] Starting subtest: pages
[318.484758] Starting dynamic subtest: rcs0
[318.556667] Dynamic subtest rcs0: SUCCESS (0.075s)
[318.567642] Starting dynamic subtest: bcs0
[318.630260] Dynamic subtest bcs0: SUCCESS (0.074s)
[318.640769] Starting dynamic subtest: vcs0
[318.706208] Dynamic subtest vcs0: SUCCESS (0.075s)
[318.717781] Starting dynamic subtest: vcs1
[318.771073] Dynamic subtest vcs1: SUCCESS (0.064s)
[318.782652] Starting dynamic subtest: vecs0
[318.834216] Dynamic subtest vecs0: SUCCESS (0.062s)
[318.845929] Starting dynamic subtest: ccs0
[318.897385] Dynamic subtest ccs0: SUCCESS (0.062s)
[318.899902] Subtest pages: SUCCESS (0.417s)
[319.088127] [065/133] (703s left) perf (mi-rpc)
[319.184026] Starting subtest: mi-rpc
[319.188686] Subtest mi-rpc: SKIP (0.000s)
[319.231897] [066/133] (702s left) sysfs_heartbeat_interval (mixed)
[319.285584] Starting subtest: mixed
[319.288020] Starting dynamic subtest: vecs0
[324.529122] Dynamic subtest vecs0: SUCCESS (5.242s)
[324.540624] Starting dynamic subtest: ccs0
[329.724563] Dynamic subtest ccs0: SUCCESS (5.193s)
[329.735670] Starting dynamic subtest: vcs0
[334.945159] Dynamic subtest vcs0: SUCCESS (5.218s)
[334.959228] Starting dynamic subtest: bcs0
[340.207839] Dynamic subtest bcs0: SUCCESS (5.259s)
[340.219102] Starting dynamic subtest: rcs0
[345.383633] Dynamic subtest rcs0: SUCCESS (5.173s)
[345.394615] Starting dynamic subtest: vcs1
[350.618233] Dynamic subtest vcs1: SUCCESS (5.232s)
[350.620852] Subtest mixed: SUCCESS (31.327s)
[350.700951] [067/133] (671s left) gem_pread (bench)
[350.768261] Subtest bench: SKIP (0.000s)
[350.837584] [068/133] (671s left) gem_exec_balancer (bonded-dual)
[350.901521] Starting subtest: bonded-dual
[350.906085] Subtest bonded-dual: SKIP (0.000s)
[351.221610] [069/133] (671s left) kms_flip (flip-vs-panning-interruptible)
[351.311536] Starting subtest: flip-vs-panning-interruptible
[351.314043] Starting dynamic subtest: A-eDP1
[359.981130] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[359.993980] Starting dynamic subtest: B-eDP1
[368.706019] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[368.717372] Starting dynamic subtest: C-eDP1
[377.430931] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[377.440972] Starting dynamic subtest: D-eDP1
[386.076100] Dynamic subtest D-eDP1: SUCCESS (8.641s)
[386.081297] Subtest flip-vs-panning-interruptible: SUCCESS (34.758s)
[387.228378] [070/133] (635s left) kms_cursor_crc (cursor-onscreen-128x42)
[387.465661] Starting subtest: cursor-onscreen-128x42
[387.517813] Subtest cursor-onscreen-128x42: SKIP (0.049s)
[387.719210] [071/133] (634s left) gem_exec_create (madvise)
[387.783790] Starting subtest: madvise
[387.786220] Starting dynamic subtest: smem
[407.950133] Dynamic subtest smem: SUCCESS (20.154s)
[407.952599] Subtest madvise: SUCCESS (20.155s)
[408.860480] [072/133] (613s left) gem_exec_capture (capture-recoverable)
[408.932264] Starting subtest: capture-recoverable
[408.935411] Subtest capture-recoverable: SUCCESS (0.005s)
[409.051643] [073/133] (613s left) gem_exec_schedule (preempt-queue-contexts)
[409.118987] Subtest preempt-queue-contexts: SKIP (0.000s)
[409.408515] [074/133] (613s left) kms_content_protection (dp-mst-lic-type-0)
[409.540262] Starting subtest: dp-mst-lic-type-0
[409.544891] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[409.651741] [075/133] (612s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[409.755603] Starting subtest: pr-cursor-plane-update-sf
[409.759926] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[409.828749] [076/133] (612s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[409.881936] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[409.884201] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[409.979263] [077/133] (612s left) kms_chamelium_hpd (dp-hpd-fast)
[410.365245] Subtest dp-hpd-fast: SKIP (0.000s)
[411.138879] [078/133] (611s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[411.226800] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[411.229092] Starting dynamic subtest: pipe-A-eDP-1
[411.251297] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.262996] Starting dynamic subtest: pipe-B-eDP-1
[411.284158] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.294893] Starting dynamic subtest: pipe-C-eDP-1
[411.315938] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.327436] Starting dynamic subtest: pipe-D-eDP-1
[411.349204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.353571] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[413.449335] [079/133] (609s left) prime_mmap_coherency (write)
[413.514626] Starting subtest: write
[418.886520] Subtest write: SUCCESS (5.374s)
[419.020537] [080/133] (603s left) kms_big_fb (linear-8bpp-rotate-0)
[419.128965] Starting subtest: linear-8bpp-rotate-0
[420.395402] Subtest linear-8bpp-rotate-0: SUCCESS (1.271s)
[420.521771] [081/133] (602s left) gem_ctx_shared (detached-shared-gtt)
[420.598448] Starting subtest: detached-shared-gtt
[422.751452] Subtest detached-shared-gtt: SUCCESS (2.152s)
[423.060309] [082/133] (599s left) i915_query (query-topology-known-pci-ids)
[423.116704] Starting subtest: query-topology-known-pci-ids
[423.121229] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[423.215205] [083/133] (599s left) gem_close_race (multigpu-basic-threads)
[423.285379] Starting subtest: multigpu-basic-threads
[423.290401] Subtest multigpu-basic-threads: SKIP (0.000s)
[423.517399] [084/133] (599s left) perf_pmu (frequency)
[423.556979] Starting subtest: frequency
[423.562732] Starting dynamic subtest: gt0
[425.697597] Dynamic subtest gt0: SUCCESS (2.133s)
[425.709581] Starting dynamic subtest: idle-gt0
[426.201752] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[426.214637] Starting dynamic subtest: gt1
[430.929569] Dynamic subtest gt1: SUCCESS (4.724s)
[430.941336] Starting dynamic subtest: idle-gt1
[431.433822] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[431.436528] Subtest frequency: SUCCESS (7.881s)
[431.533326] [085/133] (591s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[431.649260] Starting subtest: yf-tiled-64bpp-rotate-180
[431.653469] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[431.748055] [086/133] (591s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[431.865148] Starting subtest: cursorA-vs-flipB-atomic
[431.869506] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[432.024478] [087/133] (591s left) gem_mmap_offset (basic-uaf)
[432.079072] Starting subtest: basic-uaf
[432.081099] Subtest basic-uaf: SUCCESS (0.001s)
[432.170336] [088/133] (590s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[432.283303] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[432.287534] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[432.354447] [089/133] (590s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[432.461440] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[439.784414] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.325s)
[439.891780] [090/133] (583s left) sw_sync (sync_multi_consumer)
[439.933663] Starting subtest: sync_multi_consumer
[440.348596] Subtest sync_multi_consumer: SUCCESS (0.414s)
[440.416320] [091/133] (582s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[440.462182] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[440.564998] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[440.639690] [092/133] (582s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[440.745660] Starting subtest: 4-tiled-32bpp-rotate-90
[440.765431] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[440.873997] [093/133] (582s left) gem_exec_reloc (basic-cpu-noreloc)
[440.929700] Subtest basic-cpu-noreloc: SKIP (0.000s)
[440.988219] [094/133] (582s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[441.055599] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[441.059790] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[441.236397] [095/133] (582s left) perf_pmu (all-busy-idle-check-all)
[441.283741] Starting subtest: all-busy-idle-check-all
[442.898458] Subtest all-busy-idle-check-all: SUCCESS (1.615s)
[443.009149] [096/133] (580s left) kms_psr (psr-sprite-plane-move)
[443.095884] Starting subtest: psr-sprite-plane-move
[443.098224] Starting dynamic subtest: eDP-1
[444.889425] Dynamic subtest eDP-1: SUCCESS (1.793s)
[444.891790] Subtest psr-sprite-plane-move: SUCCESS (1.794s)
[445.707511] [097/133] (577s left) api_intel_bb (reset-bb)
[445.767574] Starting subtest: reset-bb
[445.769557] Subtest reset-bb: SUCCESS (0.004s)
[445.892233] [098/133] (577s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[445.980993] Starting subtest: plane-all-modeset-transition-fencing
[445.985421] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[446.057831] [099/133] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[446.167949] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[446.172342] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[446.273422] [100/133] (577s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[446.361259] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[446.365249] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[446.469711] [101/133] (577s left) kms_pm_rpm (legacy-planes)
[448.091411] Starting subtest: legacy-planes
[448.093952] Starting dynamic subtest: plane-65
[456.384964] Dynamic subtest plane-65: SUCCESS (8.297s)
[456.398334] Starting dynamic subtest: plane-95
[464.780602] Dynamic subtest plane-95: SUCCESS (8.393s)
[464.792784] Starting dynamic subtest: plane-125
[473.073110] Dynamic subtest plane-125: SUCCESS (8.289s)
[473.085573] Starting dynamic subtest: plane-135
[481.501985] Dynamic subtest plane-135: SUCCESS (8.426s)
[481.504672] Subtest legacy-planes: SUCCESS (33.417s)
[481.888062] [102/133] (541s left) kms_lease (lease-unleased-connector)
[481.986838] Starting subtest: lease-unleased-connector
[481.989069] Starting dynamic subtest: pipe-A-eDP-1
[481.994014] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[482.004170] Starting dynamic subtest: pipe-B-eDP-1
[482.006298] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[482.016172] Starting dynamic subtest: pipe-C-eDP-1
[482.018365] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[482.028077] Starting dynamic subtest: pipe-D-eDP-1
[482.030213] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[482.032332] Subtest lease-unleased-connector: SUCCESS (0.035s)
[482.124510] [103/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[482.214373] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[489.557799] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.346s)
[489.713083] [104/133] (534s left) gem_exec_schedule (semaphore-user)
[489.785968] Starting subtest: semaphore-user
[489.834735] Subtest semaphore-user: SUCCESS (0.057s)
[490.940770] [105/133] (532s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[491.045332] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[498.525641] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.481s)
[498.663103] [106/133] (525s left) kms_dsc (dsc-with-bpc-formats)
[498.765035] Starting subtest: dsc-with-bpc-formats
[498.875992] Subtest dsc-with-bpc-formats: SKIP (0.003s)
[498.919491] [107/133] (524s left) dmabuf_sync_file (import-multiple-read-write)
[498.972607] Starting subtest: import-multiple-read-write
[498.974554] Subtest import-multiple-read-write: SUCCESS (0.003s)
[499.034283] [108/133] (524s left) i915_pm_rc6_residency (rc6-idle)
[499.086988] Starting subtest: rc6-idle
[499.119379] Starting dynamic subtest: gt0-rcs0
[523.421626] Dynamic subtest gt0-rcs0: SUCCESS (24.298s)
[523.433554] Starting dynamic subtest: gt0-bcs0
[547.701129] Dynamic subtest gt0-bcs0: SUCCESS (24.272s)
[547.710945] Starting dynamic subtest: gt0-ccs0
[572.052569] Dynamic subtest gt0-ccs0: SUCCESS (24.344s)
[572.064896] Starting dynamic subtest: gt1-vcs0
[578.225983] Dynamic subtest gt1-vcs0: SUCCESS (6.168s)
[578.238958] Starting dynamic subtest: gt1-vecs0
[584.398709] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[584.401578] Subtest rc6-idle: SUCCESS (85.297s)
[584.493533] [109/133] (439s left) kms_psr2_su (frontbuffer-xrgb8888)
[584.572846] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[584.638158] [110/133] (439s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[584.742027] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[584.746187] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[584.816809] [111/133] (439s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[584.912747] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[584.916738] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[585.006448] [112/133] (439s left) core_auth (basic-auth)
[585.066397] Starting subtest: basic-auth
[585.068638] Subtest basic-auth: SUCCESS (0.003s)
[585.190466] [113/133] (438s left) gem_mmap_wc (write-read)
[585.252089] Subtest write-read: SKIP (0.000s)
[585.310752] [114/133] (438s left) kms_psr (fbc-pr-sprite-plane-move)
[585.410340] Starting subtest: fbc-pr-sprite-plane-move
[585.414260] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[585.485553] [115/133] (438s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[585.586735] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[585.590875] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[585.679402] [116/133] (438s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[585.734832] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[585.736784] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[585.829698] [117/133] (438s left) gem_busy (busy)
[585.881221] Starting subtest: busy
[585.883225] Starting dynamic subtest: all-engines
[585.941147] Dynamic subtest all-engines: SUCCESS (0.060s)
[585.954502] Starting dynamic subtest: rcs0
[587.929022] Dynamic subtest rcs0: SUCCESS (1.986s)
[587.940606] Starting dynamic subtest: bcs0
[587.970244] Dynamic subtest bcs0: SUCCESS (0.039s)
[587.980088] Starting dynamic subtest: vcs0
[588.008711] Dynamic subtest vcs0: SUCCESS (0.038s)
[588.018417] Starting dynamic subtest: vcs1
[589.912182] Dynamic subtest vcs1: SUCCESS (1.898s)
[589.924006] Starting dynamic subtest: vecs0
[591.897148] Dynamic subtest vecs0: SUCCESS (1.983s)
[591.909083] Starting dynamic subtest: ccs0
[593.942949] Dynamic subtest ccs0: SUCCESS (2.045s)
[593.945370] Subtest busy: SUCCESS (8.057s)
[594.297243] [118/133] (430s left) syncobj_timeline (multi-wait-all-available-signaled)
[594.353257] Starting subtest: multi-wait-all-available-signaled
[594.355616] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[594.475869] [119/133] (429s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[594.589520] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[601.431454] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.841s)
[601.578792] [120/133] (422s left) gem_pxp (verify-pxp-stale-ctx-execution)
[601.703887] Starting subtest: verify-pxp-stale-ctx-execution
[602.761381] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s)
[602.894978] [121/133] (421s left) kms_plane (plane-position-hole-dpms)
[603.003107] Starting subtest: plane-position-hole-dpms
[603.529968] Starting dynamic subtest: pipe-A-plane-1
[605.946652] Dynamic subtest pipe-A-plane-1: SUCCESS (2.417s)
[605.957053] Starting dynamic subtest: pipe-A-plane-2
[608.313175] Dynamic subtest pipe-A-plane-2: SUCCESS (2.365s)
[608.323528] Starting dynamic subtest: pipe-A-plane-3
[610.694675] Dynamic subtest pipe-A-plane-3: SUCCESS (2.379s)
[610.705745] Starting dynamic subtest: pipe-A-plane-4
[613.076881] Dynamic subtest pipe-A-plane-4: SUCCESS (2.382s)
[613.090771] Starting dynamic subtest: pipe-A-plane-5
[613.105885] Dynamic subtest pipe-A-plane-5: SUCCESS (0.027s)
[614.317981] Starting dynamic subtest: pipe-B-plane-1
[616.742801] Dynamic subtest pipe-B-plane-1: SUCCESS (2.431s)
[616.753453] Starting dynamic subtest: pipe-B-plane-2
[619.100647] Dynamic subtest pipe-B-plane-2: SUCCESS (2.359s)
[619.110706] Starting dynamic subtest: pipe-B-plane-3
[621.461832] Dynamic subtest pipe-B-plane-3: SUCCESS (2.358s)
[621.476194] Starting dynamic subtest: pipe-B-plane-4
[623.828948] Dynamic subtest pipe-B-plane-4: SUCCESS (2.366s)
[623.839354] Starting dynamic subtest: pipe-B-plane-5
[623.853526] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[623.855785] Subtest plane-position-hole-dpms: SUCCESS (20.845s)
[624.640483] [122/133] (399s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[624.738964] Starting subtest: nonblocking-crc-frame-sequence
[624.741371] Starting dynamic subtest: pipe-A-eDP-1
[625.473497] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[625.485673] Starting dynamic subtest: pipe-B-eDP-1
[626.859373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.382s)
[626.870834] Starting dynamic subtest: pipe-C-eDP-1
[628.253174] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[628.263701] Starting dynamic subtest: pipe-D-eDP-1
[629.582465] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[629.584841] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.843s)
[630.393830] [123/133] (394s left) kms_flip_event_leak (basic)
[630.487125] Starting subtest: basic
[630.489335] Starting dynamic subtest: pipe-A-eDP-1
[630.913307] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[630.923541] Starting dynamic subtest: pipe-B-eDP-1
[632.024972] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.110s)
[632.035196] Starting dynamic subtest: pipe-C-eDP-1
[633.122546] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.096s)
[633.133142] Starting dynamic subtest: pipe-D-eDP-1
[634.249679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[634.251716] Subtest basic: SUCCESS (3.761s)
[635.116497] [124/133] (389s left) syncobj_timeline (multi-wait-for-submit-signaled)
[635.179558] Starting subtest: multi-wait-for-submit-signaled
[635.181944] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[635.281093] [125/133] (389s left) sw_sync (sync_merge_invalid)
[635.321688] Starting subtest: sync_merge_invalid
[635.335184] Subtest sync_merge_invalid: SUCCESS (0.017s)
[635.412995] [126/133] (389s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[635.515327] Starting subtest: yf-tiled-16bpp-rotate-90
[635.519404] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[635.615803] [127/133] (389s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[635.730279] Starting subtest: x-tiled-16bpp-rotate-90
[635.750574] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[635.852851] [128/133] (388s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[635.914440] Subtest untiled-to-tiled: SKIP (0.000s)
[636.020807] [129/133] (388s left) gem_lmem_swapping (verify-random-ccs)
[636.060846] Subtest verify-random-ccs: SKIP (0.000s)
[636.110838] [130/133] (388s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[636.225207] Starting subtest: short-flip-after-cursor-toggle
[637.141639] Subtest short-flip-after-cursor-toggle: SUCCESS (0.913s)
[637.954700] [131/133] (387s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[638.042446] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[638.046494] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[638.135617] [132/133] (386s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[638.222150] Starting subtest: fbc-psr-sprite-mmap-gtt
[638.224377] Starting dynamic subtest: eDP-1
[638.228419] Dynamic subtest eDP-1: SKIP (0.000s)
[638.232479] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[638.300757] [133/133] (386s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[638.393250] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[638.395429] Starting dynamic subtest: pipe-A
[638.455938] Dynamic subtest pipe-A: SUCCESS (0.064s)
[638.469379] Starting dynamic subtest: pipe-B
[639.588891] Dynamic subtest pipe-B: SUCCESS (1.130s)
[639.599404] Starting dynamic subtest: pipe-C
[640.692663] Dynamic subtest pipe-C: SUCCESS (1.101s)
[640.702210] Starting dynamic subtest: pipe-D
[641.824260] Dynamic subtest pipe-D: SUCCESS (1.130s)
[641.826570] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.433s)
[642.996280] Closing watchdogs
results: parsing output: 0/ for test: gem_reg_read
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_tiled_blits
results: parsing output: 3/ for test: gem_eio
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: i915_getparams_basic
results: parsing output: 9/ for test: api_intel_bb
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: i915_suspend
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: gem_ctx_isolation
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_cursor_edge_walk
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane_cursor
results: parsing output: 25/ for test: gem_workarounds
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_pipe_b_c_ivb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_vrr
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_exec_reloc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gen7_exec_parse
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_debugfs
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_universal_plane
results: parsing output: 50/ for test: gem_softpin
results: parsing output: 51/ for test: gem_mmap
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: prime_busy
results: parsing output: 54/ for test: template
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_eio
results: parsing output: 57/ for test: kms_pm_backlight
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_color
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_chamelium_color
results: parsing output: 63/ for test: gem_exec_store
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: sysfs_heartbeat_interval
results: parsing output: 66/ for test: gem_pread
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: gem_exec_create
results: parsing output: 71/ for test: gem_exec_capture
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_content_protection
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: prime_mmap_coherency
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: gem_close_race
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: kms_atomic_transition
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_dsc
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: i915_pm_rc6_residency
results: parsing output: 108/ for test: kms_psr2_su
results: parsing output: 109/ for test: kms_plane
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: core_auth
results: parsing output: 112/ for test: gem_mmap_wc
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_wait
results: parsing output: 116/ for test: gem_busy
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_pxp
results: parsing output: 120/ for test: kms_plane
results: parsing output: 121/ for test: kms_pipe_crc_basic
results: parsing output: 122/ for test: kms_flip_event_leak
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: sw_sync
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_set_tiling_vs_blt
results: parsing output: 128/ for test: gem_lmem_swapping
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_plane_scaling
Done.