[62.808407] Initializing watchdogs
[62.808461]   /dev/watchdog0
[62.824064] [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]
[62.828603] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.830983] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.832918] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[62.927474] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[62.929236] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[62.999598] [002/133] (960s left) gem_flink_basic (double-flink)
[63.045034] Starting subtest: double-flink
[63.045967] Subtest double-flink: SUCCESS (0.000s)
[63.152441] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[63.709982] Starting subtest: invalid-timeline-fence-array
[63.711371] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[65.374683] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[65.376727] [004/133] (958s left) kms_joiner (invalid-modeset-ultra-joiner)
[65.471543] Starting subtest: invalid-modeset-ultra-joiner
[65.473325] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[65.562888] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[65.650969] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[70.332651] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.669s)
[71.516109] [006/133] (951s left) gem_exec_schedule (semaphore-codependency)
[71.581041] Starting subtest: semaphore-codependency
[71.598146] Subtest semaphore-codependency: SUCCESS (0.018s)
[71.920968] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[72.008225] Starting subtest: 64x64-right-edge
[72.009121] Starting dynamic subtest: pipe-A-eDP-1
[75.500450] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s)
[75.509731] Starting dynamic subtest: pipe-D-eDP-1
[78.716518] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.211s)
[78.717437] Subtest 64x64-right-edge: SUCCESS (6.700s)
[79.521732] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[79.609078] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[79.610665] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[79.726229] [009/133] (943s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[79.841025] Starting subtest: cursorA-vs-flipA-toggle
[90.998120] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.154s)
[91.866140] [010/133] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[91.965343] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[91.966840] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.085507] [011/133] (931s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[92.135779] Subtest writes-after-reads-uncached: SKIP (0.000s)
[92.199773] [012/133] (931s left) kms_hdr (invalid-metadata-sizes)
[92.288801] Starting subtest: invalid-metadata-sizes
[92.292478] Subtest invalid-metadata-sizes: SKIP (0.000s)
[92.354361] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[92.411462] Subtest reads: SKIP (0.000s)
[92.479314] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[92.556111] Starting subtest: test-cursor-atomic
[92.929486] Starting dynamic subtest: pipe-A-eDP-1
[93.754160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[94.147389] Starting dynamic subtest: pipe-B-eDP-1
[94.893378] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.752s)
[95.272379] Starting dynamic subtest: pipe-C-eDP-1
[96.022979] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.756s)
[96.398276] Starting dynamic subtest: pipe-D-eDP-1
[97.162616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[97.163619] Subtest test-cursor-atomic: SUCCESS (4.606s)
[98.332298] [015/133] (925s left) kms_busy (extended-modeset-hang-newfb)
[98.424390] Starting subtest: extended-modeset-hang-newfb
[98.425426] Starting dynamic subtest: pipe-A
[133.283946] Dynamic subtest pipe-A: SUCCESS (34.856s)
[133.292506] Starting dynamic subtest: pipe-D
[156.276068] Dynamic subtest pipe-D: SUCCESS (22.988s)
[156.276941] Subtest extended-modeset-hang-newfb: SUCCESS (57.848s)
[157.074277] [016/133] (866s left) syncobj_timeline (wait-all-delayed-signal)
[157.119044] Starting subtest: wait-all-delayed-signal
[157.223686] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[157.298714] [017/133] (866s left) kms_pm_dc (dc5-psr)
[158.392200] Starting subtest: dc5-psr
[161.287245] Subtest dc5-psr: SUCCESS (2.894s)
[162.127574] [018/133] (861s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[162.219301] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[162.220919] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[162.316647] [019/133] (861s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[162.405291] Starting subtest: y-tiled-16bpp-rotate-270
[162.406957] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[162.500190] [020/133] (861s left) kms_psr (fbc-psr2-suspend)
[162.581579] Starting subtest: fbc-psr2-suspend
[162.582457] Starting dynamic subtest: eDP-1
[162.584157] Dynamic subtest eDP-1: SKIP (0.000s)
[162.585780] Subtest fbc-psr2-suspend: SKIP (0.001s)
[162.651150] [021/133] (861s left) gem_exec_basic (basic)
[162.707266] Starting subtest: basic
[162.708212] Starting dynamic subtest: rcs0-smem
[162.711089] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[162.719041] Starting dynamic subtest: bcs0-smem
[162.719847] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[162.726198] Starting dynamic subtest: vcs0-smem
[162.726990] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[162.733461] Starting dynamic subtest: vcs1-smem
[162.734293] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[162.740743] Starting dynamic subtest: vecs0-smem
[162.741760] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[162.748277] Starting dynamic subtest: ccs0-smem
[162.749144] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[162.749975] Subtest basic: SUCCESS (0.013s)
[164.347760] [022/133] (859s left) gem_ctx_persistence (heartbeat-many)
[164.394369] Starting subtest: heartbeat-many
[164.397110] Subtest heartbeat-many: SKIP (0.000s)
[164.512600] [023/133] (859s left) api_intel_allocator (reloc-allocator)
[164.561250] Starting subtest: reloc-allocator
[164.562163] Starting dynamic subtest: basic
[164.565601] Dynamic subtest basic: SUCCESS (0.005s)
[164.574468] Starting dynamic subtest: parallel-one
[164.575376] Dynamic subtest parallel-one: SUCCESS (0.008s)
[164.583340] Starting dynamic subtest: print
[164.584281] Dynamic subtest print: SUCCESS (0.000s)
[164.591336] Starting dynamic subtest: reuse
[164.592088] Dynamic subtest reuse: SUCCESS (0.000s)
[164.598600] Starting dynamic subtest: fork-reopen-allocator
[164.599402] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[164.600145] Subtest reloc-allocator: SUCCESS (0.026s)
[164.714855] [024/133] (859s left) kms_flip (flip-vs-panning-vs-hang)
[164.806838] Starting subtest: flip-vs-panning-vs-hang
[164.807672] Starting dynamic subtest: A-eDP1
[215.883979] Dynamic subtest A-eDP1: SUCCESS (51.074s)
[215.892347] Starting dynamic subtest: D-eDP1
[256.777338] Dynamic subtest D-eDP1: SUCCESS (40.891s)
[256.779104] Subtest flip-vs-panning-vs-hang: SUCCESS (91.968s)
[257.991654] [025/133] (766s left) kms_chamelium_frames (vga-frame-dump)
[258.362258] Subtest vga-frame-dump: SKIP (0.000s)
[259.187723] [026/133] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[259.279571] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[259.281533] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[259.376695] [027/133] (764s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[259.670579] Starting subtest: cursor-rapid-movement-max-size
[259.673823] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[259.786336] [028/133] (764s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[259.832717] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[259.935914] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[260.006729] [029/133] (764s left) kms_psr (fbc-psr2-dpms)
[260.094566] Starting subtest: fbc-psr2-dpms
[260.095571] Starting dynamic subtest: eDP-1
[260.097349] Dynamic subtest eDP-1: SKIP (0.000s)
[260.099269] Subtest fbc-psr2-dpms: SKIP (0.001s)
[260.159987] [030/133] (764s left) kms_flip (flip-vs-rmfb-interruptible)
[260.249932] Starting subtest: flip-vs-rmfb-interruptible
[260.251187] Starting dynamic subtest: A-eDP1
[268.910780] Dynamic subtest A-eDP1: SUCCESS (8.659s)
[268.920601] Starting dynamic subtest: B-eDP1
[277.541542] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[277.553346] Starting dynamic subtest: C-eDP1
[286.164132] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[286.175478] Starting dynamic subtest: D-eDP1
[294.787838] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[294.790557] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.540s)
[295.970307] [031/133] (728s left) i915_suspend (fence-restore-untiled)
[296.017615] Starting subtest: fence-restore-untiled
[296.019207] Subtest fence-restore-untiled: SKIP (0.000s)
[296.107210] [032/133] (728s left) gem_ctx_bad_destroy (invalid-default-ctx)
[296.160587] Starting subtest: invalid-default-ctx
[296.161549] Subtest invalid-default-ctx: SUCCESS (0.000s)
[296.219970] [033/133] (728s left) kms_flip (2x-modeset-vs-vblank-race)
[296.297717] Starting subtest: 2x-modeset-vs-vblank-race
[296.307995] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[296.394974] [034/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[296.487884] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[296.489824] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[296.597063] [035/133] (727s left) vgem_basic (bad-flag)
[296.630562] Starting subtest: bad-flag
[296.631574] Subtest bad-flag: SUCCESS (0.000s)
[296.685759] [036/133] (727s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[296.766761] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[296.768599] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[296.830933] [037/133] (727s left) i915_drm_fdinfo (basics)
[296.865476] Starting subtest: basics
[296.866475] Subtest basics: SUCCESS (0.000s)
[296.928936] [038/133] (727s left) gem_workarounds (basic-read-fd)
[296.992266] Starting subtest: basic-read-fd
[297.003650] Subtest basic-read-fd: SUCCESS (0.011s)
[297.125179] [039/133] (727s left) kms_prop_blob (invalid-set-prop-any)
[297.175671] Starting subtest: invalid-set-prop-any
[297.176949] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[297.260870] [040/133] (727s left) i915_pm_rpm (gem-execbuf)
[299.484583] Starting subtest: gem-execbuf
[299.485457] Starting dynamic subtest: smem0
[301.235373] Dynamic subtest smem0: SUCCESS (1.752s)
[301.236286] Subtest gem-execbuf: SUCCESS (1.754s)
[301.347045] [041/133] (723s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[301.435187] Starting subtest: plane-lut1d-pre-ctm3x4
[301.583336] Starting dynamic subtest: pipe-A-plane-0
[301.782963] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[301.790324] Starting dynamic subtest: pipe-A-plane-1
[301.972481] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[301.979558] Starting dynamic subtest: pipe-A-plane-2
[302.161088] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[303.420266] Starting dynamic subtest: pipe-B-plane-0
[303.579613] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[303.587273] Starting dynamic subtest: pipe-B-plane-1
[303.768544] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[303.775696] Starting dynamic subtest: pipe-B-plane-2
[303.935230] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[305.140171] Starting dynamic subtest: pipe-C-plane-0
[305.299462] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[305.310564] Starting dynamic subtest: pipe-C-plane-1
[305.466093] Dynamic subtest pipe-C-plane-1: SUCCESS (0.165s)
[305.473649] Starting dynamic subtest: pipe-C-plane-2
[305.633038] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[306.860173] Starting dynamic subtest: pipe-D-plane-0
[307.020788] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[307.028428] Starting dynamic subtest: pipe-D-plane-1
[307.176207] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[307.183528] Starting dynamic subtest: pipe-D-plane-2
[307.333676] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[307.627615] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.192s)
[308.508622] [042/133] (716s left) kms_async_flips (crc)
[308.602079] Starting subtest: crc
[308.990516] Starting dynamic subtest: pipe-A-eDP-1
[311.951729] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.961s)
[312.344850] Starting dynamic subtest: pipe-B-eDP-1
[315.264409] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.934s)
[315.651383] Starting dynamic subtest: pipe-C-eDP-1
[318.598764] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.954s)
[318.960310] Starting dynamic subtest: pipe-D-eDP-1
[321.832970] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.880s)
[321.834154] Subtest crc: SUCCESS (13.232s)
[323.000009] [043/133] (701s left) gem_mmap_wc (bad-offset)
[323.056475] Subtest bad-offset: SKIP (0.000s)
[323.112823] [044/133] (701s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[323.484930] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[324.316344] [045/133] (700s left) gem_ctx_create (basic)
[324.369507] Starting subtest: basic
[324.370488] Subtest basic: SUCCESS (0.000s)
[324.551962] [046/133] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[324.636225] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[324.638193] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[324.732455] [047/133] (700s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[324.788464] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[324.843417] [048/133] (700s left) gem_exec_reloc (basic-cpu)
[324.893086] Subtest basic-cpu: SKIP (0.000s)
[324.963722] [049/133] (699s left) gem_mmap_offset (mmap-boundaries)
[325.007783] Starting subtest: mmap-boundaries
[325.008799] Starting dynamic subtest: smem0
[325.291122] Dynamic subtest smem0: SUCCESS (0.284s)
[325.292400] Subtest mmap-boundaries: SUCCESS (0.285s)
[325.389642] [050/133] (699s left) gem_eio (in-flight-contexts-10ms)
[325.609763] Starting subtest: in-flight-contexts-10ms
[339.369120] Subtest in-flight-contexts-10ms: SUCCESS (13.760s)
[339.488652] [051/133] (685s left) gem_exec_whisper (basic-contexts-priority-all)
[339.544435] Starting subtest: basic-contexts-priority-all
[364.308859] Subtest basic-contexts-priority-all: SUCCESS (24.714s)
[364.441049] [052/133] (660s left) kms_big_fb (linear-8bpp-rotate-180)
[364.543729] Starting subtest: linear-8bpp-rotate-180
[365.813065] Subtest linear-8bpp-rotate-180: SUCCESS (1.270s)
[365.943999] [053/133] (659s left) sw_sync (sync_busy_fork)
[365.977484] Starting subtest: sync_busy_fork
[366.997307] Subtest sync_busy_fork: SUCCESS (1.011s)
[367.049390] [054/133] (658s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[367.137593] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[367.138466] Starting dynamic subtest: pipe-A-default-mode
[369.885865] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[369.887203] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.749s)
[370.717457] [055/133] (654s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[370.815161] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[370.816827] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[370.927250] [056/133] (654s left) gem_gpgpu_fill (offset-16x16)
[370.985176] Starting subtest: offset-16x16
[370.991642] Subtest offset-16x16: SUCCESS (0.008s)
[371.117375] [057/133] (654s left) dmabuf_sync_file (import-basic)
[371.164983] Starting subtest: import-basic
[371.165914] Subtest import-basic: SUCCESS (0.002s)
[371.219279] [058/133] (654s left) gem_ctx_bad_destroy (invalid-pad)
[371.263507] Starting subtest: invalid-pad
[371.264465] Subtest invalid-pad: SUCCESS (0.000s)
[371.328355] [059/133] (653s left) core_auth (basic-auth)
[371.370077] Starting subtest: basic-auth
[371.371087] Subtest basic-auth: SUCCESS (0.001s)
[371.464316] [060/133] (653s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[371.552492] Starting subtest: yf-tiled-16bpp-rotate-90
[371.554243] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[371.647706] [061/133] (653s left) kms_dp_link_training (non-uhbr-mst)
[371.748090] Starting subtest: non-uhbr-mst
[371.751440] Subtest non-uhbr-mst: SKIP (0.000s)
[371.815979] [062/133] (653s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[371.903711] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[371.904593] Starting dynamic subtest: pipe-A-eDP-1
[372.818343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.911s)
[372.828971] Starting dynamic subtest: pipe-B-eDP-1
[374.466929] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.648s)
[374.475115] Starting dynamic subtest: pipe-C-eDP-1
[376.036570] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.568s)
[376.045406] Starting dynamic subtest: pipe-D-eDP-1
[377.563382] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s)
[377.564283] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.658s)
[378.738611] [063/133] (646s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[378.839004] Starting subtest: yf-tiled-8bpp-rotate-0
[378.841037] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[378.926839] [064/133] (646s left) gem_basic (multigpu-create-close)
[378.979675] Starting subtest: multigpu-create-close
[378.981481] Subtest multigpu-create-close: SKIP (0.000s)
[379.079077] [065/133] (646s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[379.157363] Starting subtest: flip-vs-dpms-off-vs-modeset
[379.159487] Starting dynamic subtest: A-eDP1
[382.779053] Dynamic subtest A-eDP1: SUCCESS (3.620s)
[382.789351] Starting dynamic subtest: B-eDP1
[385.959471] Dynamic subtest B-eDP1: SUCCESS (3.178s)
[385.967658] Starting dynamic subtest: C-eDP1
[389.097574] Dynamic subtest C-eDP1: SUCCESS (3.137s)
[389.105987] Starting dynamic subtest: D-eDP1
[392.214765] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[392.216546] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.060s)
[393.017783] [066/133] (632s left) gem_exec_balancer (full)
[393.083742] Starting subtest: full
[398.269492] Subtest full: SUCCESS (5.185s)
[398.596267] [067/133] (626s left) i915_hangman (engine-engine-error)
[398.644789] Starting subtest: engine-engine-error
[398.645825] Starting dynamic subtest: rcs0
[400.324368] Dynamic subtest rcs0: SUCCESS (1.670s)
[400.335025] Starting dynamic subtest: bcs0
[402.306789] Dynamic subtest bcs0: SUCCESS (1.979s)
[402.317633] Starting dynamic subtest: vcs0
[404.291322] Dynamic subtest vcs0: SUCCESS (1.981s)
[404.303807] Starting dynamic subtest: vcs1
[406.275467] Dynamic subtest vcs1: SUCCESS (1.981s)
[406.284977] Starting dynamic subtest: vecs0
[408.322838] Dynamic subtest vecs0: SUCCESS (2.045s)
[408.332562] Starting dynamic subtest: ccs0
[410.242585] Dynamic subtest ccs0: SUCCESS (1.916s)
[410.243985] Subtest engine-engine-error: SUCCESS (11.589s)
[410.314101] [068/133] (615s left) gem_mmap_gtt (basic-small-bo-tiledy)
[410.375592] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[410.436580] [069/133] (615s left) kms_frontbuffer_tracking (basic)
[410.533056] Starting subtest: basic
[413.968954] Subtest basic: SUCCESS (3.436s)
[414.069159] [070/133] (611s left) api_intel_bb (reset-flags)
[414.118804] Starting subtest: reset-flags
[414.126757] Subtest reset-flags: SUCCESS (0.009s)
[414.262246] [071/133] (611s left) kms_flip (flip-vs-absolute-wf_vblank)
[414.348180] Starting subtest: flip-vs-absolute-wf_vblank
[414.349192] Starting dynamic subtest: A-eDP1
[423.253233] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[423.266505] Starting dynamic subtest: B-eDP1
[432.181497] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[432.192168] Starting dynamic subtest: C-eDP1
[441.145418] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[441.154985] Starting dynamic subtest: D-eDP1
[450.035442] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[450.039483] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.690s)
[451.262147] [072/133] (574s left) kms_plane_scaling (planes-upscale-20x20)
[451.354497] Starting subtest: planes-upscale-20x20
[451.355343] Starting dynamic subtest: pipe-A
[451.416411] Dynamic subtest pipe-A: SUCCESS (0.063s)
[451.426702] Starting dynamic subtest: pipe-B
[452.578902] Dynamic subtest pipe-B: SUCCESS (1.162s)
[452.589572] Starting dynamic subtest: pipe-C
[453.701850] Dynamic subtest pipe-C: SUCCESS (1.122s)
[453.711377] Starting dynamic subtest: pipe-D
[454.830631] Dynamic subtest pipe-D: SUCCESS (1.128s)
[454.831540] Subtest planes-upscale-20x20: SUCCESS (3.478s)
[455.991853] [073/133] (569s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[456.086834] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[456.088847] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[456.154842] [074/133] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[456.250547] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[456.252441] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[456.337796] [075/133] (569s left) kms_sequence (get-busy)
[456.416346] Starting subtest: get-busy
[456.417362] Starting dynamic subtest: pipe-A-eDP-1
[458.355088] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[458.363701] Starting dynamic subtest: pipe-B-eDP-1
[461.010595] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.655s)
[461.018958] Starting dynamic subtest: pipe-C-eDP-1
[463.615842] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.604s)
[463.625729] Starting dynamic subtest: pipe-D-eDP-1
[466.241560] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[466.242716] Subtest get-busy: SUCCESS (9.824s)
[467.030339] [076/133] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[467.115800] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[467.117440] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[467.209403] [077/133] (558s left) gem_vm_create (execbuf)
[467.260808] Starting subtest: execbuf
[467.267330] Subtest execbuf: SUCCESS (0.007s)
[467.354989] [078/133] (558s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[467.441494] Starting subtest: 4-tiled-32bpp-rotate-90
[467.461079] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[467.569579] [079/133] (558s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[467.613572] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[467.678918] [080/133] (558s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[467.718231] Starting subtest: single-wait-all-for-submit-unsubmitted
[467.825448] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[467.897200] [081/133] (558s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[467.977800] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[467.979513] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[468.073051] [082/133] (558s left) gen7_exec_parse (oacontrol-tracking)
[468.115421] Subtest oacontrol-tracking: SKIP (0.000s)
[468.178674] [083/133] (557s left) kms_vrr (negative-basic)
[468.262409] Starting subtest: negative-basic
[468.265117] Starting dynamic subtest: pipe-A-eDP-1
[473.728373] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.414s)
[473.984947] Subtest negative-basic: SUCCESS (5.722s)
[474.843088] [084/133] (551s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[474.942843] Starting subtest: stress-xrgb8888-4tiled
[480.862998] Subtest stress-xrgb8888-4tiled: SUCCESS (5.920s)
[480.915870] [085/133] (545s left) kms_addfb_basic (no-handle)
[480.967508] Starting subtest: no-handle
[480.968600] Subtest no-handle: SUCCESS (0.000s)
[481.093535] [086/133] (545s left) kms_psr (psr2-dpms)
[481.170252] Starting subtest: psr2-dpms
[481.171039] Starting dynamic subtest: eDP-1
[484.175262] Dynamic subtest eDP-1: SUCCESS (3.004s)
[484.176077] Subtest psr2-dpms: SUCCESS (3.005s)
[485.050794] [087/133] (541s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[485.107881] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[485.168389] [088/133] (541s left) gem_exec_params (no-bsd)
[485.218124] Starting subtest: no-bsd
[485.220528] Subtest no-bsd: SUCCESS (0.002s)
[486.344696] [089/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[486.427212] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[486.429146] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[486.528088] [090/133] (539s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[486.618082] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[486.646041] Starting dynamic subtest: pipe-A-plane-0
[487.091128] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[487.099502] Starting dynamic subtest: pipe-A-plane-3
[487.357308] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[488.434165] Starting dynamic subtest: pipe-B-plane-0
[488.870819] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[488.879893] Starting dynamic subtest: pipe-B-plane-3
[489.148648] Dynamic subtest pipe-B-plane-3: SUCCESS (0.277s)
[489.456959] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.839s)
[490.288065] [091/133] (536s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[490.428466] Starting subtest: dp-mst-type-1-suspend-resume
[490.430371] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[490.548388] [092/133] (535s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[490.629701] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[497.428428] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.799s)
[497.557579] [093/133] (528s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[497.640515] Starting subtest: plane-use-after-nonblocking-unbind
[497.641357] Starting dynamic subtest: pipe-A-eDP-1
[497.704429] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[498.013864] Starting dynamic subtest: pipe-B-eDP-1
[498.821059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.815s)
[499.132300] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.491s)
[499.974441] [094/133] (526s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[500.019366] Starting subtest: etime-multi-wait-all-for-submit-submitted
[500.127594] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[500.200141] [095/133] (526s left) kms_psr (psr-sprite-plane-onoff)
[500.282598] Starting subtest: psr-sprite-plane-onoff
[500.283517] Starting dynamic subtest: eDP-1
[502.027236] Dynamic subtest eDP-1: SUCCESS (1.745s)
[502.028205] Subtest psr-sprite-plane-onoff: SUCCESS (1.746s)
[502.843592] [096/133] (523s left) perf_pmu (busy-no-semaphores)
[502.881992] Starting subtest: busy-no-semaphores
[502.882988] Starting dynamic subtest: rcs0
[503.443962] Dynamic subtest rcs0: SUCCESS (0.551s)
[503.453810] Starting dynamic subtest: bcs0
[503.994744] Dynamic subtest bcs0: SUCCESS (0.548s)
[504.005702] Starting dynamic subtest: vcs0
[504.547265] Dynamic subtest vcs0: SUCCESS (0.550s)
[504.560077] Starting dynamic subtest: vcs1
[505.829711] Dynamic subtest vcs1: SUCCESS (1.279s)
[505.840934] Starting dynamic subtest: vecs0
[507.816687] Dynamic subtest vecs0: SUCCESS (1.983s)
[507.826800] Starting dynamic subtest: ccs0
[509.863918] Dynamic subtest ccs0: SUCCESS (2.044s)
[509.865230] Subtest busy-no-semaphores: SUCCESS (6.974s)
[509.980028] [097/133] (516s left) kms_vblank (wait-forked)
[510.065838] Starting subtest: wait-forked
[510.066628] Starting dynamic subtest: pipe-A-eDP-1
[511.877561] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[511.888377] Starting dynamic subtest: pipe-D-eDP-1
[514.346035] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.466s)
[514.347141] Subtest wait-forked: SUCCESS (4.280s)
[515.209607] [098/133] (511s left) gem_mmap_gtt (basic-write-read-distinct)
[515.267781] Subtest basic-write-read-distinct: SKIP (0.000s)
[515.354921] [099/133] (511s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[515.448174] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[519.780928] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.333s)
[520.951939] [100/133] (505s left) kms_psr (pr-dpms)
[521.042249] Starting subtest: pr-dpms
[521.044064] Subtest pr-dpms: SKIP (0.000s)
[521.111622] [101/133] (505s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[521.204070] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[521.205850] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[521.302234] [102/133] (505s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[521.386371] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[521.387431] Starting dynamic subtest: pipe-A-eDP-1
[532.702131] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.317s)
[532.711758] Starting dynamic subtest: pipe-B-eDP-1
[544.740436] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.036s)
[544.741305] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.356s)
[545.587269] [103/133] (481s left) syncobj_basic (bad-flags-handle-to-fd)
[545.644312] Starting subtest: bad-flags-handle-to-fd
[545.645280] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[545.731709] [104/133] (481s left) syncobj_timeline (multi-wait-all-available-signaled)
[545.783504] Starting subtest: multi-wait-all-available-signaled
[545.784557] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[545.900437] [105/133] (481s left) gem_spin_batch (resubmit-new-all)
[545.950175] Starting subtest: resubmit-new-all
[545.950932] Starting dynamic subtest: rcs0
[545.961547] Dynamic subtest rcs0: SUCCESS (0.012s)
[545.972111] Starting dynamic subtest: bcs0
[545.974034] Dynamic subtest bcs0: SUCCESS (0.011s)
[545.982573] Starting dynamic subtest: vcs0
[545.985398] Dynamic subtest vcs0: SUCCESS (0.011s)
[545.993571] Starting dynamic subtest: vcs1
[545.995932] Dynamic subtest vcs1: SUCCESS (0.009s)
[546.004075] Starting dynamic subtest: vecs0
[546.006058] Dynamic subtest vecs0: SUCCESS (0.009s)
[546.014070] Starting dynamic subtest: ccs0
[546.016555] Dynamic subtest ccs0: SUCCESS (0.011s)
[546.017709] Subtest resubmit-new-all: SUCCESS (0.068s)
[547.326899] [106/133] (479s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[547.417357] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[547.419530] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.511399] [107/133] (479s left) gem_ctx_engines (execute-one)
[547.562582] Starting subtest: execute-one
[550.146103] Subtest execute-one: SUCCESS (2.585s)
[550.341359] [108/133] (476s left) kms_pm_rpm (modeset-stress-extra-wait)
[552.573056] Starting subtest: modeset-stress-extra-wait
[606.931897] Subtest modeset-stress-extra-wait: SUCCESS (54.323s)
[606.986849] [109/133] (420s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[607.098604] Starting subtest: flip-vs-cursor-crc-legacy
[607.812064] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.713s)
[608.677361] [110/133] (418s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[608.763454] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[608.764448] Starting dynamic subtest: pipe-A-eDP-1
[609.715790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.949s)
[609.724384] Starting dynamic subtest: pipe-B-eDP-1
[611.316276] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.599s)
[611.325404] Starting dynamic subtest: pipe-C-eDP-1
[612.861480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.543s)
[612.872181] Starting dynamic subtest: pipe-D-eDP-1
[614.351486] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.490s)
[614.352415] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.586s)
[615.505925] [111/133] (411s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[615.563056] Starting subtest: single-wait-for-submit-unsubmitted
[615.672884] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[615.743136] [112/133] (411s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[615.795359] Starting subtest: y-tiled-to-vebox-y-tiled
[615.797287] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[615.983409] [113/133] (411s left) kms_plane_multiple (tiling-x)
[616.073294] Starting subtest: tiling-x
[616.074154] Starting dynamic subtest: pipe-A-eDP-1
[619.824350] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.750s)
[619.833817] Starting dynamic subtest: pipe-B-eDP-1
[624.370379] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.543s)
[624.380357] Starting dynamic subtest: pipe-C-eDP-1
[628.719755] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[628.728744] Starting dynamic subtest: pipe-D-eDP-1
[633.052223] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.331s)
[633.053097] Subtest tiling-x: SUCCESS (16.978s)
[633.859044] [114/133] (393s left) gem_render_copy (yf-tiled)
[633.907520] Starting subtest: yf-tiled
[633.910118] Subtest yf-tiled: SKIP (0.000s)
[634.098140] [115/133] (393s left) gem_ctx_shared (q-smoketest-all)
[634.172061] Starting subtest: Q-smoketest-all
[666.537363] Subtest Q-smoketest-all: SUCCESS (32.339s)
[667.411790] [116/133] (359s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[667.545963] Starting subtest: multiplane-atomic-fence-wait
[667.863779] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[668.999951] [117/133] (358s left) gem_shrink (reclaim)
[669.050156] Starting subtest: reclaim
[671.556397] Subtest reclaim: SUCCESS (2.504s)
[671.725951] [118/133] (355s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[671.816315] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[671.818034] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[671.903719] [119/133] (355s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[671.991409] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[671.992477] Starting dynamic subtest: pipe-A-eDP-1
[672.139969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[672.149970] Starting dynamic subtest: pipe-B-eDP-1
[672.157843] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[672.166506] Starting dynamic subtest: pipe-C-eDP-1
[672.174187] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[672.182931] Starting dynamic subtest: pipe-D-eDP-1
[672.190568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[672.191424] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[674.475533] [120/133] (352s left) gem_exec_parallel (userptr)
[674.525321] Starting subtest: userptr
[674.526414] Starting dynamic subtest: rcs0
[675.999918] Dynamic subtest rcs0: SUCCESS (1.474s)
[676.011945] Starting dynamic subtest: bcs0
[677.487839] Dynamic subtest bcs0: SUCCESS (1.485s)
[677.499093] Starting dynamic subtest: vcs0
[679.280956] Dynamic subtest vcs0: SUCCESS (1.781s)
[679.292628] Starting dynamic subtest: vcs1
[681.316743] Dynamic subtest vcs1: SUCCESS (2.032s)
[681.330062] Starting dynamic subtest: vecs0
[683.299735] Dynamic subtest vecs0: SUCCESS (1.981s)
[683.310359] Starting dynamic subtest: ccs0
[684.789608] Dynamic subtest ccs0: SUCCESS (1.496s)
[684.792591] Subtest userptr: SUCCESS (10.265s)
[684.971629] [121/133] (342s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[685.064705] Starting subtest: x-tiled-16bpp-rotate-0
[686.388219] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.324s)
[686.529270] [122/133] (340s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[686.614240] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[686.615059] Starting dynamic subtest: pipe-A-eDP-1
[686.624785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[686.633574] Starting dynamic subtest: pipe-B-eDP-1
[686.643679] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[686.652380] Starting dynamic subtest: pipe-C-eDP-1
[686.661412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[686.670027] Starting dynamic subtest: pipe-D-eDP-1
[686.680745] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[686.682568] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[688.823271] [123/133] (338s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[688.910442] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[688.911352] Starting dynamic subtest: pipe-A
[689.139757] Dynamic subtest pipe-A: SUCCESS (0.230s)
[689.148614] Starting dynamic subtest: pipe-B
[690.422417] Dynamic subtest pipe-B: SUCCESS (1.281s)
[690.437984] Starting dynamic subtest: pipe-C
[691.755891] Dynamic subtest pipe-C: SUCCESS (1.333s)
[691.764420] Starting dynamic subtest: pipe-D
[693.100037] Dynamic subtest pipe-D: SUCCESS (1.343s)
[693.101083] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.191s)
[694.280120] [124/133] (333s left) gem_exec_params (cliprects_ptr-dirt)
[694.340980] Starting subtest: cliprects_ptr-dirt
[694.342139] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[694.432579] [125/133] (333s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[694.484939] Starting subtest: multi-wait-available-unsubmitted-signaled
[694.485813] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[694.576699] [126/133] (333s left) kms_lease (cursor-implicit-plane)
[694.661099] Starting subtest: cursor-implicit-plane
[694.662075] Starting dynamic subtest: pipe-A-eDP-1
[695.119863] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[695.131970] Starting dynamic subtest: pipe-B-eDP-1
[696.203867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[696.214280] Starting dynamic subtest: pipe-C-eDP-1
[697.323061] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[697.333360] Starting dynamic subtest: pipe-D-eDP-1
[698.449853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[698.450796] Subtest cursor-implicit-plane: SUCCESS (3.790s)
[699.309421] [127/133] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[699.403254] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[699.404848] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[699.503104] [128/133] (328s left) gem_ctx_isolation (nonpriv)
[699.556215] Starting subtest: nonpriv
[699.557268] Starting dynamic subtest: rcs0
[699.788304] Dynamic subtest rcs0: SUCCESS (0.232s)
[699.799966] Starting dynamic subtest: bcs0
[700.042076] Dynamic subtest bcs0: SUCCESS (0.253s)
[700.051417] Starting dynamic subtest: vcs0
[700.296535] Dynamic subtest vcs0: SUCCESS (0.254s)
[700.305192] Starting dynamic subtest: vcs1
[701.559922] Dynamic subtest vcs1: SUCCESS (1.262s)
[701.569943] Starting dynamic subtest: vecs0
[703.571906] Dynamic subtest vecs0: SUCCESS (2.011s)
[703.583211] Starting dynamic subtest: ccs0
[705.570765] Dynamic subtest ccs0: SUCCESS (1.998s)
[705.571940] Subtest nonpriv: SUCCESS (6.015s)
[705.810597] [129/133] (321s left) kms_cursor_crc (cursor-offscreen-32x10)
[705.962177] Starting subtest: cursor-offscreen-32x10
[706.010053] Subtest cursor-offscreen-32x10: SKIP (0.047s)
[706.286040] [130/133] (321s left) gem_exec_schedule (manyslice)
[706.344606] Starting subtest: manyslice
[706.345663] Starting dynamic subtest: rcs0
[711.540874] Dynamic subtest rcs0: SUCCESS (5.149s)
[711.555251] Starting dynamic subtest: bcs0
[718.183817] Dynamic subtest bcs0: SUCCESS (6.643s)
[718.199437] Starting dynamic subtest: vcs0
[724.267201] Dynamic subtest vcs0: SUCCESS (6.079s)
[724.282571] Starting dynamic subtest: vcs1
[730.355730] Dynamic subtest vcs1: SUCCESS (6.087s)
[730.368223] Starting dynamic subtest: vecs0
[735.926500] Dynamic subtest vecs0: SUCCESS (5.569s)
[735.941678] Starting dynamic subtest: ccs0
[741.616470] Dynamic subtest ccs0: SUCCESS (5.688s)
[741.617648] Subtest manyslice: SUCCESS (35.225s)
[741.867448] [131/133] (285s left) kms_chamelium_audio (dp-audio-edid)
[742.244179] Subtest dp-audio-edid: SKIP (0.000s)
[743.021319] [132/133] (284s left) prime_busy (before-wait)
[743.073764] Starting subtest: before-wait
[743.075487] Starting dynamic subtest: rcs0
[743.112463] Dynamic subtest rcs0: SUCCESS (0.037s)
[743.122471] Starting dynamic subtest: bcs0
[743.151220] Dynamic subtest bcs0: SUCCESS (0.038s)
[743.159491] Starting dynamic subtest: vcs0
[743.193830] Dynamic subtest vcs0: SUCCESS (0.042s)
[743.202275] Starting dynamic subtest: vcs1
[743.232110] Dynamic subtest vcs1: SUCCESS (0.038s)
[743.240510] Starting dynamic subtest: vecs0
[743.273055] Dynamic subtest vecs0: SUCCESS (0.040s)
[743.281335] Starting dynamic subtest: ccs0
[743.314217] Dynamic subtest ccs0: SUCCESS (0.040s)
[743.421785] Subtest before-wait: SUCCESS (0.349s)
[743.509905] [133/133] (284s left) gem_softpin (invalid)
[743.563921] Starting subtest: invalid
[743.570131] Subtest invalid: SUCCESS (0.006s)
[743.670970] 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.