[58.152357] Initializing watchdogs
[58.152405]   /dev/watchdog0
[58.167899] [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.172456] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.174847] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.176925] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[58.275421] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[58.277241] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[58.370607] [002/133] (960s left) gem_flink_basic (double-flink)
[58.421073] Starting subtest: double-flink
[58.421988] Subtest double-flink: SUCCESS (0.000s)
[58.513472] [003/133] (960s left) gem_exec_fence (invalid-timeline-fence-array)
[59.076860] Starting subtest: invalid-timeline-fence-array
[59.078221] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[60.368349] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[60.369979] [004/133] (958s left) kms_joiner (invalid-modeset-ultra-joiner)
[60.454776] Starting subtest: invalid-modeset-ultra-joiner
[60.456508] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[60.520882] [005/133] (958s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[60.611919] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[65.091578] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.461s)
[66.490952] [006/133] (952s left) gem_exec_schedule (semaphore-codependency)
[66.550891] Starting subtest: semaphore-codependency
[66.566255] Subtest semaphore-codependency: SUCCESS (0.015s)
[66.904682] [007/133] (951s left) kms_cursor_edge_walk (64x64-right-edge)
[66.984154] Starting subtest: 64x64-right-edge
[66.984981] Starting dynamic subtest: pipe-A-eDP-1
[70.461530] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.470s)
[70.469442] Starting dynamic subtest: pipe-D-eDP-1
[73.602047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[73.603015] Subtest 64x64-right-edge: SUCCESS (6.607s)
[74.397331] [008/133] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[74.491373] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[74.493059] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[74.589302] [009/133] (944s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[74.705123] Starting subtest: cursorA-vs-flipA-toggle
[85.836261] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.125s)
[86.645058] [010/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[86.737493] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[86.739264] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[86.834253] [011/133] (932s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[86.890787] Subtest writes-after-reads-uncached: SKIP (0.000s)
[86.948436] [012/133] (932s left) kms_hdr (invalid-metadata-sizes)
[87.043543] Starting subtest: invalid-metadata-sizes
[87.045991] Subtest invalid-metadata-sizes: SKIP (0.000s)
[87.126235] [013/133] (931s left) gem_tiled_partial_pwrite_pread (reads)
[87.177239] Subtest reads: SKIP (0.000s)
[87.248143] [014/133] (931s left) kms_async_flips (test-cursor-atomic)
[87.334202] Starting subtest: test-cursor-atomic
[87.719225] Starting dynamic subtest: pipe-A-eDP-1
[88.540845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s)
[88.933719] Starting dynamic subtest: pipe-B-eDP-1
[89.680978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.753s)
[90.060189] Starting dynamic subtest: pipe-C-eDP-1
[90.817099] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.762s)
[91.195266] Starting dynamic subtest: pipe-D-eDP-1
[91.953628] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s)
[91.954605] Subtest test-cursor-atomic: SUCCESS (4.619s)
[93.122330] [015/133] (926s left) kms_busy (extended-modeset-hang-newfb)
[93.216164] Starting subtest: extended-modeset-hang-newfb
[93.217179] Starting dynamic subtest: pipe-A
[127.286322] Dynamic subtest pipe-A: SUCCESS (34.065s)
[127.294706] Starting dynamic subtest: pipe-D
[150.295110] Dynamic subtest pipe-D: SUCCESS (23.005s)
[150.295931] Subtest extended-modeset-hang-newfb: SUCCESS (57.074s)
[151.090739] [016/133] (868s left) syncobj_timeline (wait-all-delayed-signal)
[151.153016] Starting subtest: wait-all-delayed-signal
[151.258268] Subtest wait-all-delayed-signal: SUCCESS (0.104s)
[151.342238] [017/133] (867s left) kms_pm_dc (dc5-psr)
[152.443576] Starting subtest: dc5-psr
[155.332965] Subtest dc5-psr: SUCCESS (2.890s)
[156.142888] [018/133] (863s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[156.237429] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[156.240086] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[156.324200] [019/133] (862s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[156.414736] Starting subtest: y-tiled-16bpp-rotate-270
[156.416921] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[156.520407] [020/133] (862s left) kms_psr (fbc-psr2-suspend)
[156.598719] Starting subtest: fbc-psr2-suspend
[156.599676] Starting dynamic subtest: eDP-1
[156.601511] Dynamic subtest eDP-1: SKIP (0.000s)
[156.603260] Subtest fbc-psr2-suspend: SKIP (0.001s)
[156.682215] [021/133] (862s left) gem_exec_basic (basic)
[156.738384] Starting subtest: basic
[156.739615] Starting dynamic subtest: rcs0-smem
[156.742085] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[156.750257] Starting dynamic subtest: bcs0-smem
[156.751117] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[156.757579] Starting dynamic subtest: vcs0-smem
[156.758459] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[156.764982] Starting dynamic subtest: vcs1-smem
[156.765915] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[156.772409] Starting dynamic subtest: vecs0-smem
[156.773331] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[156.779814] Starting dynamic subtest: ccs0-smem
[156.780763] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[156.781622] Subtest basic: SUCCESS (0.012s)
[158.339929] [022/133] (861s left) gem_ctx_persistence (heartbeat-many)
[158.389025] Starting subtest: heartbeat-many
[158.390872] Subtest heartbeat-many: SKIP (0.000s)
[158.478367] [023/133] (860s left) api_intel_allocator (reloc-allocator)
[158.520856] Starting subtest: reloc-allocator
[158.522049] Starting dynamic subtest: basic
[158.525059] Dynamic subtest basic: SUCCESS (0.004s)
[158.532906] Starting dynamic subtest: parallel-one
[158.533756] Dynamic subtest parallel-one: SUCCESS (0.008s)
[158.540494] Starting dynamic subtest: print
[158.541340] Dynamic subtest print: SUCCESS (0.000s)
[158.548038] Starting dynamic subtest: reuse
[158.548844] Dynamic subtest reuse: SUCCESS (0.000s)
[158.555321] Starting dynamic subtest: fork-reopen-allocator
[158.556301] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[158.557148] Subtest reloc-allocator: SUCCESS (0.025s)
[158.652177] [024/133] (860s left) kms_flip (flip-vs-panning-vs-hang)
[158.737196] Starting subtest: flip-vs-panning-vs-hang
[158.738033] Starting dynamic subtest: A-eDP1
[209.806574] Dynamic subtest A-eDP1: SUCCESS (51.066s)
[209.813904] Starting dynamic subtest: D-eDP1
[249.798904] Dynamic subtest D-eDP1: SUCCESS (39.990s)
[249.803375] Subtest flip-vs-panning-vs-hang: SUCCESS (91.063s)
[251.035125] [025/133] (768s left) kms_chamelium_frames (vga-frame-dump)
[251.422920] Subtest vga-frame-dump: SKIP (0.000s)
[252.239625] [026/133] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[252.327183] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[252.328921] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[252.425307] [027/133] (767s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[252.741286] Starting subtest: cursor-rapid-movement-max-size
[252.744103] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[252.864510] [028/133] (766s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[252.917572] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[253.025964] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[253.098107] [029/133] (766s left) kms_psr (fbc-psr2-dpms)
[253.184116] Starting subtest: fbc-psr2-dpms
[253.184961] Starting dynamic subtest: eDP-1
[253.186987] Dynamic subtest eDP-1: SKIP (0.000s)
[253.188769] Subtest fbc-psr2-dpms: SKIP (0.001s)
[253.252843] [030/133] (766s left) kms_flip (flip-vs-rmfb-interruptible)
[253.336947] Starting subtest: flip-vs-rmfb-interruptible
[253.338283] Starting dynamic subtest: A-eDP1
[261.963312] Dynamic subtest A-eDP1: SUCCESS (8.624s)
[261.972579] Starting dynamic subtest: B-eDP1
[270.605072] Dynamic subtest B-eDP1: SUCCESS (8.640s)
[270.615934] Starting dynamic subtest: C-eDP1
[279.220443] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[279.233154] Starting dynamic subtest: D-eDP1
[287.859165] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[287.862932] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.525s)
[289.038783] [031/133] (730s left) i915_suspend (fence-restore-untiled)
[289.087439] Starting subtest: fence-restore-untiled
[289.089040] Subtest fence-restore-untiled: SKIP (0.000s)
[289.195474] [032/133] (730s left) gem_ctx_bad_destroy (invalid-default-ctx)
[289.241592] Starting subtest: invalid-default-ctx
[289.242694] Subtest invalid-default-ctx: SUCCESS (0.000s)
[289.301901] [033/133] (730s left) kms_flip (2x-modeset-vs-vblank-race)
[289.385557] Starting subtest: 2x-modeset-vs-vblank-race
[289.397342] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[289.473146] [034/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[289.563089] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[289.565044] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[289.662861] [035/133] (730s left) vgem_basic (bad-flag)
[289.697958] Starting subtest: bad-flag
[289.698779] Subtest bad-flag: SUCCESS (0.000s)
[289.752945] [036/133] (730s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[289.844939] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[289.846587] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[289.923889] [037/133] (729s left) i915_drm_fdinfo (basics)
[289.960646] Starting subtest: basics
[289.961730] Subtest basics: SUCCESS (0.000s)
[290.021696] [038/133] (729s left) gem_workarounds (basic-read-fd)
[290.077641] Starting subtest: basic-read-fd
[290.088790] Subtest basic-read-fd: SUCCESS (0.011s)
[290.211885] [039/133] (729s left) kms_prop_blob (invalid-set-prop-any)
[290.251343] Starting subtest: invalid-set-prop-any
[290.252346] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[290.348997] [040/133] (729s left) i915_pm_rpm (gem-execbuf)
[292.467070] Starting subtest: gem-execbuf
[292.468746] Starting dynamic subtest: smem0
[294.228881] Dynamic subtest smem0: SUCCESS (1.760s)
[294.229960] Subtest gem-execbuf: SUCCESS (1.763s)
[294.343991] [041/133] (725s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[294.442135] Starting subtest: plane-lut1d-pre-ctm3x4
[294.590180] Starting dynamic subtest: pipe-A-plane-0
[294.767621] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[294.775256] Starting dynamic subtest: pipe-A-plane-1
[294.967643] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s)
[294.976150] Starting dynamic subtest: pipe-A-plane-2
[295.156567] Dynamic subtest pipe-A-plane-2: SUCCESS (0.187s)
[296.421580] Starting dynamic subtest: pipe-B-plane-0
[296.592347] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[296.601771] Starting dynamic subtest: pipe-B-plane-1
[296.781653] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[296.789518] Starting dynamic subtest: pipe-B-plane-2
[296.948281] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[298.135309] Starting dynamic subtest: pipe-C-plane-0
[298.283909] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[298.291375] Starting dynamic subtest: pipe-C-plane-1
[298.439554] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[298.446954] Starting dynamic subtest: pipe-C-plane-2
[298.605935] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[299.762490] Starting dynamic subtest: pipe-D-plane-0
[299.922782] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[299.930181] Starting dynamic subtest: pipe-D-plane-1
[300.089656] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[300.097121] Starting dynamic subtest: pipe-D-plane-2
[300.245095] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[300.533207] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.091s)
[301.421583] [042/133] (718s left) kms_async_flips (crc)
[301.504851] Starting subtest: crc
[301.879243] Starting dynamic subtest: pipe-A-eDP-1
[304.831033] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.952s)
[305.220749] Starting dynamic subtest: pipe-B-eDP-1
[308.160403] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.949s)
[308.552284] Starting dynamic subtest: pipe-C-eDP-1
[311.486274] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.941s)
[311.849865] Starting dynamic subtest: pipe-D-eDP-1
[314.702271] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.859s)
[314.703253] Subtest crc: SUCCESS (13.199s)
[315.855718] [043/133] (704s left) gem_mmap_wc (bad-offset)
[315.907792] Subtest bad-offset: SKIP (0.000s)
[315.960194] [044/133] (704s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[316.331855] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[317.175662] [045/133] (702s left) gem_ctx_create (basic)
[317.234561] Starting subtest: basic
[317.235648] Subtest basic: SUCCESS (0.000s)
[317.413119] [046/133] (702s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[317.509745] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[317.511747] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[317.620970] [047/133] (702s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[317.671054] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[317.731212] [048/133] (702s left) gem_exec_reloc (basic-cpu)
[317.783298] Subtest basic-cpu: SKIP (0.000s)
[317.848914] [049/133] (702s left) gem_mmap_offset (mmap-boundaries)
[317.889819] Starting subtest: mmap-boundaries
[317.890700] Starting dynamic subtest: smem0
[318.171102] Dynamic subtest smem0: SUCCESS (0.282s)
[318.172297] Subtest mmap-boundaries: SUCCESS (0.283s)
[318.295960] [050/133] (702s left) gem_eio (in-flight-contexts-10ms)
[318.529274] Starting subtest: in-flight-contexts-10ms
[332.337073] Subtest in-flight-contexts-10ms: SUCCESS (13.807s)
[332.462116] [051/133] (687s left) gem_exec_whisper (basic-contexts-priority-all)
[332.515689] Starting subtest: basic-contexts-priority-all
[355.514433] Subtest basic-contexts-priority-all: SUCCESS (22.988s)
[355.686542] [052/133] (664s left) kms_big_fb (linear-8bpp-rotate-180)
[355.790449] Starting subtest: linear-8bpp-rotate-180
[357.070569] Subtest linear-8bpp-rotate-180: SUCCESS (1.280s)
[357.176010] [053/133] (663s left) sw_sync (sync_busy_fork)
[357.205283] Starting subtest: sync_busy_fork
[358.226908] Subtest sync_busy_fork: SUCCESS (1.012s)
[358.277036] [054/133] (662s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[358.362587] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[358.363487] Starting dynamic subtest: pipe-A-default-mode
[361.175033] Dynamic subtest pipe-A-default-mode: SUCCESS (2.810s)
[361.176176] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.811s)
[361.998051] [055/133] (658s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[362.083458] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[362.085244] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[362.183932] [056/133] (658s left) gem_gpgpu_fill (offset-16x16)
[362.228142] Starting subtest: offset-16x16
[362.235445] Subtest offset-16x16: SUCCESS (0.008s)
[362.357139] [057/133] (658s left) dmabuf_sync_file (import-basic)
[362.401320] Starting subtest: import-basic
[362.404443] Subtest import-basic: SUCCESS (0.002s)
[362.456514] [058/133] (658s left) gem_ctx_bad_destroy (invalid-pad)
[362.495652] Starting subtest: invalid-pad
[362.496455] Subtest invalid-pad: SUCCESS (0.000s)
[362.556048] [059/133] (658s left) core_auth (basic-auth)
[362.599869] Starting subtest: basic-auth
[362.600711] Subtest basic-auth: SUCCESS (0.001s)
[362.689133] [060/133] (657s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[362.775527] Starting subtest: yf-tiled-16bpp-rotate-90
[362.777513] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[362.878096] [061/133] (657s left) kms_dp_link_training (non-uhbr-mst)
[362.963760] Starting subtest: non-uhbr-mst
[362.967656] Subtest non-uhbr-mst: SKIP (0.000s)
[363.032794] [062/133] (657s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[363.110510] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[363.111484] Starting dynamic subtest: pipe-A-eDP-1
[364.015206] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[364.023511] Starting dynamic subtest: pipe-B-eDP-1
[365.661064] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.644s)
[365.669198] Starting dynamic subtest: pipe-C-eDP-1
[367.152326] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.490s)
[367.160199] Starting dynamic subtest: pipe-D-eDP-1
[368.709665] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.556s)
[368.710557] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.597s)
[369.940882] [063/133] (650s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[370.046628] Starting subtest: yf-tiled-8bpp-rotate-0
[370.048608] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[370.137639] [064/133] (650s left) gem_basic (multigpu-create-close)
[370.180965] Starting subtest: multigpu-create-close
[370.182582] Subtest multigpu-create-close: SKIP (0.000s)
[370.270217] [065/133] (650s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[370.362629] Starting subtest: flip-vs-dpms-off-vs-modeset
[370.363584] Starting dynamic subtest: A-eDP1
[373.975290] Dynamic subtest A-eDP1: SUCCESS (3.611s)
[373.983659] Starting dynamic subtest: B-eDP1
[377.177441] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[377.186202] Starting dynamic subtest: C-eDP1
[380.278637] Dynamic subtest C-eDP1: SUCCESS (3.100s)
[380.288141] Starting dynamic subtest: D-eDP1
[383.391857] Dynamic subtest D-eDP1: SUCCESS (3.111s)
[383.393975] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.032s)
[384.187129] [066/133] (636s left) gem_exec_balancer (full)
[384.249097] Starting subtest: full
[389.222207] Subtest full: SUCCESS (4.974s)
[389.538852] [067/133] (631s left) i915_hangman (engine-engine-error)
[389.598378] Starting subtest: engine-engine-error
[389.599181] Starting dynamic subtest: rcs0
[391.302082] Dynamic subtest rcs0: SUCCESS (1.693s)
[391.313504] Starting dynamic subtest: bcs0
[393.285945] Dynamic subtest bcs0: SUCCESS (1.981s)
[393.297343] Starting dynamic subtest: vcs0
[395.270301] Dynamic subtest vcs0: SUCCESS (1.981s)
[395.282503] Starting dynamic subtest: vcs1
[397.317374] Dynamic subtest vcs1: SUCCESS (2.045s)
[397.328580] Starting dynamic subtest: vecs0
[399.303975] Dynamic subtest vecs0: SUCCESS (1.984s)
[399.314276] Starting dynamic subtest: ccs0
[401.285607] Dynamic subtest ccs0: SUCCESS (1.979s)
[401.286872] Subtest engine-engine-error: SUCCESS (11.678s)
[401.367043] [068/133] (619s left) gem_mmap_gtt (basic-small-bo-tiledy)
[401.412705] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[401.464435] [069/133] (619s left) kms_frontbuffer_tracking (basic)
[401.549998] Starting subtest: basic
[405.005617] Subtest basic: SUCCESS (3.456s)
[405.117271] [070/133] (615s left) api_intel_bb (reset-flags)
[405.172329] Starting subtest: reset-flags
[405.180388] Subtest reset-flags: SUCCESS (0.009s)
[405.302828] [071/133] (615s left) kms_flip (flip-vs-absolute-wf_vblank)
[405.386809] Starting subtest: flip-vs-absolute-wf_vblank
[405.388913] Starting dynamic subtest: A-eDP1
[414.332942] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[414.342957] Starting dynamic subtest: B-eDP1
[423.263307] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[423.273753] Starting dynamic subtest: C-eDP1
[432.224916] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[432.239200] Starting dynamic subtest: D-eDP1
[441.160036] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[441.160948] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.739s)
[442.345589] [072/133] (578s left) kms_plane_scaling (planes-upscale-20x20)
[442.438475] Starting subtest: planes-upscale-20x20
[442.439342] Starting dynamic subtest: pipe-A
[442.500399] Dynamic subtest pipe-A: SUCCESS (0.062s)
[442.509452] Starting dynamic subtest: pipe-B
[443.677986] Dynamic subtest pipe-B: SUCCESS (1.176s)
[443.688647] Starting dynamic subtest: pipe-C
[444.780068] Dynamic subtest pipe-C: SUCCESS (1.101s)
[444.790992] Starting dynamic subtest: pipe-D
[445.924352] Dynamic subtest pipe-D: SUCCESS (1.142s)
[445.925410] Subtest planes-upscale-20x20: SUCCESS (3.486s)
[447.072203] [073/133] (574s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[447.165040] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[447.166844] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[447.234647] [074/133] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[447.314437] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[447.316044] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[447.410384] [075/133] (573s left) kms_sequence (get-busy)
[447.503501] Starting subtest: get-busy
[447.504492] Starting dynamic subtest: pipe-A-eDP-1
[449.436257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[449.445030] Starting dynamic subtest: pipe-B-eDP-1
[452.064956] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.627s)
[452.074168] Starting dynamic subtest: pipe-C-eDP-1
[454.683551] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.616s)
[454.692268] Starting dynamic subtest: pipe-D-eDP-1
[457.313710] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.630s)
[457.314713] Subtest get-busy: SUCCESS (9.811s)
[458.104574] [076/133] (563s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[458.189656] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[458.191737] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[458.279363] [077/133] (562s left) gem_vm_create (execbuf)
[458.329544] Starting subtest: execbuf
[458.335294] Subtest execbuf: SUCCESS (0.007s)
[458.461166] [078/133] (562s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[458.560735] Starting subtest: 4-tiled-32bpp-rotate-90
[458.581505] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[458.693718] [079/133] (562s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[458.751698] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[458.811443] [080/133] (562s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[458.853285] Starting subtest: single-wait-all-for-submit-unsubmitted
[458.969598] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[459.046409] [081/133] (562s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[459.140088] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[459.141717] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[459.231470] [082/133] (562s left) gen7_exec_parse (oacontrol-tracking)
[459.283634] Subtest oacontrol-tracking: SKIP (0.000s)
[459.348831] [083/133] (562s left) kms_vrr (negative-basic)
[459.435562] Starting subtest: negative-basic
[459.438222] Starting dynamic subtest: pipe-A-eDP-1
[464.902163] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.419s)
[465.163322] Subtest negative-basic: SUCCESS (5.729s)
[466.042971] [084/133] (555s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[466.134440] Starting subtest: stress-xrgb8888-4tiled
[472.012819] Subtest stress-xrgb8888-4tiled: SUCCESS (5.878s)
[472.063105] [085/133] (549s left) kms_addfb_basic (no-handle)
[472.123195] Starting subtest: no-handle
[472.124248] Subtest no-handle: SUCCESS (0.000s)
[472.254040] [086/133] (549s left) kms_psr (psr2-dpms)
[472.342478] Starting subtest: psr2-dpms
[472.343463] Starting dynamic subtest: eDP-1
[475.184397] Dynamic subtest eDP-1: SUCCESS (2.841s)
[475.185734] Subtest psr2-dpms: SUCCESS (2.842s)
[476.056993] [087/133] (545s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[476.113515] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[476.169577] [088/133] (545s left) gem_exec_params (no-bsd)
[476.214916] Starting subtest: no-bsd
[476.217645] Subtest no-bsd: SUCCESS (0.002s)
[477.388195] [089/133] (544s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[477.484772] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[477.486498] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[477.588378] [090/133] (544s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[477.664433] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[477.692449] Starting dynamic subtest: pipe-A-plane-0
[478.147854] Dynamic subtest pipe-A-plane-0: SUCCESS (0.455s)
[478.156506] Starting dynamic subtest: pipe-A-plane-3
[478.403428] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[479.549169] Starting dynamic subtest: pipe-B-plane-0
[479.985042] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[479.994191] Starting dynamic subtest: pipe-B-plane-3
[480.240483] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[480.548638] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.884s)
[481.415996] [091/133] (540s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[481.557226] Starting subtest: dp-mst-type-1-suspend-resume
[481.560048] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[481.668990] [092/133] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[481.756997] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[488.539611] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.784s)
[488.673284] [093/133] (533s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[488.756485] Starting subtest: plane-use-after-nonblocking-unbind
[488.757367] Starting dynamic subtest: pipe-A-eDP-1
[488.818869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[489.127912] Starting dynamic subtest: pipe-B-eDP-1
[489.942143] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.822s)
[490.242633] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.486s)
[491.105906] [094/133] (530s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[491.156097] Starting subtest: etime-multi-wait-all-for-submit-submitted
[491.257377] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[491.330362] [095/133] (530s left) kms_psr (psr-sprite-plane-onoff)
[491.415181] Starting subtest: psr-sprite-plane-onoff
[491.415975] Starting dynamic subtest: eDP-1
[493.165209] Dynamic subtest eDP-1: SUCCESS (1.749s)
[493.166074] Subtest psr-sprite-plane-onoff: SUCCESS (1.750s)
[493.964904] [096/133] (527s left) perf_pmu (busy-no-semaphores)
[493.999268] Starting subtest: busy-no-semaphores
[494.000244] Starting dynamic subtest: rcs0
[494.573291] Dynamic subtest rcs0: SUCCESS (0.563s)
[494.584217] Starting dynamic subtest: bcs0
[495.124352] Dynamic subtest bcs0: SUCCESS (0.548s)
[495.135863] Starting dynamic subtest: vcs0
[495.675189] Dynamic subtest vcs0: SUCCESS (0.548s)
[495.684934] Starting dynamic subtest: vcs1
[496.871832] Dynamic subtest vcs1: SUCCESS (1.194s)
[496.883616] Starting dynamic subtest: vecs0
[498.858562] Dynamic subtest vecs0: SUCCESS (1.983s)
[498.869443] Starting dynamic subtest: ccs0
[500.843706] Dynamic subtest ccs0: SUCCESS (1.981s)
[500.845184] Subtest busy-no-semaphores: SUCCESS (6.835s)
[500.947328] [097/133] (521s left) kms_vblank (wait-forked)
[501.042240] Starting subtest: wait-forked
[501.042986] Starting dynamic subtest: pipe-A-eDP-1
[502.853870] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[502.864389] Starting dynamic subtest: pipe-D-eDP-1
[505.367137] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.510s)
[505.368179] Subtest wait-forked: SUCCESS (4.324s)
[506.234838] [098/133] (515s left) gem_mmap_gtt (basic-write-read-distinct)
[506.284612] Subtest basic-write-read-distinct: SKIP (0.000s)
[506.332980] [099/133] (515s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[506.418338] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[510.769708] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.351s)
[511.921332] [100/133] (510s left) kms_psr (pr-dpms)
[512.013082] Starting subtest: pr-dpms
[512.015405] Subtest pr-dpms: SKIP (0.000s)
[512.091547] [101/133] (510s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[512.176533] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[512.178266] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[512.270146] [102/133] (509s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[512.359058] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[512.359923] Starting dynamic subtest: pipe-A-eDP-1
[523.662996] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.304s)
[523.672390] Starting dynamic subtest: pipe-B-eDP-1
[535.725828] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.060s)
[535.727014] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.367s)
[536.587328] [103/133] (485s left) syncobj_basic (bad-flags-handle-to-fd)
[536.632975] Starting subtest: bad-flags-handle-to-fd
[536.634056] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[536.727867] [104/133] (485s left) syncobj_timeline (multi-wait-all-available-signaled)
[536.781666] Starting subtest: multi-wait-all-available-signaled
[536.782511] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[536.878917] [105/133] (485s left) gem_spin_batch (resubmit-new-all)
[536.932305] Starting subtest: resubmit-new-all
[536.933369] Starting dynamic subtest: rcs0
[536.947853] Dynamic subtest rcs0: SUCCESS (0.015s)
[536.956729] Starting dynamic subtest: bcs0
[536.959076] Dynamic subtest bcs0: SUCCESS (0.010s)
[536.967648] Starting dynamic subtest: vcs0
[536.970929] Dynamic subtest vcs0: SUCCESS (0.009s)
[536.979078] Starting dynamic subtest: vcs1
[536.979884] Dynamic subtest vcs1: SUCCESS (0.010s)
[536.990603] Starting dynamic subtest: vecs0
[536.991526] Dynamic subtest vecs0: SUCCESS (0.009s)
[536.999557] Starting dynamic subtest: ccs0
[537.000377] Dynamic subtest ccs0: SUCCESS (0.008s)
[537.001253] Subtest resubmit-new-all: SUCCESS (0.068s)
[538.305276] [106/133] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[538.387491] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[538.389206] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[538.474533] [107/133] (483s left) gem_ctx_engines (execute-one)
[538.532420] Starting subtest: execute-one
[541.143108] Subtest execute-one: SUCCESS (2.610s)
[541.375873] [108/133] (480s left) kms_pm_rpm (modeset-stress-extra-wait)
[543.507780] Starting subtest: modeset-stress-extra-wait
[597.843629] Subtest modeset-stress-extra-wait: SUCCESS (54.289s)
[597.896152] [109/133] (424s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[598.019478] Starting subtest: flip-vs-cursor-crc-legacy
[598.722913] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.702s)
[599.589243] [110/133] (422s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[599.687622] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[599.688894] Starting dynamic subtest: pipe-A-eDP-1
[600.614878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.925s)
[600.628283] Starting dynamic subtest: pipe-B-eDP-1
[602.240989] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.625s)
[602.249623] Starting dynamic subtest: pipe-C-eDP-1
[603.741488] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s)
[603.751552] Starting dynamic subtest: pipe-D-eDP-1
[605.293580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.551s)
[605.294502] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.605s)
[606.545512] [111/133] (415s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[606.592127] Starting subtest: single-wait-for-submit-unsubmitted
[606.697768] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[606.794871] [112/133] (415s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[606.850949] Starting subtest: y-tiled-to-vebox-y-tiled
[606.852979] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[607.043066] [113/133] (415s left) kms_plane_multiple (tiling-x)
[607.120067] Starting subtest: tiling-x
[607.121059] Starting dynamic subtest: pipe-A-eDP-1
[610.905173] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.784s)
[610.915356] Starting dynamic subtest: pipe-B-eDP-1
[615.381050] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.474s)
[615.390834] Starting dynamic subtest: pipe-C-eDP-1
[619.775986] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.393s)
[619.784431] Starting dynamic subtest: pipe-D-eDP-1
[624.123263] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.346s)
[624.124164] Subtest tiling-x: SUCCESS (17.002s)
[624.925498] [114/133] (397s left) gem_render_copy (yf-tiled)
[624.977373] Starting subtest: yf-tiled
[624.979129] Subtest yf-tiled: SKIP (0.000s)
[625.159052] [115/133] (397s left) gem_ctx_shared (q-smoketest-all)
[625.212492] Starting subtest: Q-smoketest-all
[657.576711] Subtest Q-smoketest-all: SUCCESS (32.337s)
[659.332769] [116/133] (363s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[659.467055] Starting subtest: multiplane-atomic-fence-wait
[659.784422] Subtest multiplane-atomic-fence-wait: SUCCESS (0.318s)
[660.956638] [117/133] (361s left) gem_shrink (reclaim)
[661.016367] Starting subtest: reclaim
[663.456863] Subtest reclaim: SUCCESS (2.394s)
[663.559417] [118/133] (359s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[663.661323] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[663.662961] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[663.759144] [119/133] (358s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[663.836534] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[663.837509] Starting dynamic subtest: pipe-A-eDP-1
[663.989967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[664.001267] Starting dynamic subtest: pipe-B-eDP-1
[664.009867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[664.018863] Starting dynamic subtest: pipe-C-eDP-1
[664.028203] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[664.042870] Starting dynamic subtest: pipe-D-eDP-1
[664.050877] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[664.051723] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.184s)
[666.305899] [120/133] (356s left) gem_exec_parallel (userptr)
[666.364063] Starting subtest: userptr
[666.365163] Starting dynamic subtest: rcs0
[667.801759] Dynamic subtest rcs0: SUCCESS (1.437s)
[667.814415] Starting dynamic subtest: bcs0
[669.282306] Dynamic subtest bcs0: SUCCESS (1.478s)
[669.293080] Starting dynamic subtest: vcs0
[671.334337] Dynamic subtest vcs0: SUCCESS (2.040s)
[671.345994] Starting dynamic subtest: vcs1
[673.318139] Dynamic subtest vcs1: SUCCESS (1.981s)
[673.329629] Starting dynamic subtest: vecs0
[675.301725] Dynamic subtest vecs0: SUCCESS (1.982s)
[675.312781] Starting dynamic subtest: ccs0
[676.787101] Dynamic subtest ccs0: SUCCESS (1.493s)
[676.790508] Subtest userptr: SUCCESS (10.424s)
[676.987171] [121/133] (345s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[677.098688] Starting subtest: x-tiled-16bpp-rotate-0
[678.479873] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.381s)
[678.585980] [122/133] (344s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[678.676096] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[678.676846] Starting dynamic subtest: pipe-A-eDP-1
[678.687454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[678.696694] Starting dynamic subtest: pipe-B-eDP-1
[678.706452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[678.714979] Starting dynamic subtest: pipe-C-eDP-1
[678.723970] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[678.732225] Starting dynamic subtest: pipe-D-eDP-1
[678.741496] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[678.743082] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[680.989662] [123/133] (341s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[681.075171] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[681.076275] Starting dynamic subtest: pipe-A
[681.313776] Dynamic subtest pipe-A: SUCCESS (0.240s)
[681.322470] Starting dynamic subtest: pipe-B
[682.587744] Dynamic subtest pipe-B: SUCCESS (1.273s)
[682.596615] Starting dynamic subtest: pipe-C
[683.913775] Dynamic subtest pipe-C: SUCCESS (1.325s)
[683.922612] Starting dynamic subtest: pipe-D
[685.243403] Dynamic subtest pipe-D: SUCCESS (1.328s)
[685.244399] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.170s)
[686.423458] [124/133] (336s left) gem_exec_params (cliprects_ptr-dirt)
[686.479894] Starting subtest: cliprects_ptr-dirt
[686.480910] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[686.565351] [125/133] (336s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[686.613227] Starting subtest: multi-wait-available-unsubmitted-signaled
[686.614334] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[686.705881] [126/133] (336s left) kms_lease (cursor-implicit-plane)
[686.794460] Starting subtest: cursor-implicit-plane
[686.795408] Starting dynamic subtest: pipe-A-eDP-1
[687.261295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[687.271653] Starting dynamic subtest: pipe-B-eDP-1
[688.354248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[688.364756] Starting dynamic subtest: pipe-C-eDP-1
[689.464306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[689.474688] Starting dynamic subtest: pipe-D-eDP-1
[690.599897] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[690.601342] Subtest cursor-implicit-plane: SUCCESS (3.805s)
[691.460064] [127/133] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[691.556667] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[691.558297] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[691.641515] [128/133] (331s left) gem_ctx_isolation (nonpriv)
[691.690241] Starting subtest: nonpriv
[691.691131] Starting dynamic subtest: rcs0
[691.922380] Dynamic subtest rcs0: SUCCESS (0.232s)
[691.932877] Starting dynamic subtest: bcs0
[692.176268] Dynamic subtest bcs0: SUCCESS (0.253s)
[692.189669] Starting dynamic subtest: vcs0
[692.436476] Dynamic subtest vcs0: SUCCESS (0.259s)
[692.447495] Starting dynamic subtest: vcs1
[693.565553] Dynamic subtest vcs1: SUCCESS (1.128s)
[693.574122] Starting dynamic subtest: vecs0
[695.739258] Dynamic subtest vecs0: SUCCESS (2.172s)
[695.749778] Starting dynamic subtest: ccs0
[697.576093] Dynamic subtest ccs0: SUCCESS (1.836s)
[697.577391] Subtest nonpriv: SUCCESS (5.887s)
[697.809321] [129/133] (325s left) kms_cursor_crc (cursor-offscreen-32x10)
[697.975852] Starting subtest: cursor-offscreen-32x10
[698.023547] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[698.290908] [130/133] (324s left) gem_exec_schedule (manyslice)
[698.343704] Starting subtest: manyslice
[698.344592] Starting dynamic subtest: rcs0
[703.536592] Dynamic subtest rcs0: SUCCESS (5.146s)
[703.547694] Starting dynamic subtest: bcs0
[710.182680] Dynamic subtest bcs0: SUCCESS (6.643s)
[710.193794] Starting dynamic subtest: vcs0
[716.764157] Dynamic subtest vcs0: SUCCESS (6.581s)
[716.780038] Starting dynamic subtest: vcs1
[723.357614] Dynamic subtest vcs1: SUCCESS (6.591s)
[723.368782] Starting dynamic subtest: vecs0
[729.906147] Dynamic subtest vecs0: SUCCESS (6.582s)
[729.916187] Starting dynamic subtest: ccs0
[736.650425] Dynamic subtest ccs0: SUCCESS (6.707s)
[736.651706] Subtest manyslice: SUCCESS (38.260s)
[736.923410] [131/133] (286s left) kms_chamelium_audio (dp-audio-edid)
[737.296188] Subtest dp-audio-edid: SKIP (0.000s)
[738.065624] [132/133] (285s left) prime_busy (before-wait)
[738.121839] Starting subtest: before-wait
[738.125143] Starting dynamic subtest: rcs0
[738.149757] Dynamic subtest rcs0: SUCCESS (0.024s)
[738.160524] Starting dynamic subtest: bcs0
[738.190102] Dynamic subtest bcs0: SUCCESS (0.040s)
[738.200648] Starting dynamic subtest: vcs0
[738.231659] Dynamic subtest vcs0: SUCCESS (0.041s)
[738.240371] Starting dynamic subtest: vcs1
[738.271956] Dynamic subtest vcs1: SUCCESS (0.040s)
[738.280741] Starting dynamic subtest: vecs0
[738.311565] Dynamic subtest vecs0: SUCCESS (0.039s)
[738.320482] Starting dynamic subtest: ccs0
[738.352166] Dynamic subtest ccs0: SUCCESS (0.040s)
[738.459917] Subtest before-wait: SUCCESS (0.337s)
[738.534765] [133/133] (284s left) gem_softpin (invalid)
[738.587794] Starting subtest: invalid
[738.593263] Subtest invalid: SUCCESS (0.006s)
[738.709415] 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.