[73.589159] Initializing watchdogs
[73.589221]   /dev/watchdog0
[73.603682] [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]
[73.608202] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.610939] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.614688] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[73.744790] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[73.749242] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[73.852923] [002/133] (960s left) gem_flink_basic (double-flink)
[73.913817] Starting subtest: double-flink
[73.915777] Subtest double-flink: SUCCESS (0.000s)
[74.021835] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[74.574784] Starting subtest: invalid-timeline-fence-array
[74.579671] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[76.372816] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[76.375954] [004/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[76.487213] Starting subtest: invalid-modeset-ultra-joiner
[76.491620] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[76.582866] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[76.675466] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[81.043089] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.370s)
[82.252060] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[82.320111] Starting subtest: semaphore-codependency
[82.326473] Subtest semaphore-codependency: SUCCESS (0.014s)
[82.661216] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[82.745650] Starting subtest: 64x64-right-edge
[82.747918] Starting dynamic subtest: pipe-A-eDP-1
[86.198402] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[86.210925] Starting dynamic subtest: pipe-D-eDP-1
[89.324783] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[89.326684] Subtest 64x64-right-edge: SUCCESS (6.579s)
[90.123290] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[90.234451] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[90.238617] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[90.339487] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[90.452689] Starting subtest: cursorA-vs-flipA-toggle
[101.569472] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.114s)
[102.370766] [010/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[102.482910] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[102.487272] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.577269] [011/133] (931s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[102.639984] Subtest writes-after-reads-uncached: SKIP (0.000s)
[102.708929] [012/133] (931s left) kms_hdr (invalid-metadata-sizes)
[102.811099] Starting subtest: invalid-metadata-sizes
[102.817353] Subtest invalid-metadata-sizes: SKIP (0.000s)
[102.881611] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[102.959571] Subtest reads: SKIP (0.000s)
[103.030780] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[103.119570] Starting subtest: test-cursor-atomic
[103.494761] Starting dynamic subtest: pipe-A-eDP-1
[104.249764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s)
[104.638127] Starting dynamic subtest: pipe-B-eDP-1
[105.388788] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s)
[105.754152] Starting dynamic subtest: pipe-C-eDP-1
[106.516641] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[106.883326] Starting dynamic subtest: pipe-D-eDP-1
[107.639302] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.762s)
[107.641524] Subtest test-cursor-atomic: SUCCESS (4.521s)
[108.820580] [015/133] (925s left) kms_busy (extended-modeset-hang-newfb)
[108.913744] Starting subtest: extended-modeset-hang-newfb
[108.915591] Starting dynamic subtest: pipe-A
[143.243810] Dynamic subtest pipe-A: SUCCESS (34.330s)
[143.251985] Starting dynamic subtest: pipe-D
[166.201647] Dynamic subtest pipe-D: SUCCESS (22.954s)
[166.204069] Subtest extended-modeset-hang-newfb: SUCCESS (57.288s)
[166.999893] [016/133] (867s left) syncobj_timeline (wait-all-delayed-signal)
[167.068391] Starting subtest: wait-all-delayed-signal
[167.171820] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[167.264915] [017/133] (867s left) kms_pm_dc (dc5-psr)
[168.372398] Starting subtest: dc5-psr
[171.256895] Subtest dc5-psr: SUCCESS (2.884s)
[172.138104] [018/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[172.245055] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[172.249555] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[172.348745] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[172.463877] Starting subtest: y-tiled-16bpp-rotate-270
[172.468379] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[172.580240] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[172.673625] Starting subtest: fbc-psr2-suspend
[172.675845] Starting dynamic subtest: eDP-1
[172.679946] Dynamic subtest eDP-1: SKIP (0.000s)
[172.683990] Subtest fbc-psr2-suspend: SKIP (0.001s)
[172.745227] [021/133] (862s left) gem_exec_basic (basic)
[172.799515] Starting subtest: basic
[172.801841] Starting dynamic subtest: rcs0-smem
[172.804072] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[172.812219] Starting dynamic subtest: bcs0-smem
[172.814465] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[172.822502] Starting dynamic subtest: vcs0-smem
[172.824465] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[172.831908] Starting dynamic subtest: vcs1-smem
[172.833865] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[172.841279] Starting dynamic subtest: vecs0-smem
[172.843159] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[172.850452] Starting dynamic subtest: ccs0-smem
[172.852362] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[172.854282] Subtest basic: SUCCESS (0.016s)
[174.311983] [022/133] (860s left) gem_ctx_persistence (heartbeat-many)
[174.372064] Starting subtest: heartbeat-many
[174.377105] Subtest heartbeat-many: SKIP (0.000s)
[174.470318] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[174.531131] Starting subtest: reloc-allocator
[174.533262] Starting dynamic subtest: basic
[174.535883] Dynamic subtest basic: SUCCESS (0.004s)
[174.548057] Starting dynamic subtest: parallel-one
[174.550459] Dynamic subtest parallel-one: SUCCESS (0.007s)
[174.560863] Starting dynamic subtest: print
[174.562800] Dynamic subtest print: SUCCESS (0.000s)
[174.570286] Starting dynamic subtest: reuse
[174.572129] Dynamic subtest reuse: SUCCESS (0.000s)
[174.579498] Starting dynamic subtest: fork-reopen-allocator
[174.581408] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[174.583382] Subtest reloc-allocator: SUCCESS (0.027s)
[174.679263] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[174.776324] Starting subtest: flip-vs-panning-vs-hang
[174.778793] Starting dynamic subtest: A-eDP1
[225.770049] Dynamic subtest A-eDP1: SUCCESS (50.994s)
[225.778131] Starting dynamic subtest: D-eDP1
[265.771907] Dynamic subtest D-eDP1: SUCCESS (39.998s)
[265.776694] Subtest flip-vs-panning-vs-hang: SUCCESS (90.999s)
[266.949219] [025/133] (768s left) kms_chamelium_frames (vga-frame-dump)
[267.331904] Subtest vga-frame-dump: SKIP (0.000s)
[268.151285] [026/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[268.250060] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[268.254369] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[268.334966] [027/133] (766s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[268.646538] Starting subtest: cursor-rapid-movement-max-size
[268.652714] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[268.772722] [028/133] (766s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[268.839933] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[268.947667] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[269.025827] [029/133] (766s left) kms_psr (fbc-psr2-dpms)
[269.116872] Starting subtest: fbc-psr2-dpms
[269.119101] Starting dynamic subtest: eDP-1
[269.123180] Dynamic subtest eDP-1: SKIP (0.000s)
[269.127186] Subtest fbc-psr2-dpms: SKIP (0.001s)
[269.189424] [030/133] (766s left) kms_flip (flip-vs-rmfb-interruptible)
[269.282556] Starting subtest: flip-vs-rmfb-interruptible
[269.284789] Starting dynamic subtest: A-eDP1
[277.961462] Dynamic subtest A-eDP1: SUCCESS (8.678s)
[277.972259] Starting dynamic subtest: B-eDP1
[286.589137] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[286.598043] Starting dynamic subtest: C-eDP1
[295.210297] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[295.220107] Starting dynamic subtest: D-eDP1
[303.837699] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[303.842123] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.559s)
[305.019481] [031/133] (730s left) i915_suspend (fence-restore-untiled)
[305.079190] Starting subtest: fence-restore-untiled
[305.083210] Subtest fence-restore-untiled: SKIP (0.000s)
[305.185922] [032/133] (730s left) gem_ctx_bad_destroy (invalid-default-ctx)
[305.254298] Starting subtest: invalid-default-ctx
[305.256649] Subtest invalid-default-ctx: SUCCESS (0.000s)
[305.331359] [033/133] (730s left) kms_flip (2x-modeset-vs-vblank-race)
[305.429168] Starting subtest: 2x-modeset-vs-vblank-race
[305.440277] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[305.527424] [034/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[305.621336] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[305.625716] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[305.705862] [035/133] (729s left) vgem_basic (bad-flag)
[305.757112] Starting subtest: bad-flag
[305.759447] Subtest bad-flag: SUCCESS (0.000s)
[305.815213] [036/133] (729s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[305.925435] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[305.929669] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[305.994088] [037/133] (729s left) i915_drm_fdinfo (basics)
[306.031539] Starting subtest: basics
[306.033501] Subtest basics: SUCCESS (0.000s)
[306.093031] [038/133] (729s left) gem_workarounds (basic-read-fd)
[306.151072] Starting subtest: basic-read-fd
[306.161537] Subtest basic-read-fd: SUCCESS (0.010s)
[306.293871] [039/133] (729s left) kms_prop_blob (invalid-set-prop-any)
[306.352762] Starting subtest: invalid-set-prop-any
[306.354399] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[306.447492] [040/133] (729s left) i915_pm_rpm (gem-execbuf)
[308.487847] Starting subtest: gem-execbuf
[308.489950] Starting dynamic subtest: smem0
[310.019068] Dynamic subtest smem0: SUCCESS (1.533s)
[310.021227] Subtest gem-execbuf: SUCCESS (1.536s)
[310.104688] [041/133] (725s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[310.200772] Starting subtest: plane-lut1d-pre-ctm3x4
[310.337907] Starting dynamic subtest: pipe-A-plane-0
[310.504242] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[310.512923] Starting dynamic subtest: pipe-A-plane-1
[310.679841] Dynamic subtest pipe-A-plane-1: SUCCESS (0.176s)
[310.688499] Starting dynamic subtest: pipe-A-plane-2
[310.835210] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[312.078526] Starting dynamic subtest: pipe-B-plane-0
[312.249528] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[312.266221] Starting dynamic subtest: pipe-B-plane-1
[312.416280] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[312.424988] Starting dynamic subtest: pipe-B-plane-2
[312.571615] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[313.801681] Starting dynamic subtest: pipe-C-plane-0
[313.961789] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[313.970304] Starting dynamic subtest: pipe-C-plane-1
[314.106176] Dynamic subtest pipe-C-plane-1: SUCCESS (0.143s)
[314.114449] Starting dynamic subtest: pipe-C-plane-2
[314.250612] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[315.451985] Starting dynamic subtest: pipe-D-plane-0
[315.610919] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[315.624165] Starting dynamic subtest: pipe-D-plane-1
[315.755450] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[315.764069] Starting dynamic subtest: pipe-D-plane-2
[315.911062] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[316.204184] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.002s)
[317.021493] [042/133] (718s left) kms_async_flips (crc)
[317.129452] Starting subtest: crc
[317.510070] Starting dynamic subtest: pipe-A-eDP-1
[320.460698] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[320.821692] Starting dynamic subtest: pipe-B-eDP-1
[323.768056] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.952s)
[324.140910] Starting dynamic subtest: pipe-C-eDP-1
[327.112959] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.947s)
[327.448291] Starting dynamic subtest: pipe-D-eDP-1
[330.338767] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s)
[330.341800] Subtest crc: SUCCESS (13.167s)
[331.462336] [043/133] (704s left) gem_mmap_wc (bad-offset)
[331.521328] Subtest bad-offset: SKIP (0.000s)
[331.579366] [044/133] (704s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[331.960831] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[332.766108] [045/133] (703s left) gem_ctx_create (basic)
[332.832525] Starting subtest: basic
[332.835112] Subtest basic: SUCCESS (0.000s)
[333.016382] [046/133] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[333.120040] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[333.124245] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[333.208900] [047/133] (702s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[333.266349] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[333.323220] [048/133] (702s left) gem_exec_reloc (basic-cpu)
[333.377911] Subtest basic-cpu: SKIP (0.000s)
[333.450964] [049/133] (702s left) gem_mmap_offset (mmap-boundaries)
[333.503928] Starting subtest: mmap-boundaries
[333.506305] Starting dynamic subtest: smem0
[333.785604] Dynamic subtest smem0: SUCCESS (0.284s)
[333.788204] Subtest mmap-boundaries: SUCCESS (0.285s)
[333.912208] [050/133] (702s left) gem_eio (in-flight-contexts-10ms)
[334.149129] Starting subtest: in-flight-contexts-10ms
[347.358107] Subtest in-flight-contexts-10ms: SUCCESS (13.207s)
[347.523660] [051/133] (688s left) gem_exec_whisper (basic-contexts-priority-all)
[347.598874] Starting subtest: basic-contexts-priority-all
[370.568920] Subtest basic-contexts-priority-all: SUCCESS (22.968s)
[370.754507] [052/133] (665s left) kms_big_fb (linear-8bpp-rotate-180)
[370.857315] Starting subtest: linear-8bpp-rotate-180
[372.117057] Subtest linear-8bpp-rotate-180: SUCCESS (1.260s)
[372.261963] [053/133] (663s left) sw_sync (sync_busy_fork)
[372.294231] Starting subtest: sync_busy_fork
[373.306293] Subtest sync_busy_fork: SUCCESS (1.011s)
[373.367565] [054/133] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[373.463996] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[373.466412] Starting dynamic subtest: pipe-A-default-mode
[376.240022] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[376.242302] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.776s)
[377.076291] [055/133] (659s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[377.173746] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[377.178245] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[377.278300] [056/133] (659s left) gem_gpgpu_fill (offset-16x16)
[377.329944] Starting subtest: offset-16x16
[377.335740] Subtest offset-16x16: SUCCESS (0.008s)
[377.522603] [057/133] (658s left) dmabuf_sync_file (import-basic)
[377.585410] Starting subtest: import-basic
[377.587602] Subtest import-basic: SUCCESS (0.003s)
[377.652448] [058/133] (658s left) gem_ctx_bad_destroy (invalid-pad)
[377.709908] Starting subtest: invalid-pad
[377.712354] Subtest invalid-pad: SUCCESS (0.000s)
[377.796289] [059/133] (658s left) core_auth (basic-auth)
[377.866609] Starting subtest: basic-auth
[377.868890] Subtest basic-auth: SUCCESS (0.001s)
[377.992090] [060/133] (658s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[378.078079] Starting subtest: yf-tiled-16bpp-rotate-90
[378.081813] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[378.166847] [061/133] (658s left) kms_dp_link_training (non-uhbr-mst)
[378.258168] Starting subtest: non-uhbr-mst
[378.265178] Subtest non-uhbr-mst: SKIP (0.000s)
[378.333978] [062/133] (658s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[378.426024] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[378.427883] Starting dynamic subtest: pipe-A-eDP-1
[379.345841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.914s)
[379.356058] Starting dynamic subtest: pipe-B-eDP-1
[380.948812] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.599s)
[380.958946] Starting dynamic subtest: pipe-C-eDP-1
[382.496403] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s)
[382.506144] Starting dynamic subtest: pipe-D-eDP-1
[384.027560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s)
[384.029573] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.594s)
[385.214422] [063/133] (651s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[385.317152] Starting subtest: yf-tiled-8bpp-rotate-0
[385.321186] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[385.418489] [064/133] (651s left) gem_basic (multigpu-create-close)
[385.478756] Starting subtest: multigpu-create-close
[385.483031] Subtest multigpu-create-close: SKIP (0.000s)
[385.580244] [065/133] (651s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[385.673600] Starting subtest: flip-vs-dpms-off-vs-modeset
[385.675915] Starting dynamic subtest: A-eDP1
[389.354770] Dynamic subtest A-eDP1: SUCCESS (3.682s)
[389.365618] Starting dynamic subtest: B-eDP1
[392.559203] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[392.568771] Starting dynamic subtest: C-eDP1
[395.682264] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[395.693239] Starting dynamic subtest: D-eDP1
[398.767857] Dynamic subtest D-eDP1: SUCCESS (3.085s)
[398.770176] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.097s)
[399.571746] [066/133] (637s left) gem_exec_balancer (full)
[399.628686] Starting subtest: full
[404.218396] Subtest full: SUCCESS (4.589s)
[404.556603] [067/133] (632s left) i915_hangman (engine-engine-error)
[404.617521] Starting subtest: engine-engine-error
[404.619730] Starting dynamic subtest: rcs0
[406.239043] Dynamic subtest rcs0: SUCCESS (1.620s)
[406.251651] Starting dynamic subtest: bcs0
[408.285970] Dynamic subtest bcs0: SUCCESS (2.044s)
[408.298675] Starting dynamic subtest: vcs0
[410.270388] Dynamic subtest vcs0: SUCCESS (1.981s)
[410.283417] Starting dynamic subtest: vcs1
[412.254580] Dynamic subtest vcs1: SUCCESS (1.982s)
[412.267308] Starting dynamic subtest: vecs0
[414.238337] Dynamic subtest vecs0: SUCCESS (1.981s)
[414.252638] Starting dynamic subtest: ccs0
[416.286366] Dynamic subtest ccs0: SUCCESS (2.045s)
[416.289337] Subtest engine-engine-error: SUCCESS (11.669s)
[416.373629] [068/133] (620s left) gem_mmap_gtt (basic-small-bo-tiledy)
[416.431175] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[416.487926] [069/133] (620s left) kms_frontbuffer_tracking (basic)
[416.590347] Starting subtest: basic
[419.822862] Subtest basic: SUCCESS (3.236s)
[419.931232] [070/133] (617s left) api_intel_bb (reset-flags)
[419.983701] Starting subtest: reset-flags
[419.987982] Subtest reset-flags: SUCCESS (0.006s)
[420.105008] [071/133] (616s left) kms_flip (flip-vs-absolute-wf_vblank)
[420.191762] Starting subtest: flip-vs-absolute-wf_vblank
[420.193586] Starting dynamic subtest: A-eDP1
[429.105099] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[429.116339] Starting dynamic subtest: B-eDP1
[438.030760] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[438.049290] Starting dynamic subtest: C-eDP1
[446.997452] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[447.007127] Starting dynamic subtest: D-eDP1
[455.941946] Dynamic subtest D-eDP1: SUCCESS (8.939s)
[455.944306] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.707s)
[457.121532] [072/133] (579s left) kms_plane_scaling (planes-upscale-20x20)
[457.215058] Starting subtest: planes-upscale-20x20
[457.217353] Starting dynamic subtest: pipe-A
[457.274959] Dynamic subtest pipe-A: SUCCESS (0.062s)
[457.290617] Starting dynamic subtest: pipe-B
[458.448822] Dynamic subtest pipe-B: SUCCESS (1.173s)
[458.463517] Starting dynamic subtest: pipe-C
[459.548633] Dynamic subtest pipe-C: SUCCESS (1.098s)
[459.562701] Starting dynamic subtest: pipe-D
[460.676207] Dynamic subtest pipe-D: SUCCESS (1.126s)
[460.678537] Subtest planes-upscale-20x20: SUCCESS (3.464s)
[461.854091] [073/133] (575s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[461.952920] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[461.957233] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[462.027452] [074/133] (575s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[462.130464] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[462.134778] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[462.233678] [075/133] (574s left) kms_sequence (get-busy)
[462.340585] Starting subtest: get-busy
[462.342984] Starting dynamic subtest: pipe-A-eDP-1
[464.276349] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[464.286501] Starting dynamic subtest: pipe-B-eDP-1
[466.850510] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[466.861535] Starting dynamic subtest: pipe-C-eDP-1
[469.444573] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s)
[469.455510] Starting dynamic subtest: pipe-D-eDP-1
[472.076890] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.633s)
[472.079254] Subtest get-busy: SUCCESS (9.739s)
[472.885198] [076/133] (564s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[472.973620] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[472.977998] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[473.077791] [077/133] (564s left) gem_vm_create (execbuf)
[473.137077] Starting subtest: execbuf
[473.141068] Subtest execbuf: SUCCESS (0.007s)
[473.276410] [078/133] (564s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[473.384062] Starting subtest: 4-tiled-32bpp-rotate-90
[473.403740] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[473.518643] [079/133] (563s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[473.589615] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[473.661219] [080/133] (563s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[473.715472] Starting subtest: single-wait-all-for-submit-unsubmitted
[473.819909] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[473.897811] [081/133] (563s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[473.997589] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[474.001663] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[474.116790] [082/133] (563s left) gen7_exec_parse (oacontrol-tracking)
[474.177587] Subtest oacontrol-tracking: SKIP (0.000s)
[474.271167] [083/133] (563s left) kms_vrr (negative-basic)
[474.367233] Starting subtest: negative-basic
[474.374052] Starting dynamic subtest: pipe-A-eDP-1
[479.839045] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.413s)
[480.090721] Subtest negative-basic: SUCCESS (5.724s)
[480.914577] [084/133] (556s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[481.013829] Starting subtest: stress-xrgb8888-4tiled
[486.855297] Subtest stress-xrgb8888-4tiled: SUCCESS (5.842s)
[486.905625] [085/133] (550s left) kms_addfb_basic (no-handle)
[486.968916] Starting subtest: no-handle
[486.970627] Subtest no-handle: SUCCESS (0.000s)
[487.116540] [086/133] (550s left) kms_psr (psr2-dpms)
[487.205968] Starting subtest: psr2-dpms
[487.207725] Starting dynamic subtest: eDP-1
[490.041478] Dynamic subtest eDP-1: SUCCESS (2.834s)
[490.043410] Subtest psr2-dpms: SUCCESS (2.835s)
[490.928721] [087/133] (546s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[490.984905] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[491.044523] [088/133] (546s left) gem_exec_params (no-bsd)
[491.100629] Starting subtest: no-bsd
[491.103038] Subtest no-bsd: SUCCESS (0.002s)
[492.336946] [089/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[492.430601] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[492.434707] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[492.533581] [090/133] (545s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[492.634872] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[492.661467] Starting dynamic subtest: pipe-A-plane-0
[493.094609] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[493.107035] Starting dynamic subtest: pipe-A-plane-3
[493.349841] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[494.500697] Starting dynamic subtest: pipe-B-plane-0
[494.925729] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[494.935744] Starting dynamic subtest: pipe-B-plane-3
[495.182117] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[495.501107] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.867s)
[496.371751] [091/133] (541s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[496.522234] Starting subtest: dp-mst-type-1-suspend-resume
[496.526628] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[496.632994] [092/133] (541s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[496.737213] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[503.480080] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.745s)
[503.617377] [093/133] (534s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[503.705884] Starting subtest: plane-use-after-nonblocking-unbind
[503.708105] Starting dynamic subtest: pipe-A-eDP-1
[503.767431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[504.073805] Starting dynamic subtest: pipe-B-eDP-1
[504.886606] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[505.174480] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.467s)
[506.048976] [094/133] (531s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[506.111245] Starting subtest: etime-multi-wait-all-for-submit-submitted
[506.219799] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[506.298366] [095/133] (531s left) kms_psr (psr-sprite-plane-onoff)
[506.390967] Starting subtest: psr-sprite-plane-onoff
[506.393186] Starting dynamic subtest: eDP-1
[508.201301] Dynamic subtest eDP-1: SUCCESS (1.811s)
[508.203581] Subtest psr-sprite-plane-onoff: SUCCESS (1.812s)
[509.016457] [096/133] (529s left) perf_pmu (busy-no-semaphores)
[509.057690] Starting subtest: busy-no-semaphores
[509.059761] Starting dynamic subtest: rcs0
[509.624196] Dynamic subtest rcs0: SUCCESS (0.566s)
[509.635518] Starting dynamic subtest: bcs0
[510.174474] Dynamic subtest bcs0: SUCCESS (0.547s)
[510.186975] Starting dynamic subtest: vcs0
[510.728378] Dynamic subtest vcs0: SUCCESS (0.550s)
[510.740741] Starting dynamic subtest: vcs1
[512.772317] Dynamic subtest vcs1: SUCCESS (2.040s)
[512.784053] Starting dynamic subtest: vecs0
[514.818370] Dynamic subtest vecs0: SUCCESS (2.043s)
[514.831511] Starting dynamic subtest: ccs0
[516.803234] Dynamic subtest ccs0: SUCCESS (1.981s)
[516.806116] Subtest busy-no-semaphores: SUCCESS (7.746s)
[516.923367] [097/133] (521s left) kms_vblank (wait-forked)
[517.040847] Starting subtest: wait-forked
[517.042694] Starting dynamic subtest: pipe-A-eDP-1
[518.893282] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.848s)
[518.908699] Starting dynamic subtest: pipe-D-eDP-1
[521.410444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[521.412877] Subtest wait-forked: SUCCESS (4.369s)
[522.268416] [098/133] (515s left) gem_mmap_gtt (basic-write-read-distinct)
[522.330425] Subtest basic-write-read-distinct: SKIP (0.000s)
[522.389231] [099/133] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[522.497469] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[526.790052] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.296s)
[527.972237] [100/133] (510s left) kms_psr (pr-dpms)
[528.068916] Starting subtest: pr-dpms
[528.073142] Subtest pr-dpms: SKIP (0.000s)
[528.147368] [101/133] (510s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[528.247559] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[528.252019] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[528.369962] [102/133] (510s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[528.474724] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[528.477070] Starting dynamic subtest: pipe-A-eDP-1
[539.769800] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.300s)
[539.781086] Starting dynamic subtest: pipe-B-eDP-1
[551.777894] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.003s)
[551.780536] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.306s)
[552.618483] [103/133] (485s left) syncobj_basic (bad-flags-handle-to-fd)
[552.686138] Starting subtest: bad-flags-handle-to-fd
[552.688490] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[552.793791] [104/133] (485s left) syncobj_timeline (multi-wait-all-available-signaled)
[552.850131] Starting subtest: multi-wait-all-available-signaled
[552.852426] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[552.952901] [105/133] (485s left) gem_spin_batch (resubmit-new-all)
[553.017664] Starting subtest: resubmit-new-all
[553.020035] Starting dynamic subtest: rcs0
[553.030180] Dynamic subtest rcs0: SUCCESS (0.012s)
[553.042230] Starting dynamic subtest: bcs0
[553.044439] Dynamic subtest bcs0: SUCCESS (0.010s)
[553.054642] Starting dynamic subtest: vcs0
[553.056829] Dynamic subtest vcs0: SUCCESS (0.009s)
[553.066882] Starting dynamic subtest: vcs1
[553.068735] Dynamic subtest vcs1: SUCCESS (0.009s)
[553.078655] Starting dynamic subtest: vecs0
[553.080782] Dynamic subtest vecs0: SUCCESS (0.009s)
[553.090609] Starting dynamic subtest: ccs0
[553.092488] Dynamic subtest ccs0: SUCCESS (0.011s)
[553.094351] Subtest resubmit-new-all: SUCCESS (0.065s)
[554.344972] [106/133] (484s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[554.455769] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[554.459926] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[554.552922] [107/133] (484s left) gem_ctx_engines (execute-one)
[554.621591] Starting subtest: execute-one
[557.192612] Subtest execute-one: SUCCESS (2.574s)
[557.380892] [108/133] (481s left) kms_pm_rpm (modeset-stress-extra-wait)
[559.409660] Starting subtest: modeset-stress-extra-wait
[613.749023] Subtest modeset-stress-extra-wait: SUCCESS (54.286s)
[613.791295] [109/133] (424s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[613.902629] Starting subtest: flip-vs-cursor-crc-legacy
[614.563668] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.659s)
[615.373869] [110/133] (423s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[615.471589] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[615.473811] Starting dynamic subtest: pipe-A-eDP-1
[616.396785] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.919s)
[616.407038] Starting dynamic subtest: pipe-B-eDP-1
[617.974025] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.574s)
[617.985796] Starting dynamic subtest: pipe-C-eDP-1
[619.506135] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.528s)
[619.517167] Starting dynamic subtest: pipe-D-eDP-1
[621.072995] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.567s)
[621.075208] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.594s)
[622.313654] [111/133] (416s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[622.369867] Starting subtest: single-wait-for-submit-unsubmitted
[622.475205] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[622.550241] [112/133] (416s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[622.622859] Starting subtest: y-tiled-to-vebox-y-tiled
[622.627080] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[622.830521] [113/133] (416s left) kms_plane_multiple (tiling-x)
[622.933094] Starting subtest: tiling-x
[622.935068] Starting dynamic subtest: pipe-A-eDP-1
[626.696801] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.763s)
[626.712572] Starting dynamic subtest: pipe-B-eDP-1
[631.122022] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.424s)
[631.132080] Starting dynamic subtest: pipe-C-eDP-1
[635.468047] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.345s)
[635.478538] Starting dynamic subtest: pipe-D-eDP-1
[639.813031] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.344s)
[639.815207] Subtest tiling-x: SUCCESS (16.881s)
[640.620418] [114/133] (398s left) gem_render_copy (yf-tiled)
[640.687979] Starting subtest: yf-tiled
[640.692401] Subtest yf-tiled: SKIP (0.000s)
[640.872991] [115/133] (398s left) gem_ctx_shared (q-smoketest-all)
[640.933910] Starting subtest: Q-smoketest-all
[673.316995] Subtest Q-smoketest-all: SUCCESS (32.336s)
[674.416262] [116/133] (364s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[674.559709] Starting subtest: multiplane-atomic-fence-wait
[674.878046] Subtest multiplane-atomic-fence-wait: SUCCESS (0.321s)
[676.054414] [117/133] (362s left) gem_shrink (reclaim)
[676.121974] Starting subtest: reclaim
[678.554468] Subtest reclaim: SUCCESS (2.412s)
[678.654376] [118/133] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[678.763226] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[678.767467] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[678.873574] [119/133] (360s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[678.970941] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[678.973273] Starting dynamic subtest: pipe-A-eDP-1
[679.125284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[679.137788] Starting dynamic subtest: pipe-B-eDP-1
[679.157067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[679.167115] Starting dynamic subtest: pipe-C-eDP-1
[679.186354] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[679.195713] Starting dynamic subtest: pipe-D-eDP-1
[679.214661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[679.216821] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s)
[681.414613] [120/133] (357s left) gem_exec_parallel (userptr)
[681.488472] Starting subtest: userptr
[681.490833] Starting dynamic subtest: rcs0
[682.938198] Dynamic subtest rcs0: SUCCESS (1.449s)
[682.950221] Starting dynamic subtest: bcs0
[684.415733] Dynamic subtest bcs0: SUCCESS (1.476s)
[684.428699] Starting dynamic subtest: vcs0
[686.271070] Dynamic subtest vcs0: SUCCESS (1.851s)
[686.282408] Starting dynamic subtest: vcs1
[688.319498] Dynamic subtest vcs1: SUCCESS (2.045s)
[688.330288] Starting dynamic subtest: vecs0
[690.303565] Dynamic subtest vecs0: SUCCESS (1.981s)
[690.315878] Starting dynamic subtest: ccs0
[691.813094] Dynamic subtest ccs0: SUCCESS (1.508s)
[691.815802] Subtest userptr: SUCCESS (10.326s)
[692.002606] [121/133] (347s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[692.097952] Starting subtest: x-tiled-16bpp-rotate-0
[693.455054] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s)
[693.571133] [122/133] (345s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[693.667024] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[693.668935] Starting dynamic subtest: pipe-A-eDP-1
[693.690066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[693.701916] Starting dynamic subtest: pipe-B-eDP-1
[693.721714] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[693.730937] Starting dynamic subtest: pipe-C-eDP-1
[693.750092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[693.758977] Starting dynamic subtest: pipe-D-eDP-1
[693.778976] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[693.782673] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[695.995619] [123/133] (343s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[696.135542] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[696.137954] Starting dynamic subtest: pipe-A
[696.374438] Dynamic subtest pipe-A: SUCCESS (0.241s)
[696.385697] Starting dynamic subtest: pipe-B
[697.677817] Dynamic subtest pipe-B: SUCCESS (1.303s)
[697.688785] Starting dynamic subtest: pipe-C
[699.000538] Dynamic subtest pipe-C: SUCCESS (1.322s)
[699.011027] Starting dynamic subtest: pipe-D
[700.342468] Dynamic subtest pipe-D: SUCCESS (1.341s)
[700.344872] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.210s)
[701.521380] [124/133] (337s left) gem_exec_params (cliprects_ptr-dirt)
[701.596269] Starting subtest: cliprects_ptr-dirt
[701.598134] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[701.691235] [125/133] (337s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[701.742339] Starting subtest: multi-wait-available-unsubmitted-signaled
[701.744602] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[701.839711] [126/133] (337s left) kms_lease (cursor-implicit-plane)
[701.922785] Starting subtest: cursor-implicit-plane
[701.925139] Starting dynamic subtest: pipe-A-eDP-1
[702.379367] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[702.393326] Starting dynamic subtest: pipe-B-eDP-1
[703.566274] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s)
[703.576807] Starting dynamic subtest: pipe-C-eDP-1
[704.658364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.091s)
[704.668308] Starting dynamic subtest: pipe-D-eDP-1
[705.789660] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[705.791619] Subtest cursor-implicit-plane: SUCCESS (3.866s)
[706.657900] [127/133] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[706.745635] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[706.750114] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[706.836930] [128/133] (332s left) gem_ctx_isolation (nonpriv)
[706.891590] Starting subtest: nonpriv
[706.894020] Starting dynamic subtest: rcs0
[707.130180] Dynamic subtest rcs0: SUCCESS (0.238s)
[707.140723] Starting dynamic subtest: bcs0
[707.374992] Dynamic subtest bcs0: SUCCESS (0.244s)
[707.387711] Starting dynamic subtest: vcs0
[707.667403] Dynamic subtest vcs0: SUCCESS (0.292s)
[707.677694] Starting dynamic subtest: vcs1
[709.574020] Dynamic subtest vcs1: SUCCESS (1.904s)
[709.586461] Starting dynamic subtest: vecs0
[711.679596] Dynamic subtest vecs0: SUCCESS (2.104s)
[711.696132] Starting dynamic subtest: ccs0
[713.588801] Dynamic subtest ccs0: SUCCESS (1.908s)
[713.590999] Subtest nonpriv: SUCCESS (6.698s)
[713.821645] [129/133] (325s left) kms_cursor_crc (cursor-offscreen-32x10)
[714.017710] Starting subtest: cursor-offscreen-32x10
[714.065839] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[714.353879] [130/133] (325s left) gem_exec_schedule (manyslice)
[714.425597] Starting subtest: manyslice
[714.427499] Starting dynamic subtest: rcs0
[719.608670] Dynamic subtest rcs0: SUCCESS (5.136s)
[719.623086] Starting dynamic subtest: bcs0
[726.248453] Dynamic subtest bcs0: SUCCESS (6.641s)
[726.262416] Starting dynamic subtest: vcs0
[732.338673] Dynamic subtest vcs0: SUCCESS (6.088s)
[732.351506] Starting dynamic subtest: vcs1
[738.421613] Dynamic subtest vcs1: SUCCESS (6.081s)
[738.434475] Starting dynamic subtest: vecs0
[744.484523] Dynamic subtest vecs0: SUCCESS (6.061s)
[744.499794] Starting dynamic subtest: ccs0
[750.679534] Dynamic subtest ccs0: SUCCESS (6.192s)
[750.682239] Subtest manyslice: SUCCESS (36.209s)
[750.947683] [131/133] (288s left) kms_chamelium_audio (dp-audio-edid)
[751.347856] Subtest dp-audio-edid: SKIP (0.000s)
[752.169811] [132/133] (287s left) prime_busy (before-wait)
[752.240862] Starting subtest: before-wait
[752.246531] Starting dynamic subtest: rcs0
[752.285052] Dynamic subtest rcs0: SUCCESS (0.041s)
[752.297061] Starting dynamic subtest: bcs0
[752.342399] Dynamic subtest bcs0: SUCCESS (0.057s)
[752.355872] Starting dynamic subtest: vcs0
[752.381229] Dynamic subtest vcs0: SUCCESS (0.038s)
[752.392482] Starting dynamic subtest: vcs1
[752.421883] Dynamic subtest vcs1: SUCCESS (0.039s)
[752.434057] Starting dynamic subtest: vecs0
[752.462044] Dynamic subtest vecs0: SUCCESS (0.040s)
[752.472255] Starting dynamic subtest: ccs0
[752.503088] Dynamic subtest ccs0: SUCCESS (0.040s)
[752.612536] Subtest before-wait: SUCCESS (0.370s)
[752.705306] [133/133] (287s left) gem_softpin (invalid)
[752.758069] Starting subtest: invalid
[752.765227] Subtest invalid: SUCCESS (0.006s)
[752.869610] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_flink_basic
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_cursor_edge_walk
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_hdr
results: parsing output: 12/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 13/ for test: kms_async_flips
results: parsing output: 14/ for test: kms_busy
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_pm_dc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_basic
results: parsing output: 21/ for test: gem_ctx_persistence
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: i915_suspend
results: parsing output: 31/ for test: gem_ctx_bad_destroy
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: i915_drm_fdinfo
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_prop_blob
results: parsing output: 39/ for test: i915_pm_rpm
results: parsing output: 40/ for test: kms_color_pipeline
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: gem_mmap_wc
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: gem_ctx_create
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: gem_eio
results: parsing output: 50/ for test: gem_exec_whisper
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_gpgpu_fill
results: parsing output: 56/ for test: dmabuf_sync_file
results: parsing output: 57/ for test: gem_ctx_bad_destroy
results: parsing output: 58/ for test: core_auth
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_dp_link_training
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_basic
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: i915_hangman
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_sequence
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gen7_exec_parse
results: parsing output: 82/ for test: kms_vrr
results: parsing output: 83/ for test: kms_pipe_stress
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_pipe_b_c_ivb
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_content_protection
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_atomic_transition
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_vblank
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr2_sf
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_spin_batch
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_engines
results: parsing output: 107/ for test: kms_pm_rpm
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: gem_render_copy
results: parsing output: 114/ for test: gem_ctx_shared
results: parsing output: 115/ for test: kms_explicit_fence
results: parsing output: 116/ for test: gem_shrink
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_ctx_isolation
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: kms_chamelium_audio
results: parsing output: 131/ for test: prime_busy
results: parsing output: 132/ for test: gem_softpin
Done.