[54.936192] Initializing watchdogs
[54.936245]   /dev/watchdog0
[54.950580] [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]
[54.955099] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.957290] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.960634] [001/131] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[60.102685] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[60.107589] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[60.963495] [002/131] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[61.059969] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[61.062377] Starting dynamic subtest: pipe-A-eDP-1
[61.475096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[61.483844] Starting dynamic subtest: pipe-B-eDP-1
[62.878835] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[62.887797] Starting dynamic subtest: pipe-C-eDP-1
[64.294680] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[64.304026] Starting dynamic subtest: pipe-D-eDP-1
[65.632350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[65.634825] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.503s)
[66.836377] [003/131] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[66.946028] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[66.948537] Starting dynamic subtest: pipe-A
[67.304366] Dynamic subtest pipe-A: SUCCESS (0.356s)
[67.316435] Starting dynamic subtest: pipe-B
[68.740695] Dynamic subtest pipe-B: SUCCESS (1.430s)
[68.749604] Starting dynamic subtest: pipe-C
[70.190063] Dynamic subtest pipe-C: SUCCESS (1.444s)
[70.197346] Starting dynamic subtest: pipe-D
[71.612744] Dynamic subtest pipe-D: SUCCESS (1.418s)
[71.615311] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.649s)
[72.874705] [004/131] (942s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[72.999462] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.791469] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.792s)
[73.960104] [005/131] (941s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[74.055366] Starting subtest: plane-primary-toggle-with-vblank-wait
[74.057732] Starting dynamic subtest: pipe-A-eDP-1
[74.231375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[74.533290] Starting dynamic subtest: pipe-B-eDP-1
[75.476893] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.948s)
[75.774186] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.714s)
[76.635057] [006/131] (939s left) drm_read (fault-buffer)
[76.785901] Starting subtest: fault-buffer
[76.788464] Subtest fault-buffer: SUCCESS (0.000s)
[76.924719] [007/131] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[77.033260] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[81.339816] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.312s)
[82.548473] [008/131] (933s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[82.647110] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[82.649464] Starting dynamic subtest: pipe-A-default-mode
[82.936100] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[82.940783] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.284s)
[83.765707] [009/131] (931s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[83.859258] Starting subtest: fbc-psr2-sprite-mmap-gtt
[83.861565] Starting dynamic subtest: eDP-1
[83.865650] Dynamic subtest eDP-1: SKIP (0.000s)
[83.869669] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[83.931286] [010/131] (931s left) kms_psr (pr-cursor-mmap-cpu)
[84.035095] Starting subtest: pr-cursor-mmap-cpu
[84.039565] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[84.104525] [011/131] (931s left) gem_ctx_param (invalid-get-engines)
[84.159621] Starting subtest: invalid-get-engines
[84.161866] Subtest invalid-get-engines: SUCCESS (0.002s)
[84.266020] [012/131] (931s left) i915_hangman (detector)
[84.338196] Starting subtest: detector
[84.340075] Starting dynamic subtest: rcs0
[95.861149] Dynamic subtest rcs0: SUCCESS (11.515s)
[95.871796] Starting dynamic subtest: bcs0
[106.868472] Dynamic subtest bcs0: SUCCESS (11.002s)
[106.878573] Starting dynamic subtest: vcs0
[118.834680] Dynamic subtest vcs0: SUCCESS (11.962s)
[118.844577] Starting dynamic subtest: vcs1
[130.803856] Dynamic subtest vcs1: SUCCESS (11.966s)
[130.814240] Starting dynamic subtest: vecs0
[141.876266] Dynamic subtest vecs0: SUCCESS (11.070s)
[141.887069] Starting dynamic subtest: ccs0
[153.842143] Dynamic subtest ccs0: SUCCESS (11.966s)
[153.844803] Subtest detector: SUCCESS (69.486s)
[153.971364] [013/131] (861s left) kms_rmfb (close-fd)
[154.068078] Starting subtest: close-fd
[154.070497] Starting dynamic subtest: pipe-A-eDP-1
[154.178072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[154.187513] Starting dynamic subtest: pipe-B-eDP-1
[155.340191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.162s)
[155.350485] Starting dynamic subtest: pipe-C-eDP-1
[156.468068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[156.477367] Starting dynamic subtest: pipe-D-eDP-1
[157.602090] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[157.603998] Subtest close-fd: SUCCESS (3.532s)
[158.808185] [014/131] (857s left) kms_pm_lpsp (kms-lpsp)
[159.915270] Starting subtest: kms-lpsp
[159.917414] Starting dynamic subtest: pipe-A-eDP-1
[160.061722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[160.345928] Subtest kms-lpsp: SUCCESS (0.432s)
[161.139549] [015/131] (854s left) kms_frontbuffer_tracking (fbc-suspend)
[161.242679] Starting subtest: fbc-suspend
[199.358349] Subtest fbc-suspend: SUCCESS (8.104s)
[208.566444] [016/131] (815s left) gem_linear_blits (interruptible)
[208.890676] Starting subtest: interruptible
[213.761732] Subtest interruptible: SUCCESS (4.746s)
[213.916652] [017/131] (810s left) gem_pxp (create-regular-context-1)
[214.094810] Starting subtest: create-regular-context-1
[214.097236] Subtest create-regular-context-1: SUCCESS (0.002s)
[214.220321] [018/131] (809s left) i915_pm_rps (reset)
[214.296660] Starting subtest: reset
[214.383422] Subtest reset: FAIL (0.027s)
[214.457965] [019/131] (809s left) gem_madvise (dontneed-after-mmap)
[214.490011] Starting subtest: dontneed-after-mmap
[214.520727] Subtest dontneed-after-mmap: SUCCESS (0.029s)
[214.645433] [020/131] (809s left) kms_cursor_legacy (torture-bo)
[214.780385] Starting subtest: torture-bo
[214.782368] Starting dynamic subtest: pipe-A
[220.504241] Dynamic subtest pipe-A: SUCCESS (5.656s)
[220.523936] Starting dynamic subtest: pipe-B
[227.318176] Dynamic subtest pipe-B: SUCCESS (6.779s)
[227.330750] Starting dynamic subtest: pipe-C
[233.714052] Dynamic subtest pipe-C: SUCCESS (6.379s)
[233.723615] Starting dynamic subtest: pipe-D
[240.145139] Dynamic subtest pipe-D: SUCCESS (6.422s)
[240.154132] Starting dynamic subtest: all-pipes
[246.220838] Dynamic subtest all-pipes: SUCCESS (6.072s)
[246.223480] Subtest torture-bo: SUCCESS (31.313s)
[246.398145] [021/131] (777s left) syncobj_timeline (wait-all-for-submit-snapshot)
[246.466433] Starting subtest: wait-all-for-submit-snapshot
[246.549217] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[246.619573] [022/131] (777s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[246.720271] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[246.731261] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[246.825831] [023/131] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[246.931494] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[254.357690] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.429s)
[254.521766] [024/131] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[254.626000] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[254.629956] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[254.748449] [025/131] (769s left) kms_cursor_crc (cursor-suspend)
[254.888703] Starting subtest: cursor-suspend
[254.891014] Starting dynamic subtest: pipe-A-eDP-1
[288.602158] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.967s)
[288.611664] Starting dynamic subtest: pipe-D-eDP-1
[323.559550] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.405s)
[323.561469] Subtest cursor-suspend: SUCCESS (8.374s)
[334.383196] [026/131] (700s left) kms_lease (lease-invalid-connector)
[334.489969] Starting subtest: lease-invalid-connector
[334.492310] Starting dynamic subtest: pipe-A-eDP-1
[334.494734] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[334.504355] Starting dynamic subtest: pipe-B-eDP-1
[334.506360] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[334.515550] Starting dynamic subtest: pipe-C-eDP-1
[334.517857] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[334.526943] Starting dynamic subtest: pipe-D-eDP-1
[334.529018] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[334.530949] Subtest lease-invalid-connector: SUCCESS (0.004s)
[334.567700] [027/131] (699s left) gem_mmap_wc (pf-nonblock)
[334.642582] Subtest pf-nonblock: SKIP (0.000s)
[334.710202] [028/131] (699s left) kms_cursor_crc (cursor-onscreen-max-size)
[335.001721] Starting subtest: cursor-onscreen-max-size
[335.008434] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[335.149096] [029/131] (699s left) gem_userptr_blits (relocations)
[335.201923] Starting subtest: relocations
[335.206185] Subtest relocations: SKIP (0.000s)
[335.331874] [030/131] (699s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[335.428971] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[335.432635] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[335.532444] [031/131] (699s left) kms_atomic_transition (modeset-transition-nonblocking)
[335.633398] Starting subtest: modeset-transition-nonblocking
[335.635067] Starting dynamic subtest: 1x-outputs
[346.565712] Dynamic subtest 1x-outputs: SUCCESS (10.751s)
[346.838732] Subtest modeset-transition-nonblocking: SUCCESS (11.023s)
[347.698711] [032/131] (687s left) kms_content_protection (dp-mst-type-1)
[347.846477] Starting subtest: dp-mst-type-1
[347.850977] Subtest dp-mst-type-1: SKIP (0.000s)
[347.973531] [033/131] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[348.077048] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[348.081055] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[348.186097] [034/131] (686s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[348.279583] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[348.281995] Starting dynamic subtest: pipe-A-eDP-1
[348.436187] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[348.446948] Starting dynamic subtest: pipe-B-eDP-1
[348.469667] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[348.484539] Starting dynamic subtest: pipe-C-eDP-1
[348.502778] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[348.511857] Starting dynamic subtest: pipe-D-eDP-1
[348.530649] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[348.532525] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[350.782359] [035/131] (684s left) prime_busy (before-wait)
[350.841221] Starting subtest: before-wait
[350.846038] Starting dynamic subtest: rcs0
[350.895596] Dynamic subtest rcs0: SUCCESS (0.051s)
[350.906596] Starting dynamic subtest: bcs0
[350.958371] Dynamic subtest bcs0: SUCCESS (0.062s)
[350.968422] Starting dynamic subtest: vcs0
[350.999648] Dynamic subtest vcs0: SUCCESS (0.041s)
[351.008859] Starting dynamic subtest: vcs1
[351.041168] Dynamic subtest vcs1: SUCCESS (0.041s)
[351.050461] Starting dynamic subtest: vecs0
[351.081743] Dynamic subtest vecs0: SUCCESS (0.040s)
[351.091073] Starting dynamic subtest: ccs0
[351.121868] Dynamic subtest ccs0: SUCCESS (0.039s)
[351.229869] Subtest before-wait: SUCCESS (0.385s)
[351.299923] [036/131] (683s left) kms_flip (2x-blocking-absolute-wf_vblank)
[351.389934] Starting subtest: 2x-blocking-absolute-wf_vblank
[351.401124] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[351.532149] [037/131] (683s left) gem_ccs (ctrl-surf-copy-new-ctx)
[351.601353] Starting subtest: ctrl-surf-copy-new-ctx
[351.605717] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[351.712816] [038/131] (683s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[351.812064] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[351.816270] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[351.919277] [039/131] (683s left) kms_dp_linktrain_fallback (dp-fallback)
[352.018752] Starting subtest: dp-fallback
[352.025612] Subtest dp-fallback: SKIP (0.000s)
[352.091486] [040/131] (682s left) kms_rmfb (rmfb-ioctl)
[352.191871] Starting subtest: rmfb-ioctl
[352.194121] Starting dynamic subtest: pipe-A-eDP-1
[352.299369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[352.309423] Starting dynamic subtest: pipe-B-eDP-1
[353.442432] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[353.456075] Starting dynamic subtest: pipe-C-eDP-1
[354.571245] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[354.580917] Starting dynamic subtest: pipe-D-eDP-1
[355.717128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[355.719544] Subtest rmfb-ioctl: SUCCESS (3.515s)
[356.933158] [041/131] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[357.029413] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[357.033443] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[357.130139] [042/131] (677s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[357.226950] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[357.229312] Starting dynamic subtest: pipe-A-default-mode
[357.519246] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[357.523883] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.288s)
[358.376158] [043/131] (676s left) gen9_exec_parse (unaligned-jump)
[358.429825] Subtest unaligned-jump: SKIP (0.000s)
[358.502274] [044/131] (676s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[358.605289] Starting subtest: y-tiled-64bpp-rotate-180
[358.609450] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[358.711449] [045/131] (676s left) gem_workarounds (basic-read)
[358.785489] Starting subtest: basic-read
[358.797281] Subtest basic-read: SUCCESS (0.012s)
[358.920542] [046/131] (676s left) kms_scaling_modes (scaling-mode-none)
[359.008896] Starting subtest: scaling-mode-none
[359.011217] Starting dynamic subtest: pipe-A-eDP-1
[359.109956] Dynamic subtest pipe-A-eDP-1: SKIP (0.098s)
[359.121041] Starting dynamic subtest: pipe-B-eDP-1
[359.146342] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[359.155218] Starting dynamic subtest: pipe-C-eDP-1
[359.178856] Dynamic subtest pipe-C-eDP-1: SKIP (0.031s)
[359.187723] Starting dynamic subtest: pipe-D-eDP-1
[359.210418] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[359.214547] Subtest scaling-mode-none: SKIP (0.199s)
[359.343316] [047/131] (675s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[359.726494] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[360.497612] [048/131] (674s left) perf (per-context-mode-unprivileged)
[360.618197] Starting subtest: per-context-mode-unprivileged
[360.622537] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[360.660868] [049/131] (674s left) kms_async_flips (alternate-sync-async-flip-atomic)
[360.750982] Starting subtest: alternate-sync-async-flip-atomic
[361.146671] Starting dynamic subtest: pipe-A-eDP-1
[363.923743] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.777s)
[364.305416] Starting dynamic subtest: pipe-B-eDP-1
[367.066877] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[367.451965] Starting dynamic subtest: pipe-C-eDP-1
[370.202585] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.758s)
[370.563266] Starting dynamic subtest: pipe-D-eDP-1
[373.339894] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.783s)
[373.341832] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.581s)
[374.512123] [050/131] (660s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[374.616071] Starting subtest: basic-max-pipe-crc-check
[374.620619] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[374.674655] [051/131] (660s left) gem_exec_reloc (basic-write-gtt-active)
[374.736403] Subtest basic-write-gtt-active: SKIP (0.000s)
[374.813949] [052/131] (660s left) gem_lmem_swapping (massive-random)
[374.853182] Subtest massive-random: SKIP (0.000s)
[374.892048] [053/131] (660s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[374.986001] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[374.988284] Starting dynamic subtest: pipe-A-eDP-1
[375.010826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[375.020711] Starting dynamic subtest: pipe-B-eDP-1
[375.041909] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[375.050272] Starting dynamic subtest: pipe-C-eDP-1
[375.071428] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[375.079576] Starting dynamic subtest: pipe-D-eDP-1
[375.101295] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[375.105673] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[377.202974] [054/131] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[377.297615] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[381.014613] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.720s)
[382.190270] [055/131] (653s left) sw_sync (alloc_fence_invalid_timeline)
[382.224867] Starting subtest: alloc_fence_invalid_timeline
[382.227292] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[382.278375] [056/131] (653s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[382.862328] Starting subtest: syncobj-backward-timeline-chain-engines
[382.950491] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.090s)
[384.321994] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[384.325319] [057/131] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[384.417899] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[384.422058] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[384.507981] [058/131] (651s left) gem_exec_schedule (submit-late-slice)
[384.581001] Starting subtest: submit-late-slice
[384.583154] Starting dynamic subtest: rcs0
[384.614371] Dynamic subtest rcs0: SUCCESS (0.039s)
[384.625258] Starting dynamic subtest: bcs0
[384.645237] Dynamic subtest bcs0: SUCCESS (0.029s)
[384.654134] Starting dynamic subtest: vcs0
[384.677016] Dynamic subtest vcs0: SUCCESS (0.031s)
[384.686077] Starting dynamic subtest: vcs1
[384.708036] Dynamic subtest vcs1: SUCCESS (0.030s)
[384.717062] Starting dynamic subtest: vecs0
[384.735939] Dynamic subtest vecs0: SUCCESS (0.027s)
[384.751298] Starting dynamic subtest: ccs0
[384.768894] Dynamic subtest ccs0: SUCCESS (0.031s)
[384.771276] Subtest submit-late-slice: SUCCESS (0.193s)
[386.323779] [059/131] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[386.428086] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[390.675185] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.249s)
[391.872386] [060/131] (643s left) gem_mmap_wc (write)
[391.928224] Subtest write: SKIP (0.000s)
[391.996427] [061/131] (643s left) kms_psr (pr-primary-render)
[392.087859] Starting subtest: pr-primary-render
[392.091771] Subtest pr-primary-render: SKIP (0.000s)
[392.158741] [062/131] (643s left) gem_exec_reloc (basic-cpu-gtt-active)
[392.213077] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[392.306641] [063/131] (643s left) gem_exec_whisper (basic-fds-forked-all)
[392.372675] Starting subtest: basic-fds-forked-all
[412.157269] Subtest basic-fds-forked-all: SUCCESS (19.771s)
[412.350323] [064/131] (623s left) kms_plane_lowres (tiling-yf)
[412.461850] Starting subtest: tiling-yf
[412.466207] Subtest tiling-yf: SKIP (0.000s)
[412.535572] [065/131] (623s left) kms_flip (dpms-vs-vblank-race)
[412.639940] Starting subtest: dpms-vs-vblank-race
[412.642271] Starting dynamic subtest: A-eDP1
[417.589494] Dynamic subtest A-eDP1: SUCCESS (4.945s)
[417.599517] Starting dynamic subtest: B-eDP1
[422.200268] Dynamic subtest B-eDP1: SUCCESS (4.608s)
[422.210253] Starting dynamic subtest: C-eDP1
[426.747529] Dynamic subtest C-eDP1: SUCCESS (4.542s)
[426.757640] Starting dynamic subtest: D-eDP1
[431.373466] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[431.376045] Subtest dpms-vs-vblank-race: SUCCESS (18.725s)
[432.256315] [066/131] (603s left) gem_ctx_shared (q-independent)
[432.322170] Starting subtest: Q-independent
[432.324400] Starting dynamic subtest: rcs0
[432.390197] Dynamic subtest rcs0: SUCCESS (0.067s)
[432.399538] Starting dynamic subtest: vcs0
[432.429836] Dynamic subtest vcs0: SUCCESS (0.039s)
[432.438859] Starting dynamic subtest: vcs1
[432.472912] Dynamic subtest vcs1: SUCCESS (0.042s)
[432.482365] Starting dynamic subtest: vecs0
[432.515986] Dynamic subtest vecs0: SUCCESS (0.043s)
[432.525211] Starting dynamic subtest: ccs0
[432.563818] Dynamic subtest ccs0: SUCCESS (0.047s)
[432.566234] Subtest Q-independent: SUCCESS (0.242s)
[434.325148] [067/131] (601s left) kms_psr (psr-cursor-plane-move)
[434.422016] Starting subtest: psr-cursor-plane-move
[434.424169] Starting dynamic subtest: eDP-1
[436.148126] Dynamic subtest eDP-1: SUCCESS (1.726s)
[436.150338] Subtest psr-cursor-plane-move: SUCCESS (1.726s)
[437.024421] [068/131] (599s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[437.082203] Starting subtest: invalid-bsd1-flag-on-vebox
[437.084711] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[437.206126] [069/131] (599s left) kms_flip (flip-vs-wf_vblank-interruptible)
[437.304138] Starting subtest: flip-vs-wf_vblank-interruptible
[437.306493] Starting dynamic subtest: A-eDP1
[439.170837] Dynamic subtest A-eDP1: SUCCESS (1.866s)
[439.187162] Starting dynamic subtest: B-eDP1
[441.093400] Dynamic subtest B-eDP1: SUCCESS (1.922s)
[441.104630] Starting dynamic subtest: C-eDP1
[443.018231] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[443.030914] Starting dynamic subtest: D-eDP1
[444.945418] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[444.947802] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.647s)
[446.170733] [070/131] (590s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[446.232663] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[446.237424] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[446.419000] [071/131] (589s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[446.520594] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[450.101133] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.586s)
[451.287012] [072/131] (585s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[456.360538] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[456.365341] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[457.226692] [073/131] (579s left) syncobj_timeline (signal-point-0)
[457.280362] Starting subtest: signal-point-0
[457.282476] Subtest signal-point-0: SUCCESS (0.000s)
[457.387960] [074/131] (579s left) api_intel_bb (bb-with-allocator)
[457.445026] Starting subtest: bb-with-allocator
[457.449550] Subtest bb-with-allocator: SUCCESS (0.008s)
[457.584556] [075/131] (578s left) gem_exec_balancer (full-late)
[457.640584] Starting subtest: full-late
[462.069866] Subtest full-late: SUCCESS (4.429s)
[462.408704] [076/131] (574s left) kms_chamelium_frames (hdmi-frame-dump)
[462.792461] Subtest hdmi-frame-dump: SKIP (0.000s)
[463.622355] [077/131] (572s left) gem_wait (write-busy)
[463.692621] Starting subtest: write-busy
[463.695083] Starting dynamic subtest: all-engines
[464.363070] Dynamic subtest all-engines: SUCCESS (0.669s)
[464.374853] Starting dynamic subtest: rcs0
[464.927901] Dynamic subtest rcs0: SUCCESS (0.564s)
[464.937347] Starting dynamic subtest: bcs0
[465.485373] Dynamic subtest bcs0: SUCCESS (0.556s)
[465.503859] Starting dynamic subtest: vcs0
[467.226028] Dynamic subtest vcs0: SUCCESS (1.738s)
[467.242851] Starting dynamic subtest: vcs1
[469.209122] Dynamic subtest vcs1: SUCCESS (1.981s)
[469.225634] Starting dynamic subtest: vecs0
[471.192753] Dynamic subtest vecs0: SUCCESS (1.982s)
[471.213090] Starting dynamic subtest: ccs0
[471.741074] Dynamic subtest ccs0: SUCCESS (0.548s)
[471.743482] Subtest write-busy: SUCCESS (8.048s)
[471.936942] [078/131] (564s left) kms_chamelium_frames (dp-crc-fast)
[472.325046] Subtest dp-crc-fast: SKIP (0.000s)
[473.153336] [079/131] (563s left) dumb_buffer (map-valid)
[473.212868] Starting subtest: map-valid
[473.214901] Subtest map-valid: SUCCESS (0.000s)
[473.311543] [080/131] (563s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[473.406251] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[473.410460] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[473.513193] [081/131] (563s left) syncobj_basic (bad-pad-fd-to-handle)
[473.578483] Starting subtest: bad-pad-fd-to-handle
[473.580749] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[473.692054] [082/131] (563s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[473.754359] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[473.862034] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[473.937919] [083/131] (562s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[474.039551] Starting subtest: psr-rgb565-draw-mmap-wc
[480.718182] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.680s)
[480.829774] [084/131] (555s left) kms_rotation_crc (bad-pixel-format)
[480.926840] Starting subtest: bad-pixel-format
[480.931284] Subtest bad-pixel-format: SKIP (0.001s)
[480.999844] [085/131] (555s left) kms_vblank (wait-idle-hang)
[481.095877] Starting subtest: wait-idle-hang
[481.098174] Starting dynamic subtest: pipe-A-eDP-1
[507.980465] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.876s)
[507.995052] Starting dynamic subtest: pipe-D-eDP-1
[531.985680] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.994s)
[531.987987] Subtest wait-idle-hang: SUCCESS (50.873s)
[532.856790] [086/131] (504s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[532.915805] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[532.982196] [087/131] (503s left) syncobj_wait (wait-all-for-submit-snapshot)
[533.034214] Starting subtest: wait-all-for-submit-snapshot
[533.116680] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[533.191902] [088/131] (503s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[533.316395] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[564.149325] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.827s)
[565.002091] [089/131] (472s left) gem_workarounds (suspend-resume-context)
[565.067602] Starting subtest: suspend-resume-context
[581.187737] Subtest suspend-resume-context: SUCCESS (1.593s)
[590.340560] [090/131] (455s left) sysfs_heartbeat_interval (precise)
[590.423113] Starting subtest: precise
[590.426081] Starting dynamic subtest: vecs0
[597.740223] Dynamic subtest vecs0: SUCCESS (7.140s)
[597.750311] Starting dynamic subtest: ccs0
[600.626549] Dynamic subtest ccs0: SUCCESS (2.852s)
[600.638764] Starting dynamic subtest: vcs0
[607.806285] Dynamic subtest vcs0: SUCCESS (7.131s)
[607.818519] Starting dynamic subtest: bcs0
[608.917570] Dynamic subtest bcs0: SUCCESS (1.104s)
[608.929311] Starting dynamic subtest: rcs0
[609.985021] Dynamic subtest rcs0: SUCCESS (1.063s)
[609.994647] Starting dynamic subtest: vcs1
[617.773275] Dynamic subtest vcs1: SUCCESS (7.770s)
[617.775913] Subtest precise: SUCCESS (27.069s)
[617.850460] [091/131] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[617.957520] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[617.963352] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[618.068292] [092/131] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[618.179524] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[618.184232] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.285823] [093/131] (427s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[618.388999] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[625.406250] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (7.013s)
[625.567605] [094/131] (420s left) gem_sync (basic-all)
[625.640677] Starting subtest: basic-all
[629.721782] Subtest basic-all: SUCCESS (4.090s)
[629.907655] [095/131] (416s left) kms_plane_scaling (planes-scaler-unity-scaling)
[630.011435] Starting subtest: planes-scaler-unity-scaling
[630.014152] Starting dynamic subtest: pipe-A
[630.078513] Dynamic subtest pipe-A: SUCCESS (0.070s)
[630.088521] Starting dynamic subtest: pipe-B
[631.192181] Dynamic subtest pipe-B: SUCCESS (1.112s)
[631.203941] Starting dynamic subtest: pipe-C
[632.307800] Dynamic subtest pipe-C: SUCCESS (1.115s)
[632.317875] Starting dynamic subtest: pipe-D
[633.440351] Dynamic subtest pipe-D: SUCCESS (1.131s)
[633.442707] Subtest planes-scaler-unity-scaling: SUCCESS (3.432s)
[634.605804] [096/131] (411s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[634.711320] Starting subtest: yf-tiled-16bpp-rotate-180
[634.716400] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[634.797098] [097/131] (411s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[634.862884] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[634.942966] [098/131] (411s left) gem_exec_balancer (parallel-contexts)
[635.201534] Starting subtest: parallel-contexts
[637.773647] Subtest parallel-contexts: SUCCESS (2.572s)
[638.726728] [099/131] (407s left) gem_ctx_param (invalid-set-no-zeromap)
[638.781520] Starting subtest: invalid-set-no-zeromap
[638.784531] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[638.856866] [100/131] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[638.963325] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[638.968236] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[639.072222] [101/131] (407s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[639.160917] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[639.163339] Starting dynamic subtest: pipe-A-eDP-1
[639.189011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[639.198488] Starting dynamic subtest: pipe-B-eDP-1
[639.222549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[639.232084] Starting dynamic subtest: pipe-C-eDP-1
[639.260392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[639.271013] Starting dynamic subtest: pipe-D-eDP-1
[639.297385] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[639.302306] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[641.396810] [102/131] (405s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[641.454422] Starting subtest: etime-single-wait-available-unsubmitted
[641.557408] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[641.638941] [103/131] (404s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[641.684659] Starting subtest: invalid-signal-one-illegal-handle
[641.686813] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[641.773195] [104/131] (404s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[641.820428] Starting subtest: mixed-tiled-to-y-tiled-ccs
[641.825209] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[642.003536] [105/131] (404s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[642.063240] Starting subtest: framebuffer-vs-set-tiling
[642.068183] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[642.228859] [106/131] (404s left) gem_mmap_gtt (cpuset-big-copy-xy)
[642.287931] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[642.364541] [107/131] (404s left) gem_userptr_blits (nohangcheck)
[642.445600] Starting subtest: nohangcheck
[642.697236] Subtest nohangcheck: SUCCESS (0.248s)
[642.816835] [108/131] (404s left) api_intel_bb (simple-bb-ctx)
[642.873802] Starting subtest: simple-bb-ctx
[642.879430] Subtest simple-bb-ctx: SUCCESS (0.007s)
[643.004229] [109/131] (403s left) kms_sequence (queue-idle)
[643.100109] Starting subtest: queue-idle
[643.103668] Starting dynamic subtest: pipe-A-eDP-1
[644.893160] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.790s)
[644.903065] Starting dynamic subtest: pipe-B-eDP-1
[647.339544] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.445s)
[647.351454] Starting dynamic subtest: pipe-C-eDP-1
[649.748506] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[649.760097] Starting dynamic subtest: pipe-D-eDP-1
[652.191460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.441s)
[652.194155] Subtest queue-idle: SUCCESS (9.088s)
[653.002251] [110/131] (393s left) perf_pmu (busy-accuracy-2)
[653.044258] Starting subtest: busy-accuracy-2
[653.046255] Starting dynamic subtest: rcs0
[656.088411] Dynamic subtest rcs0: SUCCESS (3.042s)
[656.105035] Starting dynamic subtest: bcs0
[659.146965] Dynamic subtest bcs0: SUCCESS (3.055s)
[659.157355] Starting dynamic subtest: vcs0
[662.194421] Dynamic subtest vcs0: SUCCESS (3.046s)
[662.204715] Starting dynamic subtest: vcs1
[665.244529] Dynamic subtest vcs1: SUCCESS (3.046s)
[665.256519] Starting dynamic subtest: vecs0
[668.291213] Dynamic subtest vecs0: SUCCESS (3.045s)
[668.303098] Starting dynamic subtest: ccs0
[671.348039] Dynamic subtest ccs0: SUCCESS (3.053s)
[671.350959] Subtest busy-accuracy-2: SUCCESS (18.297s)
[671.463512] [111/131] (375s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[671.526997] Subtest writes-after-reads-snoop: SKIP (0.000s)
[671.611977] [112/131] (375s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[671.719379] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[671.825208] [113/131] (375s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[671.916220] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[671.918909] Starting dynamic subtest: pipe-A-eDP-1
[671.943977] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[671.955523] Starting dynamic subtest: pipe-B-eDP-1
[671.980288] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[671.989965] Starting dynamic subtest: pipe-C-eDP-1
[672.014072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[672.023435] Starting dynamic subtest: pipe-D-eDP-1
[672.049008] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[672.053162] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[674.085321] [114/131] (373s left) gem_exec_schedule (out-order)
[674.156346] Starting subtest: out-order
[674.158813] Starting dynamic subtest: rcs0
[674.256426] Dynamic subtest rcs0: SUCCESS (0.108s)
[674.268900] Starting dynamic subtest: vcs0
[674.338786] Dynamic subtest vcs0: SUCCESS (0.082s)
[674.350524] Starting dynamic subtest: vcs1
[674.420552] Dynamic subtest vcs1: SUCCESS (0.081s)
[674.433130] Starting dynamic subtest: vecs0
[674.492517] Dynamic subtest vecs0: SUCCESS (0.072s)
[674.505130] Starting dynamic subtest: ccs0
[674.576281] Dynamic subtest ccs0: SUCCESS (0.083s)
[674.579184] Subtest out-order: SUCCESS (0.428s)
[675.848719] [115/131] (371s left) gem_exec_fence (syncobj-timeline-repeat)
[676.424064] Starting subtest: syncobj-timeline-repeat
[676.648138] Subtest syncobj-timeline-repeat: SUCCESS (0.224s)
[677.843291] [116/131] (369s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[677.954553] Starting subtest: psr-1p-primscrn-cur-indfb-move
[685.158143] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.204s)
[685.315024] [117/131] (361s left) kms_big_fb (linear-8bpp-rotate-90)
[685.420696] Starting subtest: linear-8bpp-rotate-90
[685.441444] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[685.593139] [118/131] (361s left) gem_mmap_gtt (medium-copy-odd)
[685.655203] Subtest medium-copy-odd: SKIP (0.000s)
[685.721772] [119/131] (361s left) kms_getfb (getfb2-into-addfb2)
[685.823150] Starting subtest: getfb2-into-addfb2
[685.825173] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[685.943027] [120/131] (361s left) kms_prop_blob (invalid-get-prop-any)
[686.002131] Starting subtest: invalid-get-prop-any
[686.004125] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[686.099933] [121/131] (361s left) gem_exec_schedule (preempt-queue-contexts-chain)
[686.170792] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[686.473864] [122/131] (360s left) kms_psr (fbc-pr-sprite-render)
[686.565088] Starting subtest: fbc-pr-sprite-render
[686.569564] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[686.637647] [123/131] (360s left) perf (invalid-remove-userspace-config)
[686.712971] Starting subtest: invalid-remove-userspace-config
[686.723061] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[686.770886] [124/131] (360s left) gem_userptr_blits (forbidden-operations)
[686.833242] Starting subtest: forbidden-operations
[686.838204] Subtest forbidden-operations: SKIP (0.000s)
[686.960727] [125/131] (360s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[687.083175] Starting subtest: cursorA-vs-flipA-atomic-transitions
[698.246092] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.160s)
[699.037753] [126/131] (348s left) perf_pmu (enable-race)
[699.082336] Starting subtest: enable-race
[699.084812] Starting dynamic subtest: rcs0
[711.835767] Dynamic subtest rcs0: SUCCESS (12.757s)
[711.846519] Starting dynamic subtest: bcs0
[724.576543] Dynamic subtest bcs0: SUCCESS (12.739s)
[724.587449] Starting dynamic subtest: vcs0
[739.738421] Dynamic subtest vcs0: SUCCESS (15.157s)
[739.751346] Starting dynamic subtest: vcs1
[755.737390] Dynamic subtest vcs1: SUCCESS (15.993s)
[755.749692] Starting dynamic subtest: vecs0
[771.737120] Dynamic subtest vecs0: SUCCESS (15.993s)
[771.750522] Starting dynamic subtest: ccs0
[784.559812] Dynamic subtest ccs0: SUCCESS (12.818s)
[784.562528] Subtest enable-race: SUCCESS (85.472s)
[784.655462] [127/131] (262s left) kms_joiner (basic-force-big-joiner)
[784.777709] Starting subtest: basic-force-big-joiner
[784.780099] Starting dynamic subtest: single
[788.077522] Dynamic subtest single: SUCCESS (3.306s)
[788.080309] Subtest basic-force-big-joiner: SUCCESS (3.307s)
[789.258019] [128/131] (258s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[789.360452] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[790.314991] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.956s)
[790.463366] [129/131] (257s left) i915_pm_rpm (gem-execbuf)
[791.987047] Starting subtest: gem-execbuf
[791.990096] Starting dynamic subtest: smem0
[794.044359] Dynamic subtest smem0: SUCCESS (2.054s)
[794.047131] Subtest gem-execbuf: SUCCESS (2.056s)
[794.148514] [130/131] (253s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[794.247384] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[800.934415] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.687s)
[801.080078] [131/131] (246s left) gem_basic (create-close)
[801.142265] Starting subtest: create-close
[801.147898] Subtest create-close: SUCCESS (0.000s)
[801.232039] 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.