[53.940835] Initializing watchdogs
[53.940883]   /dev/watchdog0
[53.954376] [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]
[53.958477] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[53.960684] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[53.963926] [001/131] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[58.948453] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[58.955813] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.006s)
[59.810984] [002/131] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[59.909047] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[59.911401] Starting dynamic subtest: pipe-A-eDP-1
[60.349328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[60.356768] Starting dynamic subtest: pipe-B-eDP-1
[61.719067] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.368s)
[61.725589] Starting dynamic subtest: pipe-C-eDP-1
[63.115221] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[63.121698] Starting dynamic subtest: pipe-D-eDP-1
[64.451754] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[64.454110] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.505s)
[65.630594] [003/131] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[65.715055] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[65.717457] Starting dynamic subtest: pipe-A
[66.068956] Dynamic subtest pipe-A: SUCCESS (0.353s)
[66.077955] Starting dynamic subtest: pipe-B
[67.451030] Dynamic subtest pipe-B: SUCCESS (1.381s)
[67.459575] Starting dynamic subtest: pipe-C
[68.861248] Dynamic subtest pipe-C: SUCCESS (1.409s)
[68.874121] Starting dynamic subtest: pipe-D
[70.294432] Dynamic subtest pipe-D: SUCCESS (1.431s)
[70.296967] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.575s)
[71.488458] [004/131] (943s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[71.633926] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[72.502863] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.871s)
[72.638417] [005/131] (942s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[72.727959] Starting subtest: plane-primary-toggle-with-vblank-wait
[72.730277] Starting dynamic subtest: pipe-A-eDP-1
[72.901109] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[73.215720] Starting dynamic subtest: pipe-B-eDP-1
[74.076748] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.868s)
[74.392542] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.664s)
[75.231984] [006/131] (939s left) drm_read (fault-buffer)
[75.371556] Starting subtest: fault-buffer
[75.374022] Subtest fault-buffer: SUCCESS (0.000s)
[75.514813] [007/131] (939s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[75.611083] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[79.907529] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.300s)
[81.051149] [008/131] (933s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[81.143741] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[81.145908] Starting dynamic subtest: pipe-A-default-mode
[81.433078] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[81.437699] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s)
[82.267675] [009/131] (932s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[82.358826] Starting subtest: fbc-psr2-sprite-mmap-gtt
[82.361020] Starting dynamic subtest: eDP-1
[82.364844] Dynamic subtest eDP-1: SKIP (0.000s)
[82.368715] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[82.426714] [010/131] (932s left) kms_psr (pr-cursor-mmap-cpu)
[82.519419] Starting subtest: pr-cursor-mmap-cpu
[82.523997] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[82.590315] [011/131] (932s left) gem_ctx_param (invalid-get-engines)
[82.639582] Starting subtest: invalid-get-engines
[82.642046] Subtest invalid-get-engines: SUCCESS (0.001s)
[82.768990] [012/131] (932s left) i915_hangman (detector)
[82.830807] Starting subtest: detector
[82.832796] Starting dynamic subtest: rcs0
[93.874968] Dynamic subtest rcs0: SUCCESS (11.042s)
[93.884341] Starting dynamic subtest: bcs0
[105.843461] Dynamic subtest bcs0: SUCCESS (11.966s)
[105.856217] Starting dynamic subtest: vcs0
[117.874849] Dynamic subtest vcs0: SUCCESS (12.029s)
[117.885164] Starting dynamic subtest: vcs1
[129.843246] Dynamic subtest vcs1: SUCCESS (11.966s)
[129.852810] Starting dynamic subtest: vecs0
[141.810415] Dynamic subtest vecs0: SUCCESS (11.965s)
[141.820302] Starting dynamic subtest: ccs0
[153.841267] Dynamic subtest ccs0: SUCCESS (12.030s)
[153.843729] Subtest detector: SUCCESS (71.004s)
[153.916354] [013/131] (861s left) kms_rmfb (close-fd)
[154.015074] Starting subtest: close-fd
[154.017071] Starting dynamic subtest: pipe-A-eDP-1
[154.120423] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[154.128232] Starting dynamic subtest: pipe-B-eDP-1
[155.330842] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[155.339700] Starting dynamic subtest: pipe-C-eDP-1
[156.472137] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s)
[156.481489] Starting dynamic subtest: pipe-D-eDP-1
[157.593120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[157.595059] Subtest close-fd: SUCCESS (3.578s)
[158.802681] [014/131] (856s left) kms_pm_lpsp (kms-lpsp)
[159.904080] Starting subtest: kms-lpsp
[159.906445] Starting dynamic subtest: pipe-A-eDP-1
[160.037027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.136s)
[160.324868] Subtest kms-lpsp: SUCCESS (0.422s)
[161.135287] [015/131] (853s left) kms_frontbuffer_tracking (fbc-suspend)
[161.234179] Starting subtest: fbc-suspend
[198.894376] Subtest fbc-suspend: SUCCESS (7.266s)
[200.082318] [016/131] (814s left) gem_linear_blits (interruptible)
[200.360240] Starting subtest: interruptible
[204.127702] Subtest interruptible: SUCCESS (3.752s)
[204.231885] [017/131] (810s left) gem_pxp (create-regular-context-1)
[204.387824] Starting subtest: create-regular-context-1
[204.390533] Subtest create-regular-context-1: SUCCESS (0.002s)
[204.507219] [018/131] (810s left) i915_pm_rps (reset)
[204.579013] Starting subtest: reset
[204.661543] Subtest reset: FAIL (0.027s)
[204.733878] [019/131] (810s left) gem_madvise (dontneed-after-mmap)
[204.765281] Starting subtest: dontneed-after-mmap
[204.796065] Subtest dontneed-after-mmap: SUCCESS (0.031s)
[204.900268] [020/131] (810s left) kms_cursor_legacy (torture-bo)
[205.020046] Starting subtest: torture-bo
[205.021884] Starting dynamic subtest: pipe-A
[210.668991] Dynamic subtest pipe-A: SUCCESS (5.623s)
[210.678140] Starting dynamic subtest: pipe-B
[217.454156] Dynamic subtest pipe-B: SUCCESS (6.790s)
[217.466823] Starting dynamic subtest: pipe-C
[224.280717] Dynamic subtest pipe-C: SUCCESS (6.819s)
[224.290889] Starting dynamic subtest: pipe-D
[232.614816] Dynamic subtest pipe-D: SUCCESS (8.333s)
[232.626622] Starting dynamic subtest: all-pipes
[240.093296] Dynamic subtest all-pipes: SUCCESS (7.479s)
[240.096004] Subtest torture-bo: SUCCESS (35.049s)
[240.245586] [021/131] (774s left) syncobj_timeline (wait-all-for-submit-snapshot)
[240.318856] Starting subtest: wait-all-for-submit-snapshot
[240.400754] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[240.476068] [022/131] (774s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[240.587569] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[240.598972] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[240.716891] [023/131] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[240.824530] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[248.157233] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.336s)
[248.301600] [024/131] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[248.411359] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[248.415646] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[248.511303] [025/131] (766s left) kms_cursor_crc (cursor-suspend)
[248.636762] Starting subtest: cursor-suspend
[248.639377] Starting dynamic subtest: pipe-A-eDP-1
[281.110258] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.081s)
[281.120785] Starting dynamic subtest: pipe-D-eDP-1
[314.081140] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.594s)
[314.083565] Subtest cursor-suspend: SUCCESS (6.677s)
[314.886262] [026/131] (700s left) kms_lease (lease-invalid-connector)
[314.992326] Starting subtest: lease-invalid-connector
[314.994625] Starting dynamic subtest: pipe-A-eDP-1
[314.997037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[315.006205] Starting dynamic subtest: pipe-B-eDP-1
[315.008498] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[315.016588] Starting dynamic subtest: pipe-C-eDP-1
[315.018956] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[315.027717] Starting dynamic subtest: pipe-D-eDP-1
[315.031785] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[315.034006] Subtest lease-invalid-connector: SUCCESS (0.003s)
[315.068275] [027/131] (700s left) gem_mmap_wc (pf-nonblock)
[315.117816] Subtest pf-nonblock: SKIP (0.000s)
[315.179976] [028/131] (700s left) kms_cursor_crc (cursor-onscreen-max-size)
[315.470967] Starting subtest: cursor-onscreen-max-size
[315.477665] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[315.595569] [029/131] (699s left) gem_userptr_blits (relocations)
[315.659977] Starting subtest: relocations
[315.664415] Subtest relocations: SKIP (0.000s)
[315.794261] [030/131] (699s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[315.897761] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[315.901610] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[315.992974] [031/131] (699s left) kms_atomic_transition (modeset-transition-nonblocking)
[316.086632] Starting subtest: modeset-transition-nonblocking
[316.088503] Starting dynamic subtest: 1x-outputs
[326.895234] Dynamic subtest 1x-outputs: SUCCESS (10.774s)
[327.176665] Subtest modeset-transition-nonblocking: SUCCESS (11.056s)
[328.023070] [032/131] (687s left) kms_content_protection (dp-mst-type-1)
[328.162940] Starting subtest: dp-mst-type-1
[328.167614] Subtest dp-mst-type-1: SKIP (0.000s)
[328.302363] [033/131] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[328.392676] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[328.396788] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[328.495644] [034/131] (687s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[328.592073] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[328.594294] Starting dynamic subtest: pipe-A-eDP-1
[328.738710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[328.747418] Starting dynamic subtest: pipe-B-eDP-1
[328.766513] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[328.774761] Starting dynamic subtest: pipe-C-eDP-1
[328.795163] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[328.805317] Starting dynamic subtest: pipe-D-eDP-1
[328.824361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[328.826243] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.175s)
[331.000699] [035/131] (684s left) prime_busy (before-wait)
[331.060208] Starting subtest: before-wait
[331.065908] Starting dynamic subtest: rcs0
[331.116911] Dynamic subtest rcs0: SUCCESS (0.053s)
[331.127741] Starting dynamic subtest: bcs0
[331.175894] Dynamic subtest bcs0: SUCCESS (0.058s)
[331.186246] Starting dynamic subtest: vcs0
[331.216610] Dynamic subtest vcs0: SUCCESS (0.040s)
[331.225602] Starting dynamic subtest: vcs1
[331.256779] Dynamic subtest vcs1: SUCCESS (0.040s)
[331.265788] Starting dynamic subtest: vecs0
[331.297568] Dynamic subtest vecs0: SUCCESS (0.040s)
[331.306761] Starting dynamic subtest: ccs0
[331.338140] Dynamic subtest ccs0: SUCCESS (0.040s)
[331.446815] Subtest before-wait: SUCCESS (0.384s)
[331.520830] [036/131] (684s left) kms_flip (2x-blocking-absolute-wf_vblank)
[331.621552] Starting subtest: 2x-blocking-absolute-wf_vblank
[331.629824] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[331.758199] [037/131] (684s left) gem_ccs (ctrl-surf-copy-new-ctx)
[331.816628] Starting subtest: ctrl-surf-copy-new-ctx
[331.821210] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[331.927521] [038/131] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[332.026609] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[332.031028] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[332.135566] [039/131] (683s left) kms_dp_linktrain_fallback (dp-fallback)
[332.234508] Starting subtest: dp-fallback
[332.240825] Subtest dp-fallback: SKIP (0.000s)
[332.304562] [040/131] (683s left) kms_rmfb (rmfb-ioctl)
[332.402084] Starting subtest: rmfb-ioctl
[332.404016] Starting dynamic subtest: pipe-A-eDP-1
[332.506231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[332.516283] Starting dynamic subtest: pipe-B-eDP-1
[333.679568] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[333.688622] Starting dynamic subtest: pipe-C-eDP-1
[334.886586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[334.894849] Starting dynamic subtest: pipe-D-eDP-1
[336.027441] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[336.029790] Subtest rmfb-ioctl: SUCCESS (3.626s)
[337.250687] [041/131] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[337.343999] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[337.348205] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.448460] [042/131] (678s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[337.541083] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[337.543385] Starting dynamic subtest: pipe-A-default-mode
[337.829669] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[337.834224] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.289s)
[338.678347] [043/131] (677s left) gen9_exec_parse (unaligned-jump)
[338.743286] Subtest unaligned-jump: SKIP (0.000s)
[338.815764] [044/131] (677s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[338.914762] Starting subtest: y-tiled-64bpp-rotate-180
[338.918991] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[339.026930] [045/131] (677s left) gem_workarounds (basic-read)
[339.101135] Starting subtest: basic-read
[339.115600] Subtest basic-read: SUCCESS (0.014s)
[339.262978] [046/131] (676s left) kms_scaling_modes (scaling-mode-none)
[339.355244] Starting subtest: scaling-mode-none
[339.357406] Starting dynamic subtest: pipe-A-eDP-1
[339.449233] Dynamic subtest pipe-A-eDP-1: SKIP (0.093s)
[339.459447] Starting dynamic subtest: pipe-B-eDP-1
[339.486174] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[339.494681] Starting dynamic subtest: pipe-C-eDP-1
[339.517621] Dynamic subtest pipe-C-eDP-1: SKIP (0.030s)
[339.526762] Starting dynamic subtest: pipe-D-eDP-1
[339.548500] Dynamic subtest pipe-D-eDP-1: SKIP (0.030s)
[339.553469] Subtest scaling-mode-none: SKIP (0.193s)
[339.682172] [047/131] (676s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[340.068380] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[340.889625] [048/131] (675s left) perf (per-context-mode-unprivileged)
[341.022788] Starting subtest: per-context-mode-unprivileged
[341.027195] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[341.067961] [049/131] (675s left) kms_async_flips (alternate-sync-async-flip-atomic)
[341.161267] Starting subtest: alternate-sync-async-flip-atomic
[341.531970] Starting dynamic subtest: pipe-A-eDP-1
[344.308350] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.776s)
[344.677226] Starting dynamic subtest: pipe-B-eDP-1
[347.445202] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.779s)
[347.809225] Starting dynamic subtest: pipe-C-eDP-1
[350.579636] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.778s)
[350.942327] Starting dynamic subtest: pipe-D-eDP-1
[353.699481] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[353.701567] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.544s)
[354.864544] [050/131] (661s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[354.967297] Starting subtest: basic-max-pipe-crc-check
[354.971987] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[355.010889] [051/131] (661s left) gem_exec_reloc (basic-write-gtt-active)
[355.083980] Subtest basic-write-gtt-active: SKIP (0.000s)
[355.170434] [052/131] (661s left) gem_lmem_swapping (massive-random)
[355.212401] Subtest massive-random: SKIP (0.000s)
[355.259335] [053/131] (661s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[355.350158] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[355.352463] Starting dynamic subtest: pipe-A-eDP-1
[355.375108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.385938] Starting dynamic subtest: pipe-B-eDP-1
[355.406879] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.415333] Starting dynamic subtest: pipe-C-eDP-1
[355.437270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.446845] Starting dynamic subtest: pipe-D-eDP-1
[355.468675] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.473022] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[357.558615] [054/131] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[357.654705] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[361.369077] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.718s)
[362.568617] [055/131] (653s left) sw_sync (alloc_fence_invalid_timeline)
[362.606132] Starting subtest: alloc_fence_invalid_timeline
[362.608632] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[362.659633] [056/131] (653s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[363.241555] Starting subtest: syncobj-backward-timeline-chain-engines
[363.332274] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.092s)
[365.143142] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[365.147413] [057/131] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[365.249771] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[365.254231] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[365.354925] [058/131] (651s left) gem_exec_schedule (submit-late-slice)
[365.431986] Starting subtest: submit-late-slice
[365.434300] Starting dynamic subtest: rcs0
[365.461683] Dynamic subtest rcs0: SUCCESS (0.037s)
[365.472169] Starting dynamic subtest: bcs0
[365.494930] Dynamic subtest bcs0: SUCCESS (0.033s)
[365.503979] Starting dynamic subtest: vcs0
[365.526360] Dynamic subtest vcs0: SUCCESS (0.031s)
[365.535063] Starting dynamic subtest: vcs1
[365.555167] Dynamic subtest vcs1: SUCCESS (0.028s)
[365.564468] Starting dynamic subtest: vecs0
[365.584235] Dynamic subtest vecs0: SUCCESS (0.028s)
[365.594205] Starting dynamic subtest: ccs0
[365.614964] Dynamic subtest ccs0: SUCCESS (0.030s)
[365.617420] Subtest submit-late-slice: SUCCESS (0.191s)
[367.125393] [059/131] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[367.220706] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[371.513746] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.296s)
[372.671237] [060/131] (644s left) gem_mmap_wc (write)
[372.723004] Subtest write: SKIP (0.000s)
[372.786905] [061/131] (643s left) kms_psr (pr-primary-render)
[372.889211] Starting subtest: pr-primary-render
[372.893257] Subtest pr-primary-render: SKIP (0.000s)
[372.961106] [062/131] (643s left) gem_exec_reloc (basic-cpu-gtt-active)
[373.020222] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[373.107592] [063/131] (643s left) gem_exec_whisper (basic-fds-forked-all)
[373.171016] Starting subtest: basic-fds-forked-all
[393.087251] Subtest basic-fds-forked-all: SUCCESS (19.909s)
[393.275293] [064/131] (623s left) kms_plane_lowres (tiling-yf)
[393.381245] Starting subtest: tiling-yf
[393.385291] Subtest tiling-yf: SKIP (0.000s)
[393.451824] [065/131] (623s left) kms_flip (dpms-vs-vblank-race)
[393.557001] Starting subtest: dpms-vs-vblank-race
[393.558896] Starting dynamic subtest: A-eDP1
[397.447360] Dynamic subtest A-eDP1: SUCCESS (3.890s)
[397.456043] Starting dynamic subtest: B-eDP1
[402.068007] Dynamic subtest B-eDP1: SUCCESS (4.617s)
[402.077261] Starting dynamic subtest: C-eDP1
[406.668878] Dynamic subtest C-eDP1: SUCCESS (4.598s)
[406.677785] Starting dynamic subtest: D-eDP1
[411.313647] Dynamic subtest D-eDP1: SUCCESS (4.644s)
[411.315633] Subtest dpms-vs-vblank-race: SUCCESS (17.759s)
[412.178972] [066/131] (604s left) gem_ctx_shared (q-independent)
[412.244554] Starting subtest: Q-independent
[412.246930] Starting dynamic subtest: rcs0
[412.309937] Dynamic subtest rcs0: SUCCESS (0.065s)
[412.321951] Starting dynamic subtest: vcs0
[412.347098] Dynamic subtest vcs0: SUCCESS (0.037s)
[412.358913] Starting dynamic subtest: vcs1
[412.383661] Dynamic subtest vcs1: SUCCESS (0.036s)
[412.393103] Starting dynamic subtest: vecs0
[412.420312] Dynamic subtest vecs0: SUCCESS (0.036s)
[412.429573] Starting dynamic subtest: ccs0
[412.463611] Dynamic subtest ccs0: SUCCESS (0.043s)
[412.465988] Subtest Q-independent: SUCCESS (0.219s)
[414.131477] [067/131] (602s left) kms_psr (psr-cursor-plane-move)
[414.220406] Starting subtest: psr-cursor-plane-move
[414.222707] Starting dynamic subtest: eDP-1
[415.972015] Dynamic subtest eDP-1: SUCCESS (1.754s)
[415.974327] Subtest psr-cursor-plane-move: SUCCESS (1.754s)
[416.840350] [068/131] (600s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[416.896303] Starting subtest: invalid-bsd1-flag-on-vebox
[416.898754] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[417.010994] [069/131] (600s left) kms_flip (flip-vs-wf_vblank-interruptible)
[417.115362] Starting subtest: flip-vs-wf_vblank-interruptible
[417.117661] Starting dynamic subtest: A-eDP1
[418.999525] Dynamic subtest A-eDP1: SUCCESS (1.873s)
[419.009046] Starting dynamic subtest: B-eDP1
[420.914046] Dynamic subtest B-eDP1: SUCCESS (1.924s)
[420.923076] Starting dynamic subtest: C-eDP1
[422.830773] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[422.841660] Starting dynamic subtest: D-eDP1
[424.757260] Dynamic subtest D-eDP1: SUCCESS (1.926s)
[424.759584] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.646s)
[425.980169] [070/131] (591s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[426.040418] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[426.044925] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[426.218718] [071/131] (590s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[426.321243] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[429.916621] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.600s)
[431.100815] [072/131] (586s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[436.138815] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[436.143553] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[436.995956] [073/131] (580s left) syncobj_timeline (signal-point-0)
[437.060732] Starting subtest: signal-point-0
[437.063136] Subtest signal-point-0: SUCCESS (0.000s)
[437.154784] [074/131] (580s left) api_intel_bb (bb-with-allocator)
[437.198798] Starting subtest: bb-with-allocator
[437.204246] Subtest bb-with-allocator: SUCCESS (0.005s)
[437.336353] [075/131] (579s left) gem_exec_balancer (full-late)
[437.397056] Starting subtest: full-late
[441.799837] Subtest full-late: SUCCESS (4.403s)
[442.148749] [076/131] (575s left) kms_chamelium_frames (hdmi-frame-dump)
[442.525417] Subtest hdmi-frame-dump: SKIP (0.000s)
[443.303072] [077/131] (574s left) gem_wait (write-busy)
[443.372666] Starting subtest: write-busy
[443.375033] Starting dynamic subtest: all-engines
[444.014099] Dynamic subtest all-engines: SUCCESS (0.641s)
[444.026013] Starting dynamic subtest: rcs0
[444.580649] Dynamic subtest rcs0: SUCCESS (0.565s)
[444.597833] Starting dynamic subtest: bcs0
[445.134590] Dynamic subtest bcs0: SUCCESS (0.553s)
[445.148776] Starting dynamic subtest: vcs0
[447.031258] Dynamic subtest vcs0: SUCCESS (1.894s)
[447.045947] Starting dynamic subtest: vcs1
[449.026951] Dynamic subtest vcs1: SUCCESS (1.979s)
[449.036808] Starting dynamic subtest: vecs0
[451.060964] Dynamic subtest vecs0: SUCCESS (2.047s)
[451.074346] Starting dynamic subtest: ccs0
[451.611083] Dynamic subtest ccs0: SUCCESS (0.549s)
[451.613649] Subtest write-busy: SUCCESS (8.238s)
[451.809479] [078/131] (565s left) kms_chamelium_frames (dp-crc-fast)
[452.191697] Subtest dp-crc-fast: SKIP (0.000s)
[453.028257] [079/131] (564s left) dumb_buffer (map-valid)
[453.079602] Starting subtest: map-valid
[453.081759] Subtest map-valid: SUCCESS (0.000s)
[453.177369] [080/131] (564s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[453.275791] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[453.279869] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[453.371848] [081/131] (564s left) syncobj_basic (bad-pad-fd-to-handle)
[453.421290] Starting subtest: bad-pad-fd-to-handle
[453.423605] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[453.516607] [082/131] (564s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[453.560107] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[453.666442] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[453.742928] [083/131] (563s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[453.829749] Starting subtest: psr-rgb565-draw-mmap-wc
[460.522678] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.697s)
[460.611806] [084/131] (557s left) kms_rotation_crc (bad-pixel-format)
[460.713402] Starting subtest: bad-pixel-format
[460.717468] Subtest bad-pixel-format: SKIP (0.001s)
[460.794892] [085/131] (556s left) kms_vblank (wait-idle-hang)
[460.899420] Starting subtest: wait-idle-hang
[460.901288] Starting dynamic subtest: pipe-A-eDP-1
[487.782485] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.879s)
[487.796201] Starting dynamic subtest: pipe-D-eDP-1
[513.770663] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.980s)
[513.773552] Subtest wait-idle-hang: SUCCESS (52.863s)
[514.614371] [086/131] (503s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[514.675114] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[514.746929] [087/131] (503s left) syncobj_wait (wait-all-for-submit-snapshot)
[514.800699] Starting subtest: wait-all-for-submit-snapshot
[514.883319] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[514.962548] [088/131] (502s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[515.073588] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[545.912054] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.834s)
[546.751068] [089/131] (471s left) gem_workarounds (suspend-resume-context)
[546.812241] Starting subtest: suspend-resume-context
[562.665048] Subtest suspend-resume-context: SUCCESS (1.172s)
[562.811915] [090/131] (455s left) sysfs_heartbeat_interval (precise)
[562.877707] Starting subtest: precise
[562.879999] Starting dynamic subtest: vecs0
[570.722623] Dynamic subtest vecs0: SUCCESS (7.801s)
[570.734809] Starting dynamic subtest: ccs0
[573.450998] Dynamic subtest ccs0: SUCCESS (2.721s)
[573.463589] Starting dynamic subtest: vcs0
[580.697506] Dynamic subtest vcs0: SUCCESS (7.233s)
[580.709098] Starting dynamic subtest: bcs0
[583.532012] Dynamic subtest bcs0: SUCCESS (2.828s)
[583.542749] Starting dynamic subtest: rcs0
[584.620139] Dynamic subtest rcs0: SUCCESS (1.087s)
[584.630163] Starting dynamic subtest: vcs1
[591.719552] Dynamic subtest vcs1: SUCCESS (7.092s)
[591.722075] Subtest precise: SUCCESS (28.772s)
[591.797784] [091/131] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[591.897681] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[591.901730] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[592.005758] [092/131] (425s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[592.090901] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[592.094853] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[592.205221] [093/131] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[592.300889] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[599.121546] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (6.818s)
[599.244226] [094/131] (418s left) gem_sync (basic-all)
[599.334260] Starting subtest: basic-all
[601.492574] Subtest basic-all: SUCCESS (2.168s)
[601.675497] [095/131] (416s left) kms_plane_scaling (planes-scaler-unity-scaling)
[601.774265] Starting subtest: planes-scaler-unity-scaling
[601.776566] Starting dynamic subtest: pipe-A
[601.839258] Dynamic subtest pipe-A: SUCCESS (0.067s)
[601.849921] Starting dynamic subtest: pipe-B
[603.006952] Dynamic subtest pipe-B: SUCCESS (1.166s)
[603.016815] Starting dynamic subtest: pipe-C
[604.108568] Dynamic subtest pipe-C: SUCCESS (1.100s)
[604.118687] Starting dynamic subtest: pipe-D
[605.239048] Dynamic subtest pipe-D: SUCCESS (1.129s)
[605.241486] Subtest planes-scaler-unity-scaling: SUCCESS (3.466s)
[606.410818] [096/131] (411s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[606.514768] Starting subtest: yf-tiled-16bpp-rotate-180
[606.518819] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[606.632181] [097/131] (411s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[606.684214] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[606.752738] [098/131] (411s left) gem_exec_balancer (parallel-contexts)
[607.000505] Starting subtest: parallel-contexts
[609.571997] Subtest parallel-contexts: SUCCESS (2.569s)
[610.743653] [099/131] (407s left) gem_ctx_param (invalid-set-no-zeromap)
[610.784238] Starting subtest: invalid-set-no-zeromap
[610.786685] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[610.858567] [100/131] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[610.967949] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[610.972273] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[611.079345] [101/131] (407s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[611.172263] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[611.174662] Starting dynamic subtest: pipe-A-eDP-1
[611.199890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[611.210949] Starting dynamic subtest: pipe-B-eDP-1
[611.235429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[611.247450] Starting dynamic subtest: pipe-C-eDP-1
[611.271673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[611.280791] Starting dynamic subtest: pipe-D-eDP-1
[611.305178] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[611.309233] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[613.387273] [102/131] (404s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[613.446795] Starting subtest: etime-single-wait-available-unsubmitted
[613.554224] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[613.633469] [103/131] (404s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[613.690163] Starting subtest: invalid-signal-one-illegal-handle
[613.692498] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[613.799870] [104/131] (404s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[613.855038] Starting subtest: mixed-tiled-to-y-tiled-ccs
[613.859635] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[614.044404] [105/131] (404s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[614.102880] Starting subtest: framebuffer-vs-set-tiling
[614.107452] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[614.246572] [106/131] (404s left) gem_mmap_gtt (cpuset-big-copy-xy)
[614.309196] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[614.373934] [107/131] (404s left) gem_userptr_blits (nohangcheck)
[614.439429] Starting subtest: nohangcheck
[614.696244] Subtest nohangcheck: SUCCESS (0.254s)
[614.821422] [108/131] (403s left) api_intel_bb (simple-bb-ctx)
[614.870647] Starting subtest: simple-bb-ctx
[614.877700] Subtest simple-bb-ctx: SUCCESS (0.008s)
[615.001760] [109/131] (403s left) kms_sequence (queue-idle)
[615.098321] Starting subtest: queue-idle
[615.100560] Starting dynamic subtest: pipe-A-eDP-1
[616.888422] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.789s)
[616.899477] Starting dynamic subtest: pipe-B-eDP-1
[619.347236] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.457s)
[619.357665] Starting dynamic subtest: pipe-C-eDP-1
[621.768197] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.419s)
[621.778971] Starting dynamic subtest: pipe-D-eDP-1
[624.220214] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.448s)
[624.222516] Subtest queue-idle: SUCCESS (9.117s)
[625.028956] [110/131] (393s left) perf_pmu (busy-accuracy-2)
[625.066681] Starting subtest: busy-accuracy-2
[625.069004] Starting dynamic subtest: rcs0
[628.106515] Dynamic subtest rcs0: SUCCESS (3.036s)
[628.118441] Starting dynamic subtest: bcs0
[631.168828] Dynamic subtest bcs0: SUCCESS (3.058s)
[631.180338] Starting dynamic subtest: vcs0
[634.213200] Dynamic subtest vcs0: SUCCESS (3.041s)
[634.223625] Starting dynamic subtest: vcs1
[637.260923] Dynamic subtest vcs1: SUCCESS (3.044s)
[637.270191] Starting dynamic subtest: vecs0
[640.308280] Dynamic subtest vecs0: SUCCESS (3.044s)
[640.319549] Starting dynamic subtest: ccs0
[643.365770] Dynamic subtest ccs0: SUCCESS (3.054s)
[643.368626] Subtest busy-accuracy-2: SUCCESS (18.288s)
[643.499990] [111/131] (375s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[643.554509] Subtest writes-after-reads-snoop: SKIP (0.000s)
[643.621999] [112/131] (375s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[643.726648] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[643.836221] [113/131] (374s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[643.927463] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[643.929605] Starting dynamic subtest: pipe-A-eDP-1
[643.962986] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.971686] Starting dynamic subtest: pipe-B-eDP-1
[643.999539] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[644.011079] Starting dynamic subtest: pipe-C-eDP-1
[644.034170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[644.043772] Starting dynamic subtest: pipe-D-eDP-1
[644.066002] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[644.070109] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[646.115732] [114/131] (372s left) gem_exec_schedule (out-order)
[646.181607] Starting subtest: out-order
[646.183491] Starting dynamic subtest: rcs0
[646.271991] Dynamic subtest rcs0: SUCCESS (0.098s)
[646.283305] Starting dynamic subtest: vcs0
[646.350051] Dynamic subtest vcs0: SUCCESS (0.078s)
[646.361436] Starting dynamic subtest: vcs1
[646.424801] Dynamic subtest vcs1: SUCCESS (0.074s)
[646.438585] Starting dynamic subtest: vecs0
[646.497266] Dynamic subtest vecs0: SUCCESS (0.072s)
[646.511424] Starting dynamic subtest: ccs0
[646.576270] Dynamic subtest ccs0: SUCCESS (0.078s)
[646.579019] Subtest out-order: SUCCESS (0.403s)
[647.803511] [115/131] (371s left) gem_exec_fence (syncobj-timeline-repeat)
[648.348672] Starting subtest: syncobj-timeline-repeat
[648.566677] Subtest syncobj-timeline-repeat: SUCCESS (0.218s)
[649.831030] [116/131] (369s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[649.933898] Starting subtest: psr-1p-primscrn-cur-indfb-move
[657.105976] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.170s)
[657.252784] [117/131] (361s left) kms_big_fb (linear-8bpp-rotate-90)
[657.346625] Starting subtest: linear-8bpp-rotate-90
[657.366643] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[657.504805] [118/131] (361s left) gem_mmap_gtt (medium-copy-odd)
[657.562527] Subtest medium-copy-odd: SKIP (0.000s)
[657.623366] [119/131] (361s left) kms_getfb (getfb2-into-addfb2)
[657.706691] Starting subtest: getfb2-into-addfb2
[657.708882] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[657.812011] [120/131] (361s left) kms_prop_blob (invalid-get-prop-any)
[657.866441] Starting subtest: invalid-get-prop-any
[657.868680] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[657.971935] [121/131] (361s left) gem_exec_schedule (preempt-queue-contexts-chain)
[658.036126] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[658.331725] [122/131] (360s left) kms_psr (fbc-pr-sprite-render)
[658.422341] Starting subtest: fbc-pr-sprite-render
[658.426897] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[658.496827] [123/131] (360s left) perf (invalid-remove-userspace-config)
[658.571607] Starting subtest: invalid-remove-userspace-config
[658.581130] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[658.622665] [124/131] (360s left) gem_userptr_blits (forbidden-operations)
[658.682445] Starting subtest: forbidden-operations
[658.686583] Subtest forbidden-operations: SKIP (0.000s)
[658.819946] [125/131] (360s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[658.946202] Starting subtest: cursorA-vs-flipA-atomic-transitions
[670.127709] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.188s)
[670.952007] [126/131] (348s left) perf_pmu (enable-race)
[670.997347] Starting subtest: enable-race
[670.999715] Starting dynamic subtest: rcs0
[683.761756] Dynamic subtest rcs0: SUCCESS (12.767s)
[683.771713] Starting dynamic subtest: bcs0
[696.496304] Dynamic subtest bcs0: SUCCESS (12.733s)
[696.505764] Starting dynamic subtest: vcs0
[711.693592] Dynamic subtest vcs0: SUCCESS (15.191s)
[711.706270] Starting dynamic subtest: vcs1
[727.693581] Dynamic subtest vcs1: SUCCESS (15.994s)
[727.704695] Starting dynamic subtest: vecs0
[743.693693] Dynamic subtest vecs0: SUCCESS (15.993s)
[743.704668] Starting dynamic subtest: ccs0
[756.543461] Dynamic subtest ccs0: SUCCESS (12.845s)
[756.545956] Subtest enable-race: SUCCESS (85.535s)
[756.671792] [127/131] (262s left) kms_joiner (basic-force-big-joiner)
[756.786208] Starting subtest: basic-force-big-joiner
[756.788367] Starting dynamic subtest: single
[760.108120] Dynamic subtest single: SUCCESS (3.328s)
[760.110439] Subtest basic-force-big-joiner: SUCCESS (3.329s)
[761.281546] [128/131] (258s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[761.388552] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[762.311442] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.924s)
[762.456371] [129/131] (256s left) i915_pm_rpm (gem-execbuf)
[763.981570] Starting subtest: gem-execbuf
[763.984185] Starting dynamic subtest: smem0
[766.073068] Dynamic subtest smem0: SUCCESS (2.090s)
[766.075402] Subtest gem-execbuf: SUCCESS (2.092s)
[766.164597] [130/131] (253s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[766.265884] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[772.880761] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.617s)
[772.996775] [131/131] (246s left) gem_basic (create-close)
[773.050601] Starting subtest: create-close
[773.054606] Subtest create-close: SUCCESS (0.000s)
[773.159076] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: drm_read
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: i915_hangman
results: parsing output: 12/ for test: kms_rmfb
results: parsing output: 13/ for test: kms_pm_lpsp
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_linear_blits
results: parsing output: 16/ for test: gem_pxp
results: parsing output: 17/ for test: i915_pm_rps
results: parsing output: 18/ for test: gem_madvise
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_flip
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_cursor_crc
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_busy
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_dp_linktrain_fallback
results: parsing output: 39/ for test: kms_rmfb
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_workarounds
results: parsing output: 45/ for test: kms_scaling_modes
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_multipipe_modeset
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: gem_lmem_swapping
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_mmap_wc
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: gem_exec_whisper
results: parsing output: 63/ for test: kms_plane_lowres
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_ctx_shared
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_params
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: dumb_buffer
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_pipe_b_c_ivb
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_cursor_legacy
results: parsing output: 88/ for test: gem_workarounds
results: parsing output: 89/ for test: sysfs_heartbeat_interval
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_render_copy
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: kms_sequence
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: gem_partial_pwrite_pread
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_exec_fence
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: kms_getfb
results: parsing output: 119/ for test: kms_prop_blob
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_joiner
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: i915_pm_rpm
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_basic
Done.