[84.198891] Initializing watchdogs
[84.198978]   /dev/watchdog0
[84.219753] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[84.230850] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[84.234888] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[84.237375] [001/131] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[84.435175] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[84.477518] [002/131] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[84.666231] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[84.667170] Starting dynamic subtest: pipe-A-DP-3
[84.688285] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[84.695724] Starting dynamic subtest: pipe-B-DP-3
[84.717324] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[84.725194] Starting dynamic subtest: pipe-C-DP-3
[84.749731] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[84.757443] Starting dynamic subtest: pipe-D-DP-3
[84.782614] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[84.784144] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.011s)
[85.113220] [003/131] (959s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[85.300182] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[85.301057] Starting dynamic subtest: pipe-A
[85.859601] Dynamic subtest pipe-A: SUCCESS (0.558s)
[85.875748] Starting dynamic subtest: pipe-B
[86.510387] Dynamic subtest pipe-B: SUCCESS (0.650s)
[86.528826] Starting dynamic subtest: pipe-C
[87.159203] Dynamic subtest pipe-C: SUCCESS (0.648s)
[87.173899] Starting dynamic subtest: pipe-D
[87.807991] Dynamic subtest pipe-D: SUCCESS (0.648s)
[87.808861] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.505s)
[88.133833] [004/131] (956s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[88.344694] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[89.457479] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.112s)
[89.658060] [005/131] (955s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[89.844360] Starting subtest: plane-primary-toggle-with-vblank-wait
[89.845269] Starting dynamic subtest: pipe-A-DP-3
[90.058483] Dynamic subtest pipe-A-DP-3: SUCCESS (0.212s)
[90.192709] Starting dynamic subtest: pipe-B-DP-3
[90.462909] Dynamic subtest pipe-B-DP-3: SUCCESS (0.278s)
[90.576243] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.730s)
[90.821846] [006/131] (954s left) drm_read (fault-buffer)
[91.090358] Starting subtest: fault-buffer
[91.091272] Subtest fault-buffer: SUCCESS (0.001s)
[91.321514] [007/131] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[91.517515] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[93.947393] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.425s)
[94.096488] [008/131] (951s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[94.280191] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[94.281169] Starting dynamic subtest: pipe-A-valid-mode
[94.357657] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[94.359461] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.077s)
[94.563175] [009/131] (950s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[94.754129] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[94.802645] [010/131] (950s left) kms_psr (pr-cursor-mmap-cpu)
[94.992122] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[95.053224] [011/131] (950s left) gem_ctx_param (invalid-get-engines)
[95.122380] Starting subtest: invalid-get-engines
[95.124180] Subtest invalid-get-engines: SUCCESS (0.002s)
[95.272134] [012/131] (950s left) i915_hangman (detector)
[95.360983] Starting subtest: detector
[95.361922] Starting dynamic subtest: rcs0
[105.214297] Dynamic subtest rcs0: SUCCESS (9.841s)
[105.223232] Starting dynamic subtest: bcs0
[115.152373] Dynamic subtest bcs0: SUCCESS (9.930s)
[115.161046] Starting dynamic subtest: vcs0
[125.203457] Dynamic subtest vcs0: SUCCESS (10.045s)
[125.213288] Starting dynamic subtest: vcs1
[135.193354] Dynamic subtest vcs1: SUCCESS (9.986s)
[135.201693] Starting dynamic subtest: vecs0
[145.174304] Dynamic subtest vecs0: SUCCESS (9.978s)
[145.183017] Starting dynamic subtest: vecs1
[155.167543] Dynamic subtest vecs1: SUCCESS (9.990s)
[155.176837] Starting dynamic subtest: ccs0
[165.135467] Dynamic subtest ccs0: SUCCESS (9.970s)
[165.136342] Subtest detector: SUCCESS (69.741s)
[165.315626] [013/131] (880s left) kms_rmfb (close-fd)
[165.504176] Starting subtest: close-fd
[165.505191] Starting dynamic subtest: pipe-A-DP-3
[165.669397] Dynamic subtest pipe-A-DP-3: SUCCESS (0.164s)
[165.684574] Starting dynamic subtest: pipe-B-DP-3
[165.962059] Dynamic subtest pipe-B-DP-3: SUCCESS (0.291s)
[165.970703] Starting dynamic subtest: pipe-C-DP-3
[166.226989] Dynamic subtest pipe-C-DP-3: SUCCESS (0.264s)
[166.235623] Starting dynamic subtest: pipe-D-DP-3
[166.492108] Dynamic subtest pipe-D-DP-3: SUCCESS (0.264s)
[166.493008] Subtest close-fd: SUCCESS (0.988s)
[166.808570] [014/131] (878s left) kms_pm_lpsp (kms-lpsp)
[168.009124] Starting subtest: kms-lpsp
[168.010913] Subtest kms-lpsp: SKIP (0.000s)
[168.103933] [015/131] (877s left) kms_frontbuffer_tracking (fbc-suspend)
[168.295821] Starting subtest: fbc-suspend
[209.659731] Subtest fbc-suspend: SUCCESS (10.506s)
[226.935845] [016/131] (835s left) gem_linear_blits (interruptible)
[227.265483] Starting subtest: interruptible
[234.282025] Subtest interruptible: SUCCESS (7.015s)
[234.542447] [017/131] (828s left) gem_pxp (create-regular-context-1)
[237.197882] Starting subtest: create-regular-context-1
[237.200594] Subtest create-regular-context-1: SKIP (0.000s)
[237.297763] [018/131] (825s left) i915_pm_rps (reset)
[237.376619] Starting subtest: reset
[241.169052] Subtest reset: SUCCESS (3.791s)
[241.297260] [019/131] (821s left) gem_madvise (dontneed-after-mmap)
[241.340436] Starting subtest: dontneed-after-mmap
[241.378998] Subtest dontneed-after-mmap: SUCCESS (0.038s)
[241.500598] [020/131] (821s left) kms_cursor_legacy (torture-bo)
[241.711808] Starting subtest: torture-bo
[241.712873] Starting dynamic subtest: pipe-A
[247.242222] Dynamic subtest pipe-A: SUCCESS (5.526s)
[247.256737] Starting dynamic subtest: pipe-B
[252.785931] Dynamic subtest pipe-B: SUCCESS (5.540s)
[252.798098] Starting dynamic subtest: pipe-C
[258.964124] Dynamic subtest pipe-C: SUCCESS (6.177s)
[258.975699] Starting dynamic subtest: pipe-D
[264.762646] Dynamic subtest pipe-D: SUCCESS (5.799s)
[264.776157] Starting dynamic subtest: all-pipes
[270.261396] Dynamic subtest all-pipes: SUCCESS (5.498s)
[270.262282] Subtest torture-bo: SUCCESS (28.546s)
[270.359173] [021/131] (792s left) syncobj_timeline (wait-all-for-submit-snapshot)
[270.460297] Starting subtest: wait-all-for-submit-snapshot
[270.543578] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[270.682180] [022/131] (792s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[270.877449] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[270.892879] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.015s)
[270.986917] [023/131] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[271.187944] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[271.189652] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[271.322818] [024/131] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[271.514121] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[271.515859] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[271.664683] [025/131] (791s left) kms_cursor_crc (cursor-suspend)
[271.930314] Starting subtest: cursor-suspend
[271.932265] Starting dynamic subtest: pipe-A-DP-3
[310.065437] Dynamic subtest pipe-A-DP-3: SUCCESS (8.029s)
[310.089649] Starting dynamic subtest: pipe-D-DP-3
[349.026369] Dynamic subtest pipe-D-DP-3: SUCCESS (7.451s)
[349.027496] Subtest cursor-suspend: SUCCESS (15.487s)
[376.579826] [026/131] (713s left) kms_lease (lease-invalid-connector)
[376.766198] Starting subtest: lease-invalid-connector
[376.767209] Starting dynamic subtest: pipe-A-DP-3
[376.768122] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[376.779719] Starting dynamic subtest: pipe-B-DP-3
[376.780655] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[376.792048] Starting dynamic subtest: pipe-C-DP-3
[376.793208] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[376.804478] Starting dynamic subtest: pipe-D-DP-3
[376.805621] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[376.806775] Subtest lease-invalid-connector: SUCCESS (0.004s)
[376.857654] [027/131] (713s left) gem_mmap_wc (pf-nonblock)
[376.928839] Subtest pf-nonblock: SKIP (0.000s)
[377.002204] [028/131] (713s left) kms_cursor_crc (cursor-onscreen-max-size)
[377.494826] Starting subtest: cursor-onscreen-max-size
[377.497551] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[377.666349] [029/131] (712s left) gem_userptr_blits (relocations)
[377.746414] Starting subtest: relocations
[377.748081] Subtest relocations: SKIP (0.001s)
[377.924479] [030/131] (712s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[378.124725] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[378.126382] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[378.277019] [031/131] (712s left) kms_atomic_transition (modeset-transition-nonblocking)
[378.464605] Starting subtest: modeset-transition-nonblocking
[378.465516] Starting dynamic subtest: 1x-outputs
[381.031424] Dynamic subtest 1x-outputs: SUCCESS (2.565s)
[381.087086] Subtest modeset-transition-nonblocking: SUCCESS (2.621s)
[381.353799] [032/131] (709s left) kms_content_protection (dp-mst-type-1)
[381.603406] Starting subtest: dp-mst-type-1
[381.605140] Subtest dp-mst-type-1: SKIP (0.000s)
[381.762090] [033/131] (709s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[381.954838] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[381.956619] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[382.088588] [034/131] (708s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[382.279117] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[382.280057] Starting dynamic subtest: pipe-A-DP-3
[382.288776] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[382.300144] Starting dynamic subtest: pipe-B-DP-3
[382.308827] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[382.320032] Starting dynamic subtest: pipe-C-DP-3
[382.328464] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[382.340073] Starting dynamic subtest: pipe-D-DP-3
[382.350988] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[382.352602] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s)
[382.745918] [035/131] (708s left) prime_busy (before-wait)
[382.827908] Starting subtest: before-wait
[382.832800] Starting dynamic subtest: rcs0
[382.888092] Dynamic subtest rcs0: SUCCESS (0.055s)
[382.900024] Starting dynamic subtest: bcs0
[382.942074] Dynamic subtest bcs0: SUCCESS (0.053s)
[382.962310] Starting dynamic subtest: vcs0
[382.982605] Dynamic subtest vcs0: SUCCESS (0.040s)
[383.006425] Starting dynamic subtest: vcs1
[383.023241] Dynamic subtest vcs1: SUCCESS (0.040s)
[383.042591] Starting dynamic subtest: vecs0
[383.064336] Dynamic subtest vecs0: SUCCESS (0.040s)
[383.079421] Starting dynamic subtest: vecs1
[383.105552] Dynamic subtest vecs1: SUCCESS (0.041s)
[383.122214] Starting dynamic subtest: ccs0
[383.146970] Dynamic subtest ccs0: SUCCESS (0.040s)
[383.255152] Subtest before-wait: SUCCESS (0.427s)
[383.440489] [036/131] (707s left) kms_flip (2x-blocking-absolute-wf_vblank)
[383.628896] Starting subtest: 2x-blocking-absolute-wf_vblank
[383.643797] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.014s)
[383.737919] [037/131] (707s left) gem_ccs (ctrl-surf-copy-new-ctx)
[383.815370] Starting subtest: ctrl-surf-copy-new-ctx
[383.816320] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[383.873080] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.057s)
[383.885318] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[384.068595] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.195s)
[384.080660] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[384.098996] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.030s)
[384.110627] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[384.301904] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[384.313562] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[384.330828] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.028s)
[384.342525] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[384.536652] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.205s)
[384.548448] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[384.563985] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.027s)
[384.575705] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[384.767043] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.202s)
[384.768104] Subtest ctrl-surf-copy-new-ctx: SUCCESS (0.951s)
[384.935057] [038/131] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[385.127593] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[385.129283] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[385.260305] [039/131] (706s left) kms_dp_linktrain_fallback (dp-fallback)
[385.459366] Starting subtest: dp-fallback
[395.263380] Subtest dp-fallback: SUCCESS (9.801s)
[395.633483] [040/131] (695s left) kms_rmfb (rmfb-ioctl)
[395.842287] Starting subtest: rmfb-ioctl
[395.844583] Starting dynamic subtest: pipe-A-DP-3
[395.985203] Dynamic subtest pipe-A-DP-3: SUCCESS (0.142s)
[396.007436] Starting dynamic subtest: pipe-B-DP-3
[396.302121] Dynamic subtest pipe-B-DP-3: SUCCESS (0.315s)
[396.314886] Starting dynamic subtest: pipe-C-DP-3
[396.552016] Dynamic subtest pipe-C-DP-3: SUCCESS (0.248s)
[396.564854] Starting dynamic subtest: pipe-D-DP-3
[396.800785] Dynamic subtest pipe-D-DP-3: SUCCESS (0.247s)
[396.801744] Subtest rmfb-ioctl: SUCCESS (0.959s)
[397.046118] [041/131] (694s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[397.248808] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[397.250389] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.393175] [042/131] (694s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[397.586398] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[397.588869] Starting dynamic subtest: pipe-A-valid-mode
[397.680060] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s)
[397.682144] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.092s)
[397.894558] [043/131] (693s left) gen9_exec_parse (unaligned-jump)
[397.977186] Subtest unaligned-jump: SKIP (0.000s)
[398.075218] [044/131] (693s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[398.278266] Starting subtest: y-tiled-64bpp-rotate-180
[398.280005] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[398.420804] [045/131] (693s left) gem_workarounds (basic-read)
[398.508380] Starting subtest: basic-read
[398.547839] Subtest basic-read: SUCCESS (0.039s)
[398.743306] [046/131] (693s left) kms_scaling_modes (scaling-mode-none)
[398.932267] Starting subtest: scaling-mode-none
[398.937508] Subtest scaling-mode-none: SKIP (0.001s)
[399.029832] [047/131] (692s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[399.306335] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[399.475339] [048/131] (692s left) perf (per-context-mode-unprivileged)
[399.837718] Starting subtest: per-context-mode-unprivileged
[399.839370] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[399.899868] [049/131] (692s left) kms_async_flips (alternate-sync-async-flip-atomic)
[400.087501] Starting subtest: alternate-sync-async-flip-atomic
[400.314076] Starting dynamic subtest: pipe-A-DP-3
[402.587602] Dynamic subtest pipe-A-DP-3: SUCCESS (2.273s)
[402.836029] Starting dynamic subtest: pipe-B-DP-3
[404.935600] Dynamic subtest pipe-B-DP-3: SUCCESS (2.112s)
[405.147648] Starting dynamic subtest: pipe-C-DP-3
[407.262918] Dynamic subtest pipe-C-DP-3: SUCCESS (2.126s)
[407.492077] Starting dynamic subtest: pipe-D-DP-3
[409.608754] Dynamic subtest pipe-D-DP-3: SUCCESS (2.129s)
[409.614970] Subtest alternate-sync-async-flip-atomic: SUCCESS (9.522s)
[410.088737] [050/131] (681s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[410.282406] Starting subtest: basic-max-pipe-crc-check
[410.284201] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[410.347946] [051/131] (681s left) gem_exec_reloc (basic-write-gtt-active)
[410.432257] Subtest basic-write-gtt-active: SKIP (0.000s)
[410.519111] [052/131] (681s left) gem_lmem_swapping (massive-random)
[413.195072] Starting subtest: massive-random
[413.195978] Starting dynamic subtest: lmem0
[413.293630] Dynamic subtest lmem0: SUCCESS (0.100s)
[413.294470] Subtest massive-random: SUCCESS (0.102s)
[414.928684] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[414.931209] [053/131] (677s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[416.499507] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[416.502166] Starting dynamic subtest: pipe-A-DP-3
[416.509994] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[416.521237] Starting dynamic subtest: pipe-B-DP-3
[416.529082] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[416.539015] Starting dynamic subtest: pipe-C-DP-3
[416.546801] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[416.556632] Starting dynamic subtest: pipe-D-DP-3
[416.564151] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[416.565028] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SUCCESS (0.017s)
[416.982099] [FACT kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)] changed: hardware.pci.drm_card_at_addr.0000:03:00.0: card1 -> card0
[416.984432] [FACT kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[416.987422] [054/131] (675s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[417.183412] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[419.732691] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.552s)
[419.930280] [055/131] (672s left) sw_sync (alloc_fence_invalid_timeline)
[419.976146] Starting subtest: alloc_fence_invalid_timeline
[419.977241] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[420.043514] [056/131] (672s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[420.721959] Starting subtest: syncobj-backward-timeline-chain-engines
[420.879464] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.158s)
[421.234361] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[421.236914] [057/131] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[421.436031] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[421.437775] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[421.570062] [058/131] (670s left) gem_exec_schedule (submit-late-slice)
[421.665315] Starting subtest: submit-late-slice
[421.666261] Starting dynamic subtest: rcs0
[421.746116] Dynamic subtest rcs0: SUCCESS (0.080s)
[421.757309] Starting dynamic subtest: bcs0
[421.800870] Dynamic subtest bcs0: SUCCESS (0.054s)
[421.813698] Starting dynamic subtest: vcs0
[421.854117] Dynamic subtest vcs0: SUCCESS (0.052s)
[421.866700] Starting dynamic subtest: vcs1
[421.908385] Dynamic subtest vcs1: SUCCESS (0.053s)
[421.921199] Starting dynamic subtest: vecs0
[421.961403] Dynamic subtest vecs0: SUCCESS (0.052s)
[421.974326] Starting dynamic subtest: vecs1
[422.014657] Dynamic subtest vecs1: SUCCESS (0.052s)
[422.027668] Starting dynamic subtest: ccs0
[422.065304] Dynamic subtest ccs0: SUCCESS (0.049s)
[422.066280] Subtest submit-late-slice: SUCCESS (0.401s)
[422.576811] [059/131] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[422.779890] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[426.180609] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.401s)
[426.432336] [060/131] (666s left) gem_mmap_wc (write)
[426.510208] Subtest write: SKIP (0.000s)
[426.578758] [061/131] (666s left) kms_psr (pr-primary-render)
[426.776242] Subtest pr-primary-render: SKIP (0.000s)
[426.842513] [062/131] (666s left) gem_exec_reloc (basic-cpu-gtt-active)
[426.929801] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[427.014777] [063/131] (665s left) gem_exec_whisper (basic-fds-forked-all)
[427.108201] Starting subtest: basic-fds-forked-all
[450.042498] Subtest basic-fds-forked-all: SUCCESS (22.933s)
[450.279761] [064/131] (642s left) kms_plane_lowres (tiling-yf)
[450.476362] Starting subtest: tiling-yf
[450.478254] Subtest tiling-yf: SKIP (0.000s)
[450.595097] [065/131] (642s left) kms_flip (dpms-vs-vblank-race)
[450.792931] Starting subtest: dpms-vs-vblank-race
[450.797455] Starting dynamic subtest: A-DP3
[454.078504] Dynamic subtest A-DP3: SUCCESS (3.279s)
[454.107265] Starting dynamic subtest: B-DP3
[457.219635] Dynamic subtest B-DP3: SUCCESS (3.138s)
[457.236893] Starting dynamic subtest: C-DP3
[460.213132] Dynamic subtest C-DP3: SUCCESS (2.992s)
[460.230674] Starting dynamic subtest: D-DP3
[463.377074] Dynamic subtest D-DP3: SUCCESS (3.161s)
[463.379718] Subtest dpms-vs-vblank-race: SUCCESS (12.584s)
[463.634887] [066/131] (629s left) gem_ctx_shared (q-independent)
[463.730972] Starting subtest: Q-independent
[463.732011] Starting dynamic subtest: rcs0
[463.961414] Dynamic subtest rcs0: SUCCESS (0.230s)
[463.973383] Starting dynamic subtest: bcs0
[464.111697] Dynamic subtest bcs0: SUCCESS (0.149s)
[464.124061] Starting dynamic subtest: vcs0
[464.272275] Dynamic subtest vcs0: SUCCESS (0.160s)
[464.284220] Starting dynamic subtest: vcs1
[464.435144] Dynamic subtest vcs1: SUCCESS (0.162s)
[464.447052] Starting dynamic subtest: vecs0
[464.593739] Dynamic subtest vecs0: SUCCESS (0.158s)
[464.605593] Starting dynamic subtest: vecs1
[464.755028] Dynamic subtest vecs1: SUCCESS (0.160s)
[464.766821] Starting dynamic subtest: ccs0
[464.911373] Dynamic subtest ccs0: SUCCESS (0.155s)
[464.912312] Subtest Q-independent: SUCCESS (1.181s)
[465.251678] [067/131] (627s left) kms_psr (psr-cursor-plane-move)
[465.447096] Subtest psr-cursor-plane-move: SKIP (0.000s)
[465.505826] [068/131] (627s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[465.602545] Starting subtest: invalid-bsd1-flag-on-vebox
[465.603480] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[465.773154] [069/131] (627s left) kms_flip (flip-vs-wf_vblank-interruptible)
[465.972876] Starting subtest: flip-vs-wf_vblank-interruptible
[465.977614] Starting dynamic subtest: A-DP3
[467.086777] Dynamic subtest A-DP3: SUCCESS (1.109s)
[467.112912] Starting dynamic subtest: B-DP3
[468.299340] Dynamic subtest B-DP3: SUCCESS (1.210s)
[468.313138] Starting dynamic subtest: C-DP3
[469.340459] Dynamic subtest C-DP3: SUCCESS (1.040s)
[469.354152] Starting dynamic subtest: D-DP3
[470.373809] Dynamic subtest D-DP3: SUCCESS (1.032s)
[470.376274] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.402s)
[470.727123] [070/131] (622s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[470.824458] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[470.826400] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[471.063008] [071/131] (622s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[471.273246] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[471.275110] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[471.382747] [072/131] (622s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[471.584212] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[471.671800] [073/131] (622s left) syncobj_timeline (signal-point-0)
[471.751192] Starting subtest: signal-point-0
[471.752136] Subtest signal-point-0: SUCCESS (0.000s)
[471.924896] [074/131] (621s left) api_intel_bb (bb-with-allocator)
[472.002253] Starting subtest: bb-with-allocator
[472.032111] Subtest bb-with-allocator: SUCCESS (0.030s)
[472.230062] [075/131] (621s left) gem_exec_balancer (full-late)
[472.330359] Starting subtest: full-late
[474.381134] Subtest full-late: SUCCESS (2.052s)
[474.777759] [076/131] (619s left) kms_chamelium_frames (hdmi-frame-dump)
[475.051333] Subtest hdmi-frame-dump: SKIP (0.000s)
[475.239296] [077/131] (618s left) gem_wait (write-busy)
[475.343902] Starting subtest: write-busy
[475.344896] Starting dynamic subtest: all-engines
[475.942783] Dynamic subtest all-engines: SUCCESS (0.598s)
[475.955770] Starting dynamic subtest: rcs0
[476.499105] Dynamic subtest rcs0: SUCCESS (0.555s)
[476.512147] Starting dynamic subtest: bcs0
[477.048207] Dynamic subtest bcs0: SUCCESS (0.548s)
[477.061043] Starting dynamic subtest: vcs0
[477.592169] Dynamic subtest vcs0: SUCCESS (0.543s)
[477.604930] Starting dynamic subtest: vcs1
[478.135321] Dynamic subtest vcs1: SUCCESS (0.542s)
[478.148372] Starting dynamic subtest: vecs0
[478.678131] Dynamic subtest vecs0: SUCCESS (0.542s)
[478.690799] Starting dynamic subtest: vecs1
[479.220268] Dynamic subtest vecs1: SUCCESS (0.541s)
[479.233150] Starting dynamic subtest: ccs0
[479.762212] Dynamic subtest ccs0: SUCCESS (0.541s)
[479.763211] Subtest write-busy: SUCCESS (4.417s)
[480.021871] [078/131] (614s left) kms_chamelium_frames (dp-crc-fast)
[480.303814] Subtest dp-crc-fast: SKIP (0.000s)
[480.452885] [079/131] (613s left) dumb_buffer (map-valid)
[480.534232] Starting subtest: map-valid
[480.535152] Subtest map-valid: SUCCESS (0.000s)
[480.710340] [080/131] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[480.917983] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[480.919725] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[481.060496] [081/131] (613s left) syncobj_basic (bad-pad-fd-to-handle)
[481.143221] Starting subtest: bad-pad-fd-to-handle
[481.144349] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[481.306272] [082/131] (613s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[481.388358] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[481.492784] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[481.600408] [083/131] (612s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[481.799965] Starting subtest: psr-rgb565-draw-mmap-wc
[481.801656] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[481.970646] [084/131] (612s left) kms_rotation_crc (bad-pixel-format)
[482.167352] Starting subtest: bad-pixel-format
[482.169129] Subtest bad-pixel-format: SKIP (0.001s)
[482.273634] [085/131] (612s left) kms_vblank (wait-idle-hang)
[482.471339] Starting subtest: wait-idle-hang
[482.473854] Starting dynamic subtest: pipe-A-DP-3
[509.047269] Dynamic subtest pipe-A-DP-3: SUCCESS (26.566s)
[509.062967] Starting dynamic subtest: pipe-D-DP-3
[533.977230] Dynamic subtest pipe-D-DP-3: SUCCESS (24.921s)
[533.978133] Subtest wait-idle-hang: SUCCESS (51.493s)
[534.241970] [086/131] (560s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[534.323091] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[534.399157] [087/131] (560s left) syncobj_wait (wait-all-for-submit-snapshot)
[534.483346] Starting subtest: wait-all-for-submit-snapshot
[534.566965] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[534.687816] [088/131] (560s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[534.883825] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[567.809350] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.918s)
[568.089509] [089/131] (526s left) gem_workarounds (suspend-resume-context)
[568.186678] Starting subtest: suspend-resume-context
[587.207102] Subtest suspend-resume-context: SUCCESS (3.696s)
[607.355316] [090/131] (507s left) sysfs_heartbeat_interval (precise)
[607.443395] Starting subtest: precise
[607.445566] Starting dynamic subtest: vecs0
[609.015442] Dynamic subtest vecs0: SUCCESS (1.570s)
[609.028384] Starting dynamic subtest: ccs0
[610.536244] Dynamic subtest ccs0: SUCCESS (1.519s)
[610.550784] Starting dynamic subtest: vcs0
[612.874461] Dynamic subtest vcs0: SUCCESS (2.336s)
[612.887605] Starting dynamic subtest: bcs0
[614.336385] Dynamic subtest bcs0: SUCCESS (1.460s)
[614.349551] Starting dynamic subtest: vecs1
[615.786469] Dynamic subtest vecs1: SUCCESS (1.449s)
[615.799600] Starting dynamic subtest: rcs0
[617.253432] Dynamic subtest rcs0: SUCCESS (1.465s)
[617.266539] Starting dynamic subtest: vcs1
[618.692271] Dynamic subtest vcs1: SUCCESS (1.437s)
[618.693229] Subtest precise: SUCCESS (11.247s)
[618.835500] [091/131] (496s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[619.034253] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[619.036107] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[619.181598] [092/131] (495s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[619.381221] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[619.383026] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[619.528291] [093/131] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[619.728247] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[619.729994] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[619.886466] [094/131] (495s left) gem_sync (basic-all)
[619.982633] Starting subtest: basic-all
[622.133841] Subtest basic-all: SUCCESS (2.150s)
[622.342170] [095/131] (492s left) kms_plane_scaling (planes-scaler-unity-scaling)
[622.535606] Starting subtest: planes-scaler-unity-scaling
[622.536524] Starting dynamic subtest: pipe-A
[622.632480] Dynamic subtest pipe-A: SUCCESS (0.096s)
[622.649999] Starting dynamic subtest: pipe-B
[622.850743] Dynamic subtest pipe-B: SUCCESS (0.217s)
[622.868759] Starting dynamic subtest: pipe-C
[623.048230] Dynamic subtest pipe-C: SUCCESS (0.196s)
[623.071027] Starting dynamic subtest: pipe-D
[623.283573] Dynamic subtest pipe-D: SUCCESS (0.234s)
[623.284557] Subtest planes-scaler-unity-scaling: SUCCESS (0.748s)
[623.605208] [096/131] (491s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[623.818355] Starting subtest: yf-tiled-16bpp-rotate-180
[623.820228] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[623.957853] [097/131] (491s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[624.044495] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[624.169503] [098/131] (491s left) gem_exec_balancer (parallel-contexts)
[624.540015] Starting subtest: parallel-contexts
[631.331518] Subtest parallel-contexts: SUCCESS (6.790s)
[631.434652] [099/131] (484s left) gem_ctx_param (invalid-set-no-zeromap)
[631.513838] Starting subtest: invalid-set-no-zeromap
[631.514765] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[631.633181] [100/131] (484s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[631.831157] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[631.832918] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[631.985901] [101/131] (483s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[632.180634] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[632.183368] Starting dynamic subtest: pipe-A-DP-3
[632.193026] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[632.206141] Starting dynamic subtest: pipe-B-DP-3
[632.215717] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[632.228279] Starting dynamic subtest: pipe-C-DP-3
[632.238311] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[632.251310] Starting dynamic subtest: pipe-D-DP-3
[632.263428] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[632.265203] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[632.668349] [102/131] (483s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[632.747582] Starting subtest: etime-single-wait-available-unsubmitted
[632.855716] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.106s)
[632.982015] [103/131] (482s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[633.060516] Starting subtest: invalid-signal-one-illegal-handle
[633.061576] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[633.221416] [104/131] (482s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[633.305884] Starting subtest: mixed-tiled-to-y-tiled-ccs
[633.307928] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[633.573601] [105/131] (482s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[633.654882] Starting subtest: framebuffer-vs-set-tiling
[633.656617] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[633.936931] [106/131] (482s left) gem_mmap_gtt (cpuset-big-copy-xy)
[634.016519] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[634.106103] [107/131] (482s left) gem_userptr_blits (nohangcheck)
[634.203841] Starting subtest: nohangcheck
[634.511848] Subtest nohangcheck: SUCCESS (0.308s)
[634.693538] [108/131] (481s left) api_intel_bb (simple-bb-ctx)
[634.801035] Starting subtest: simple-bb-ctx
[634.834022] Subtest simple-bb-ctx: SUCCESS (0.033s)
[635.010006] [109/131] (481s left) kms_sequence (queue-idle)
[635.207587] Starting subtest: queue-idle
[635.210194] Starting dynamic subtest: pipe-A-DP-3
[637.605300] Dynamic subtest pipe-A-DP-3: SUCCESS (2.395s)
[637.618574] Starting dynamic subtest: pipe-B-DP-3
[639.869129] Dynamic subtest pipe-B-DP-3: SUCCESS (2.262s)
[639.888440] Starting dynamic subtest: pipe-C-DP-3
[642.165544] Dynamic subtest pipe-C-DP-3: SUCCESS (2.293s)
[642.180308] Starting dynamic subtest: pipe-D-DP-3
[644.453389] Dynamic subtest pipe-D-DP-3: SUCCESS (2.287s)
[644.454348] Subtest queue-idle: SUCCESS (9.246s)
[644.724394] [110/131] (471s left) perf_pmu (busy-accuracy-2)
[644.796590] Starting subtest: busy-accuracy-2
[644.799017] Starting dynamic subtest: rcs0
[647.868457] Dynamic subtest rcs0: SUCCESS (3.070s)
[647.881757] Starting dynamic subtest: bcs0
[650.944092] Dynamic subtest bcs0: SUCCESS (3.074s)
[650.957561] Starting dynamic subtest: vcs0
[654.013515] Dynamic subtest vcs0: SUCCESS (3.068s)
[654.027276] Starting dynamic subtest: vcs1
[657.082468] Dynamic subtest vcs1: SUCCESS (3.067s)
[657.096023] Starting dynamic subtest: vecs0
[660.150448] Dynamic subtest vecs0: SUCCESS (3.066s)
[660.164295] Starting dynamic subtest: vecs1
[663.216262] Dynamic subtest vecs1: SUCCESS (3.064s)
[663.230251] Starting dynamic subtest: ccs0
[666.280518] Dynamic subtest ccs0: SUCCESS (3.063s)
[666.281472] Subtest busy-accuracy-2: SUCCESS (21.481s)
[666.451643] [111/131] (450s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[666.545926] Subtest writes-after-reads-snoop: SKIP (0.000s)
[666.620417] [112/131] (450s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[666.816268] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[666.973486] [113/131] (449s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[667.167648] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[667.170151] Starting dynamic subtest: pipe-A-DP-3
[670.994711] Dynamic subtest pipe-A-DP-3: SUCCESS (3.820s)
[671.011886] Starting dynamic subtest: pipe-B-DP-3
[671.745796] Dynamic subtest pipe-B-DP-3: SUCCESS (0.744s)
[671.786985] Starting dynamic subtest: pipe-C-DP-3
[672.527731] Dynamic subtest pipe-C-DP-3: SUCCESS (0.773s)
[672.572559] Starting dynamic subtest: pipe-D-DP-3
[673.326874] Dynamic subtest pipe-D-DP-3: SUCCESS (0.790s)
[673.329118] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SUCCESS (6.154s)
[673.662921] [114/131] (443s left) gem_exec_schedule (out-order)
[673.762082] Starting subtest: out-order
[673.763097] Starting dynamic subtest: rcs0
[674.046903] Dynamic subtest rcs0: SUCCESS (0.284s)
[674.060143] Starting dynamic subtest: bcs0
[674.246051] Dynamic subtest bcs0: SUCCESS (0.198s)
[674.259237] Starting dynamic subtest: vcs0
[674.460072] Dynamic subtest vcs0: SUCCESS (0.213s)
[674.473399] Starting dynamic subtest: vcs1
[674.674246] Dynamic subtest vcs1: SUCCESS (0.213s)
[674.687794] Starting dynamic subtest: vecs0
[674.887572] Dynamic subtest vecs0: SUCCESS (0.212s)
[674.900796] Starting dynamic subtest: vecs1
[675.102687] Dynamic subtest vecs1: SUCCESS (0.214s)
[675.115956] Starting dynamic subtest: ccs0
[675.315938] Dynamic subtest ccs0: SUCCESS (0.212s)
[675.317106] Subtest out-order: SUCCESS (1.554s)
[675.856899] [115/131] (441s left) gem_exec_fence (syncobj-timeline-repeat)
[676.558974] Starting subtest: syncobj-timeline-repeat
[676.942547] Subtest syncobj-timeline-repeat: SUCCESS (0.383s)
[677.276572] [116/131] (439s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[677.480243] Starting subtest: psr-1p-primscrn-cur-indfb-move
[677.482115] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[677.604554] [117/131] (439s left) kms_big_fb (linear-8bpp-rotate-90)
[677.813446] Starting subtest: linear-8bpp-rotate-90
[677.870297] Subtest linear-8bpp-rotate-90: SKIP (0.056s)
[678.059807] [118/131] (439s left) gem_mmap_gtt (medium-copy-odd)
[678.136357] Subtest medium-copy-odd: SKIP (0.000s)
[678.226010] [119/131] (439s left) kms_getfb (getfb2-into-addfb2)
[678.424039] Starting subtest: getfb2-into-addfb2
[678.425018] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[678.631986] [120/131] (438s left) kms_prop_blob (invalid-get-prop-any)
[678.708443] Starting subtest: invalid-get-prop-any
[678.709350] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[678.844595] [121/131] (438s left) gem_exec_schedule (preempt-queue-contexts-chain)
[678.939948] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[679.354473] [122/131] (438s left) kms_psr (fbc-pr-sprite-render)
[679.550216] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[679.617798] [123/131] (437s left) perf (invalid-remove-userspace-config)
[679.963613] Starting subtest: invalid-remove-userspace-config
[679.972739] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[680.037605] [124/131] (437s left) gem_userptr_blits (forbidden-operations)
[680.123073] Starting subtest: forbidden-operations
[680.124868] Subtest forbidden-operations: SKIP (0.000s)
[680.326153] [125/131] (437s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[680.524073] Starting subtest: cursorA-vs-flipA-atomic-transitions
[691.496537] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.970s)
[691.774244] [126/131] (425s left) perf_pmu (enable-race)
[691.855513] Starting subtest: enable-race
[691.856419] Starting dynamic subtest: rcs0
[704.614513] Dynamic subtest rcs0: SUCCESS (12.759s)
[704.629704] Starting dynamic subtest: bcs0
[717.352659] Dynamic subtest bcs0: SUCCESS (12.738s)
[717.367718] Starting dynamic subtest: vcs0
[730.094755] Dynamic subtest vcs0: SUCCESS (12.741s)
[730.107990] Starting dynamic subtest: vcs1
[742.834590] Dynamic subtest vcs1: SUCCESS (12.738s)
[742.849454] Starting dynamic subtest: vecs0
[755.571662] Dynamic subtest vecs0: SUCCESS (12.735s)
[755.586738] Starting dynamic subtest: vecs1
[768.314609] Dynamic subtest vecs1: SUCCESS (12.740s)
[768.327729] Starting dynamic subtest: ccs0
[781.053848] Dynamic subtest ccs0: SUCCESS (12.736s)
[781.055024] Subtest enable-race: SUCCESS (89.197s)
[781.212234] [127/131] (336s left) kms_joiner (basic-force-big-joiner)
[781.415564] Starting subtest: basic-force-big-joiner
[781.416422] Starting dynamic subtest: single
[782.215385] Dynamic subtest single: SUCCESS (0.800s)
[782.218062] Subtest basic-force-big-joiner: SUCCESS (0.803s)
[782.619560] [128/131] (335s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[782.825366] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[784.097594] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.271s)
[784.267477] [129/131] (333s left) i915_pm_rpm (gem-execbuf)
[785.880895] Starting subtest: gem-execbuf
[785.887613] Starting dynamic subtest: lmem0
[788.447620] Dynamic subtest lmem0: SUCCESS (2.563s)
[788.463769] Starting dynamic subtest: smem0
[792.871144] Dynamic subtest smem0: SUCCESS (4.421s)
[792.872618] Subtest gem-execbuf: SUCCESS (6.992s)
[793.187611] [130/131] (324s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[793.382240] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[793.384072] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[793.504839] [131/131] (324s left) gem_basic (create-close)
[793.584473] Starting subtest: create-close
[793.586302] Subtest create-close: SUCCESS (0.000s)
[793.745435] 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.