[54.493764] Initializing watchdogs
[54.493813]   /dev/watchdog0
[54.508974] [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.513263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.515581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.518826] [001/131] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[59.635656] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[59.640134] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[60.475206] [002/131] (954s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[60.585414] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[60.587895] Starting dynamic subtest: pipe-A-eDP-1
[60.992329] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[61.001612] Starting dynamic subtest: pipe-B-eDP-1
[62.359330] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[62.365659] Starting dynamic subtest: pipe-C-eDP-1
[63.750954] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s)
[63.759146] Starting dynamic subtest: pipe-D-eDP-1
[65.102598] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.358s)
[65.104576] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.519s)
[66.261827] [003/131] (948s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[66.368213] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[66.370660] Starting dynamic subtest: pipe-A
[66.706226] Dynamic subtest pipe-A: SUCCESS (0.342s)
[66.715698] Starting dynamic subtest: pipe-B
[68.152889] Dynamic subtest pipe-B: SUCCESS (1.452s)
[68.161476] Starting dynamic subtest: pipe-C
[69.598217] Dynamic subtest pipe-C: SUCCESS (1.449s)
[69.605961] Starting dynamic subtest: pipe-D
[71.014463] Dynamic subtest pipe-D: SUCCESS (1.420s)
[71.016814] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.664s)
[72.278681] [004/131] (942s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[72.390206] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[73.179513] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.793s)
[73.357647] [005/131] (941s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[73.444501] Starting subtest: plane-primary-toggle-with-vblank-wait
[73.446913] Starting dynamic subtest: pipe-A-eDP-1
[73.619574] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[73.931308] Starting dynamic subtest: pipe-B-eDP-1
[74.800943] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.877s)
[75.096135] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.653s)
[75.947664] [006/131] (939s left) drm_read (fault-buffer)
[76.092861] Starting subtest: fault-buffer
[76.095220] Subtest fault-buffer: SUCCESS (0.001s)
[76.237142] [007/131] (938s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[76.327283] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[80.650401] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.331s)
[81.838914] [008/131] (933s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[81.937412] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[81.939725] Starting dynamic subtest: pipe-A-default-mode
[82.225400] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[82.230054] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.285s)
[83.059062] [009/131] (932s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[83.164438] Starting subtest: fbc-psr2-sprite-mmap-gtt
[83.166629] Starting dynamic subtest: eDP-1
[83.170866] Dynamic subtest eDP-1: SKIP (0.000s)
[83.175248] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[83.231794] [010/131] (932s left) kms_psr (pr-cursor-mmap-cpu)
[83.319754] Starting subtest: pr-cursor-mmap-cpu
[83.324098] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[83.388228] [011/131] (931s left) gem_ctx_param (invalid-get-engines)
[83.447035] Starting subtest: invalid-get-engines
[83.449430] Subtest invalid-get-engines: SUCCESS (0.002s)
[83.541427] [012/131] (931s left) i915_hangman (detector)
[83.608263] Starting subtest: detector
[83.610166] Starting dynamic subtest: rcs0
[93.876707] Dynamic subtest rcs0: SUCCESS (10.266s)
[93.886857] Starting dynamic subtest: bcs0
[105.908749] Dynamic subtest bcs0: SUCCESS (12.030s)
[105.918756] Starting dynamic subtest: vcs0
[117.811604] Dynamic subtest vcs0: SUCCESS (11.901s)
[117.821053] Starting dynamic subtest: vcs1
[128.819594] Dynamic subtest vcs1: SUCCESS (11.006s)
[128.830044] Starting dynamic subtest: vecs0
[138.803475] Dynamic subtest vecs0: SUCCESS (9.982s)
[138.816069] Starting dynamic subtest: ccs0
[149.875246] Dynamic subtest ccs0: SUCCESS (11.070s)
[149.878308] Subtest detector: SUCCESS (66.262s)
[150.001097] [013/131] (865s left) kms_rmfb (close-fd)
[150.094936] Starting subtest: close-fd
[150.097209] Starting dynamic subtest: pipe-A-eDP-1
[150.201775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[150.209518] Starting dynamic subtest: pipe-B-eDP-1
[151.426781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s)
[151.433645] Starting dynamic subtest: pipe-C-eDP-1
[152.543997] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[152.553688] Starting dynamic subtest: pipe-D-eDP-1
[153.689096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[153.691326] Subtest close-fd: SUCCESS (3.592s)
[154.875665] [014/131] (860s left) kms_pm_lpsp (kms-lpsp)
[155.985467] Starting subtest: kms-lpsp
[155.987398] Starting dynamic subtest: pipe-A-eDP-1
[156.122703] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[156.419393] Subtest kms-lpsp: SUCCESS (0.434s)
[157.209256] [015/131] (858s left) kms_frontbuffer_tracking (fbc-suspend)
[157.306652] Starting subtest: fbc-suspend
[194.928462] Subtest fbc-suspend: SUCCESS (7.385s)
[196.090255] [016/131] (819s left) gem_linear_blits (interruptible)
[196.364228] Starting subtest: interruptible
[200.004322] Subtest interruptible: SUCCESS (3.703s)
[200.117336] [017/131] (815s left) gem_pxp (create-regular-context-1)
[200.283970] Starting subtest: create-regular-context-1
[200.286393] Subtest create-regular-context-1: SUCCESS (0.002s)
[200.401702] [018/131] (815s left) i915_pm_rps (reset)
[200.471895] Starting subtest: reset
[200.556745] Subtest reset: FAIL (0.027s)
[200.629399] [019/131] (815s left) gem_madvise (dontneed-after-mmap)
[200.667304] Starting subtest: dontneed-after-mmap
[200.698985] Subtest dontneed-after-mmap: SUCCESS (0.030s)
[200.814523] [020/131] (814s left) kms_cursor_legacy (torture-bo)
[200.927257] Starting subtest: torture-bo
[200.929468] Starting dynamic subtest: pipe-A
[206.879709] Dynamic subtest pipe-A: SUCCESS (6.001s)
[206.895172] Starting dynamic subtest: pipe-B
[214.331125] Dynamic subtest pipe-B: SUCCESS (7.481s)
[214.340464] Starting dynamic subtest: pipe-C
[220.765600] Dynamic subtest pipe-C: SUCCESS (6.446s)
[220.775836] Starting dynamic subtest: pipe-D
[226.997876] Dynamic subtest pipe-D: SUCCESS (6.236s)
[227.005956] Starting dynamic subtest: all-pipes
[233.322371] Dynamic subtest all-pipes: SUCCESS (6.321s)
[233.324882] Subtest torture-bo: SUCCESS (32.488s)
[233.474222] [021/131] (782s left) syncobj_timeline (wait-all-for-submit-snapshot)
[233.546429] Starting subtest: wait-all-for-submit-snapshot
[233.629637] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[233.704922] [022/131] (782s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[233.796537] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[233.811943] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.014s)
[233.880068] [023/131] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[233.975186] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[241.450081] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.479s)
[241.596211] [024/131] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[241.690902] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[241.694856] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[241.781454] [025/131] (774s left) kms_cursor_crc (cursor-suspend)
[241.914764] Starting subtest: cursor-suspend
[241.916633] Starting dynamic subtest: pipe-A-eDP-1
[275.190994] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.074s)
[275.199612] Starting dynamic subtest: pipe-D-eDP-1
[308.164820] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.630s)
[308.166771] Subtest cursor-suspend: SUCCESS (6.707s)
[308.947499] [026/131] (706s left) kms_lease (lease-invalid-connector)
[309.048118] Starting subtest: lease-invalid-connector
[309.050460] Starting dynamic subtest: pipe-A-eDP-1
[309.052409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[309.061296] Starting dynamic subtest: pipe-B-eDP-1
[309.063565] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[309.071453] Starting dynamic subtest: pipe-C-eDP-1
[309.073824] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[309.081141] Starting dynamic subtest: pipe-D-eDP-1
[309.083045] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[309.084940] Subtest lease-invalid-connector: SUCCESS (0.003s)
[309.117427] [027/131] (706s left) gem_mmap_wc (pf-nonblock)
[309.177114] Subtest pf-nonblock: SKIP (0.000s)
[309.245414] [028/131] (706s left) kms_cursor_crc (cursor-onscreen-max-size)
[309.521743] Starting subtest: cursor-onscreen-max-size
[309.528252] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[309.663641] [029/131] (706s left) gem_userptr_blits (relocations)
[309.740989] Starting subtest: relocations
[309.745073] Subtest relocations: SKIP (0.000s)
[309.867216] [030/131] (706s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[309.953068] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[309.956957] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[310.056053] [031/131] (706s left) kms_atomic_transition (modeset-transition-nonblocking)
[310.158647] Starting subtest: modeset-transition-nonblocking
[310.160240] Starting dynamic subtest: 1x-outputs
[320.872593] Dynamic subtest 1x-outputs: SUCCESS (10.816s)
[321.152494] Subtest modeset-transition-nonblocking: SUCCESS (11.099s)
[322.000671] [032/131] (694s left) kms_content_protection (dp-mst-type-1)
[322.157978] Starting subtest: dp-mst-type-1
[322.162405] Subtest dp-mst-type-1: SKIP (0.000s)
[322.307501] [033/131] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[322.414213] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[322.418716] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[322.521829] [034/131] (693s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[322.625864] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[322.628065] Starting dynamic subtest: pipe-A-eDP-1
[322.774582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[322.790241] Starting dynamic subtest: pipe-B-eDP-1
[322.810438] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[322.819151] Starting dynamic subtest: pipe-C-eDP-1
[322.839204] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[322.847492] Starting dynamic subtest: pipe-D-eDP-1
[322.867177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[322.869355] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.175s)
[325.046469] [035/131] (691s left) prime_busy (before-wait)
[325.105348] Starting subtest: before-wait
[325.110337] Starting dynamic subtest: rcs0
[325.157175] Dynamic subtest rcs0: SUCCESS (0.049s)
[325.167497] Starting dynamic subtest: bcs0
[325.236084] Dynamic subtest bcs0: SUCCESS (0.078s)
[325.246571] Starting dynamic subtest: vcs0
[325.275907] Dynamic subtest vcs0: SUCCESS (0.040s)
[325.284749] Starting dynamic subtest: vcs1
[325.316984] Dynamic subtest vcs1: SUCCESS (0.041s)
[325.326162] Starting dynamic subtest: vecs0
[325.358572] Dynamic subtest vecs0: SUCCESS (0.041s)
[325.367259] Starting dynamic subtest: ccs0
[325.398491] Dynamic subtest ccs0: SUCCESS (0.039s)
[325.506819] Subtest before-wait: SUCCESS (0.401s)
[325.576591] [036/131] (690s left) kms_flip (2x-blocking-absolute-wf_vblank)
[325.677120] Starting subtest: 2x-blocking-absolute-wf_vblank
[325.685376] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[325.808831] [037/131] (690s left) gem_ccs (ctrl-surf-copy-new-ctx)
[325.870915] Starting subtest: ctrl-surf-copy-new-ctx
[325.875766] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[325.982520] [038/131] (690s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[326.077118] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[326.081625] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[326.179527] [039/131] (690s left) kms_dp_linktrain_fallback (dp-fallback)
[326.273498] Starting subtest: dp-fallback
[326.280621] Subtest dp-fallback: SKIP (0.000s)
[326.341717] [040/131] (690s left) kms_rmfb (rmfb-ioctl)
[326.452678] Starting subtest: rmfb-ioctl
[326.454608] Starting dynamic subtest: pipe-A-eDP-1
[326.556821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[326.565877] Starting dynamic subtest: pipe-B-eDP-1
[327.705922] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[327.716855] Starting dynamic subtest: pipe-C-eDP-1
[328.831047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[328.839293] Starting dynamic subtest: pipe-D-eDP-1
[329.964329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[329.968747] Subtest rmfb-ioctl: SUCCESS (3.521s)
[331.172149] [041/131] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[331.277080] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[331.281160] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[331.382885] [042/131] (685s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[331.477743] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[331.479884] Starting dynamic subtest: pipe-A-default-mode
[331.766469] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[331.771339] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.286s)
[332.605991] [043/131] (683s left) gen9_exec_parse (unaligned-jump)
[332.664231] Subtest unaligned-jump: SKIP (0.000s)
[332.745366] [044/131] (683s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[332.849980] Starting subtest: y-tiled-64bpp-rotate-180
[332.854088] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[332.948579] [045/131] (683s left) gem_workarounds (basic-read)
[333.021752] Starting subtest: basic-read
[333.031302] Subtest basic-read: SUCCESS (0.010s)
[333.144188] [046/131] (683s left) kms_scaling_modes (scaling-mode-none)
[333.231495] Starting subtest: scaling-mode-none
[333.233844] Starting dynamic subtest: pipe-A-eDP-1
[333.326301] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[333.335630] Starting dynamic subtest: pipe-B-eDP-1
[333.363753] Dynamic subtest pipe-B-eDP-1: SKIP (0.035s)
[333.373157] Starting dynamic subtest: pipe-C-eDP-1
[333.397108] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[333.407559] Starting dynamic subtest: pipe-D-eDP-1
[333.429298] Dynamic subtest pipe-D-eDP-1: SKIP (0.032s)
[333.433713] Subtest scaling-mode-none: SKIP (0.198s)
[333.544109] [047/131] (683s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[333.929158] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[334.715158] [048/131] (682s left) perf (per-context-mode-unprivileged)
[334.843137] Starting subtest: per-context-mode-unprivileged
[334.847614] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[334.884895] [049/131] (681s left) kms_async_flips (alternate-sync-async-flip-atomic)
[334.987797] Starting subtest: alternate-sync-async-flip-atomic
[335.356569] Starting dynamic subtest: pipe-A-eDP-1
[338.117719] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.764s)
[338.486188] Starting dynamic subtest: pipe-B-eDP-1
[341.245067] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[341.608157] Starting dynamic subtest: pipe-C-eDP-1
[344.374826] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[344.738303] Starting dynamic subtest: pipe-D-eDP-1
[347.495551] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[347.497442] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.521s)
[348.662011] [050/131] (668s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[348.761650] Starting subtest: basic-max-pipe-crc-check
[348.766023] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[348.805152] [051/131] (668s left) gem_exec_reloc (basic-write-gtt-active)
[348.866846] Subtest basic-write-gtt-active: SKIP (0.000s)
[348.957497] [052/131] (667s left) gem_lmem_swapping (massive-random)
[348.993899] Subtest massive-random: SKIP (0.000s)
[349.037881] [053/131] (667s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[349.126941] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[349.129203] Starting dynamic subtest: pipe-A-eDP-1
[349.152814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[349.164081] Starting dynamic subtest: pipe-B-eDP-1
[349.186014] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[349.194358] Starting dynamic subtest: pipe-C-eDP-1
[349.216007] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[349.224190] Starting dynamic subtest: pipe-D-eDP-1
[349.246491] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[349.250601] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[351.341128] [054/131] (665s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[351.441566] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[355.161913] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.727s)
[356.348139] [055/131] (660s left) sw_sync (alloc_fence_invalid_timeline)
[356.387880] Starting subtest: alloc_fence_invalid_timeline
[356.390198] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[356.442573] [056/131] (660s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[357.025402] Starting subtest: syncobj-backward-timeline-chain-engines
[357.122593] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.099s)
[358.914326] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[358.917997] [057/131] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[359.029961] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[359.033885] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[359.143607] [058/131] (657s left) gem_exec_schedule (submit-late-slice)
[359.230760] Starting subtest: submit-late-slice
[359.233350] Starting dynamic subtest: rcs0
[359.258751] Dynamic subtest rcs0: SUCCESS (0.037s)
[359.268684] Starting dynamic subtest: bcs0
[359.288825] Dynamic subtest bcs0: SUCCESS (0.029s)
[359.297890] Starting dynamic subtest: vcs0
[359.319818] Dynamic subtest vcs0: SUCCESS (0.030s)
[359.328215] Starting dynamic subtest: vcs1
[359.347220] Dynamic subtest vcs1: SUCCESS (0.027s)
[359.358743] Starting dynamic subtest: vecs0
[359.377273] Dynamic subtest vecs0: SUCCESS (0.029s)
[359.392456] Starting dynamic subtest: ccs0
[359.406606] Dynamic subtest ccs0: SUCCESS (0.029s)
[359.408848] Subtest submit-late-slice: SUCCESS (0.186s)
[360.941404] [059/131] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[361.047262] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[365.304075] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.263s)
[366.497553] [060/131] (650s left) gem_mmap_wc (write)
[366.561494] Subtest write: SKIP (0.000s)
[366.625834] [061/131] (650s left) kms_psr (pr-primary-render)
[366.721620] Starting subtest: pr-primary-render
[366.725686] Subtest pr-primary-render: SKIP (0.000s)
[366.793569] [062/131] (650s left) gem_exec_reloc (basic-cpu-gtt-active)
[366.856770] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[366.946758] [063/131] (650s left) gem_exec_whisper (basic-fds-forked-all)
[367.016661] Starting subtest: basic-fds-forked-all
[387.070462] Subtest basic-fds-forked-all: SUCCESS (20.061s)
[387.252407] [064/131] (630s left) kms_plane_lowres (tiling-yf)
[387.345166] Starting subtest: tiling-yf
[387.349269] Subtest tiling-yf: SKIP (0.000s)
[387.415865] [065/131] (629s left) kms_flip (dpms-vs-vblank-race)
[387.507920] Starting subtest: dpms-vs-vblank-race
[387.510239] Starting dynamic subtest: A-eDP1
[392.460595] Dynamic subtest A-eDP1: SUCCESS (4.954s)
[392.470196] Starting dynamic subtest: B-eDP1
[395.982391] Dynamic subtest B-eDP1: SUCCESS (3.523s)
[395.992617] Starting dynamic subtest: C-eDP1
[400.587946] Dynamic subtest C-eDP1: SUCCESS (4.607s)
[400.598690] Starting dynamic subtest: D-eDP1
[405.136234] Dynamic subtest D-eDP1: SUCCESS (4.547s)
[405.138570] Subtest dpms-vs-vblank-race: SUCCESS (17.637s)
[406.006456] [066/131] (611s left) gem_ctx_shared (q-independent)
[406.078351] Starting subtest: Q-independent
[406.080830] Starting dynamic subtest: rcs0
[406.145838] Dynamic subtest rcs0: SUCCESS (0.066s)
[406.158325] Starting dynamic subtest: vcs0
[406.185273] Dynamic subtest vcs0: SUCCESS (0.040s)
[406.194199] Starting dynamic subtest: vcs1
[406.233047] Dynamic subtest vcs1: SUCCESS (0.047s)
[406.241848] Starting dynamic subtest: vecs0
[406.278613] Dynamic subtest vecs0: SUCCESS (0.045s)
[406.287796] Starting dynamic subtest: ccs0
[406.323259] Dynamic subtest ccs0: SUCCESS (0.044s)
[406.326152] Subtest Q-independent: SUCCESS (0.245s)
[407.943861] [067/131] (609s left) kms_psr (psr-cursor-plane-move)
[408.034656] Starting subtest: psr-cursor-plane-move
[408.036955] Starting dynamic subtest: eDP-1
[409.707253] Dynamic subtest eDP-1: SUCCESS (1.675s)
[409.709622] Subtest psr-cursor-plane-move: SUCCESS (1.676s)
[410.576798] [068/131] (606s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[410.628689] Starting subtest: invalid-bsd1-flag-on-vebox
[410.630953] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[410.735230] [069/131] (606s left) kms_flip (flip-vs-wf_vblank-interruptible)
[410.826581] Starting subtest: flip-vs-wf_vblank-interruptible
[410.828723] Starting dynamic subtest: A-eDP1
[412.721657] Dynamic subtest A-eDP1: SUCCESS (1.895s)
[412.732343] Starting dynamic subtest: B-eDP1
[414.655576] Dynamic subtest B-eDP1: SUCCESS (1.934s)
[414.667285] Starting dynamic subtest: C-eDP1
[416.572378] Dynamic subtest C-eDP1: SUCCESS (1.916s)
[416.581394] Starting dynamic subtest: D-eDP1
[418.420439] Dynamic subtest D-eDP1: SUCCESS (1.848s)
[418.425636] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.603s)
[419.648960] [070/131] (597s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[419.708098] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[419.712554] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[419.890872] [071/131] (597s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[419.997496] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[423.571154] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.580s)
[424.739799] [072/131] (592s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[429.805066] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[429.809499] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[430.658070] [073/131] (587s left) syncobj_timeline (signal-point-0)
[430.715280] Starting subtest: signal-point-0
[430.717285] Subtest signal-point-0: SUCCESS (0.000s)
[430.828838] [074/131] (586s left) api_intel_bb (bb-with-allocator)
[430.882929] Starting subtest: bb-with-allocator
[430.885372] Subtest bb-with-allocator: SUCCESS (0.004s)
[431.017561] [075/131] (586s left) gem_exec_balancer (full-late)
[431.071363] Starting subtest: full-late
[435.703072] Subtest full-late: SUCCESS (4.634s)
[436.041366] [076/131] (581s left) kms_chamelium_frames (hdmi-frame-dump)
[436.435103] Subtest hdmi-frame-dump: SKIP (0.000s)
[437.274507] [077/131] (580s left) gem_wait (write-busy)
[437.346031] Starting subtest: write-busy
[437.348356] Starting dynamic subtest: all-engines
[437.979158] Dynamic subtest all-engines: SUCCESS (0.636s)
[437.991780] Starting dynamic subtest: rcs0
[438.537791] Dynamic subtest rcs0: SUCCESS (0.557s)
[438.553466] Starting dynamic subtest: bcs0
[439.090781] Dynamic subtest bcs0: SUCCESS (0.550s)
[439.106193] Starting dynamic subtest: vcs0
[440.864573] Dynamic subtest vcs0: SUCCESS (1.775s)
[440.881102] Starting dynamic subtest: vcs1
[442.847816] Dynamic subtest vcs1: SUCCESS (1.982s)
[442.864805] Starting dynamic subtest: vecs0
[444.832184] Dynamic subtest vecs0: SUCCESS (1.983s)
[444.847188] Starting dynamic subtest: ccs0
[445.384333] Dynamic subtest ccs0: SUCCESS (0.552s)
[445.386820] Subtest write-busy: SUCCESS (8.046s)
[445.577581] [078/131] (572s left) kms_chamelium_frames (dp-crc-fast)
[445.955630] Subtest dp-crc-fast: SKIP (0.000s)
[446.797346] [079/131] (571s left) dumb_buffer (map-valid)
[446.854684] Starting subtest: map-valid
[446.856555] Subtest map-valid: SUCCESS (0.000s)
[446.969421] [080/131] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[447.074346] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[447.078697] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[447.196506] [081/131] (570s left) syncobj_basic (bad-pad-fd-to-handle)
[447.260402] Starting subtest: bad-pad-fd-to-handle
[447.263104] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[447.372685] [082/131] (570s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[447.435098] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[447.540611] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[447.615704] [083/131] (570s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[447.709315] Starting subtest: psr-rgb565-draw-mmap-wc
[454.383247] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.681s)
[454.495018] [084/131] (563s left) kms_rotation_crc (bad-pixel-format)
[454.599613] Starting subtest: bad-pixel-format
[454.604067] Subtest bad-pixel-format: SKIP (0.001s)
[454.668102] [085/131] (563s left) kms_vblank (wait-idle-hang)
[454.763612] Starting subtest: wait-idle-hang
[454.765926] Starting dynamic subtest: pipe-A-eDP-1
[481.565592] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.795s)
[481.579416] Starting dynamic subtest: pipe-D-eDP-1
[496.602298] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[496.604793] Subtest wait-idle-hang: SUCCESS (41.834s)
[497.400693] [086/131] (520s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[497.455860] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[497.508096] [087/131] (520s left) syncobj_wait (wait-all-for-submit-snapshot)
[497.567320] Starting subtest: wait-all-for-submit-snapshot
[497.647503] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[497.739545] [088/131] (520s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[497.856952] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[528.592738] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.734s)
[529.435051] [089/131] (488s left) gem_workarounds (suspend-resume-context)
[529.499223] Starting subtest: suspend-resume-context
[545.789898] Subtest suspend-resume-context: SUCCESS (1.173s)
[545.928305] [090/131] (472s left) sysfs_heartbeat_interval (precise)
[546.000806] Starting subtest: precise
[546.002956] Starting dynamic subtest: vecs0
[553.907323] Dynamic subtest vecs0: SUCCESS (8.064s)
[553.919091] Starting dynamic subtest: ccs0
[555.023242] Dynamic subtest ccs0: SUCCESS (1.126s)
[555.034998] Starting dynamic subtest: vcs0
[562.940743] Dynamic subtest vcs0: SUCCESS (7.966s)
[562.954971] Starting dynamic subtest: bcs0
[565.947001] Dynamic subtest bcs0: SUCCESS (3.016s)
[565.958165] Starting dynamic subtest: rcs0
[567.059445] Dynamic subtest rcs0: SUCCESS (1.114s)
[567.071174] Starting dynamic subtest: vcs1
[574.967470] Dynamic subtest vcs1: SUCCESS (7.919s)
[574.969989] Subtest precise: SUCCESS (29.217s)
[575.049077] [091/131] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[575.155921] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[575.160369] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[575.235226] [092/131] (443s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[575.337039] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[575.341382] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[575.438271] [093/131] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[575.542932] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[582.522448] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (6.981s)
[582.647029] [094/131] (435s left) gem_sync (basic-all)
[582.723315] Starting subtest: basic-all
[587.884268] Subtest basic-all: SUCCESS (5.171s)
[588.071416] [095/131] (430s left) kms_plane_scaling (planes-scaler-unity-scaling)
[588.185100] Starting subtest: planes-scaler-unity-scaling
[588.187575] Starting dynamic subtest: pipe-A
[588.250684] Dynamic subtest pipe-A: SUCCESS (0.067s)
[588.259991] Starting dynamic subtest: pipe-B
[589.400551] Dynamic subtest pipe-B: SUCCESS (1.149s)
[589.412458] Starting dynamic subtest: pipe-C
[590.505688] Dynamic subtest pipe-C: SUCCESS (1.104s)
[590.516040] Starting dynamic subtest: pipe-D
[591.645285] Dynamic subtest pipe-D: SUCCESS (1.139s)
[591.647552] Subtest planes-scaler-unity-scaling: SUCCESS (3.463s)
[592.794166] [096/131] (425s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[592.899539] Starting subtest: yf-tiled-16bpp-rotate-180
[592.903997] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[592.993258] [097/131] (425s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[593.045453] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[593.140099] [098/131] (425s left) gem_exec_balancer (parallel-contexts)
[593.400429] Starting subtest: parallel-contexts
[595.985507] Subtest parallel-contexts: SUCCESS (2.586s)
[597.044416] [099/131] (421s left) gem_ctx_param (invalid-set-no-zeromap)
[597.104594] Starting subtest: invalid-set-no-zeromap
[597.106957] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[597.183327] [100/131] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[597.299161] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[597.303196] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[597.403174] [101/131] (421s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[597.498367] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[597.500599] Starting dynamic subtest: pipe-A-eDP-1
[597.525369] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[597.535275] Starting dynamic subtest: pipe-B-eDP-1
[597.558933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[597.567988] Starting dynamic subtest: pipe-C-eDP-1
[597.591786] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[597.600426] Starting dynamic subtest: pipe-D-eDP-1
[597.624530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[597.628591] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[599.671066] [102/131] (419s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[599.739880] Starting subtest: etime-single-wait-available-unsubmitted
[599.849522] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[599.926434] [103/131] (419s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[599.989040] Starting subtest: invalid-signal-one-illegal-handle
[599.991348] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[600.096290] [104/131] (418s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[600.146518] Starting subtest: mixed-tiled-to-y-tiled-ccs
[600.151039] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[600.327024] [105/131] (418s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[600.394350] Starting subtest: framebuffer-vs-set-tiling
[600.399255] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[600.525842] [106/131] (418s left) gem_mmap_gtt (cpuset-big-copy-xy)
[600.581811] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[600.636936] [107/131] (418s left) gem_userptr_blits (nohangcheck)
[600.711571] Starting subtest: nohangcheck
[600.965049] Subtest nohangcheck: SUCCESS (0.251s)
[601.094273] [108/131] (418s left) api_intel_bb (simple-bb-ctx)
[601.145008] Starting subtest: simple-bb-ctx
[601.152003] Subtest simple-bb-ctx: SUCCESS (0.010s)
[601.294103] [109/131] (417s left) kms_sequence (queue-idle)
[601.391733] Starting subtest: queue-idle
[601.393711] Starting dynamic subtest: pipe-A-eDP-1
[603.184576] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.794s)
[603.202395] Starting dynamic subtest: pipe-B-eDP-1
[605.644915] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.460s)
[605.654755] Starting dynamic subtest: pipe-C-eDP-1
[608.061893] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[608.072922] Starting dynamic subtest: pipe-D-eDP-1
[610.484789] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[610.487199] Subtest queue-idle: SUCCESS (9.099s)
[611.305269] [110/131] (407s left) perf_pmu (busy-accuracy-2)
[611.341759] Starting subtest: busy-accuracy-2
[611.343918] Starting dynamic subtest: rcs0
[614.382166] Dynamic subtest rcs0: SUCCESS (3.040s)
[614.399007] Starting dynamic subtest: bcs0
[617.488041] Dynamic subtest bcs0: SUCCESS (3.054s)
[617.500104] Starting dynamic subtest: vcs0
[620.527906] Dynamic subtest vcs0: SUCCESS (3.045s)
[620.539800] Starting dynamic subtest: vcs1
[623.575216] Dynamic subtest vcs1: SUCCESS (3.045s)
[623.584454] Starting dynamic subtest: vecs0
[626.618657] Dynamic subtest vecs0: SUCCESS (3.042s)
[626.629936] Starting dynamic subtest: ccs0
[629.673577] Dynamic subtest ccs0: SUCCESS (3.054s)
[629.675960] Subtest busy-accuracy-2: SUCCESS (18.291s)
[629.761364] [111/131] (389s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[629.817620] Subtest writes-after-reads-snoop: SKIP (0.000s)
[629.905904] [112/131] (389s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[630.006472] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[630.096970] [113/131] (389s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[630.193269] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[630.195531] Starting dynamic subtest: pipe-A-eDP-1
[630.217534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[630.227659] Starting dynamic subtest: pipe-B-eDP-1
[630.248435] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[630.257622] Starting dynamic subtest: pipe-C-eDP-1
[630.278674] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[630.288485] Starting dynamic subtest: pipe-D-eDP-1
[630.311483] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[630.316007] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[632.381591] [114/131] (386s left) gem_exec_schedule (out-order)
[632.448892] Starting subtest: out-order
[632.450740] Starting dynamic subtest: rcs0
[632.545037] Dynamic subtest rcs0: SUCCESS (0.102s)
[632.558068] Starting dynamic subtest: vcs0
[632.632433] Dynamic subtest vcs0: SUCCESS (0.088s)
[632.643633] Starting dynamic subtest: vcs1
[632.708809] Dynamic subtest vcs1: SUCCESS (0.076s)
[632.722469] Starting dynamic subtest: vecs0
[632.781588] Dynamic subtest vecs0: SUCCESS (0.073s)
[632.794107] Starting dynamic subtest: ccs0
[632.860357] Dynamic subtest ccs0: SUCCESS (0.078s)
[632.862672] Subtest out-order: SUCCESS (0.419s)
[634.072088] [115/131] (385s left) gem_exec_fence (syncobj-timeline-repeat)
[634.612446] Starting subtest: syncobj-timeline-repeat
[634.831085] Subtest syncobj-timeline-repeat: SUCCESS (0.219s)
[636.061554] [116/131] (383s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[636.166575] Starting subtest: psr-1p-primscrn-cur-indfb-move
[643.397959] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.235s)
[643.565370] [117/131] (375s left) kms_big_fb (linear-8bpp-rotate-90)
[643.679974] Starting subtest: linear-8bpp-rotate-90
[643.700266] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[643.825972] [118/131] (375s left) gem_mmap_gtt (medium-copy-odd)
[643.877844] Subtest medium-copy-odd: SKIP (0.000s)
[643.942473] [119/131] (375s left) kms_getfb (getfb2-into-addfb2)
[644.034684] Starting subtest: getfb2-into-addfb2
[644.036947] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[644.135826] [120/131] (375s left) kms_prop_blob (invalid-get-prop-any)
[644.187945] Starting subtest: invalid-get-prop-any
[644.189854] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[644.288675] [121/131] (375s left) gem_exec_schedule (preempt-queue-contexts-chain)
[644.361310] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[644.655847] [122/131] (375s left) kms_psr (fbc-pr-sprite-render)
[644.745369] Starting subtest: fbc-pr-sprite-render
[644.749364] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[644.815142] [123/131] (374s left) perf (invalid-remove-userspace-config)
[644.909601] Starting subtest: invalid-remove-userspace-config
[644.919461] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[644.960712] [124/131] (374s left) gem_userptr_blits (forbidden-operations)
[645.023980] Starting subtest: forbidden-operations
[645.028241] Subtest forbidden-operations: SKIP (0.000s)
[645.168545] [125/131] (374s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[645.288561] Starting subtest: cursorA-vs-flipA-atomic-transitions
[656.453890] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.155s)
[657.332562] [126/131] (362s left) perf_pmu (enable-race)
[657.372142] Starting subtest: enable-race
[657.374346] Starting dynamic subtest: rcs0
[670.165997] Dynamic subtest rcs0: SUCCESS (12.772s)
[670.177216] Starting dynamic subtest: bcs0
[682.910750] Dynamic subtest bcs0: SUCCESS (12.740s)
[682.920846] Starting dynamic subtest: vcs0
[698.924212] Dynamic subtest vcs0: SUCCESS (16.029s)
[698.936979] Starting dynamic subtest: vcs1
[714.923889] Dynamic subtest vcs1: SUCCESS (15.999s)
[714.934578] Starting dynamic subtest: vecs0
[730.925707] Dynamic subtest vecs0: SUCCESS (16.001s)
[730.936723] Starting dynamic subtest: ccs0
[743.784498] Dynamic subtest ccs0: SUCCESS (12.860s)
[743.787500] Subtest enable-race: SUCCESS (86.413s)
[743.881360] [127/131] (276s left) kms_joiner (basic-force-big-joiner)
[743.995694] Starting subtest: basic-force-big-joiner
[743.997942] Starting dynamic subtest: single
[747.360822] Dynamic subtest single: SUCCESS (3.374s)
[747.363194] Subtest basic-force-big-joiner: SUCCESS (3.375s)
[748.550812] [128/131] (271s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[748.647352] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[749.578604] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.933s)
[749.725270] [129/131] (270s left) i915_pm_rpm (gem-execbuf)
[751.256858] Starting subtest: gem-execbuf
[751.260019] Starting dynamic subtest: smem0
[753.332062] Dynamic subtest smem0: SUCCESS (2.074s)
[753.334378] Subtest gem-execbuf: SUCCESS (2.076s)
[753.415725] [130/131] (266s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[753.516528] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[760.140770] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.629s)
[760.276454] [131/131] (259s left) gem_basic (create-close)
[760.331097] Starting subtest: create-close
[760.335771] Subtest create-close: SUCCESS (0.000s)
[760.437183] 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.