[59.409921] Initializing watchdogs
[59.409968]   /dev/watchdog0
[59.427339] [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]
[59.431976] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.434148] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.437396] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[59.559505] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[59.563768] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[59.678578] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[59.738838] Starting subtest: wait-for-submit-delayed-submit
[59.843896] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[59.928470] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[60.318754] Subtest dp-hpd: SKIP (0.000s)
[61.131980] [004/133] (958s left) kms_cursor_edge_walk (256x256-top-bottom)
[61.215877] Starting subtest: 256x256-top-bottom
[61.218335] Starting dynamic subtest: pipe-A-eDP-1
[64.639236] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s)
[64.649394] Starting dynamic subtest: pipe-D-eDP-1
[67.758093] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[67.760444] Subtest 256x256-top-bottom: SUCCESS (6.534s)
[68.582941] [005/133] (951s left) gem_mmap_offset (clear)
[68.640820] Starting subtest: clear
[68.643348] Starting dynamic subtest: smem0
[91.063985] Dynamic subtest smem0: SUCCESS (22.412s)
[91.066376] Subtest clear: SUCCESS (22.413s)
[91.229810] [006/133] (928s left) kms_joiner (basic-force-big-joiner)
[91.389070] Starting subtest: basic-force-big-joiner
[91.393485] Subtest basic-force-big-joiner: SKIP (0.000s)
[91.477389] [007/133] (928s left) gem_exec_balancer (waits)
[91.537927] Starting subtest: waits
[98.075433] Subtest waits: SUCCESS (6.535s)
[98.400195] [008/133] (921s left) gem_exec_whisper (basic-queues)
[98.471764] Starting subtest: basic-queues
[105.843895] Subtest basic-queues: SUCCESS (7.369s)
[106.036069] [009/133] (914s left) gem_exec_suspend (basic-s3)
[106.104611] Starting subtest: basic-S3
[106.106924] Starting dynamic subtest: smem
[126.941738] Dynamic subtest smem: SUCCESS (7.770s)
[126.944852] Subtest basic-S3: SUCCESS (7.771s)
[127.133928] [010/133] (893s left) kms_psr (psr2-sprite-render)
[127.251840] Starting subtest: psr2-sprite-render
[127.254861] Starting dynamic subtest: eDP-1
[128.954048] Dynamic subtest eDP-1: SUCCESS (1.704s)
[128.956498] Subtest psr2-sprite-render: SUCCESS (1.704s)
[129.823946] [011/133] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[129.921524] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[136.625758] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.703s)
[136.772828] [012/133] (883s left) kms_content_protection (atomic)
[136.926732] Starting subtest: atomic
[136.932358] Subtest atomic: SKIP (0.000s)
[137.073317] [013/133] (883s left) kms_async_flips (invalid-async-flip)
[137.168111] Starting subtest: invalid-async-flip
[137.549961] Starting dynamic subtest: pipe-A-eDP-1
[138.387825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[138.757558] Starting dynamic subtest: pipe-B-eDP-1
[139.617173] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.858s)
[139.974712] Starting dynamic subtest: pipe-C-eDP-1
[140.752843] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.778s)
[141.110781] Starting dynamic subtest: pipe-D-eDP-1
[141.901367] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.792s)
[141.903870] Subtest invalid-async-flip: SUCCESS (4.688s)
[143.087174] [014/133] (877s left) kms_flip (blocking-absolute-wf_vblank)
[143.183849] Starting subtest: blocking-absolute-wf_vblank
[143.186523] Starting dynamic subtest: A-eDP1
[151.951067] Dynamic subtest A-eDP1: SUCCESS (8.732s)
[151.961686] Starting dynamic subtest: B-eDP1
[160.690596] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[160.704381] Starting dynamic subtest: C-eDP1
[169.421097] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[169.436571] Starting dynamic subtest: D-eDP1
[178.160603] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[178.163627] Subtest blocking-absolute-wf_vblank: SUCCESS (34.920s)
[179.387232] [015/133] (841s left) gem_exec_schedule (reorder-wide)
[179.584018] Subtest reorder-wide: SKIP (0.000s)
[179.776652] [016/133] (840s left) gem_watchdog (default-virtual)
[179.862002] Starting subtest: default-virtual
[186.134425] Subtest default-virtual: SUCCESS (6.282s)
[186.226087] [017/133] (834s left) gem_pwrite (basic-self)
[186.285653] Subtest basic-self: SKIP (0.000s)
[186.347157] [018/133] (834s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[186.452734] Starting subtest: fbc-psr2-cursor-mmap-gtt
[186.455129] Starting dynamic subtest: eDP-1
[186.459600] Dynamic subtest eDP-1: SKIP (0.000s)
[186.464204] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[186.534251] [019/133] (834s left) kms_cursor_legacy (forked-move)
[186.666241] Starting subtest: forked-move
[186.668390] Starting dynamic subtest: pipe-A
[192.137496] Dynamic subtest pipe-A: SUCCESS (5.471s)
[192.148319] Starting dynamic subtest: pipe-B
[197.615884] Dynamic subtest pipe-B: SUCCESS (5.478s)
[197.626754] Starting dynamic subtest: pipe-C
[203.092620] Dynamic subtest pipe-C: SUCCESS (5.475s)
[203.103319] Starting dynamic subtest: pipe-D
[208.570210] Dynamic subtest pipe-D: SUCCESS (5.475s)
[208.581460] Starting dynamic subtest: all-pipes
[214.057004] Dynamic subtest all-pipes: SUCCESS (5.484s)
[214.059824] Subtest forked-move: SUCCESS (27.389s)
[214.215678] [020/133] (806s left) vgem_basic (debugfs)
[214.346387] Starting subtest: debugfs
[214.348903] Subtest debugfs: SUCCESS (0.001s)
[214.413888] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[214.417213] [021/133] (806s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[214.521818] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[214.526831] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[214.623873] [022/133] (806s left) kms_plane_lowres (tiling-yf)
[214.729116] Starting subtest: tiling-yf
[214.733208] Subtest tiling-yf: SKIP (0.000s)
[214.811662] [023/133] (805s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[214.909499] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[214.921568] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[215.026742] [024/133] (805s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[215.133860] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[215.136044] Starting dynamic subtest: pipe-A-default-mode
[217.936758] Dynamic subtest pipe-A-default-mode: SUCCESS (2.799s)
[217.939376] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.801s)
[218.779627] [025/133] (802s left) kms_vrr (flip-basic)
[218.874051] Starting subtest: flip-basic
[218.881299] Subtest flip-basic: SKIP (0.000s)
[218.955496] [026/133] (801s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[219.051589] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[219.056107] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[219.147858] [027/133] (801s left) kms_flip (modeset-vs-vblank-race-interruptible)
[219.247932] Starting subtest: modeset-vs-vblank-race-interruptible
[219.250501] Starting dynamic subtest: A-eDP1
[223.901457] Dynamic subtest A-eDP1: SUCCESS (4.650s)
[223.910588] Starting dynamic subtest: B-eDP1
[228.526060] Dynamic subtest B-eDP1: SUCCESS (4.622s)
[228.549173] Starting dynamic subtest: C-eDP1
[233.224459] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[233.233718] Starting dynamic subtest: D-eDP1
[237.765828] Dynamic subtest D-eDP1: SUCCESS (4.539s)
[237.768595] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.514s)
[239.036426] [028/133] (781s left) kms_addfb_basic (bad-pitch-63)
[239.111642] Starting subtest: bad-pitch-63
[239.114419] Subtest bad-pitch-63: SUCCESS (0.000s)
[239.258121] [029/133] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[239.363587] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[239.368617] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[239.487975] [030/133] (781s left) syncobj_wait (invalid-reset-one-illegal-handle)
[239.554003] Starting subtest: invalid-reset-one-illegal-handle
[239.556433] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[239.685222] [031/133] (781s left) gem_ctx_persistence (legacy-engines-queued)
[239.746250] Starting subtest: legacy-engines-queued
[239.748837] Starting dynamic subtest: render
[239.854172] Dynamic subtest render: SUCCESS (0.107s)
[239.865895] Starting dynamic subtest: bsd1
[240.957822] Dynamic subtest bsd1: SUCCESS (1.099s)
[240.969830] Starting dynamic subtest: bsd2
[242.938241] Dynamic subtest bsd2: SUCCESS (1.976s)
[242.949817] Starting dynamic subtest: blt
[243.017200] Dynamic subtest blt: SUCCESS (0.078s)
[243.028762] Starting dynamic subtest: vebox
[244.922303] Dynamic subtest vebox: SUCCESS (1.901s)
[244.925420] Subtest legacy-engines-queued: SUCCESS (5.174s)
[245.014183] [032/133] (776s left) syncobj_wait (invalid-single-wait-unsubmitted)
[245.076142] Starting subtest: invalid-single-wait-unsubmitted
[245.078466] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[245.198489] [033/133] (776s left) gem_pxp (verify-pxp-stale-ctx-execution)
[245.321585] Starting subtest: verify-pxp-stale-ctx-execution
[246.393709] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.071s)
[246.544475] [034/133] (774s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[246.607693] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[246.672202] [035/133] (774s left) kms_cursor_crc (cursor-onscreen-512x170)
[246.940264] Starting subtest: cursor-onscreen-512x170
[246.944653] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[247.104832] [036/133] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[247.204751] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[253.798438] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.599s)
[253.945537] [037/133] (767s left) kms_chamelium_color (ctm-0-25)
[254.049591] Subtest ctm-0-25: SKIP (0.000s)
[254.093382] [038/133] (767s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[254.151599] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[254.257093] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[254.346221] [039/133] (767s left) gem_exec_fence (syncobj-timeline-unused-fence)
[254.881580] Starting subtest: syncobj-timeline-unused-fence
[254.888520] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[256.062107] [040/133] (765s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[256.159566] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[256.164357] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[256.274554] [041/133] (765s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[256.370458] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[256.375331] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[256.487329] [042/133] (765s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[256.873839] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[257.657063] [043/133] (763s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[257.761600] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[257.764375] Starting dynamic subtest: pipe-A
[257.782022] Dynamic subtest pipe-A: SKIP (0.016s)
[257.792043] Starting dynamic subtest: pipe-B
[257.812829] Dynamic subtest pipe-B: SKIP (0.030s)
[257.821423] Starting dynamic subtest: pipe-C
[257.842804] Dynamic subtest pipe-C: SKIP (0.030s)
[257.851171] Starting dynamic subtest: pipe-D
[257.873270] Dynamic subtest pipe-D: SKIP (0.030s)
[257.877490] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.108s)
[258.004348] [044/133] (763s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[258.080351] Starting subtest: y-tiled-to-vebox-x-tiled
[258.086327] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[258.282369] [045/133] (763s left) gen9_exec_parse (batch-without-end)
[258.345840] Subtest batch-without-end: SKIP (0.000s)
[258.428057] [046/133] (763s left) syncobj_timeline (etime-single-wait-submitted)
[258.494089] Starting subtest: etime-single-wait-submitted
[258.602235] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[258.719191] [047/133] (763s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[258.833666] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[258.838381] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[258.952106] [048/133] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[259.046559] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[265.642658] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.601s)
[265.813804] [049/133] (756s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[265.913670] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[265.916563] Starting dynamic subtest: pipe-A-eDP-1
[265.927081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.941002] Starting dynamic subtest: pipe-B-eDP-1
[265.951116] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.959370] Starting dynamic subtest: pipe-C-eDP-1
[265.968818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.977095] Starting dynamic subtest: pipe-D-eDP-1
[265.987234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.991751] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[268.160301] [050/133] (753s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[268.252021] Starting subtest: plane-use-after-nonblocking-unbind
[268.254485] Starting dynamic subtest: pipe-A-eDP-1
[268.312722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[268.607632] Starting dynamic subtest: pipe-B-eDP-1
[269.450356] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.851s)
[269.749011] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.496s)
[270.630320] [051/133] (751s left) gem_partial_pwrite_pread (reads-uncached)
[270.696616] Subtest reads-uncached: SKIP (0.000s)
[270.776341] [052/133] (751s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[270.839195] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[270.841601] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[270.958370] [053/133] (751s left) i915_pm_rc6_residency (rc6-fence)
[271.012294] Starting subtest: rc6-fence
[271.028828] Starting dynamic subtest: gt0
[283.349811] Dynamic subtest gt0: SUCCESS (12.321s)
[283.362178] Starting dynamic subtest: gt1
[297.948586] Dynamic subtest gt1: SUCCESS (14.594s)
[297.952089] Subtest rc6-fence: SUCCESS (26.939s)
[298.039187] [054/133] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[298.155638] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[298.160337] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.268860] [055/133] (723s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[298.370617] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[298.375358] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[298.487875] [056/133] (723s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[298.586607] Starting subtest: yf-tiled-16bpp-rotate-180
[298.591561] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[298.698023] [057/133] (723s left) gem_ctx_param (root-set)
[298.770998] Starting subtest: root-set
[298.773460] Subtest root-set: SUCCESS (0.001s)
[298.897150] [058/133] (723s left) gem_exec_fence (syncobj-invalid-wait)
[299.311450] Starting subtest: syncobj-invalid-wait
[299.314312] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[301.035258] [059/133] (721s left) kms_lease (invalid-create-leases)
[301.131837] Starting subtest: invalid-create-leases
[301.136461] Subtest invalid-create-leases: SUCCESS (0.005s)
[301.271323] [060/133] (721s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[301.367334] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[301.369633] Starting dynamic subtest: pipe-A-eDP-1
[301.391885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[301.401698] Starting dynamic subtest: pipe-B-eDP-1
[301.423937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[301.433183] Starting dynamic subtest: pipe-C-eDP-1
[301.455526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[301.464467] Starting dynamic subtest: pipe-D-eDP-1
[301.485683] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[301.487933] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[303.607509] [061/133] (718s left) kms_sequence (queue-busy)
[303.701527] Starting subtest: queue-busy
[303.703832] Starting dynamic subtest: pipe-A-eDP-1
[305.643680] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[305.654663] Starting dynamic subtest: pipe-B-eDP-1
[308.204851] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.556s)
[308.219602] Starting dynamic subtest: pipe-C-eDP-1
[310.815762] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[310.825356] Starting dynamic subtest: pipe-D-eDP-1
[313.360397] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[313.363055] Subtest queue-busy: SUCCESS (9.657s)
[314.163483] [062/133] (708s left) prime_vgem (basic-fence-blt)
[314.256565] Starting subtest: basic-fence-blt
[314.347513] Subtest basic-fence-blt: SUCCESS (0.092s)
[314.486004] [063/133] (708s left) i915_suspend (basic-s3-without-i915)
[314.527408] Starting subtest: basic-s3-without-i915
[316.414097] Subtest basic-s3-without-i915: SKIP (1.886s)
[319.283603] [064/133] (703s left) i915_module_load (reload-no-display)
[319.326075] Starting subtest: reload-no-display
[325.023295] Subtest reload-no-display: SUCCESS (5.694s)
[325.054012] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[325.054728] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[325.058598] [065/133] (697s left) prime_vgem (basic-gtt)
[327.937661] Starting subtest: basic-gtt
[327.942773] Subtest basic-gtt: SKIP (0.000s)
[328.033266] [FACT prime_vgem (basic-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[328.034560] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.i915: true
[328.038505] [066/133] (694s left) vgem_basic (second-client)
[328.094651] Starting subtest: second-client
[328.113210] Subtest second-client: SUCCESS (0.022s)
[328.187190] [067/133] (694s left) kms_psr (fbc-pr-dpms)
[328.293454] Starting subtest: fbc-pr-dpms
[328.298569] Subtest fbc-pr-dpms: SKIP (0.000s)
[328.390880] [068/133] (694s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[328.500612] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[328.505658] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[328.627089] [069/133] (694s left) gem_exec_balancer (full-late)
[328.690708] Starting subtest: full-late
[333.848193] Subtest full-late: SUCCESS (5.156s)
[334.208812] [070/133] (688s left) kms_psr (pr-primary-mmap-gtt)
[334.325905] Starting subtest: pr-primary-mmap-gtt
[334.331423] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[334.408627] [071/133] (688s left) syncobj_wait (single-wait-all-signaled)
[334.472987] Starting subtest: single-wait-all-signaled
[334.475415] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[334.592573] [072/133] (688s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[334.690318] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[334.692794] Starting dynamic subtest: pipe-A-eDP-1
[334.717508] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[334.728952] Starting dynamic subtest: pipe-B-eDP-1
[334.754516] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[334.762809] Starting dynamic subtest: pipe-C-eDP-1
[334.789433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[334.798768] Starting dynamic subtest: pipe-D-eDP-1
[334.824750] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[334.829633] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[336.959263] [073/133] (685s left) syncobj_timeline (single-wait-all-available-signaled)
[337.022953] Starting subtest: single-wait-all-available-signaled
[337.025601] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[337.128509] [074/133] (685s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[337.234837] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[337.356560] [075/133] (685s left) gem_exec_capture (userptr)
[337.421562] Starting subtest: userptr
[338.228770] Subtest userptr: SUCCESS (0.807s)
[338.363341] [076/133] (684s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[338.475822] Starting subtest: fbcpsr-rgb565-draw-render
[345.520309] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.045s)
[345.687972] [077/133] (677s left) prime_mmap (test_reprime)
[345.754817] Starting subtest: test_reprime
[345.757836] Starting dynamic subtest: test_reprime-smem
[345.783628] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[345.786066] Subtest test_reprime: SUCCESS (0.032s)
[345.911094] [078/133] (677s left) syncobj_wait (wait-all-snapshot)
[345.968602] Starting subtest: wait-all-snapshot
[346.048557] Subtest wait-all-snapshot: SUCCESS (0.082s)
[346.137180] [079/133] (677s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[346.260203] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[346.262667] Starting dynamic subtest: pipe-A
[346.332379] Dynamic subtest pipe-A: SUCCESS (0.073s)
[346.340835] Starting dynamic subtest: pipe-B
[347.506664] Dynamic subtest pipe-B: SUCCESS (1.173s)
[347.515303] Starting dynamic subtest: pipe-C
[348.613876] Dynamic subtest pipe-C: SUCCESS (1.104s)
[348.623591] Starting dynamic subtest: pipe-D
[349.734806] Dynamic subtest pipe-D: SUCCESS (1.120s)
[349.737630] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.477s)
[350.909290] [080/133] (672s left) gem_softpin (allocator-fork)
[350.972746] Starting subtest: allocator-fork
[353.177386] Subtest allocator-fork: SUCCESS (2.203s)
[353.329276] [081/133] (669s left) api_intel_bb (object-reloc-keep-cache)
[353.390558] Starting subtest: object-reloc-keep-cache
[353.395741] Subtest object-reloc-keep-cache: SKIP (0.006s)
[353.542214] [082/133] (669s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[353.607826] Starting subtest: wait-all-for-submit-delayed-submit
[353.707244] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[353.809011] [083/133] (669s left) kms_color (degamma)
[353.908580] Starting subtest: degamma
[353.910817] Starting dynamic subtest: pipe-A-eDP-1
[354.634643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.726s)
[354.645820] Starting dynamic subtest: pipe-B-eDP-1
[356.022561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.387s)
[356.037480] Starting dynamic subtest: pipe-C-eDP-1
[357.423368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[357.434839] Starting dynamic subtest: pipe-D-eDP-1
[358.799305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.376s)
[358.801819] Subtest degamma: SUCCESS (4.891s)
[359.676427] [084/133] (663s left) gem_userptr_blits (coherency-unsync)
[359.751009] Subtest coherency-unsync: SKIP (0.000s)
[359.904534] [085/133] (663s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[359.999131] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[360.623728] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[360.829831] [086/133] (662s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[360.957590] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[360.962405] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[361.075094] [087/133] (662s left) kms_plane_scaling (2x-scaler-multi-pipe)
[361.168815] Starting subtest: 2x-scaler-multi-pipe
[361.174301] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[361.287721] [088/133] (662s left) gem_exec_parallel (fds)
[361.347744] Starting subtest: fds
[361.350578] Starting dynamic subtest: rcs0
[365.057338] Dynamic subtest rcs0: SUCCESS (3.707s)
[365.068986] Starting dynamic subtest: bcs0
[369.294666] Dynamic subtest bcs0: SUCCESS (4.233s)
[369.306655] Starting dynamic subtest: vcs0
[373.257651] Dynamic subtest vcs0: SUCCESS (3.958s)
[373.269828] Starting dynamic subtest: vcs1
[377.271834] Dynamic subtest vcs1: SUCCESS (4.013s)
[377.281849] Starting dynamic subtest: vecs0
[381.222577] Dynamic subtest vecs0: SUCCESS (3.951s)
[381.235693] Starting dynamic subtest: ccs0
[386.044695] Dynamic subtest ccs0: SUCCESS (4.821s)
[386.048092] Subtest fds: SUCCESS (24.694s)
[386.251713] [089/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[386.361616] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[386.366631] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[386.465423] [090/133] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[386.556620] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[386.561687] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[386.684471] [091/133] (636s left) kms_getfb (getfb2-into-addfb2)
[386.782883] Starting subtest: getfb2-into-addfb2
[386.785277] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[386.913612] [092/133] (636s left) kms_flip (busy-flip)
[387.014334] Starting subtest: busy-flip
[387.016849] Starting dynamic subtest: A-eDP1
[388.677082] Dynamic subtest A-eDP1: SUCCESS (1.663s)
[388.686832] Starting dynamic subtest: B-eDP1
[390.399840] Dynamic subtest B-eDP1: SUCCESS (1.721s)
[390.410725] Starting dynamic subtest: C-eDP1
[392.109623] Dynamic subtest C-eDP1: SUCCESS (1.709s)
[392.125168] Starting dynamic subtest: D-eDP1
[393.749275] Dynamic subtest D-eDP1: SUCCESS (1.637s)
[393.751707] Subtest busy-flip: SUCCESS (6.740s)
[395.026104] [093/133] (628s left) gem_ctx_sseu (mmap-args)
[395.089863] Subtest mmap-args: SKIP (0.000s)
[395.163299] [094/133] (628s left) kms_cursor_crc (cursor-random-32x32)
[395.306094] Starting subtest: cursor-random-32x32
[395.354409] Subtest cursor-random-32x32: SKIP (0.042s)
[395.677669] [095/133] (628s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[395.771813] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[395.774340] Starting dynamic subtest: pipe-A-eDP-1
[395.797476] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[395.808352] Starting dynamic subtest: pipe-B-eDP-1
[395.830731] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[395.842030] Starting dynamic subtest: pipe-C-eDP-1
[395.867184] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[395.876419] Starting dynamic subtest: pipe-D-eDP-1
[395.904180] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[395.909598] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[398.082979] [096/133] (625s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[398.189802] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[402.167755] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.983s)
[403.366064] [097/133] (620s left) gem_exec_schedule (u-submit-late-slice)
[403.439840] Starting subtest: u-submit-late-slice
[403.442367] Starting dynamic subtest: rcs0
[403.468849] Dynamic subtest rcs0: SUCCESS (0.041s)
[403.478407] Starting dynamic subtest: bcs0
[403.497843] Dynamic subtest bcs0: SUCCESS (0.028s)
[403.507047] Starting dynamic subtest: vcs0
[403.536871] Dynamic subtest vcs0: SUCCESS (0.038s)
[403.546313] Starting dynamic subtest: vcs1
[403.563378] Dynamic subtest vcs1: SUCCESS (0.027s)
[403.572758] Starting dynamic subtest: vecs0
[403.601051] Dynamic subtest vecs0: SUCCESS (0.036s)
[403.609853] Starting dynamic subtest: ccs0
[403.630468] Dynamic subtest ccs0: SUCCESS (0.029s)
[403.632840] Subtest u-submit-late-slice: SUCCESS (0.202s)
[405.090387] [098/133] (618s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[405.191781] Starting subtest: fbcpsr-stridechange
[411.471745] Subtest fbcpsr-stridechange: SUCCESS (6.282s)
[411.632720] [099/133] (612s left) dumb_buffer (map-valid)
[411.685754] Starting subtest: map-valid
[411.688653] Subtest map-valid: SUCCESS (0.000s)
[411.814339] [100/133] (612s left) perf_pmu (idle)
[411.860354] Starting subtest: idle
[411.863124] Starting dynamic subtest: rcs0
[412.413566] Dynamic subtest rcs0: SUCCESS (0.554s)
[412.425667] Starting dynamic subtest: bcs0
[412.941662] Dynamic subtest bcs0: SUCCESS (0.525s)
[412.952666] Starting dynamic subtest: vcs0
[413.470041] Dynamic subtest vcs0: SUCCESS (0.525s)
[413.483170] Starting dynamic subtest: vcs1
[413.989112] Dynamic subtest vcs1: SUCCESS (0.517s)
[414.001079] Starting dynamic subtest: vecs0
[414.522573] Dynamic subtest vecs0: SUCCESS (0.531s)
[414.535663] Starting dynamic subtest: ccs0
[415.053814] Dynamic subtest ccs0: SUCCESS (0.529s)
[415.056716] Subtest idle: SUCCESS (3.196s)
[415.170316] [101/133] (608s left) kms_pm_rpm (i2c)
[417.097637] Starting subtest: i2c
[422.127509] Subtest i2c: SUCCESS (5.028s)
[422.224913] [102/133] (601s left) kms_big_fb (linear-64bpp-rotate-180)
[422.335535] Starting subtest: linear-64bpp-rotate-180
[424.014117] Subtest linear-64bpp-rotate-180: SUCCESS (1.679s)
[424.182962] [103/133] (599s left) kms_feature_discovery (dp-mst)
[424.289318] Starting subtest: dp-mst
[424.293699] Subtest dp-mst: SKIP (0.000s)
[424.375315] [104/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[424.474221] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[424.478106] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[424.572176] [105/133] (599s left) kms_pipe_stress (stress-xrgb8888-untiled)
[424.661336] Starting subtest: stress-xrgb8888-untiled
[430.593547] Subtest stress-xrgb8888-untiled: SUCCESS (5.932s)
[430.644963] [106/133] (593s left) gem_softpin (invalid)
[430.705536] Starting subtest: invalid
[430.711122] Subtest invalid: SUCCESS (0.005s)
[430.858031] [107/133] (593s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[435.882446] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[435.885017] Starting dynamic subtest: pipe-A-eDP-1
[436.676729] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[436.686763] Starting dynamic subtest: pipe-B-eDP-1
[437.811339] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[437.816690] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.927s)
[438.999747] [108/133] (585s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[439.105706] Starting subtest: primary-x-tiled-reflect-x-0
[446.473216] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.369s)
[447.667561] [109/133] (576s left) i915_drm_fdinfo (busy)
[447.732435] Starting subtest: busy
[447.734801] Starting dynamic subtest: rcs0
[447.756545] Dynamic subtest rcs0: SKIP (0.024s)
[447.768579] Starting dynamic subtest: bcs0
[447.773616] Dynamic subtest bcs0: SKIP (0.000s)
[447.783351] Starting dynamic subtest: vcs0
[447.788726] Dynamic subtest vcs0: SKIP (0.000s)
[447.799695] Starting dynamic subtest: vcs1
[447.804601] Dynamic subtest vcs1: SKIP (0.000s)
[447.813674] Starting dynamic subtest: vecs0
[447.818604] Dynamic subtest vecs0: SKIP (0.000s)
[447.827563] Starting dynamic subtest: ccs0
[447.832406] Dynamic subtest ccs0: SKIP (0.000s)
[447.837276] Subtest busy: SKIP (0.030s)
[447.875335] [110/133] (576s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[447.983457] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[447.988386] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[448.103172] [111/133] (576s left) kms_scaling_modes (scaling-mode-full)
[448.190382] Starting subtest: scaling-mode-full
[448.192689] Starting dynamic subtest: pipe-A-eDP-1
[448.284046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[448.297744] Starting dynamic subtest: pipe-B-eDP-1
[449.462137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[449.476719] Starting dynamic subtest: pipe-C-eDP-1
[450.568060] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[450.578050] Starting dynamic subtest: pipe-D-eDP-1
[451.690360] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[451.692852] Subtest scaling-mode-full: SUCCESS (3.503s)
[452.869293] [112/133] (571s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[457.852537] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[457.855274] Starting dynamic subtest: pipe-A-eDP-1
[458.656217] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s)
[458.666598] Starting dynamic subtest: pipe-B-eDP-1
[459.784379] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[459.789718] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.930s)
[460.993467] [113/133] (563s left) gem_exec_schedule (preemptive-hang)
[461.180674] Starting subtest: preemptive-hang
[461.183467] Starting dynamic subtest: rcs0
[470.089109] Dynamic subtest rcs0: SUCCESS (8.906s)
[470.100827] Starting dynamic subtest: bcs0
[479.110833] Dynamic subtest bcs0: SUCCESS (9.019s)
[479.122721] Starting dynamic subtest: vcs0
[488.069493] Dynamic subtest vcs0: SUCCESS (8.955s)
[488.081583] Starting dynamic subtest: vcs1
[497.092619] Dynamic subtest vcs1: SUCCESS (9.019s)
[497.109638] Starting dynamic subtest: vecs0
[506.113150] Dynamic subtest vecs0: SUCCESS (9.018s)
[506.122640] Starting dynamic subtest: ccs0
[515.144874] Dynamic subtest ccs0: SUCCESS (9.028s)
[515.147342] Subtest preemptive-hang: SUCCESS (53.958s)
[515.429633] [114/133] (509s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[515.497135] Starting subtest: multi-wait-all-for-submit-available-submitted
[515.499870] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[515.611231] [115/133] (509s left) perf (per-context-mode-unprivileged)
[515.766741] Starting subtest: per-context-mode-unprivileged
[515.771860] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[515.812104] [116/133] (508s left) gem_exec_reloc (basic-gtt-noreloc)
[515.899867] Subtest basic-gtt-noreloc: SKIP (0.000s)
[515.980980] [117/133] (508s left) kms_flip (2x-flip-vs-dpms)
[516.080492] Starting subtest: 2x-flip-vs-dpms
[516.091710] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[516.230352] [118/133] (508s left) gem_ctx_exec (basic-close-race)
[516.301539] Starting subtest: basic-close-race
[522.014774] Subtest basic-close-race: SUCCESS (5.711s)
[522.165162] [119/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[522.264196] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[522.268747] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[522.388217] [120/133] (502s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[522.482660] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[522.487582] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[522.587445] [121/133] (502s left) gem_ctx_param (invalid-get-no-zeromap)
[522.650137] Starting subtest: invalid-get-no-zeromap
[522.652637] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[522.776423] [122/133] (502s left) dumb_buffer (invalid-bpp)
[522.842670] Starting subtest: invalid-bpp
[522.845193] Subtest invalid-bpp: SUCCESS (0.000s)
[522.953912] [123/133] (502s left) kms_addfb_basic (basic)
[523.009656] Starting subtest: basic
[523.012109] Subtest basic: SUCCESS (0.000s)
[523.156137] [124/133] (501s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[523.258088] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[523.283511] Starting dynamic subtest: pipe-A-plane-0
[523.995387] Dynamic subtest pipe-A-plane-0: SUCCESS (0.711s)
[524.005065] Starting dynamic subtest: pipe-A-plane-3
[524.450837] Dynamic subtest pipe-A-plane-3: SUCCESS (0.455s)
[524.460102] Starting dynamic subtest: pipe-A-plane-5
[524.463858] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.560205] Starting dynamic subtest: pipe-B-plane-0
[526.242343] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s)
[526.252836] Starting dynamic subtest: pipe-B-plane-3
[526.719336] Dynamic subtest pipe-B-plane-3: SUCCESS (0.477s)
[526.728632] Starting dynamic subtest: pipe-B-plane-5
[526.733022] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[527.030400] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.771s)
[527.841663] [125/133] (497s left) perf_pmu (busy-double-start)
[527.884424] Starting subtest: busy-double-start
[527.886833] Starting dynamic subtest: rcs0
[531.538805] Dynamic subtest rcs0: FAIL (3.588s)
[531.549500] Starting dynamic subtest: bcs0
[535.040624] Dynamic subtest bcs0: SUCCESS (3.566s)
[535.054173] Starting dynamic subtest: vcs0
[539.523817] Dynamic subtest vcs0: SUCCESS (4.480s)
[539.536595] Starting dynamic subtest: vcs1
[543.523826] Dynamic subtest vcs1: SUCCESS (3.997s)
[543.535749] Starting dynamic subtest: vecs0
[547.496027] Dynamic subtest vecs0: SUCCESS (3.969s)
[547.508248] Starting dynamic subtest: ccs0
[551.139839] Dynamic subtest ccs0: FAIL (3.565s)
[551.141962] Subtest busy-double-start: FAIL (23.176s)
[551.188144] [126/133] (474s left) gem_ctx_param (basic-default)
[551.243221] Starting subtest: basic-default
[551.245719] Subtest basic-default: SUCCESS (0.000s)
[551.332389] [127/133] (473s left) gem_mmap_gtt (big-bo-tiledx)
[551.388651] Subtest big-bo-tiledX: SKIP (0.000s)
[551.449768] [128/133] (473s left) gem_userptr_blits (stress-mm)
[551.517993] Starting subtest: stress-mm
[556.901330] Subtest stress-mm: SUCCESS (5.369s)
[557.047068] [129/133] (468s left) prime_vgem (fence-read-hang)
[557.144047] Subtest fence-read-hang: SKIP (0.000s)
[557.268218] [130/133] (468s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[557.381811] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[557.394359] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[557.522464] [131/133] (467s left) kms_psr (fbc-psr-primary-render)
[557.633852] Starting subtest: fbc-psr-primary-render
[557.636676] Starting dynamic subtest: eDP-1
[557.642606] Dynamic subtest eDP-1: SKIP (0.000s)
[557.648710] Subtest fbc-psr-primary-render: SKIP (0.001s)
[557.758588] [132/133] (467s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[557.868160] Starting subtest: psr-modesetfrombusy
[563.978680] Subtest psr-modesetfrombusy: SUCCESS (6.114s)
[564.149852] [133/133] (461s left) kms_pm_rpm (system-suspend-modeset)
[566.095830] Starting subtest: system-suspend-modeset
[585.135865] Subtest system-suspend-modeset: SUCCESS (4.302s)
[585.531194] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: kms_cursor_edge_walk
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: gem_exec_balancer
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: gem_exec_suspend
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: kms_async_flips
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_watchdog
results: parsing output: 16/ for test: gem_pwrite
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: vgem_basic
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_plane_lowres
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_vrr
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: syncobj_wait
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_exec_fence
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_chamelium_frames
results: parsing output: 42/ for test: kms_plane_scaling
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: i915_pm_rc6_residency
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: i915_suspend
results: parsing output: 63/ for test: i915_module_load
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: gem_exec_capture
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: gem_exec_parallel
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_ctx_sseu
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: dumb_buffer
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_pipe_stress
results: parsing output: 105/ for test: gem_softpin
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_scaling_modes
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: perf
results: parsing output: 115/ for test: gem_exec_reloc
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_ctx_exec
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.