[58.351200] Initializing watchdogs
[58.351248]   /dev/watchdog0
[58.366255] [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]
[58.370733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.372935] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.376187] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[58.519507] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[58.524825] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[58.616542] [002/133] (960s left) gem_flink_basic (double-flink)
[58.677668] Starting subtest: double-flink
[58.679837] Subtest double-flink: SUCCESS (0.000s)
[58.786118] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[59.342480] Starting subtest: invalid-timeline-fence-array
[59.348471] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[60.381067] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[60.384706] [004/133] (958s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.489585] Starting subtest: invalid-modeset-ultra-joiner
[60.494044] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.553590] [005/133] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[60.654300] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[65.254818] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.606s)
[66.406577] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[66.487977] Starting subtest: semaphore-codependency
[66.499356] Subtest semaphore-codependency: SUCCESS (0.016s)
[66.867206] [007/133] (952s left) kms_cursor_edge_walk (64x64-right-edge)
[66.964433] Starting subtest: 64x64-right-edge
[66.966800] Starting dynamic subtest: pipe-A-eDP-1
[70.447747] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[70.458408] Starting dynamic subtest: pipe-D-eDP-1
[73.570681] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[73.573142] Subtest 64x64-right-edge: SUCCESS (6.607s)
[74.389344] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[74.505485] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[74.509795] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[74.590211] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[74.710527] Starting subtest: cursorA-vs-flipA-toggle
[85.848080] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.137s)
[86.692600] [010/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[86.804553] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[86.808747] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.913213] [011/133] (932s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[86.967406] Subtest writes-after-reads-uncached: SKIP (0.000s)
[87.033797] [012/133] (932s left) kms_hdr (invalid-metadata-sizes)
[87.130422] Starting subtest: invalid-metadata-sizes
[87.136996] Subtest invalid-metadata-sizes: SKIP (0.000s)
[87.201252] [013/133] (932s left) gem_tiled_partial_pwrite_pread (reads)
[87.253711] Subtest reads: SKIP (0.000s)
[87.337397] [014/133] (932s left) kms_async_flips (test-cursor-atomic)
[87.437669] Starting subtest: test-cursor-atomic
[87.813077] Starting dynamic subtest: pipe-A-eDP-1
[88.583143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[88.973986] Starting dynamic subtest: pipe-B-eDP-1
[89.721903] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[90.105231] Starting dynamic subtest: pipe-C-eDP-1
[90.843512] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.748s)
[91.214651] Starting dynamic subtest: pipe-D-eDP-1
[91.972660] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[91.975065] Subtest test-cursor-atomic: SUCCESS (4.536s)
[93.145498] [015/133] (926s left) kms_busy (extended-modeset-hang-newfb)
[93.240875] Starting subtest: extended-modeset-hang-newfb
[93.243225] Starting dynamic subtest: pipe-A
[128.222265] Dynamic subtest pipe-A: SUCCESS (34.982s)
[128.231922] Starting dynamic subtest: pipe-D
[151.182431] Dynamic subtest pipe-D: SUCCESS (22.957s)
[151.184812] Subtest extended-modeset-hang-newfb: SUCCESS (57.944s)
[151.985539] [016/133] (867s left) syncobj_timeline (wait-all-delayed-signal)
[152.053236] Starting subtest: wait-all-delayed-signal
[152.156812] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[152.246405] [017/133] (867s left) kms_pm_dc (dc5-psr)
[153.338069] Starting subtest: dc5-psr
[156.216977] Subtest dc5-psr: SUCCESS (2.879s)
[157.026525] [018/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[157.129903] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[157.134224] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[157.222866] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[157.338678] Starting subtest: y-tiled-16bpp-rotate-270
[157.342847] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[157.478699] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[157.572872] Starting subtest: fbc-psr2-suspend
[157.575174] Starting dynamic subtest: eDP-1
[157.579255] Dynamic subtest eDP-1: SKIP (0.000s)
[157.583394] Subtest fbc-psr2-suspend: SKIP (0.001s)
[157.657242] [021/133] (862s left) gem_exec_basic (basic)
[157.715270] Starting subtest: basic
[157.717633] Starting dynamic subtest: rcs0-smem
[157.719961] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[157.730089] Starting dynamic subtest: bcs0-smem
[157.732259] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[157.739958] Starting dynamic subtest: vcs0-smem
[157.742131] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[157.749745] Starting dynamic subtest: vcs1-smem
[157.751964] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[157.759796] Starting dynamic subtest: vecs0-smem
[157.761986] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[157.769956] Starting dynamic subtest: ccs0-smem
[157.772143] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[157.774234] Subtest basic: SUCCESS (0.012s)
[159.345136] [022/133] (860s left) gem_ctx_persistence (heartbeat-many)
[159.405630] Starting subtest: heartbeat-many
[159.410212] Subtest heartbeat-many: SKIP (0.000s)
[159.498857] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[159.547201] Starting subtest: reloc-allocator
[159.549649] Starting dynamic subtest: basic
[159.551776] Dynamic subtest basic: SUCCESS (0.003s)
[159.561765] Starting dynamic subtest: parallel-one
[159.564074] Dynamic subtest parallel-one: SUCCESS (0.008s)
[159.571803] Starting dynamic subtest: print
[159.574129] Dynamic subtest print: SUCCESS (0.000s)
[159.581601] Starting dynamic subtest: reuse
[159.583486] Dynamic subtest reuse: SUCCESS (0.000s)
[159.590994] Starting dynamic subtest: fork-reopen-allocator
[159.592901] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[159.594754] Subtest reloc-allocator: SUCCESS (0.027s)
[159.693443] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[159.797633] Starting subtest: flip-vs-panning-vs-hang
[159.799624] Starting dynamic subtest: A-eDP1
[210.800805] Dynamic subtest A-eDP1: SUCCESS (51.001s)
[210.809301] Starting dynamic subtest: D-eDP1
[260.789118] Dynamic subtest D-eDP1: SUCCESS (49.986s)
[260.791565] Subtest flip-vs-panning-vs-hang: SUCCESS (100.991s)
[262.016630] [025/133] (757s left) kms_chamelium_frames (vga-frame-dump)
[262.427681] Subtest vga-frame-dump: SKIP (0.000s)
[263.224683] [026/133] (756s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[263.316542] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[263.320669] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[263.419426] [027/133] (756s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[263.728432] Starting subtest: cursor-rapid-movement-max-size
[263.734798] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[263.865737] [028/133] (756s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[263.924286] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[264.027956] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[264.102283] [029/133] (755s left) kms_psr (fbc-psr2-dpms)
[264.198064] Starting subtest: fbc-psr2-dpms
[264.200224] Starting dynamic subtest: eDP-1
[264.203857] Dynamic subtest eDP-1: SKIP (0.000s)
[264.207832] Subtest fbc-psr2-dpms: SKIP (0.001s)
[264.267968] [030/133] (755s left) kms_flip (flip-vs-rmfb-interruptible)
[264.359615] Starting subtest: flip-vs-rmfb-interruptible
[264.361500] Starting dynamic subtest: A-eDP1
[273.034114] Dynamic subtest A-eDP1: SUCCESS (8.673s)
[273.045121] Starting dynamic subtest: B-eDP1
[281.657525] Dynamic subtest B-eDP1: SUCCESS (8.621s)
[281.668101] Starting dynamic subtest: C-eDP1
[290.278350] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[290.286537] Starting dynamic subtest: D-eDP1
[298.901994] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[298.907477] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.546s)
[300.089667] [031/133] (720s left) i915_suspend (fence-restore-untiled)
[300.141237] Starting subtest: fence-restore-untiled
[300.145755] Subtest fence-restore-untiled: SKIP (0.000s)
[300.230822] [032/133] (719s left) gem_ctx_bad_destroy (invalid-default-ctx)
[300.275914] Starting subtest: invalid-default-ctx
[300.278142] Subtest invalid-default-ctx: SUCCESS (0.000s)
[300.353160] [033/133] (719s left) kms_flip (2x-modeset-vs-vblank-race)
[300.445818] Starting subtest: 2x-modeset-vs-vblank-race
[300.454646] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[300.548132] [034/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[300.641377] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[300.645585] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[300.730917] [035/133] (719s left) vgem_basic (bad-flag)
[300.781449] Starting subtest: bad-flag
[300.783320] Subtest bad-flag: SUCCESS (0.000s)
[300.841775] [036/133] (719s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[300.940910] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[300.945082] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[301.027532] [037/133] (719s left) i915_drm_fdinfo (basics)
[301.076271] Starting subtest: basics
[301.077862] Subtest basics: SUCCESS (0.000s)
[301.147850] [038/133] (719s left) gem_workarounds (basic-read-fd)
[301.214283] Starting subtest: basic-read-fd
[301.225982] Subtest basic-read-fd: SUCCESS (0.012s)
[301.370990] [039/133] (719s left) kms_prop_blob (invalid-set-prop-any)
[301.434964] Starting subtest: invalid-set-prop-any
[301.437019] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[301.535764] [040/133] (719s left) i915_pm_rpm (gem-execbuf)
[303.465069] Starting subtest: gem-execbuf
[303.467146] Starting dynamic subtest: smem0
[304.886328] Dynamic subtest smem0: SUCCESS (1.424s)
[304.888654] Subtest gem-execbuf: SUCCESS (1.426s)
[304.982295] [041/133] (715s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[305.069727] Starting subtest: plane-lut1d-pre-ctm3x4
[305.238580] Starting dynamic subtest: pipe-A-plane-0
[305.415696] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[305.424309] Starting dynamic subtest: pipe-A-plane-1
[305.582387] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[305.591550] Starting dynamic subtest: pipe-A-plane-2
[305.749179] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[306.924698] Starting dynamic subtest: pipe-B-plane-0
[307.074067] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[307.082663] Starting dynamic subtest: pipe-B-plane-1
[307.240532] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[307.249436] Starting dynamic subtest: pipe-B-plane-2
[307.385255] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[308.558670] Starting dynamic subtest: pipe-C-plane-0
[308.696053] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[308.704791] Starting dynamic subtest: pipe-C-plane-1
[308.840588] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[308.849212] Starting dynamic subtest: pipe-C-plane-2
[308.985065] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[310.201912] Starting dynamic subtest: pipe-D-plane-0
[310.340406] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[310.353596] Starting dynamic subtest: pipe-D-plane-1
[310.495189] Dynamic subtest pipe-D-plane-1: SUCCESS (0.152s)
[310.504852] Starting dynamic subtest: pipe-D-plane-2
[310.650716] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[310.939247] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.871s)
[311.766685] [042/133] (708s left) kms_async_flips (crc)
[311.871149] Starting subtest: crc
[312.255635] Starting dynamic subtest: pipe-A-eDP-1
[315.188408] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[315.569076] Starting dynamic subtest: pipe-B-eDP-1
[318.432468] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.871s)
[318.832842] Starting dynamic subtest: pipe-C-eDP-1
[321.744805] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.922s)
[322.114728] Starting dynamic subtest: pipe-D-eDP-1
[324.989064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.882s)
[324.991450] Subtest crc: SUCCESS (13.120s)
[326.146762] [043/133] (694s left) gem_mmap_wc (bad-offset)
[326.206774] Subtest bad-offset: SKIP (0.000s)
[326.272844] [044/133] (694s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[326.662060] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[327.463784] [045/133] (693s left) gem_ctx_create (basic)
[327.522900] Starting subtest: basic
[327.524774] Subtest basic: SUCCESS (0.000s)
[327.706930] [046/133] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[327.809471] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[327.813519] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[327.920035] [047/133] (692s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[327.981154] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[328.043968] [048/133] (692s left) gem_exec_reloc (basic-cpu)
[328.101533] Subtest basic-cpu: SKIP (0.000s)
[328.174235] [049/133] (692s left) gem_mmap_offset (mmap-boundaries)
[328.226210] Starting subtest: mmap-boundaries
[328.228059] Starting dynamic subtest: smem0
[328.508880] Dynamic subtest smem0: SUCCESS (0.283s)
[328.511219] Subtest mmap-boundaries: SUCCESS (0.284s)
[328.629020] [050/133] (692s left) gem_eio (in-flight-contexts-10ms)
[328.868000] Starting subtest: in-flight-contexts-10ms
[342.309646] Subtest in-flight-contexts-10ms: SUCCESS (13.441s)
[342.487842] [051/133] (678s left) gem_exec_whisper (basic-contexts-priority-all)
[342.567309] Starting subtest: basic-contexts-priority-all
[365.604861] Subtest basic-contexts-priority-all: SUCCESS (23.032s)
[365.788408] [052/133] (655s left) kms_big_fb (linear-8bpp-rotate-180)
[365.895022] Starting subtest: linear-8bpp-rotate-180
[367.186695] Subtest linear-8bpp-rotate-180: SUCCESS (1.293s)
[367.308373] [053/133] (653s left) sw_sync (sync_busy_fork)
[367.340688] Starting subtest: sync_busy_fork
[368.352331] Subtest sync_busy_fork: SUCCESS (1.013s)
[368.415416] [054/133] (652s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[368.511617] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[368.514045] Starting dynamic subtest: pipe-A-default-mode
[371.220049] Dynamic subtest pipe-A-default-mode: SUCCESS (2.709s)
[371.222452] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.710s)
[372.089470] [055/133] (649s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[372.185901] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[372.190104] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[372.289726] [056/133] (648s left) gem_gpgpu_fill (offset-16x16)
[372.341129] Starting subtest: offset-16x16
[372.347721] Subtest offset-16x16: SUCCESS (0.008s)
[372.474911] [057/133] (648s left) dmabuf_sync_file (import-basic)
[372.519620] Starting subtest: import-basic
[372.521911] Subtest import-basic: SUCCESS (0.002s)
[372.589712] [058/133] (648s left) gem_ctx_bad_destroy (invalid-pad)
[372.637776] Starting subtest: invalid-pad
[372.640339] Subtest invalid-pad: SUCCESS (0.000s)
[372.713615] [059/133] (648s left) core_auth (basic-auth)
[372.780723] Starting subtest: basic-auth
[372.783060] Subtest basic-auth: SUCCESS (0.001s)
[372.878396] [060/133] (648s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[372.989103] Starting subtest: yf-tiled-16bpp-rotate-90
[372.993571] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[373.097913] [061/133] (648s left) kms_dp_link_training (non-uhbr-mst)
[373.188295] Starting subtest: non-uhbr-mst
[373.195221] Subtest non-uhbr-mst: SKIP (0.000s)
[373.258679] [062/133] (648s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[373.349984] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[373.351737] Starting dynamic subtest: pipe-A-eDP-1
[374.209538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[374.228961] Starting dynamic subtest: pipe-B-eDP-1
[375.747104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[375.758712] Starting dynamic subtest: pipe-C-eDP-1
[377.218185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.469s)
[377.229652] Starting dynamic subtest: pipe-D-eDP-1
[378.741333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[378.743610] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.385s)
[379.933804] [063/133] (641s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[380.028791] Starting subtest: yf-tiled-8bpp-rotate-0
[380.033330] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[380.121644] [064/133] (641s left) gem_basic (multigpu-create-close)
[380.168180] Starting subtest: multigpu-create-close
[380.172260] Subtest multigpu-create-close: SKIP (0.000s)
[380.271949] [065/133] (641s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[380.382437] Starting subtest: flip-vs-dpms-off-vs-modeset
[380.384622] Starting dynamic subtest: A-eDP1
[383.961440] Dynamic subtest A-eDP1: SUCCESS (3.578s)
[383.971756] Starting dynamic subtest: B-eDP1
[387.159824] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[387.170182] Starting dynamic subtest: C-eDP1
[390.264933] Dynamic subtest C-eDP1: SUCCESS (3.102s)
[390.276318] Starting dynamic subtest: D-eDP1
[393.388784] Dynamic subtest D-eDP1: SUCCESS (3.122s)
[393.390684] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.012s)
[394.174141] [066/133] (627s left) gem_exec_balancer (full)
[394.250320] Starting subtest: full
[399.138985] Subtest full: SUCCESS (4.890s)
[399.466329] [067/133] (622s left) i915_hangman (engine-engine-error)
[399.542443] Starting subtest: engine-engine-error
[399.544826] Starting dynamic subtest: rcs0
[401.253079] Dynamic subtest rcs0: SUCCESS (1.709s)
[401.264097] Starting dynamic subtest: bcs0
[403.238356] Dynamic subtest bcs0: SUCCESS (1.982s)
[403.251138] Starting dynamic subtest: vcs0
[405.286339] Dynamic subtest vcs0: SUCCESS (2.045s)
[405.299807] Starting dynamic subtest: vcs1
[407.270094] Dynamic subtest vcs1: SUCCESS (1.981s)
[407.282948] Starting dynamic subtest: vecs0
[409.254067] Dynamic subtest vecs0: SUCCESS (1.981s)
[409.268046] Starting dynamic subtest: ccs0
[411.250844] Dynamic subtest ccs0: SUCCESS (1.980s)
[411.255322] Subtest engine-engine-error: SUCCESS (11.695s)
[411.381669] [068/133] (610s left) gem_mmap_gtt (basic-small-bo-tiledy)
[411.441921] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[411.512775] [069/133] (610s left) kms_frontbuffer_tracking (basic)
[411.609536] Starting subtest: basic
[414.797827] Subtest basic: SUCCESS (3.192s)
[414.905082] [070/133] (606s left) api_intel_bb (reset-flags)
[414.956196] Starting subtest: reset-flags
[414.960957] Subtest reset-flags: SUCCESS (0.007s)
[415.086486] [071/133] (606s left) kms_flip (flip-vs-absolute-wf_vblank)
[415.182522] Starting subtest: flip-vs-absolute-wf_vblank
[415.184512] Starting dynamic subtest: A-eDP1
[424.118159] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[424.130293] Starting dynamic subtest: B-eDP1
[433.052381] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[433.065823] Starting dynamic subtest: C-eDP1
[441.975416] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[441.991850] Starting dynamic subtest: D-eDP1
[450.909655] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[450.914984] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.731s)
[452.138929] [072/133] (569s left) kms_plane_scaling (planes-upscale-20x20)
[452.239065] Starting subtest: planes-upscale-20x20
[452.241293] Starting dynamic subtest: pipe-A
[452.297754] Dynamic subtest pipe-A: SUCCESS (0.062s)
[452.308901] Starting dynamic subtest: pipe-B
[453.455152] Dynamic subtest pipe-B: SUCCESS (1.156s)
[453.468237] Starting dynamic subtest: pipe-C
[454.577419] Dynamic subtest pipe-C: SUCCESS (1.121s)
[454.588108] Starting dynamic subtest: pipe-D
[455.708708] Dynamic subtest pipe-D: SUCCESS (1.126s)
[455.711478] Subtest planes-upscale-20x20: SUCCESS (3.471s)
[456.962273] [073/133] (564s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[457.059370] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[457.063346] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[457.143596] [074/133] (564s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[457.237452] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[457.241521] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[457.343937] [075/133] (564s left) kms_sequence (get-busy)
[457.431023] Starting subtest: get-busy
[457.433279] Starting dynamic subtest: pipe-A-eDP-1
[459.363192] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[459.372878] Starting dynamic subtest: pipe-B-eDP-1
[461.960652] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.593s)
[461.971208] Starting dynamic subtest: pipe-C-eDP-1
[464.561575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.599s)
[464.571785] Starting dynamic subtest: pipe-D-eDP-1
[467.116111] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[467.118325] Subtest get-busy: SUCCESS (9.685s)
[467.996251] [076/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[468.116873] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[468.121076] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[468.235200] [077/133] (553s left) gem_vm_create (execbuf)
[468.323435] Starting subtest: execbuf
[468.328279] Subtest execbuf: SUCCESS (0.008s)
[468.449349] [078/133] (553s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[468.551511] Starting subtest: 4-tiled-32bpp-rotate-90
[468.575088] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.023s)
[468.691330] [079/133] (553s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[468.744700] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[468.825423] [080/133] (553s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[468.874247] Starting subtest: single-wait-all-for-submit-unsubmitted
[468.979990] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[469.056808] [081/133] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[469.142277] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[469.146290] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[469.241162] [082/133] (553s left) gen7_exec_parse (oacontrol-tracking)
[469.308169] Subtest oacontrol-tracking: SKIP (0.000s)
[469.390993] [083/133] (552s left) kms_vrr (negative-basic)
[469.472036] Starting subtest: negative-basic
[469.478687] Starting dynamic subtest: pipe-A-eDP-1
[474.905159] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.425s)
[475.181415] Subtest negative-basic: SUCCESS (5.711s)
[476.026321] [084/133] (546s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[476.136125] Starting subtest: stress-xrgb8888-4tiled
[482.004151] Subtest stress-xrgb8888-4tiled: SUCCESS (5.869s)
[482.053784] [085/133] (540s left) kms_addfb_basic (no-handle)
[482.117311] Starting subtest: no-handle
[482.119193] Subtest no-handle: SUCCESS (0.000s)
[482.250062] [086/133] (540s left) kms_psr (psr2-dpms)
[482.337205] Starting subtest: psr2-dpms
[482.339205] Starting dynamic subtest: eDP-1
[485.246371] Dynamic subtest eDP-1: SUCCESS (2.911s)
[485.248693] Subtest psr2-dpms: SUCCESS (2.912s)
[486.126290] [087/133] (536s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[486.190989] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[486.248129] [088/133] (536s left) gem_exec_params (no-bsd)
[486.302426] Starting subtest: no-bsd
[486.304845] Subtest no-bsd: SUCCESS (0.002s)
[488.379117] [089/133] (534s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[488.466437] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[488.470799] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.573195] [090/133] (534s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[488.677221] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[488.702590] Starting dynamic subtest: pipe-A-plane-0
[489.148051] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[489.160090] Starting dynamic subtest: pipe-A-plane-3
[489.402419] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[490.512693] Starting dynamic subtest: pipe-B-plane-0
[490.935872] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[490.945899] Starting dynamic subtest: pipe-B-plane-3
[491.191431] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[491.500113] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.825s)
[492.387290] [091/133] (530s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[492.526820] Starting subtest: dp-mst-type-1-suspend-resume
[492.531364] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[492.640831] [092/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[492.743833] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[499.552140] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.813s)
[499.679876] [093/133] (523s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[499.779926] Starting subtest: plane-use-after-nonblocking-unbind
[499.782231] Starting dynamic subtest: pipe-A-eDP-1
[499.842821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[500.146319] Starting dynamic subtest: pipe-B-eDP-1
[500.917611] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s)
[501.215596] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.435s)
[502.096971] [094/133] (520s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[502.150614] Starting subtest: etime-multi-wait-all-for-submit-submitted
[502.260041] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[502.338531] [095/133] (520s left) kms_psr (psr-sprite-plane-onoff)
[502.423025] Starting subtest: psr-sprite-plane-onoff
[502.425160] Starting dynamic subtest: eDP-1
[504.247076] Dynamic subtest eDP-1: SUCCESS (1.824s)
[504.249408] Subtest psr-sprite-plane-onoff: SUCCESS (1.825s)
[505.046292] [096/133] (517s left) perf_pmu (busy-no-semaphores)
[505.088686] Starting subtest: busy-no-semaphores
[505.091022] Starting dynamic subtest: rcs0
[505.616094] Dynamic subtest rcs0: SUCCESS (0.527s)
[505.627057] Starting dynamic subtest: bcs0
[506.165079] Dynamic subtest bcs0: SUCCESS (0.545s)
[506.176889] Starting dynamic subtest: vcs0
[506.716799] Dynamic subtest vcs0: SUCCESS (0.549s)
[506.729754] Starting dynamic subtest: vcs1
[507.785450] Dynamic subtest vcs1: SUCCESS (1.066s)
[507.797780] Starting dynamic subtest: vecs0
[509.836343] Dynamic subtest vecs0: SUCCESS (2.048s)
[509.849372] Starting dynamic subtest: ccs0
[511.826430] Dynamic subtest ccs0: SUCCESS (1.987s)
[511.829509] Subtest busy-no-semaphores: SUCCESS (6.739s)
[511.942941] [097/133] (510s left) kms_vblank (wait-forked)
[512.037912] Starting subtest: wait-forked
[512.040135] Starting dynamic subtest: pipe-A-eDP-1
[513.849781] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[513.865517] Starting dynamic subtest: pipe-D-eDP-1
[516.330285] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[516.332694] Subtest wait-forked: SUCCESS (4.295s)
[517.222394] [098/133] (505s left) gem_mmap_gtt (basic-write-read-distinct)
[517.276310] Subtest basic-write-read-distinct: SKIP (0.000s)
[517.344389] [099/133] (505s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[517.442911] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[521.684058] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.245s)
[522.815881] [100/133] (500s left) kms_psr (pr-dpms)
[522.912721] Starting subtest: pr-dpms
[522.917240] Subtest pr-dpms: SKIP (0.000s)
[523.003537] [101/133] (500s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[523.111990] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[523.116700] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[523.222694] [102/133] (499s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[523.315052] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[523.317465] Starting dynamic subtest: pipe-A-eDP-1
[534.624339] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.315s)
[534.637089] Starting dynamic subtest: pipe-B-eDP-1
[546.643078] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.016s)
[546.645482] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.335s)
[547.477075] [103/133] (475s left) syncobj_basic (bad-flags-handle-to-fd)
[547.546523] Starting subtest: bad-flags-handle-to-fd
[547.548410] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[547.664785] [104/133] (475s left) syncobj_timeline (multi-wait-all-available-signaled)
[547.723351] Starting subtest: multi-wait-all-available-signaled
[547.725600] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[547.818527] [105/133] (475s left) gem_spin_batch (resubmit-new-all)
[547.874336] Starting subtest: resubmit-new-all
[547.876684] Starting dynamic subtest: rcs0
[547.887062] Dynamic subtest rcs0: SUCCESS (0.012s)
[547.898975] Starting dynamic subtest: bcs0
[547.901335] Dynamic subtest bcs0: SUCCESS (0.010s)
[547.911159] Starting dynamic subtest: vcs0
[547.913283] Dynamic subtest vcs0: SUCCESS (0.008s)
[547.922631] Starting dynamic subtest: vcs1
[547.924526] Dynamic subtest vcs1: SUCCESS (0.009s)
[547.934079] Starting dynamic subtest: vecs0
[547.936215] Dynamic subtest vecs0: SUCCESS (0.012s)
[547.945464] Starting dynamic subtest: ccs0
[547.947346] Dynamic subtest ccs0: SUCCESS (0.013s)
[547.949220] Subtest resubmit-new-all: SUCCESS (0.070s)
[549.367579] [106/133] (473s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[549.467497] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[549.471632] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[549.570619] [107/133] (473s left) gem_ctx_engines (execute-one)
[549.647243] Starting subtest: execute-one
[552.509155] Subtest execute-one: SUCCESS (2.862s)
[552.708304] [108/133] (470s left) kms_pm_rpm (modeset-stress-extra-wait)
[554.441299] Starting subtest: modeset-stress-extra-wait
[608.699878] Subtest modeset-stress-extra-wait: SUCCESS (54.256s)
[608.791435] [109/133] (414s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[608.914908] Starting subtest: flip-vs-cursor-crc-legacy
[609.607509] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.693s)
[610.489483] [110/133] (413s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[610.583474] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[610.585584] Starting dynamic subtest: pipe-A-eDP-1
[611.404668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s)
[611.415596] Starting dynamic subtest: pipe-B-eDP-1
[612.965986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.560s)
[612.975883] Starting dynamic subtest: pipe-C-eDP-1
[614.551235] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.585s)
[614.561666] Starting dynamic subtest: pipe-D-eDP-1
[616.161233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.609s)
[616.163389] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.572s)
[617.324709] [111/133] (406s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[617.387177] Starting subtest: single-wait-for-submit-unsubmitted
[617.491661] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[617.568638] [112/133] (406s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[617.631776] Starting subtest: y-tiled-to-vebox-y-tiled
[617.636054] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[617.813032] [113/133] (405s left) kms_plane_multiple (tiling-x)
[617.906407] Starting subtest: tiling-x
[617.908675] Starting dynamic subtest: pipe-A-eDP-1
[621.756220] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.849s)
[621.766759] Starting dynamic subtest: pipe-B-eDP-1
[626.092675] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.336s)
[626.103045] Starting dynamic subtest: pipe-C-eDP-1
[630.442677] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[630.453518] Starting dynamic subtest: pipe-D-eDP-1
[634.811690] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.369s)
[634.813818] Subtest tiling-x: SUCCESS (16.907s)
[635.636809] [114/133] (388s left) gem_render_copy (yf-tiled)
[635.696408] Starting subtest: yf-tiled
[635.700836] Subtest yf-tiled: SKIP (0.000s)
[635.883660] [115/133] (387s left) gem_ctx_shared (q-smoketest-all)
[635.971898] Starting subtest: Q-smoketest-all
[668.373073] Subtest Q-smoketest-all: SUCCESS (32.352s)
[669.371276] [116/133] (354s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[669.518876] Starting subtest: multiplane-atomic-fence-wait
[669.834741] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[670.972876] [117/133] (352s left) gem_shrink (reclaim)
[671.030088] Starting subtest: reclaim
[673.410086] Subtest reclaim: SUCCESS (2.374s)
[673.595110] [118/133] (350s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[673.695230] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[673.699470] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[673.801423] [119/133] (350s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[673.891771] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[673.893976] Starting dynamic subtest: pipe-A-eDP-1
[674.045642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[674.057272] Starting dynamic subtest: pipe-B-eDP-1
[674.076835] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[674.088820] Starting dynamic subtest: pipe-C-eDP-1
[674.107337] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[674.116494] Starting dynamic subtest: pipe-D-eDP-1
[674.135181] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[674.137076] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s)
[676.329930] [120/133] (347s left) gem_exec_parallel (userptr)
[676.409050] Starting subtest: userptr
[676.411826] Starting dynamic subtest: rcs0
[677.836165] Dynamic subtest rcs0: SUCCESS (1.428s)
[677.847089] Starting dynamic subtest: bcs0
[679.330050] Dynamic subtest bcs0: SUCCESS (1.492s)
[679.345350] Starting dynamic subtest: vcs0
[681.263113] Dynamic subtest vcs0: SUCCESS (1.900s)
[681.275100] Starting dynamic subtest: vcs1
[683.271246] Dynamic subtest vcs1: SUCCESS (2.036s)
[683.283443] Starting dynamic subtest: vecs0
[685.319440] Dynamic subtest vecs0: SUCCESS (2.045s)
[685.330426] Starting dynamic subtest: ccs0
[686.830597] Dynamic subtest ccs0: SUCCESS (1.510s)
[686.833087] Subtest userptr: SUCCESS (10.425s)
[687.020993] [121/133] (336s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[687.130135] Starting subtest: x-tiled-16bpp-rotate-0
[688.532825] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.402s)
[688.663093] [122/133] (335s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[688.768411] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[688.770472] Starting dynamic subtest: pipe-A-eDP-1
[688.791307] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[688.804478] Starting dynamic subtest: pipe-B-eDP-1
[688.823807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[688.834044] Starting dynamic subtest: pipe-C-eDP-1
[688.853119] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[688.862517] Starting dynamic subtest: pipe-D-eDP-1
[688.881701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[688.884960] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[691.009890] [123/133] (333s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[691.104829] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[691.107186] Starting dynamic subtest: pipe-A
[691.332109] Dynamic subtest pipe-A: SUCCESS (0.229s)
[691.343765] Starting dynamic subtest: pipe-B
[692.593363] Dynamic subtest pipe-B: SUCCESS (1.260s)
[692.603224] Starting dynamic subtest: pipe-C
[693.914441] Dynamic subtest pipe-C: SUCCESS (1.320s)
[693.924964] Starting dynamic subtest: pipe-D
[695.262550] Dynamic subtest pipe-D: SUCCESS (1.347s)
[695.264898] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.160s)
[696.549507] [124/133] (327s left) gem_exec_params (cliprects_ptr-dirt)
[696.618600] Starting subtest: cliprects_ptr-dirt
[696.620902] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[696.715086] [125/133] (327s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[696.766985] Starting subtest: multi-wait-available-unsubmitted-signaled
[696.769202] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[696.895527] [126/133] (327s left) kms_lease (cursor-implicit-plane)
[696.983367] Starting subtest: cursor-implicit-plane
[696.985596] Starting dynamic subtest: pipe-A-eDP-1
[697.448191] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[697.459626] Starting dynamic subtest: pipe-B-eDP-1
[698.561093] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.113s)
[698.574764] Starting dynamic subtest: pipe-C-eDP-1
[699.663577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.098s)
[699.673606] Starting dynamic subtest: pipe-D-eDP-1
[700.796276] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[700.798756] Subtest cursor-implicit-plane: SUCCESS (3.815s)
[701.662029] [127/133] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[701.765492] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[701.769524] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[701.870079] [128/133] (322s left) gem_ctx_isolation (nonpriv)
[701.928602] Starting subtest: nonpriv
[701.930818] Starting dynamic subtest: rcs0
[702.152759] Dynamic subtest rcs0: SUCCESS (0.224s)
[702.164747] Starting dynamic subtest: bcs0
[702.401613] Dynamic subtest bcs0: SUCCESS (0.247s)
[702.413793] Starting dynamic subtest: vcs0
[702.651589] Dynamic subtest vcs0: SUCCESS (0.249s)
[702.661892] Starting dynamic subtest: vcs1
[704.588689] Dynamic subtest vcs1: SUCCESS (1.936s)
[704.599077] Starting dynamic subtest: vecs0
[706.595731] Dynamic subtest vecs0: SUCCESS (2.005s)
[706.605352] Starting dynamic subtest: ccs0
[708.513184] Dynamic subtest ccs0: SUCCESS (1.916s)
[708.515406] Subtest nonpriv: SUCCESS (6.585s)
[708.780297] [129/133] (315s left) kms_cursor_crc (cursor-offscreen-32x10)
[708.945965] Starting subtest: cursor-offscreen-32x10
[708.991330] Subtest cursor-offscreen-32x10: SKIP (0.042s)
[709.281669] [130/133] (315s left) gem_exec_schedule (manyslice)
[709.350992] Starting subtest: manyslice
[709.353091] Starting dynamic subtest: rcs0
[714.483590] Dynamic subtest rcs0: SUCCESS (5.142s)
[714.497350] Starting dynamic subtest: bcs0
[721.125326] Dynamic subtest bcs0: SUCCESS (6.638s)
[721.139270] Starting dynamic subtest: vcs0
[726.724137] Dynamic subtest vcs0: SUCCESS (5.598s)
[726.737473] Starting dynamic subtest: vcs1
[732.300616] Dynamic subtest vcs1: SUCCESS (5.574s)
[732.315453] Starting dynamic subtest: vecs0
[737.875696] Dynamic subtest vecs0: SUCCESS (5.574s)
[737.887781] Starting dynamic subtest: ccs0
[744.573032] Dynamic subtest ccs0: SUCCESS (6.693s)
[744.575968] Subtest manyslice: SUCCESS (35.230s)
[744.876047] [131/133] (279s left) kms_chamelium_audio (dp-audio-edid)
[745.265984] Subtest dp-audio-edid: SKIP (0.000s)
[746.072511] [132/133] (278s left) prime_busy (before-wait)
[746.125883] Starting subtest: before-wait
[746.131630] Starting dynamic subtest: rcs0
[746.165644] Dynamic subtest rcs0: SUCCESS (0.037s)
[746.177748] Starting dynamic subtest: bcs0
[746.211541] Dynamic subtest bcs0: SUCCESS (0.045s)
[746.225985] Starting dynamic subtest: vcs0
[746.253951] Dynamic subtest vcs0: SUCCESS (0.042s)
[746.267273] Starting dynamic subtest: vcs1
[746.295630] Dynamic subtest vcs1: SUCCESS (0.041s)
[746.305699] Starting dynamic subtest: vecs0
[746.336568] Dynamic subtest vecs0: SUCCESS (0.040s)
[746.347952] Starting dynamic subtest: ccs0
[746.377412] Dynamic subtest ccs0: SUCCESS (0.038s)
[746.483641] Subtest before-wait: SUCCESS (0.356s)
[746.574461] [133/133] (277s left) gem_softpin (invalid)
[746.629677] Starting subtest: invalid
[746.634773] Subtest invalid: SUCCESS (0.005s)
[746.764954] 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.