[58.596868] Initializing watchdogs
[58.596910]   /dev/watchdog0
[58.611123] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.615086] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.617018] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.620252] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[58.729921] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[58.733835] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[58.828254] [002/133] (960s left) gem_flink_basic (double-flink)
[58.876493] Starting subtest: double-flink
[58.878532] Subtest double-flink: SUCCESS (0.000s)
[58.975574] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[59.513836] Starting subtest: invalid-timeline-fence-array
[59.519097] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[61.319082] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[61.322306] [004/133] (957s left) kms_joiner (invalid-modeset-ultra-joiner)
[61.419675] Starting subtest: invalid-modeset-ultra-joiner
[61.423797] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[61.483323] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[61.557293] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[66.113937] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.614s)
[67.293840] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[67.361118] Starting subtest: semaphore-codependency
[67.367505] Subtest semaphore-codependency: SUCCESS (0.014s)
[67.714603] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[67.791735] Starting subtest: 64x64-right-edge
[67.794074] Starting dynamic subtest: pipe-A-eDP-1
[71.225362] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[71.234341] Starting dynamic subtest: pipe-D-eDP-1
[74.335825] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[74.338124] Subtest 64x64-right-edge: SUCCESS (6.573s)
[75.141854] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[75.230384] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[75.234598] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[75.329234] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[75.425796] Starting subtest: cursorA-vs-flipA-toggle
[86.531804] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.117s)
[87.347642] [010/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[87.429777] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[87.433751] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[87.524485] [011/133] (931s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[87.592486] Subtest writes-after-reads-uncached: SKIP (0.000s)
[87.663831] [012/133] (931s left) kms_hdr (invalid-metadata-sizes)
[87.737442] Starting subtest: invalid-metadata-sizes
[87.743516] Subtest invalid-metadata-sizes: SKIP (0.000s)
[87.813043] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[87.873070] Subtest reads: SKIP (0.000s)
[87.937928] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[88.017863] Starting subtest: test-cursor-atomic
[88.394173] Starting dynamic subtest: pipe-A-eDP-1
[89.144677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[89.527086] Starting dynamic subtest: pipe-B-eDP-1
[90.283546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[90.678516] Starting dynamic subtest: pipe-C-eDP-1
[91.422692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.750s)
[91.788161] Starting dynamic subtest: pipe-D-eDP-1
[92.574330] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.794s)
[92.576700] Subtest test-cursor-atomic: SUCCESS (4.557s)
[93.762881] [015/133] (925s left) kms_busy (extended-modeset-hang-newfb)
[93.852100] Starting subtest: extended-modeset-hang-newfb
[93.854574] Starting dynamic subtest: pipe-A
[128.194205] Dynamic subtest pipe-A: SUCCESS (34.337s)
[128.202854] Starting dynamic subtest: pipe-D
[151.165884] Dynamic subtest pipe-D: SUCCESS (22.971s)
[151.168451] Subtest extended-modeset-hang-newfb: SUCCESS (57.313s)
[151.968786] [016/133] (867s left) syncobj_timeline (wait-all-delayed-signal)
[152.024678] Starting subtest: wait-all-delayed-signal
[152.129050] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[152.217986] [017/133] (867s left) kms_pm_dc (dc5-psr)
[153.306465] Starting subtest: dc5-psr
[156.188214] Subtest dc5-psr: SUCCESS (2.880s)
[156.991530] [018/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[157.071652] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[157.075782] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[157.169381] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[157.248775] Starting subtest: y-tiled-16bpp-rotate-270
[157.253253] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[157.342213] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[157.420861] Starting subtest: fbc-psr2-suspend
[157.423195] Starting dynamic subtest: eDP-1
[157.427654] Dynamic subtest eDP-1: SKIP (0.000s)
[157.432079] Subtest fbc-psr2-suspend: SKIP (0.001s)
[157.491941] [021/133] (862s left) gem_exec_basic (basic)
[157.541566] Starting subtest: basic
[157.543983] Starting dynamic subtest: rcs0-smem
[157.548575] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[157.556754] Starting dynamic subtest: bcs0-smem
[157.558962] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[157.566077] Starting dynamic subtest: vcs0-smem
[157.567863] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[157.574967] Starting dynamic subtest: vcs1-smem
[157.576829] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[157.583941] Starting dynamic subtest: vecs0-smem
[157.585911] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[157.593104] Starting dynamic subtest: ccs0-smem
[157.595032] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[157.596960] Subtest basic: SUCCESS (0.012s)
[159.267417] [022/133] (860s left) gem_ctx_persistence (heartbeat-many)
[159.322618] Starting subtest: heartbeat-many
[159.327644] Subtest heartbeat-many: SKIP (0.000s)
[159.436987] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[159.498185] Starting subtest: reloc-allocator
[159.500581] Starting dynamic subtest: basic
[159.502864] Dynamic subtest basic: SUCCESS (0.003s)
[159.512342] Starting dynamic subtest: parallel-one
[159.514656] Dynamic subtest parallel-one: SUCCESS (0.008s)
[159.522896] Starting dynamic subtest: print
[159.524820] Dynamic subtest print: SUCCESS (0.000s)
[159.532389] Starting dynamic subtest: reuse
[159.534318] Dynamic subtest reuse: SUCCESS (0.000s)
[159.541922] Starting dynamic subtest: fork-reopen-allocator
[159.543862] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[159.545786] Subtest reloc-allocator: SUCCESS (0.025s)
[159.661591] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[159.741430] Starting subtest: flip-vs-panning-vs-hang
[159.743407] Starting dynamic subtest: A-eDP1
[210.727824] Dynamic subtest A-eDP1: SUCCESS (50.985s)
[210.736057] Starting dynamic subtest: D-eDP1
[250.803163] Dynamic subtest D-eDP1: SUCCESS (40.071s)
[250.807988] Subtest flip-vs-panning-vs-hang: SUCCESS (91.063s)
[251.992259] [025/133] (768s left) kms_chamelium_frames (vga-frame-dump)
[252.357919] Subtest vga-frame-dump: SKIP (0.000s)
[253.195459] [026/133] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[253.274682] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[253.279214] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[253.370223] [027/133] (766s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[253.651623] Starting subtest: cursor-rapid-movement-max-size
[253.657856] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[253.767298] [028/133] (766s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[253.826779] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[253.931085] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[254.031302] [029/133] (766s left) kms_psr (fbc-psr2-dpms)
[254.103122] Starting subtest: fbc-psr2-dpms
[254.105550] Starting dynamic subtest: eDP-1
[254.109852] Dynamic subtest eDP-1: SKIP (0.000s)
[254.114766] Subtest fbc-psr2-dpms: SKIP (0.001s)
[254.215673] [030/133] (766s left) kms_flip (flip-vs-rmfb-interruptible)
[254.296371] Starting subtest: flip-vs-rmfb-interruptible
[254.298735] Starting dynamic subtest: A-eDP1
[262.908380] Dynamic subtest A-eDP1: SUCCESS (8.611s)
[262.919875] Starting dynamic subtest: B-eDP1
[271.530032] Dynamic subtest B-eDP1: SUCCESS (8.618s)
[271.541784] Starting dynamic subtest: C-eDP1
[280.149914] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[280.157792] Starting dynamic subtest: D-eDP1
[288.770669] Dynamic subtest D-eDP1: SUCCESS (8.619s)
[288.774986] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.478s)
[289.952486] [031/133] (730s left) i915_suspend (fence-restore-untiled)
[290.005071] Starting subtest: fence-restore-untiled
[290.010407] Subtest fence-restore-untiled: SKIP (0.000s)
[290.109834] [032/133] (730s left) gem_ctx_bad_destroy (invalid-default-ctx)
[290.163142] Starting subtest: invalid-default-ctx
[290.165518] Subtest invalid-default-ctx: SUCCESS (0.000s)
[290.236455] [033/133] (730s left) kms_flip (2x-modeset-vs-vblank-race)
[290.309611] Starting subtest: 2x-modeset-vs-vblank-race
[290.318042] Subtest 2x-modeset-vs-vblank-race: SKIP (0.007s)
[290.396469] [034/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[290.486569] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[290.490894] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[290.586284] [035/133] (729s left) vgem_basic (bad-flag)
[290.627810] Starting subtest: bad-flag
[290.629779] Subtest bad-flag: SUCCESS (0.000s)
[290.691584] [036/133] (729s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[290.773471] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[290.777857] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[290.840838] [037/133] (729s left) i915_drm_fdinfo (basics)
[290.878833] Starting subtest: basics
[290.881334] Subtest basics: SUCCESS (0.000s)
[290.941808] [038/133] (729s left) gem_workarounds (basic-read-fd)
[291.007879] Starting subtest: basic-read-fd
[291.018968] Subtest basic-read-fd: SUCCESS (0.011s)
[291.142419] [039/133] (729s left) kms_prop_blob (invalid-set-prop-any)
[291.195887] Starting subtest: invalid-set-prop-any
[291.197760] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[291.291446] [040/133] (729s left) i915_pm_rpm (gem-execbuf)
[293.400055] Starting subtest: gem-execbuf
[293.402458] Starting dynamic subtest: smem0
[294.926805] Dynamic subtest smem0: SUCCESS (1.528s)
[294.929026] Subtest gem-execbuf: SUCCESS (1.530s)
[295.013752] [041/133] (725s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[295.087068] Starting subtest: plane-lut1d-pre-ctm3x4
[295.211585] Starting dynamic subtest: pipe-A-plane-0
[295.400436] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[295.409390] Starting dynamic subtest: pipe-A-plane-1
[295.578751] Dynamic subtest pipe-A-plane-1: SUCCESS (0.177s)
[295.587216] Starting dynamic subtest: pipe-A-plane-2
[295.722992] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[296.865438] Starting dynamic subtest: pipe-B-plane-0
[297.002766] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[297.011298] Starting dynamic subtest: pipe-B-plane-1
[297.135832] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[297.145048] Starting dynamic subtest: pipe-B-plane-2
[297.269690] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[298.491682] Starting dynamic subtest: pipe-C-plane-0
[298.618175] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[298.626805] Starting dynamic subtest: pipe-C-plane-1
[298.762252] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[298.770890] Starting dynamic subtest: pipe-C-plane-2
[298.907767] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[300.158691] Starting dynamic subtest: pipe-D-plane-0
[300.296251] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[300.304955] Starting dynamic subtest: pipe-D-plane-1
[300.440653] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s)
[300.449204] Starting dynamic subtest: pipe-D-plane-2
[300.585118] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[300.878237] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.791s)
[301.692269] [042/133] (719s left) kms_async_flips (crc)
[301.772313] Starting subtest: crc
[302.143749] Starting dynamic subtest: pipe-A-eDP-1
[305.014389] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.869s)
[305.387164] Starting dynamic subtest: pipe-B-eDP-1
[308.267771] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.889s)
[308.643161] Starting dynamic subtest: pipe-C-eDP-1
[311.550620] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.914s)
[311.916224] Starting dynamic subtest: pipe-D-eDP-1
[314.794186] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.882s)
[314.796440] Subtest crc: SUCCESS (13.018s)
[315.970415] [043/133] (704s left) gem_mmap_wc (bad-offset)
[316.033760] Subtest bad-offset: SKIP (0.000s)
[316.086457] [044/133] (704s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[316.439691] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[317.270824] [045/133] (703s left) gem_ctx_create (basic)
[317.329316] Starting subtest: basic
[317.331735] Subtest basic: SUCCESS (0.000s)
[317.513062] [046/133] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[317.598480] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[317.602859] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[317.698090] [047/133] (703s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[317.756415] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[317.820281] [048/133] (703s left) gem_exec_reloc (basic-cpu)
[317.880818] Subtest basic-cpu: SKIP (0.000s)
[317.956244] [049/133] (703s left) gem_mmap_offset (mmap-boundaries)
[318.015479] Starting subtest: mmap-boundaries
[318.017719] Starting dynamic subtest: smem0
[318.284096] Dynamic subtest smem0: SUCCESS (0.271s)
[318.286628] Subtest mmap-boundaries: SUCCESS (0.271s)
[318.406220] [050/133] (702s left) gem_eio (in-flight-contexts-10ms)
[318.638970] Starting subtest: in-flight-contexts-10ms
[332.241059] Subtest in-flight-contexts-10ms: SUCCESS (13.601s)
[332.418345] [051/133] (688s left) gem_exec_whisper (basic-contexts-priority-all)
[332.477064] Starting subtest: basic-contexts-priority-all
[355.398763] Subtest basic-contexts-priority-all: SUCCESS (22.917s)
[355.581629] [052/133] (665s left) kms_big_fb (linear-8bpp-rotate-180)
[355.675046] Starting subtest: linear-8bpp-rotate-180
[356.909678] Subtest linear-8bpp-rotate-180: SUCCESS (1.235s)
[357.044547] [053/133] (664s left) sw_sync (sync_busy_fork)
[357.078049] Starting subtest: sync_busy_fork
[358.090368] Subtest sync_busy_fork: SUCCESS (1.011s)
[358.153143] [054/133] (663s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[358.219050] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[358.221378] Starting dynamic subtest: pipe-A-default-mode
[360.933590] Dynamic subtest pipe-A-default-mode: SUCCESS (2.712s)
[360.935997] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.714s)
[361.796563] [055/133] (659s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[361.877058] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[361.881555] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[361.979112] [056/133] (659s left) gem_gpgpu_fill (offset-16x16)
[362.040168] Starting subtest: offset-16x16
[362.045269] Subtest offset-16x16: SUCCESS (0.007s)
[362.169309] [057/133] (659s left) dmabuf_sync_file (import-basic)
[362.211081] Starting subtest: import-basic
[362.213307] Subtest import-basic: SUCCESS (0.001s)
[362.272400] [058/133] (659s left) gem_ctx_bad_destroy (invalid-pad)
[362.318440] Starting subtest: invalid-pad
[362.320701] Subtest invalid-pad: SUCCESS (0.000s)
[362.395144] [059/133] (659s left) core_auth (basic-auth)
[362.439399] Starting subtest: basic-auth
[362.441522] Subtest basic-auth: SUCCESS (0.001s)
[362.533622] [060/133] (659s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[362.604261] Starting subtest: yf-tiled-16bpp-rotate-90
[362.608304] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[362.689841] [061/133] (658s left) kms_dp_link_training (non-uhbr-mst)
[362.759104] Starting subtest: non-uhbr-mst
[362.765893] Subtest non-uhbr-mst: SKIP (0.000s)
[362.844406] [062/133] (658s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[362.907332] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[362.909184] Starting dynamic subtest: pipe-A-eDP-1
[363.745842] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[363.755239] Starting dynamic subtest: pipe-B-eDP-1
[365.416663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.667s)
[365.428294] Starting dynamic subtest: pipe-C-eDP-1
[366.918334] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[366.928070] Starting dynamic subtest: pipe-D-eDP-1
[368.454859] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[368.456803] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.539s)
[369.627134] [063/133] (652s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[369.720734] Starting subtest: yf-tiled-8bpp-rotate-0
[369.724747] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[369.817618] [064/133] (651s left) gem_basic (multigpu-create-close)
[369.866111] Starting subtest: multigpu-create-close
[369.870061] Subtest multigpu-create-close: SKIP (0.000s)
[369.980979] [065/133] (651s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[370.050989] Starting subtest: flip-vs-dpms-off-vs-modeset
[370.053258] Starting dynamic subtest: A-eDP1
[373.651324] Dynamic subtest A-eDP1: SUCCESS (3.600s)
[373.661101] Starting dynamic subtest: B-eDP1
[376.840462] Dynamic subtest B-eDP1: SUCCESS (3.188s)
[376.851084] Starting dynamic subtest: C-eDP1
[379.941480] Dynamic subtest C-eDP1: SUCCESS (3.099s)
[379.951839] Starting dynamic subtest: D-eDP1
[383.061966] Dynamic subtest D-eDP1: SUCCESS (3.117s)
[383.064303] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.013s)
[383.858472] [066/133] (637s left) gem_exec_balancer (full)
[383.935211] Starting subtest: full
[388.017769] Subtest full: SUCCESS (4.085s)
[388.326848] [067/133] (633s left) i915_hangman (engine-engine-error)
[388.385308] Starting subtest: engine-engine-error
[388.387556] Starting dynamic subtest: rcs0
[390.173555] Dynamic subtest rcs0: SUCCESS (1.786s)
[390.186790] Starting dynamic subtest: bcs0
[392.221566] Dynamic subtest bcs0: SUCCESS (2.045s)
[392.234230] Starting dynamic subtest: vcs0
[394.204151] Dynamic subtest vcs0: SUCCESS (1.980s)
[394.218525] Starting dynamic subtest: vcs1
[396.188591] Dynamic subtest vcs1: SUCCESS (1.982s)
[396.202269] Starting dynamic subtest: vecs0
[398.172236] Dynamic subtest vecs0: SUCCESS (1.980s)
[398.187601] Starting dynamic subtest: ccs0
[400.157058] Dynamic subtest ccs0: SUCCESS (1.981s)
[400.159915] Subtest engine-engine-error: SUCCESS (11.771s)
[400.329759] [068/133] (621s left) gem_mmap_gtt (basic-small-bo-tiledy)
[400.393329] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[400.459941] [069/133] (621s left) kms_frontbuffer_tracking (basic)
[400.552643] Starting subtest: basic
[403.728270] Subtest basic: SUCCESS (3.179s)
[403.842545] [070/133] (618s left) api_intel_bb (reset-flags)
[403.895983] Starting subtest: reset-flags
[403.900772] Subtest reset-flags: SUCCESS (0.006s)
[404.019242] [071/133] (618s left) kms_flip (flip-vs-absolute-wf_vblank)
[404.091482] Starting subtest: flip-vs-absolute-wf_vblank
[404.093309] Starting dynamic subtest: A-eDP1
[413.009613] Dynamic subtest A-eDP1: SUCCESS (8.919s)
[413.020666] Starting dynamic subtest: B-eDP1
[421.952446] Dynamic subtest B-eDP1: SUCCESS (8.941s)
[421.963055] Starting dynamic subtest: C-eDP1
[430.882261] Dynamic subtest C-eDP1: SUCCESS (8.927s)
[430.894698] Starting dynamic subtest: D-eDP1
[439.812915] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[439.815201] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.725s)
[441.036399] [072/133] (581s left) kms_plane_scaling (planes-upscale-20x20)
[441.111220] Starting subtest: planes-upscale-20x20
[441.113499] Starting dynamic subtest: pipe-A
[441.170262] Dynamic subtest pipe-A: SUCCESS (0.061s)
[441.186757] Starting dynamic subtest: pipe-B
[442.349753] Dynamic subtest pipe-B: SUCCESS (1.178s)
[442.360062] Starting dynamic subtest: pipe-C
[443.476061] Dynamic subtest pipe-C: SUCCESS (1.125s)
[443.486230] Starting dynamic subtest: pipe-D
[444.589737] Dynamic subtest pipe-D: SUCCESS (1.113s)
[444.592063] Subtest planes-upscale-20x20: SUCCESS (3.482s)
[445.738471] [073/133] (576s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[445.821996] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[445.826565] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[445.893010] [074/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[445.980076] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[445.984144] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[446.078373] [075/133] (576s left) kms_sequence (get-busy)
[446.157936] Starting subtest: get-busy
[446.160225] Starting dynamic subtest: pipe-A-eDP-1
[448.084463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[448.097668] Starting dynamic subtest: pipe-B-eDP-1
[450.650747] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.563s)
[450.661359] Starting dynamic subtest: pipe-C-eDP-1
[453.269517] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[453.282550] Starting dynamic subtest: pipe-D-eDP-1
[455.902944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.632s)
[455.905266] Subtest get-busy: SUCCESS (9.746s)
[456.702835] [076/133] (565s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[456.785031] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[456.789416] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[456.895576] [077/133] (565s left) gem_vm_create (execbuf)
[456.956820] Starting subtest: execbuf
[456.963019] Subtest execbuf: SUCCESS (0.006s)
[457.069913] [078/133] (565s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[457.160513] Starting subtest: 4-tiled-32bpp-rotate-90
[457.180210] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[457.296252] [079/133] (565s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[457.356882] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[457.422541] [080/133] (565s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[457.474023] Starting subtest: single-wait-all-for-submit-unsubmitted
[457.579588] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[457.669538] [081/133] (564s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[457.747066] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[457.751201] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[457.841915] [082/133] (564s left) gen7_exec_parse (oacontrol-tracking)
[457.902037] Subtest oacontrol-tracking: SKIP (0.000s)
[457.969447] [083/133] (564s left) kms_vrr (negative-basic)
[458.041062] Starting subtest: negative-basic
[458.047558] Starting dynamic subtest: pipe-A-eDP-1
[463.465031] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.416s)
[463.768646] Subtest negative-basic: SUCCESS (5.726s)
[464.628007] [084/133] (557s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[464.706611] Starting subtest: stress-xrgb8888-4tiled
[470.579921] Subtest stress-xrgb8888-4tiled: SUCCESS (5.874s)
[470.627825] [085/133] (552s left) kms_addfb_basic (no-handle)
[470.685482] Starting subtest: no-handle
[470.687045] Subtest no-handle: SUCCESS (0.000s)
[470.821440] [086/133] (551s left) kms_psr (psr2-dpms)
[470.891413] Starting subtest: psr2-dpms
[470.893412] Starting dynamic subtest: eDP-1
[473.765340] Dynamic subtest eDP-1: SUCCESS (2.872s)
[473.767635] Subtest psr2-dpms: SUCCESS (2.873s)
[474.634647] [087/133] (548s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[474.694699] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[474.759444] [088/133] (547s left) gem_exec_params (no-bsd)
[474.820300] Starting subtest: no-bsd
[474.822707] Subtest no-bsd: SUCCESS (0.002s)
[476.283890] [089/133] (546s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[476.368794] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[476.373378] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[476.476597] [090/133] (546s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[476.551662] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[476.577682] Starting dynamic subtest: pipe-A-plane-0
[476.999671] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[477.009799] Starting dynamic subtest: pipe-A-plane-3
[477.255241] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[478.315644] Starting dynamic subtest: pipe-B-plane-0
[478.751235] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[478.763852] Starting dynamic subtest: pipe-B-plane-3
[479.008449] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[479.319714] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.766s)
[480.180969] [091/133] (542s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[480.297074] Starting subtest: dp-mst-type-1-suspend-resume
[480.301632] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[480.437736] [092/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[480.512886] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[487.148500] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.638s)
[487.296664] [093/133] (535s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[487.376967] Starting subtest: plane-use-after-nonblocking-unbind
[487.379232] Starting dynamic subtest: pipe-A-eDP-1
[487.437044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[487.750481] Starting dynamic subtest: pipe-B-eDP-1
[488.588134] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.854s)
[488.878145] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.500s)
[489.740292] [094/133] (533s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[489.793898] Starting subtest: etime-multi-wait-all-for-submit-submitted
[489.899352] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[489.977556] [095/133] (533s left) kms_psr (psr-sprite-plane-onoff)
[490.052994] Starting subtest: psr-sprite-plane-onoff
[490.055175] Starting dynamic subtest: eDP-1
[491.778320] Dynamic subtest eDP-1: SUCCESS (1.725s)
[491.780683] Subtest psr-sprite-plane-onoff: SUCCESS (1.726s)
[492.602082] [096/133] (530s left) perf_pmu (busy-no-semaphores)
[492.644789] Starting subtest: busy-no-semaphores
[492.647099] Starting dynamic subtest: rcs0
[493.202610] Dynamic subtest rcs0: SUCCESS (0.557s)
[493.215571] Starting dynamic subtest: bcs0
[493.753072] Dynamic subtest bcs0: SUCCESS (0.547s)
[493.765995] Starting dynamic subtest: vcs0
[494.301976] Dynamic subtest vcs0: SUCCESS (0.546s)
[494.313291] Starting dynamic subtest: vcs1
[495.744862] Dynamic subtest vcs1: SUCCESS (1.440s)
[495.757357] Starting dynamic subtest: vecs0
[497.726672] Dynamic subtest vecs0: SUCCESS (1.979s)
[497.738965] Starting dynamic subtest: ccs0
[499.779045] Dynamic subtest ccs0: SUCCESS (2.049s)
[499.782033] Subtest busy-no-semaphores: SUCCESS (7.136s)
[499.902079] [097/133] (523s left) kms_vblank (wait-forked)
[499.980730] Starting subtest: wait-forked
[499.982947] Starting dynamic subtest: pipe-A-eDP-1
[501.789770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[501.804758] Starting dynamic subtest: pipe-D-eDP-1
[504.283515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s)
[504.285426] Subtest wait-forked: SUCCESS (4.301s)
[505.168548] [098/133] (518s left) gem_mmap_gtt (basic-write-read-distinct)
[505.231971] Subtest basic-write-read-distinct: SKIP (0.000s)
[505.292916] [099/133] (517s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[505.363393] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[509.602225] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.241s)
[510.763880] [100/133] (512s left) kms_psr (pr-dpms)
[510.848433] Starting subtest: pr-dpms
[510.852748] Subtest pr-dpms: SKIP (0.000s)
[510.919631] [101/133] (512s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[510.985371] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[510.989507] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[511.069276] [102/133] (512s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[511.152287] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[511.154471] Starting dynamic subtest: pipe-A-eDP-1
[522.474021] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.326s)
[522.486613] Starting dynamic subtest: pipe-B-eDP-1
[534.485917] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.005s)
[534.488258] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.338s)
[535.320430] [103/133] (488s left) syncobj_basic (bad-flags-handle-to-fd)
[535.383751] Starting subtest: bad-flags-handle-to-fd
[535.386132] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[535.494539] [104/133] (487s left) syncobj_timeline (multi-wait-all-available-signaled)
[535.544023] Starting subtest: multi-wait-all-available-signaled
[535.546313] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[535.635575] [105/133] (487s left) gem_spin_batch (resubmit-new-all)
[535.683787] Starting subtest: resubmit-new-all
[535.686173] Starting dynamic subtest: rcs0
[535.696057] Dynamic subtest rcs0: SUCCESS (0.011s)
[535.707466] Starting dynamic subtest: bcs0
[535.709747] Dynamic subtest bcs0: SUCCESS (0.010s)
[535.719358] Starting dynamic subtest: vcs0
[535.721733] Dynamic subtest vcs0: SUCCESS (0.010s)
[535.730819] Starting dynamic subtest: vcs1
[535.732675] Dynamic subtest vcs1: SUCCESS (0.010s)
[535.741734] Starting dynamic subtest: vecs0
[535.743774] Dynamic subtest vecs0: SUCCESS (0.010s)
[535.752718] Starting dynamic subtest: ccs0
[535.754571] Dynamic subtest ccs0: SUCCESS (0.008s)
[535.756385] Subtest resubmit-new-all: SUCCESS (0.065s)
[537.257633] [106/133] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[537.342664] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[537.346902] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[537.451401] [107/133] (486s left) gem_ctx_engines (execute-one)
[537.511306] Starting subtest: execute-one
[539.822463] Subtest execute-one: SUCCESS (2.312s)
[540.263505] [108/133] (483s left) kms_pm_rpm (modeset-stress-extra-wait)
[542.359371] Starting subtest: modeset-stress-extra-wait
[596.631829] Subtest modeset-stress-extra-wait: SUCCESS (54.268s)
[596.720747] [109/133] (426s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[596.812403] Starting subtest: flip-vs-cursor-crc-legacy
[597.463408] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.649s)
[598.321345] [110/133] (425s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[598.398119] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[598.400610] Starting dynamic subtest: pipe-A-eDP-1
[599.265766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s)
[599.279321] Starting dynamic subtest: pipe-B-eDP-1
[600.862071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s)
[600.872520] Starting dynamic subtest: pipe-C-eDP-1
[602.320353] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.458s)
[602.330553] Starting dynamic subtest: pipe-D-eDP-1
[603.782782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.460s)
[603.785028] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.376s)
[604.949648] [111/133] (418s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[605.007785] Starting subtest: single-wait-for-submit-unsubmitted
[605.114487] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[605.190752] [112/133] (418s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[605.251312] Starting subtest: y-tiled-to-vebox-y-tiled
[605.255423] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[605.444281] [113/133] (418s left) kms_plane_multiple (tiling-x)
[605.520628] Starting subtest: tiling-x
[605.522666] Starting dynamic subtest: pipe-A-eDP-1
[609.211449] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.690s)
[609.221361] Starting dynamic subtest: pipe-B-eDP-1
[613.728619] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.517s)
[613.739188] Starting dynamic subtest: pipe-C-eDP-1
[618.045227] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.315s)
[618.055333] Starting dynamic subtest: pipe-D-eDP-1
[622.378235] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.330s)
[622.380619] Subtest tiling-x: SUCCESS (16.858s)
[623.188494] [114/133] (400s left) gem_render_copy (yf-tiled)
[623.262363] Starting subtest: yf-tiled
[623.267346] Subtest yf-tiled: SKIP (0.000s)
[623.453679] [115/133] (400s left) gem_ctx_shared (q-smoketest-all)
[623.510593] Starting subtest: Q-smoketest-all
[655.906275] Subtest Q-smoketest-all: SUCCESS (32.346s)
[657.263168] [116/133] (366s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[657.383696] Starting subtest: multiplane-atomic-fence-wait
[657.681143] Subtest multiplane-atomic-fence-wait: SUCCESS (0.295s)
[658.800349] [117/133] (365s left) gem_shrink (reclaim)
[658.854205] Starting subtest: reclaim
[661.237062] Subtest reclaim: SUCCESS (2.378s)
[661.386692] [118/133] (362s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[661.471585] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[661.475612] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[661.609316] [119/133] (362s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[661.676718] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[661.678956] Starting dynamic subtest: pipe-A-eDP-1
[661.822078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[661.834577] Starting dynamic subtest: pipe-B-eDP-1
[661.854152] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[661.865382] Starting dynamic subtest: pipe-C-eDP-1
[661.884403] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[661.895251] Starting dynamic subtest: pipe-D-eDP-1
[661.914397] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[661.916580] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.169s)
[664.192571] [120/133] (359s left) gem_exec_parallel (userptr)
[664.250217] Starting subtest: userptr
[664.252435] Starting dynamic subtest: rcs0
[665.663916] Dynamic subtest rcs0: SUCCESS (1.413s)
[665.674350] Starting dynamic subtest: bcs0
[667.154064] Dynamic subtest bcs0: SUCCESS (1.488s)
[667.167634] Starting dynamic subtest: vcs0
[669.246210] Dynamic subtest vcs0: SUCCESS (2.088s)
[669.258500] Starting dynamic subtest: vcs1
[671.165651] Dynamic subtest vcs1: SUCCESS (1.917s)
[671.177820] Starting dynamic subtest: vecs0
[673.214758] Dynamic subtest vecs0: SUCCESS (2.046s)
[673.227779] Starting dynamic subtest: ccs0
[674.709619] Dynamic subtest ccs0: SUCCESS (1.494s)
[674.712083] Subtest userptr: SUCCESS (10.460s)
[674.897780] [121/133] (349s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[674.988774] Starting subtest: x-tiled-16bpp-rotate-0
[676.234127] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.246s)
[676.348020] [122/133] (347s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[676.421279] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[676.423563] Starting dynamic subtest: pipe-A-eDP-1
[676.447013] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[676.456222] Starting dynamic subtest: pipe-B-eDP-1
[676.476164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[676.484889] Starting dynamic subtest: pipe-C-eDP-1
[676.504597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[676.513062] Starting dynamic subtest: pipe-D-eDP-1
[676.533090] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[676.536855] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[678.633394] [123/133] (345s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[678.717178] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[678.719349] Starting dynamic subtest: pipe-A
[678.955851] Dynamic subtest pipe-A: SUCCESS (0.240s)
[678.967758] Starting dynamic subtest: pipe-B
[680.221632] Dynamic subtest pipe-B: SUCCESS (1.265s)
[680.231804] Starting dynamic subtest: pipe-C
[681.568121] Dynamic subtest pipe-C: SUCCESS (1.345s)
[681.578111] Starting dynamic subtest: pipe-D
[682.896486] Dynamic subtest pipe-D: SUCCESS (1.327s)
[682.898778] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.183s)
[684.075916] [124/133] (340s left) gem_exec_params (cliprects_ptr-dirt)
[684.134842] Starting subtest: cliprects_ptr-dirt
[684.137314] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[684.230398] [125/133] (340s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[684.281048] Starting subtest: multi-wait-available-unsubmitted-signaled
[684.283406] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[684.361366] [126/133] (340s left) kms_lease (cursor-implicit-plane)
[684.434589] Starting subtest: cursor-implicit-plane
[684.437034] Starting dynamic subtest: pipe-A-eDP-1
[684.891034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[684.902837] Starting dynamic subtest: pipe-B-eDP-1
[686.013641] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.120s)
[686.024923] Starting dynamic subtest: pipe-C-eDP-1
[687.109098] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.094s)
[687.122672] Starting dynamic subtest: pipe-D-eDP-1
[688.233843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[688.236280] Subtest cursor-implicit-plane: SUCCESS (3.801s)
[689.082548] [127/133] (335s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[689.172744] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[689.177168] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[689.280493] [128/133] (335s left) gem_ctx_isolation (nonpriv)
[689.341476] Starting subtest: nonpriv
[689.343857] Starting dynamic subtest: rcs0
[689.563686] Dynamic subtest rcs0: SUCCESS (0.222s)
[689.573591] Starting dynamic subtest: bcs0
[689.813606] Dynamic subtest bcs0: SUCCESS (0.248s)
[689.824149] Starting dynamic subtest: vcs0
[690.077892] Dynamic subtest vcs0: SUCCESS (0.264s)
[690.088210] Starting dynamic subtest: vcs1
[691.472234] Dynamic subtest vcs1: SUCCESS (1.393s)
[691.483362] Starting dynamic subtest: vecs0
[693.487317] Dynamic subtest vecs0: SUCCESS (2.014s)
[693.499590] Starting dynamic subtest: ccs0
[695.560877] Dynamic subtest ccs0: SUCCESS (2.072s)
[695.563834] Subtest nonpriv: SUCCESS (6.220s)
[695.895544] [129/133] (328s left) kms_cursor_crc (cursor-offscreen-32x10)
[696.108039] Starting subtest: cursor-offscreen-32x10
[696.155746] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[696.411136] [130/133] (328s left) gem_exec_schedule (manyslice)
[696.475985] Starting subtest: manyslice
[696.478270] Starting dynamic subtest: rcs0
[701.060606] Dynamic subtest rcs0: SUCCESS (4.594s)
[701.074620] Starting dynamic subtest: bcs0
[707.159240] Dynamic subtest bcs0: SUCCESS (6.096s)
[707.169524] Starting dynamic subtest: vcs0
[713.228516] Dynamic subtest vcs0: SUCCESS (6.067s)
[713.239832] Starting dynamic subtest: vcs1
[718.282298] Dynamic subtest vcs1: SUCCESS (5.052s)
[718.293104] Starting dynamic subtest: vecs0
[723.322856] Dynamic subtest vecs0: SUCCESS (5.039s)
[723.332921] Starting dynamic subtest: ccs0
[729.467762] Dynamic subtest ccs0: SUCCESS (6.142s)
[729.470241] Subtest manyslice: SUCCESS (33.001s)
[729.770181] [131/133] (294s left) kms_chamelium_audio (dp-audio-edid)
[730.140047] Subtest dp-audio-edid: SKIP (0.000s)
[730.997635] [132/133] (293s left) prime_busy (before-wait)
[731.059326] Starting subtest: before-wait
[731.061590] Starting dynamic subtest: rcs0
[731.087065] Dynamic subtest rcs0: SUCCESS (0.027s)
[731.097829] Starting dynamic subtest: bcs0
[731.134260] Dynamic subtest bcs0: SUCCESS (0.047s)
[731.144704] Starting dynamic subtest: vcs0
[731.174551] Dynamic subtest vcs0: SUCCESS (0.039s)
[731.183852] Starting dynamic subtest: vcs1
[731.214046] Dynamic subtest vcs1: SUCCESS (0.039s)
[731.223246] Starting dynamic subtest: vecs0
[731.253179] Dynamic subtest vecs0: SUCCESS (0.038s)
[731.262142] Starting dynamic subtest: ccs0
[731.291979] Dynamic subtest ccs0: SUCCESS (0.039s)
[731.400087] Subtest before-wait: SUCCESS (0.342s)
[731.484660] [133/133] (293s left) gem_softpin (invalid)
[731.540571] Starting subtest: invalid
[731.548463] Subtest invalid: SUCCESS (0.005s)
[731.655989] 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.