[55.712560] Initializing watchdogs
[55.712623]   /dev/watchdog0
[55.727095] [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]
[55.731758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.734063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.737290] [001/131] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[60.845277] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[60.850160] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[61.698862] [002/131] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[61.810543] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[61.813235] Starting dynamic subtest: pipe-A-eDP-1
[62.347647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.502s)
[62.356347] Starting dynamic subtest: pipe-B-eDP-1
[63.727188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s)
[63.736523] Starting dynamic subtest: pipe-C-eDP-1
[65.132291] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[65.141245] Starting dynamic subtest: pipe-D-eDP-1
[66.462542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[66.464554] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.591s)
[67.658246] [003/131] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[67.753110] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[67.755670] Starting dynamic subtest: pipe-A
[68.097336] Dynamic subtest pipe-A: SUCCESS (0.343s)
[68.105411] Starting dynamic subtest: pipe-B
[69.490300] Dynamic subtest pipe-B: SUCCESS (1.387s)
[69.498525] Starting dynamic subtest: pipe-C
[70.923684] Dynamic subtest pipe-C: SUCCESS (1.430s)
[70.932122] Starting dynamic subtest: pipe-D
[72.346804] Dynamic subtest pipe-D: SUCCESS (1.420s)
[72.349074] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.580s)
[73.511087] [004/131] (942s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[73.617395] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[74.431506] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[74.622858] [005/131] (941s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[74.717854] Starting subtest: plane-primary-toggle-with-vblank-wait
[74.720141] Starting dynamic subtest: pipe-A-eDP-1
[74.900564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[75.198798] Starting dynamic subtest: pipe-B-eDP-1
[76.129512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.938s)
[76.427742] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.703s)
[77.281755] [006/131] (939s left) drm_read (fault-buffer)
[77.430496] Starting subtest: fault-buffer
[77.433068] Subtest fault-buffer: SUCCESS (0.000s)
[77.575238] [007/131] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[77.677745] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[81.979258] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.302s)
[83.186498] [008/131] (933s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[83.280371] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[83.283031] Starting dynamic subtest: pipe-A-default-mode
[83.571084] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[83.575901] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.287s)
[84.408646] [009/131] (932s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[84.507658] Starting subtest: fbc-psr2-sprite-mmap-gtt
[84.509747] Starting dynamic subtest: eDP-1
[84.514182] Dynamic subtest eDP-1: SKIP (0.000s)
[84.518644] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[84.577938] [010/131] (931s left) kms_psr (pr-cursor-mmap-cpu)
[84.675187] Starting subtest: pr-cursor-mmap-cpu
[84.679781] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[84.754219] [011/131] (931s left) gem_ctx_param (invalid-get-engines)
[84.804649] Starting subtest: invalid-get-engines
[84.807052] Subtest invalid-get-engines: SUCCESS (0.001s)
[84.922043] [012/131] (931s left) i915_hangman (detector)
[84.994831] Starting subtest: detector
[84.996868] Starting dynamic subtest: rcs0
[96.822088] Dynamic subtest rcs0: SUCCESS (11.821s)
[96.832244] Starting dynamic subtest: bcs0
[107.893770] Dynamic subtest bcs0: SUCCESS (11.068s)
[107.903844] Starting dynamic subtest: vcs0
[119.796349] Dynamic subtest vcs0: SUCCESS (11.900s)
[119.805452] Starting dynamic subtest: vcs1
[130.804740] Dynamic subtest vcs1: SUCCESS (11.007s)
[130.813708] Starting dynamic subtest: vecs0
[141.813264] Dynamic subtest vecs0: SUCCESS (11.006s)
[141.825199] Starting dynamic subtest: ccs0
[152.885075] Dynamic subtest ccs0: SUCCESS (11.070s)
[152.887938] Subtest detector: SUCCESS (67.877s)
[153.031182] [013/131] (863s left) kms_rmfb (close-fd)
[153.138050] Starting subtest: close-fd
[153.140383] Starting dynamic subtest: pipe-A-eDP-1
[153.248237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[153.257442] Starting dynamic subtest: pipe-B-eDP-1
[154.384070] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s)
[154.397251] Starting dynamic subtest: pipe-C-eDP-1
[155.518840] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[155.526016] Starting dynamic subtest: pipe-D-eDP-1
[156.644076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[156.646058] Subtest close-fd: SUCCESS (3.504s)
[157.769525] [014/131] (858s left) kms_pm_lpsp (kms-lpsp)
[158.881881] Starting subtest: kms-lpsp
[158.884278] Starting dynamic subtest: pipe-A-eDP-1
[159.033149] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[159.325782] Subtest kms-lpsp: SUCCESS (0.445s)
[160.199800] [015/131] (856s left) kms_frontbuffer_tracking (fbc-suspend)
[160.301834] Starting subtest: fbc-suspend
[197.660309] Subtest fbc-suspend: SUCCESS (7.283s)
[198.886276] [016/131] (817s left) gem_linear_blits (interruptible)
[199.220366] Starting subtest: interruptible
[203.339820] Subtest interruptible: SUCCESS (4.039s)
[203.497880] [017/131] (813s left) gem_pxp (create-regular-context-1)
[203.669078] Starting subtest: create-regular-context-1
[203.671937] Subtest create-regular-context-1: SUCCESS (0.002s)
[203.785334] [018/131] (813s left) i915_pm_rps (reset)
[203.846105] Starting subtest: reset
[203.937466] Subtest reset: FAIL (0.028s)
[204.021766] [019/131] (812s left) gem_madvise (dontneed-after-mmap)
[204.055013] Starting subtest: dontneed-after-mmap
[204.077470] Subtest dontneed-after-mmap: SUCCESS (0.022s)
[204.185176] [020/131] (812s left) kms_cursor_legacy (torture-bo)
[204.312910] Starting subtest: torture-bo
[204.315428] Starting dynamic subtest: pipe-A
[210.250518] Dynamic subtest pipe-A: SUCCESS (5.880s)
[210.261999] Starting dynamic subtest: pipe-B
[217.188527] Dynamic subtest pipe-B: SUCCESS (6.907s)
[217.200724] Starting dynamic subtest: pipe-C
[225.005575] Dynamic subtest pipe-C: SUCCESS (7.801s)
[225.015000] Starting dynamic subtest: pipe-D
[232.225759] Dynamic subtest pipe-D: SUCCESS (7.257s)
[232.234326] Starting dynamic subtest: all-pipes
[239.692102] Dynamic subtest all-pipes: SUCCESS (7.485s)
[239.694707] Subtest torture-bo: SUCCESS (35.335s)
[239.842812] [021/131] (777s left) syncobj_timeline (wait-all-for-submit-snapshot)
[239.908592] Starting subtest: wait-all-for-submit-snapshot
[239.990997] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[240.064327] [022/131] (776s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[240.159574] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[240.172923] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.012s)
[240.245100] [023/131] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[240.348402] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[247.741069] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.404s)
[247.883310] [024/131] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[247.987065] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[247.992520] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[248.092332] [025/131] (769s left) kms_cursor_crc (cursor-suspend)
[248.232084] Starting subtest: cursor-suspend
[248.234717] Starting dynamic subtest: pipe-A-eDP-1
[280.774246] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.196s)
[280.783694] Starting dynamic subtest: pipe-D-eDP-1
[313.769950] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.583s)
[313.772832] Subtest cursor-suspend: SUCCESS (6.782s)
[314.603341] [026/131] (702s left) kms_lease (lease-invalid-connector)
[314.705236] Starting subtest: lease-invalid-connector
[314.707792] Starting dynamic subtest: pipe-A-eDP-1
[314.710508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[314.719462] Starting dynamic subtest: pipe-B-eDP-1
[314.721536] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[314.730938] Starting dynamic subtest: pipe-C-eDP-1
[314.733696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[314.744909] Starting dynamic subtest: pipe-D-eDP-1
[314.747242] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[314.749239] Subtest lease-invalid-connector: SUCCESS (0.003s)
[314.786666] [027/131] (702s left) gem_mmap_wc (pf-nonblock)
[314.848976] Subtest pf-nonblock: SKIP (0.000s)
[314.906749] [028/131] (702s left) kms_cursor_crc (cursor-onscreen-max-size)
[315.215936] Starting subtest: cursor-onscreen-max-size
[315.223694] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[315.347173] [029/131] (701s left) gem_userptr_blits (relocations)
[315.419117] Starting subtest: relocations
[315.424522] Subtest relocations: SKIP (0.000s)
[315.560404] [030/131] (701s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[315.666021] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[315.670433] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[315.778624] [031/131] (701s left) kms_atomic_transition (modeset-transition-nonblocking)
[315.879449] Starting subtest: modeset-transition-nonblocking
[315.881426] Starting dynamic subtest: 1x-outputs
[326.737509] Dynamic subtest 1x-outputs: SUCCESS (10.715s)
[327.004618] Subtest modeset-transition-nonblocking: SUCCESS (10.979s)
[327.869633] [032/131] (689s left) kms_content_protection (dp-mst-type-1)
[328.014112] Starting subtest: dp-mst-type-1
[328.019694] Subtest dp-mst-type-1: SKIP (0.000s)
[328.142052] [033/131] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[328.238440] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[328.242848] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[328.322428] [034/131] (689s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[328.418671] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[328.421252] Starting dynamic subtest: pipe-A-eDP-1
[328.574451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[328.583219] Starting dynamic subtest: pipe-B-eDP-1
[328.604383] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[328.613918] Starting dynamic subtest: pipe-C-eDP-1
[328.634889] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[328.644724] Starting dynamic subtest: pipe-D-eDP-1
[328.667189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[328.669200] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[330.843197] [035/131] (686s left) prime_busy (before-wait)
[330.898244] Starting subtest: before-wait
[330.903518] Starting dynamic subtest: rcs0
[330.944808] Dynamic subtest rcs0: SUCCESS (0.043s)
[330.956114] Starting dynamic subtest: bcs0
[330.997380] Dynamic subtest bcs0: SUCCESS (0.052s)
[331.007504] Starting dynamic subtest: vcs0
[331.038421] Dynamic subtest vcs0: SUCCESS (0.041s)
[331.048212] Starting dynamic subtest: vcs1
[331.079649] Dynamic subtest vcs1: SUCCESS (0.041s)
[331.089593] Starting dynamic subtest: vecs0
[331.120465] Dynamic subtest vecs0: SUCCESS (0.040s)
[331.129906] Starting dynamic subtest: ccs0
[331.161394] Dynamic subtest ccs0: SUCCESS (0.040s)
[331.270087] Subtest before-wait: SUCCESS (0.368s)
[331.344135] [036/131] (686s left) kms_flip (2x-blocking-absolute-wf_vblank)
[331.433163] Starting subtest: 2x-blocking-absolute-wf_vblank
[331.445092] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[331.521833] [037/131] (686s left) gem_ccs (ctrl-surf-copy-new-ctx)
[331.576372] Starting subtest: ctrl-surf-copy-new-ctx
[331.581162] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[331.693022] [038/131] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[331.800488] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[331.805602] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[331.893271] [039/131] (685s left) kms_dp_linktrain_fallback (dp-fallback)
[331.984536] Starting subtest: dp-fallback
[331.992097] Subtest dp-fallback: SKIP (0.000s)
[332.057046] [040/131] (685s left) kms_rmfb (rmfb-ioctl)
[332.145601] Starting subtest: rmfb-ioctl
[332.148169] Starting dynamic subtest: pipe-A-eDP-1
[332.252586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[332.261368] Starting dynamic subtest: pipe-B-eDP-1
[333.411912] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.155s)
[333.422167] Starting dynamic subtest: pipe-C-eDP-1
[334.538889] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[334.551185] Starting dynamic subtest: pipe-D-eDP-1
[335.689881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[335.692585] Subtest rmfb-ioctl: SUCCESS (3.535s)
[336.899051] [041/131] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[337.002532] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[337.007689] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.113608] [042/131] (680s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[337.206426] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[337.208911] Starting dynamic subtest: pipe-A-default-mode
[337.493408] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[337.498398] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.284s)
[338.332512] [043/131] (679s left) gen9_exec_parse (unaligned-jump)
[338.395730] Subtest unaligned-jump: SKIP (0.000s)
[338.486214] [044/131] (679s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[338.586668] Starting subtest: y-tiled-64bpp-rotate-180
[338.591626] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[338.680107] [045/131] (679s left) gem_workarounds (basic-read)
[338.748812] Starting subtest: basic-read
[338.758894] Subtest basic-read: SUCCESS (0.011s)
[338.876220] [046/131] (679s left) kms_scaling_modes (scaling-mode-none)
[338.966356] Starting subtest: scaling-mode-none
[338.968830] Starting dynamic subtest: pipe-A-eDP-1
[339.071240] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s)
[339.081594] Starting dynamic subtest: pipe-B-eDP-1
[339.108286] Dynamic subtest pipe-B-eDP-1: SKIP (0.036s)
[339.117365] Starting dynamic subtest: pipe-C-eDP-1
[339.144627] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s)
[339.153558] Starting dynamic subtest: pipe-D-eDP-1
[339.177195] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[339.181535] Subtest scaling-mode-none: SKIP (0.208s)
[339.304635] [047/131] (678s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[339.686989] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[340.552580] [048/131] (677s left) perf (per-context-mode-unprivileged)
[340.686493] Starting subtest: per-context-mode-unprivileged
[340.690772] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[340.730396] [049/131] (677s left) kms_async_flips (alternate-sync-async-flip-atomic)
[340.842929] Starting subtest: alternate-sync-async-flip-atomic
[341.216841] Starting dynamic subtest: pipe-A-eDP-1
[343.972777] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s)
[344.360053] Starting dynamic subtest: pipe-B-eDP-1
[347.085912] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.730s)
[347.458679] Starting dynamic subtest: pipe-C-eDP-1
[350.244848] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.789s)
[350.612208] Starting dynamic subtest: pipe-D-eDP-1
[353.384963] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[353.386785] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.526s)
[354.565786] [050/131] (663s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[354.664596] Starting subtest: basic-max-pipe-crc-check
[354.669684] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[354.712834] [051/131] (663s left) gem_exec_reloc (basic-write-gtt-active)
[354.772059] Subtest basic-write-gtt-active: SKIP (0.000s)
[354.858780] [052/131] (663s left) gem_lmem_swapping (massive-random)
[354.902382] Subtest massive-random: SKIP (0.000s)
[354.944653] [053/131] (663s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[355.042317] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[355.054390] Starting dynamic subtest: pipe-A-eDP-1
[355.076389] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.085000] Starting dynamic subtest: pipe-B-eDP-1
[355.109601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.118119] Starting dynamic subtest: pipe-C-eDP-1
[355.140453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.148702] Starting dynamic subtest: pipe-D-eDP-1
[355.170620] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.175289] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[357.323080] [054/131] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[357.424313] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[361.149534] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.727s)
[362.334225] [055/131] (656s left) sw_sync (alloc_fence_invalid_timeline)
[362.370931] Starting subtest: alloc_fence_invalid_timeline
[362.373805] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[362.417593] [056/131] (655s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[363.003890] Starting subtest: syncobj-backward-timeline-chain-engines
[363.096437] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.094s)
[364.625776] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[364.629202] [057/131] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[364.732806] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[364.738020] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[364.844682] [058/131] (653s left) gem_exec_schedule (submit-late-slice)
[364.925491] Starting subtest: submit-late-slice
[364.927918] Starting dynamic subtest: rcs0
[364.951829] Dynamic subtest rcs0: SUCCESS (0.038s)
[364.968196] Starting dynamic subtest: bcs0
[364.984549] Dynamic subtest bcs0: SUCCESS (0.031s)
[364.994915] Starting dynamic subtest: vcs0
[365.017317] Dynamic subtest vcs0: SUCCESS (0.032s)
[365.026441] Starting dynamic subtest: vcs1
[365.049181] Dynamic subtest vcs1: SUCCESS (0.032s)
[365.058172] Starting dynamic subtest: vecs0
[365.080691] Dynamic subtest vecs0: SUCCESS (0.030s)
[365.089937] Starting dynamic subtest: ccs0
[365.111968] Dynamic subtest ccs0: SUCCESS (0.031s)
[365.114590] Subtest submit-late-slice: SUCCESS (0.198s)
[366.601423] [059/131] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[366.695422] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[371.038913] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.345s)
[372.225870] [060/131] (646s left) gem_mmap_wc (write)
[372.291173] Subtest write: SKIP (0.000s)
[372.354500] [061/131] (646s left) kms_psr (pr-primary-render)
[372.456712] Starting subtest: pr-primary-render
[372.461524] Subtest pr-primary-render: SKIP (0.000s)
[372.528223] [062/131] (646s left) gem_exec_reloc (basic-cpu-gtt-active)
[372.595953] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[372.685267] [063/131] (646s left) gem_exec_whisper (basic-fds-forked-all)
[372.747522] Starting subtest: basic-fds-forked-all
[393.845713] Subtest basic-fds-forked-all: SUCCESS (21.101s)
[394.033937] [064/131] (624s left) kms_plane_lowres (tiling-yf)
[394.128923] Starting subtest: tiling-yf
[394.134559] Subtest tiling-yf: SKIP (0.000s)
[394.200692] [065/131] (624s left) kms_flip (dpms-vs-vblank-race)
[394.291755] Starting subtest: dpms-vs-vblank-race
[394.294366] Starting dynamic subtest: A-eDP1
[398.180936] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[398.192528] Starting dynamic subtest: B-eDP1
[402.806911] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[402.817273] Starting dynamic subtest: C-eDP1
[407.421342] Dynamic subtest C-eDP1: SUCCESS (4.613s)
[407.431647] Starting dynamic subtest: D-eDP1
[412.019646] Dynamic subtest D-eDP1: SUCCESS (4.595s)
[412.022458] Subtest dpms-vs-vblank-race: SUCCESS (17.728s)
[412.903113] [066/131] (605s left) gem_ctx_shared (q-independent)
[412.974700] Starting subtest: Q-independent
[412.977469] Starting dynamic subtest: rcs0
[413.041471] Dynamic subtest rcs0: SUCCESS (0.067s)
[413.054126] Starting dynamic subtest: vcs0
[413.082883] Dynamic subtest vcs0: SUCCESS (0.041s)
[413.092712] Starting dynamic subtest: vcs1
[413.120349] Dynamic subtest vcs1: SUCCESS (0.037s)
[413.129613] Starting dynamic subtest: vecs0
[413.159816] Dynamic subtest vecs0: SUCCESS (0.039s)
[413.168977] Starting dynamic subtest: ccs0
[413.206327] Dynamic subtest ccs0: SUCCESS (0.046s)
[413.209211] Subtest Q-independent: SUCCESS (0.232s)
[414.602028] [067/131] (604s left) kms_psr (psr-cursor-plane-move)
[414.701516] Starting subtest: psr-cursor-plane-move
[414.703956] Starting dynamic subtest: eDP-1
[416.392396] Dynamic subtest eDP-1: SUCCESS (1.692s)
[416.394740] Subtest psr-cursor-plane-move: SUCCESS (1.692s)
[417.262483] [068/131] (601s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[417.311892] Starting subtest: invalid-bsd1-flag-on-vebox
[417.314673] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[417.415720] [069/131] (601s left) kms_flip (flip-vs-wf_vblank-interruptible)
[417.508322] Starting subtest: flip-vs-wf_vblank-interruptible
[417.510673] Starting dynamic subtest: A-eDP1
[419.420680] Dynamic subtest A-eDP1: SUCCESS (1.910s)
[419.432533] Starting dynamic subtest: B-eDP1
[421.340233] Dynamic subtest B-eDP1: SUCCESS (1.918s)
[421.351459] Starting dynamic subtest: C-eDP1
[423.250461] Dynamic subtest C-eDP1: SUCCESS (1.909s)
[423.259570] Starting dynamic subtest: D-eDP1
[425.194918] Dynamic subtest D-eDP1: SUCCESS (1.942s)
[425.197657] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.687s)
[426.412275] [070/131] (592s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[426.492061] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[426.497736] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[426.678441] [071/131] (592s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[426.780495] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[430.447007] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.670s)
[431.638593] [072/131] (587s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[436.682800] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[436.687542] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[437.535703] [073/131] (581s left) syncobj_timeline (signal-point-0)
[437.588568] Starting subtest: signal-point-0
[437.591293] Subtest signal-point-0: SUCCESS (0.000s)
[437.678154] [074/131] (581s left) api_intel_bb (bb-with-allocator)
[437.731158] Starting subtest: bb-with-allocator
[437.735476] Subtest bb-with-allocator: SUCCESS (0.008s)
[437.861216] [075/131] (581s left) gem_exec_balancer (full-late)
[437.919932] Starting subtest: full-late
[442.368066] Subtest full-late: SUCCESS (4.448s)
[442.711693] [076/131] (576s left) kms_chamelium_frames (hdmi-frame-dump)
[443.107253] Subtest hdmi-frame-dump: SKIP (0.000s)
[443.945100] [077/131] (575s left) gem_wait (write-busy)
[444.013824] Starting subtest: write-busy
[444.016660] Starting dynamic subtest: all-engines
[444.638265] Dynamic subtest all-engines: SUCCESS (0.624s)
[444.654541] Starting dynamic subtest: rcs0
[445.194964] Dynamic subtest rcs0: SUCCESS (0.556s)
[445.209960] Starting dynamic subtest: bcs0
[445.745942] Dynamic subtest bcs0: SUCCESS (0.550s)
[445.761951] Starting dynamic subtest: vcs0
[447.533541] Dynamic subtest vcs0: SUCCESS (1.786s)
[447.550677] Starting dynamic subtest: vcs1
[449.516277] Dynamic subtest vcs1: SUCCESS (1.981s)
[449.532935] Starting dynamic subtest: vecs0
[451.500263] Dynamic subtest vecs0: SUCCESS (1.982s)
[451.516888] Starting dynamic subtest: ccs0
[452.050902] Dynamic subtest ccs0: SUCCESS (0.550s)
[452.053912] Subtest write-busy: SUCCESS (8.038s)
[452.249202] [078/131] (567s left) kms_chamelium_frames (dp-crc-fast)
[452.643617] Subtest dp-crc-fast: SKIP (0.000s)
[453.469708] [079/131] (565s left) dumb_buffer (map-valid)
[453.530036] Starting subtest: map-valid
[453.532373] Subtest map-valid: SUCCESS (0.000s)
[453.644478] [080/131] (565s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[453.749467] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[453.754286] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[453.841370] [081/131] (565s left) syncobj_basic (bad-pad-fd-to-handle)
[453.894982] Starting subtest: bad-pad-fd-to-handle
[453.897725] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[454.009706] [082/131] (565s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[454.070618] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[454.176390] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[454.254183] [083/131] (565s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[454.359293] Starting subtest: psr-rgb565-draw-mmap-wc
[461.144587] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.790s)
[461.272197] [084/131] (558s left) kms_rotation_crc (bad-pixel-format)
[461.376638] Starting subtest: bad-pixel-format
[461.381749] Subtest bad-pixel-format: SKIP (0.001s)
[461.454346] [085/131] (558s left) kms_vblank (wait-idle-hang)
[461.546662] Starting subtest: wait-idle-hang
[461.548917] Starting dynamic subtest: pipe-A-eDP-1
[488.230917] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.684s)
[488.245630] Starting dynamic subtest: pipe-D-eDP-1
[513.251669] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.012s)
[513.254426] Subtest wait-idle-hang: SUCCESS (51.700s)
[514.095100] [086/131] (505s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[514.155846] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[514.219316] [087/131] (505s left) syncobj_wait (wait-all-for-submit-snapshot)
[514.268711] Starting subtest: wait-all-for-submit-snapshot
[514.350517] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[514.430386] [088/131] (505s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[514.545722] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[545.501149] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.946s)
[546.337184] [089/131] (473s left) gem_workarounds (suspend-resume-context)
[546.394922] Starting subtest: suspend-resume-context
[562.338404] Subtest suspend-resume-context: SUCCESS (1.196s)
[562.478364] [090/131] (457s left) sysfs_heartbeat_interval (precise)
[562.547935] Starting subtest: precise
[562.550552] Starting dynamic subtest: vecs0
[570.251679] Dynamic subtest vecs0: SUCCESS (7.515s)
[570.264457] Starting dynamic subtest: ccs0
[571.316086] Dynamic subtest ccs0: SUCCESS (1.050s)
[571.334030] Starting dynamic subtest: vcs0
[579.281034] Dynamic subtest vcs0: SUCCESS (7.895s)
[579.292966] Starting dynamic subtest: bcs0
[580.364010] Dynamic subtest bcs0: SUCCESS (1.078s)
[580.376060] Starting dynamic subtest: rcs0
[581.462650] Dynamic subtest rcs0: SUCCESS (1.093s)
[581.472958] Starting dynamic subtest: vcs1
[589.267034] Dynamic subtest vcs1: SUCCESS (7.783s)
[589.269935] Subtest precise: SUCCESS (26.424s)
[589.348341] [091/131] (430s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[589.466832] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[589.471500] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[589.579529] [092/131] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[589.685826] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[589.690466] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[589.787461] [093/131] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[589.881140] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[596.874486] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (6.988s)
[597.010633] [094/131] (423s left) gem_sync (basic-all)
[597.088985] Starting subtest: basic-all
[599.344887] Subtest basic-all: SUCCESS (2.267s)
[599.526819] [095/131] (420s left) kms_plane_scaling (planes-scaler-unity-scaling)
[599.628794] Starting subtest: planes-scaler-unity-scaling
[599.631153] Starting dynamic subtest: pipe-A
[599.694505] Dynamic subtest pipe-A: SUCCESS (0.068s)
[599.703883] Starting dynamic subtest: pipe-B
[600.849112] Dynamic subtest pipe-B: SUCCESS (1.153s)
[600.859326] Starting dynamic subtest: pipe-C
[601.956845] Dynamic subtest pipe-C: SUCCESS (1.105s)
[601.967437] Starting dynamic subtest: pipe-D
[603.099909] Dynamic subtest pipe-D: SUCCESS (1.142s)
[603.102704] Subtest planes-scaler-unity-scaling: SUCCESS (3.472s)
[604.260505] [096/131] (415s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[604.366123] Starting subtest: yf-tiled-16bpp-rotate-180
[604.370834] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[604.483395] [097/131] (415s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[604.546934] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[604.637164] [098/131] (415s left) gem_exec_balancer (parallel-contexts)
[604.884560] Starting subtest: parallel-contexts
[607.492171] Subtest parallel-contexts: SUCCESS (2.606s)
[608.325779] [099/131] (411s left) gem_ctx_param (invalid-set-no-zeromap)
[608.388669] Starting subtest: invalid-set-no-zeromap
[608.391590] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[608.464329] [100/131] (411s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[608.566628] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[608.570752] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[608.686375] [101/131] (411s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[608.769888] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[608.772567] Starting dynamic subtest: pipe-A-eDP-1
[608.797881] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[608.808177] Starting dynamic subtest: pipe-B-eDP-1
[608.831399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[608.841018] Starting dynamic subtest: pipe-C-eDP-1
[608.869000] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[608.879398] Starting dynamic subtest: pipe-D-eDP-1
[608.906690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[608.911582] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[610.946241] [102/131] (409s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[611.003613] Starting subtest: etime-single-wait-available-unsubmitted
[611.106193] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[611.189434] [103/131] (409s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[611.240758] Starting subtest: invalid-signal-one-illegal-handle
[611.243130] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[611.328263] [104/131] (409s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[611.383155] Starting subtest: mixed-tiled-to-y-tiled-ccs
[611.388490] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[611.568668] [105/131] (408s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[611.620842] Starting subtest: framebuffer-vs-set-tiling
[611.625416] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[611.750961] [106/131] (408s left) gem_mmap_gtt (cpuset-big-copy-xy)
[611.806945] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[611.871530] [107/131] (408s left) gem_userptr_blits (nohangcheck)
[611.938837] Starting subtest: nohangcheck
[612.191966] Subtest nohangcheck: SUCCESS (0.252s)
[612.329445] [108/131] (408s left) api_intel_bb (simple-bb-ctx)
[612.373470] Starting subtest: simple-bb-ctx
[612.382777] Subtest simple-bb-ctx: SUCCESS (0.008s)
[612.495558] [109/131] (408s left) kms_sequence (queue-idle)
[612.587171] Starting subtest: queue-idle
[612.589761] Starting dynamic subtest: pipe-A-eDP-1
[614.397813] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[614.408775] Starting dynamic subtest: pipe-B-eDP-1
[616.812841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.412s)
[616.824023] Starting dynamic subtest: pipe-C-eDP-1
[619.246134] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[619.257612] Starting dynamic subtest: pipe-D-eDP-1
[621.687275] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[621.689828] Subtest queue-idle: SUCCESS (9.095s)
[622.494615] [110/131] (398s left) perf_pmu (busy-accuracy-2)
[622.534715] Starting subtest: busy-accuracy-2
[622.537006] Starting dynamic subtest: rcs0
[625.576880] Dynamic subtest rcs0: SUCCESS (3.039s)
[625.586557] Starting dynamic subtest: bcs0
[628.634139] Dynamic subtest bcs0: SUCCESS (3.056s)
[628.646819] Starting dynamic subtest: vcs0
[631.681261] Dynamic subtest vcs0: SUCCESS (3.046s)
[631.691379] Starting dynamic subtest: vcs1
[634.723174] Dynamic subtest vcs1: SUCCESS (3.040s)
[634.733660] Starting dynamic subtest: vecs0
[637.770363] Dynamic subtest vecs0: SUCCESS (3.046s)
[637.782861] Starting dynamic subtest: ccs0
[640.829985] Dynamic subtest ccs0: SUCCESS (3.058s)
[640.832510] Subtest busy-accuracy-2: SUCCESS (18.295s)
[640.944161] [111/131] (379s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[641.005697] Subtest writes-after-reads-snoop: SKIP (0.000s)
[641.088383] [112/131] (379s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[641.189946] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[641.286764] [113/131] (379s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[641.384434] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[641.386840] Starting dynamic subtest: pipe-A-eDP-1
[641.410074] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[641.420510] Starting dynamic subtest: pipe-B-eDP-1
[641.443937] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[641.453295] Starting dynamic subtest: pipe-C-eDP-1
[641.477422] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[641.486235] Starting dynamic subtest: pipe-D-eDP-1
[641.507925] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[641.512236] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[643.567495] [114/131] (377s left) gem_exec_schedule (out-order)
[643.653192] Starting subtest: out-order
[643.656139] Starting dynamic subtest: rcs0
[643.750465] Dynamic subtest rcs0: SUCCESS (0.108s)
[643.763893] Starting dynamic subtest: vcs0
[643.829155] Dynamic subtest vcs0: SUCCESS (0.079s)
[643.841166] Starting dynamic subtest: vcs1
[643.907128] Dynamic subtest vcs1: SUCCESS (0.078s)
[643.919663] Starting dynamic subtest: vecs0
[643.989297] Dynamic subtest vecs0: SUCCESS (0.080s)
[643.999474] Starting dynamic subtest: ccs0
[644.073453] Dynamic subtest ccs0: SUCCESS (0.082s)
[644.076462] Subtest out-order: SUCCESS (0.432s)
[645.346432] [115/131] (375s left) gem_exec_fence (syncobj-timeline-repeat)
[645.911134] Starting subtest: syncobj-timeline-repeat
[646.133833] Subtest syncobj-timeline-repeat: SUCCESS (0.224s)
[647.355649] [116/131] (373s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[647.455935] Starting subtest: psr-1p-primscrn-cur-indfb-move
[654.692872] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.240s)
[654.863297] [117/131] (366s left) kms_big_fb (linear-8bpp-rotate-90)
[654.966789] Starting subtest: linear-8bpp-rotate-90
[654.987955] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[655.123191] [118/131] (365s left) gem_mmap_gtt (medium-copy-odd)
[655.176319] Subtest medium-copy-odd: SKIP (0.000s)
[655.245957] [119/131] (365s left) kms_getfb (getfb2-into-addfb2)
[655.350843] Starting subtest: getfb2-into-addfb2
[655.353141] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[655.463805] [120/131] (365s left) kms_prop_blob (invalid-get-prop-any)
[655.516920] Starting subtest: invalid-get-prop-any
[655.519334] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[655.610464] [121/131] (365s left) gem_exec_schedule (preempt-queue-contexts-chain)
[655.682465] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[655.969445] [122/131] (365s left) kms_psr (fbc-pr-sprite-render)
[656.065248] Starting subtest: fbc-pr-sprite-render
[656.069917] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[656.139632] [123/131] (365s left) perf (invalid-remove-userspace-config)
[656.213732] Starting subtest: invalid-remove-userspace-config
[656.228036] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[656.269359] [124/131] (365s left) gem_userptr_blits (forbidden-operations)
[656.325770] Starting subtest: forbidden-operations
[656.330341] Subtest forbidden-operations: SKIP (0.000s)
[656.445988] [125/131] (364s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[656.570592] Starting subtest: cursorA-vs-flipA-atomic-transitions
[667.731149] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.156s)
[668.526511] [126/131] (352s left) perf_pmu (enable-race)
[668.564489] Starting subtest: enable-race
[668.566689] Starting dynamic subtest: rcs0
[681.336796] Dynamic subtest rcs0: SUCCESS (12.769s)
[681.347363] Starting dynamic subtest: bcs0
[694.081784] Dynamic subtest bcs0: SUCCESS (12.739s)
[694.092122] Starting dynamic subtest: vcs0
[709.254409] Dynamic subtest vcs0: SUCCESS (15.164s)
[709.267455] Starting dynamic subtest: vcs1
[725.190147] Dynamic subtest vcs1: SUCCESS (15.927s)
[725.201817] Starting dynamic subtest: vecs0
[741.254807] Dynamic subtest vecs0: SUCCESS (16.056s)
[741.268018] Starting dynamic subtest: ccs0
[754.077903] Dynamic subtest ccs0: SUCCESS (12.818s)
[754.081156] Subtest enable-race: SUCCESS (85.486s)
[754.176555] [127/131] (267s left) kms_joiner (basic-force-big-joiner)
[754.281882] Starting subtest: basic-force-big-joiner
[754.284281] Starting dynamic subtest: single
[757.601864] Dynamic subtest single: SUCCESS (3.327s)
[757.604052] Subtest basic-force-big-joiner: SUCCESS (3.328s)
[758.783871] [128/131] (262s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[758.882265] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[759.836365] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[759.982626] [129/131] (261s left) i915_pm_rpm (gem-execbuf)
[761.507603] Starting subtest: gem-execbuf
[761.510637] Starting dynamic subtest: smem0
[763.570822] Dynamic subtest smem0: SUCCESS (2.063s)
[763.573566] Subtest gem-execbuf: SUCCESS (2.065s)
[763.691634] [130/131] (257s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[763.794001] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[770.443349] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.654s)
[770.588943] [131/131] (251s left) gem_basic (create-close)
[770.651730] Starting subtest: create-close
[770.656575] Subtest create-close: SUCCESS (0.000s)
[770.763223] 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.