[59.086852] Initializing watchdogs
[59.086936]   /dev/watchdog0
[59.104172] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[59.113773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[59.117299] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.119972] [001/131] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[59.409625] Starting subtest: yf-tiled-8bpp-rotate-90
[59.411437] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[59.531483] [002/131] (960s left) gem_exec_schedule (timeslicing)
[59.618515] Starting subtest: timeslicing
[59.619479] Starting dynamic subtest: rcs0
[59.639580] Dynamic subtest rcs0: SUCCESS (0.021s)
[59.646483] Starting dynamic subtest: bcs0
[59.659369] Dynamic subtest bcs0: SUCCESS (0.020s)
[59.665928] Starting dynamic subtest: vcs0
[59.680455] Dynamic subtest vcs0: SUCCESS (0.021s)
[59.687846] Starting dynamic subtest: vcs1
[59.702794] Dynamic subtest vcs1: SUCCESS (0.022s)
[59.711634] Starting dynamic subtest: vecs0
[59.724428] Dynamic subtest vecs0: SUCCESS (0.021s)
[59.736605] Starting dynamic subtest: vecs1
[59.748985] Dynamic subtest vecs1: SUCCESS (0.024s)
[59.758614] Starting dynamic subtest: ccs0
[59.772514] Dynamic subtest ccs0: SUCCESS (0.023s)
[59.773523] Subtest timeslicing: SUCCESS (0.154s)
[60.234192] [003/131] (959s left) drm_fdinfo (memory-info-active)
[60.299258] Starting subtest: memory-info-active
[60.300215] Starting dynamic subtest: lmem0
[64.069762] Dynamic subtest lmem0: SUCCESS (3.764s)
[64.082527] Starting dynamic subtest: smem0
[68.971183] Dynamic subtest smem0: SUCCESS (4.894s)
[68.972173] Subtest memory-info-active: SUCCESS (8.659s)
[69.041527] [004/131] (950s left) i915_pm_rps (thresholds)
[69.126481] Starting subtest: thresholds
[69.128290] Subtest thresholds: SKIP (0.000s)
[69.235484] [005/131] (950s left) gem_lmem_swapping (smem-oom)
[72.030824] Starting subtest: smem-oom
[72.031952] Starting dynamic subtest: lmem0
[95.103693] Dynamic subtest lmem0: SUCCESS (23.064s)
[95.104796] Subtest smem-oom: SUCCESS (23.068s)
[96.424627] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true
[96.427851] [006/131] (923s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[98.449500] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[98.450452] Starting dynamic subtest: pipe-A-valid-mode
[98.529155] Dynamic subtest pipe-A-valid-mode: SKIP (0.077s)
[98.530935] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.078s)
[98.685268] [FACT kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)] new: kernel.kmod_is_loaded.i915: true
[98.686103] [FACT kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)] new: kernel.kmod_is_loaded.xe: true
[98.687756] [007/131] (921s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[98.905169] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[98.907013] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[99.032298] [008/131] (920s left) kms_addfb_basic (basic-x-tiled-legacy)
[99.104051] Starting subtest: basic-x-tiled-legacy
[99.105924] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[99.362526] [009/131] (920s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[99.445811] Starting subtest: invalid-bsd1-flag-on-blt
[99.446766] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[99.617094] [010/131] (920s left) gem_exec_gttfill (multigpu-basic)
[99.808010] Starting subtest: multigpu-basic
[114.351899] Subtest multigpu-basic: SUCCESS (14.544s)
[114.494883] [011/131] (905s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[114.745499] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[114.747215] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[114.908618] [012/131] (905s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[115.111992] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[115.113607] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[115.234748] [013/131] (905s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[115.439759] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[115.440670] Starting dynamic subtest: pipe-A
[117.468286] Dynamic subtest pipe-A: SUCCESS (2.028s)
[117.480970] Starting dynamic subtest: pipe-B
[119.505203] Dynamic subtest pipe-B: SUCCESS (2.036s)
[119.517857] Starting dynamic subtest: pipe-C
[119.809806] Dynamic subtest pipe-C: SUCCESS (0.304s)
[119.834204] Starting dynamic subtest: pipe-D
[120.130766] Dynamic subtest pipe-D: SUCCESS (0.320s)
[120.131923] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (4.691s)
[120.444919] [014/131] (899s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[120.658560] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[121.651260] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.993s)
[121.917897] [015/131] (898s left) gem_sync (basic-many-each)
[122.009380] Starting subtest: basic-many-each
[124.396886] Subtest basic-many-each: SUCCESS (2.387s)
[124.677255] [016/131] (895s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[124.883676] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[124.884578] Starting dynamic subtest: pipe-A-DP-4
[124.906759] Dynamic subtest pipe-A-DP-4: SKIP (0.002s)
[124.916963] Starting dynamic subtest: pipe-B-DP-4
[124.939155] Dynamic subtest pipe-B-DP-4: SKIP (0.002s)
[124.949195] Starting dynamic subtest: pipe-C-DP-4
[124.974749] Dynamic subtest pipe-C-DP-4: SKIP (0.002s)
[124.984519] Starting dynamic subtest: pipe-D-DP-4
[125.004615] Dynamic subtest pipe-D-DP-4: SKIP (0.002s)
[125.006524] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.011s)
[125.342450] [017/131] (895s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[125.542677] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[125.543589] Starting dynamic subtest: pipe-A-DP-4
[125.553216] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[125.563343] Starting dynamic subtest: pipe-B-DP-4
[125.573022] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[125.582890] Starting dynamic subtest: pipe-C-DP-4
[125.592116] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[125.601747] Starting dynamic subtest: pipe-D-DP-4
[125.612409] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[125.614665] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[125.990317] [018/131] (894s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[126.194859] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[126.196653] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[126.269797] [019/131] (894s left) gem_exec_schedule (in-order)
[126.361299] Starting subtest: in-order
[126.362244] Starting dynamic subtest: rcs0
[126.623842] Dynamic subtest rcs0: SUCCESS (0.262s)
[126.634226] Starting dynamic subtest: bcs0
[126.814600] Dynamic subtest bcs0: SUCCESS (0.190s)
[126.824731] Starting dynamic subtest: vcs0
[127.018519] Dynamic subtest vcs0: SUCCESS (0.204s)
[127.028626] Starting dynamic subtest: vcs1
[127.221578] Dynamic subtest vcs1: SUCCESS (0.203s)
[127.232287] Starting dynamic subtest: vecs0
[127.423191] Dynamic subtest vecs0: SUCCESS (0.201s)
[127.433390] Starting dynamic subtest: vecs1
[127.626873] Dynamic subtest vecs1: SUCCESS (0.203s)
[127.636986] Starting dynamic subtest: ccs0
[127.826736] Dynamic subtest ccs0: SUCCESS (0.200s)
[127.827871] Subtest in-order: SUCCESS (1.465s)
[128.222310] [020/131] (892s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[128.419692] Starting subtest: flip-vs-cursor-atomic
[137.615012] Subtest flip-vs-cursor-atomic: SUCCESS (9.195s)
[137.865598] [021/131] (883s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[138.069782] Starting subtest: plane-upscale-factor-0-25-with-rotation
[138.070535] Starting dynamic subtest: pipe-A
[138.429286] Dynamic subtest pipe-A: SUCCESS (0.360s)
[138.451739] Starting dynamic subtest: pipe-B
[138.915521] Dynamic subtest pipe-B: SUCCESS (0.485s)
[138.940829] Starting dynamic subtest: pipe-C
[139.401460] Dynamic subtest pipe-C: SUCCESS (0.485s)
[139.426926] Starting dynamic subtest: pipe-D
[139.889465] Dynamic subtest pipe-D: SUCCESS (0.487s)
[139.890679] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (1.821s)
[140.254592] [022/131] (880s left) perf_pmu (multi-client)
[140.321357] Starting subtest: multi-client
[140.322283] Starting dynamic subtest: rcs0
[141.402928] Dynamic subtest rcs0: SUCCESS (1.080s)
[141.415599] Starting dynamic subtest: bcs0
[142.457706] Dynamic subtest bcs0: SUCCESS (1.051s)
[142.468964] Starting dynamic subtest: vcs0
[143.510068] Dynamic subtest vcs0: SUCCESS (1.052s)
[143.522625] Starting dynamic subtest: vcs1
[144.562336] Dynamic subtest vcs1: SUCCESS (1.050s)
[144.577695] Starting dynamic subtest: vecs0
[145.612681] Dynamic subtest vecs0: SUCCESS (1.049s)
[145.625473] Starting dynamic subtest: vecs1
[146.664896] Dynamic subtest vecs1: SUCCESS (1.050s)
[146.677510] Starting dynamic subtest: ccs0
[147.717277] Dynamic subtest ccs0: SUCCESS (1.050s)
[147.719294] Subtest multi-client: SUCCESS (7.396s)
[147.873702] [023/131] (873s left) i915_query (query-topology-unsupported)
[147.945013] Starting subtest: query-topology-unsupported
[147.947022] Subtest query-topology-unsupported: SKIP (0.000s)
[148.102475] [024/131] (873s left) gem_exec_balancer (bonded-sync)
[148.180263] Starting subtest: bonded-sync
[148.182561] Subtest bonded-sync: SKIP (0.000s)
[148.538696] [025/131] (872s left) gem_softpin (32b-excludes-last-page)
[148.614136] Starting subtest: 32b-excludes-last-page
[148.618499] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[148.784664] [026/131] (872s left) gem_eio (wait-wedge-1us)
[149.042260] Starting subtest: wait-wedge-1us
[150.947685] Subtest wait-wedge-1us: SUCCESS (1.906s)
[151.171203] [027/131] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[151.376798] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[151.378501] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[151.540874] [028/131] (869s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[151.618110] Starting subtest: saturated-hostile-nopreempt
[151.619113] Starting dynamic subtest: rcs0
[151.729208] Dynamic subtest rcs0: SKIP (0.109s)
[151.769746] Starting dynamic subtest: bcs0
[151.772170] Dynamic subtest bcs0: SKIP (0.016s)
[151.790515] Starting dynamic subtest: vcs0
[151.792812] Dynamic subtest vcs0: SKIP (0.018s)
[151.804564] Starting dynamic subtest: vcs1
[151.806426] Dynamic subtest vcs1: SKIP (0.017s)
[151.817524] Starting dynamic subtest: vecs0
[151.819650] Dynamic subtest vecs0: SKIP (0.022s)
[151.830515] Starting dynamic subtest: vecs1
[151.832594] Dynamic subtest vecs1: SKIP (0.024s)
[151.843612] Starting dynamic subtest: ccs0
[151.848367] Dynamic subtest ccs0: SKIP (0.018s)
[151.850178] Subtest saturated-hostile-nopreempt: SKIP (0.229s)
[152.010694] [029/131] (869s left) kms_sequence (get-forked-busy)
[152.209819] Starting subtest: get-forked-busy
[152.210731] Starting dynamic subtest: pipe-A-DP-4
[154.853529] Dynamic subtest pipe-A-DP-4: SUCCESS (2.641s)
[154.869181] Starting dynamic subtest: pipe-B-DP-4
[157.417640] Dynamic subtest pipe-B-DP-4: SUCCESS (2.563s)
[157.432870] Starting dynamic subtest: pipe-C-DP-4
[159.952027] Dynamic subtest pipe-C-DP-4: SUCCESS (2.532s)
[159.982774] Starting dynamic subtest: pipe-D-DP-4
[162.536067] Dynamic subtest pipe-D-DP-4: SUCCESS (2.582s)
[162.537289] Subtest get-forked-busy: SUCCESS (10.326s)
[162.807446] [030/131] (858s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[163.015078] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[163.069456] [031/131] (858s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[163.276457] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[164.515961] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.239s)
[164.682465] [032/131] (856s left) gem_vm_create (create-ext)
[164.765440] Starting subtest: create-ext
[164.770914] Subtest create-ext: SUCCESS (0.005s)
[164.947086] [033/131] (856s left) kms_cursor_crc (cursor-sliding-64x64)
[165.247967] Starting subtest: cursor-sliding-64x64
[165.252415] Starting dynamic subtest: pipe-A-DP-4
[169.546561] Dynamic subtest pipe-A-DP-4: SUCCESS (4.293s)
[169.597212] Starting dynamic subtest: pipe-D-DP-4
[173.881641] Dynamic subtest pipe-D-DP-4: SUCCESS (4.295s)
[173.882582] Subtest cursor-sliding-64x64: SUCCESS (8.634s)
[174.368576] [034/131] (847s left) gem_exec_reloc (basic-gtt-read-noreloc)
[174.444228] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[174.531053] [035/131] (847s left) gem_eio (in-flight-contexts-10ms)
[174.815421] Starting subtest: in-flight-contexts-10ms
[188.995750] Subtest in-flight-contexts-10ms: SUCCESS (14.181s)
[189.212670] [036/131] (832s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[189.420111] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[189.421882] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[189.513738] [037/131] (832s left) syncobj_wait (single-wait-for-submit-submitted)
[189.588608] Starting subtest: single-wait-for-submit-submitted
[189.698469] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[189.835765] [038/131] (832s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[190.037209] Starting subtest: cursorB-vs-flipA-varying-size
[190.040134] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[190.126343] [039/131] (831s left) kms_cursor_edge_walk (128x128-top-edge)
[190.327781] Starting subtest: 128x128-top-edge
[190.330010] Starting dynamic subtest: pipe-A-DP-4
[193.784365] Dynamic subtest pipe-A-DP-4: SUCCESS (3.455s)
[193.799580] Starting dynamic subtest: pipe-D-DP-4
[197.100415] Dynamic subtest pipe-D-DP-4: SUCCESS (3.314s)
[197.101481] Subtest 128x128-top-edge: SUCCESS (6.772s)
[197.387553] [040/131] (824s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[197.591766] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[197.593462] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[197.747275] [041/131] (824s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[197.955696] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[198.007521] [042/131] (824s left) gem_unfence_active_buffers
[198.252901] [043/131] (824s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[198.331751] Starting subtest: invalid-signal-one-illegal-handle
[198.332673] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[198.505170] [044/131] (823s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[198.727301] Starting subtest: 4-tiled-64bpp-rotate-180
[200.488232] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.760s)
[200.689422] [045/131] (821s left) kms_flip (2x-plain-flip-fb-recreate)
[200.890062] Starting subtest: 2x-plain-flip-fb-recreate
[200.902564] Subtest 2x-plain-flip-fb-recreate: SKIP (0.013s)
[201.001896] [046/131] (821s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[201.212498] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[201.214292] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[201.508813] [047/131] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[201.717170] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[201.718975] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[201.854251] [048/131] (820s left) gem_close_race (multigpu-basic-threads)
[201.959232] Starting subtest: multigpu-basic-threads
[201.961384] Subtest multigpu-basic-threads: SKIP (0.000s)
[202.267560] [049/131] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[202.476040] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[202.477803] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[202.628748] [050/131] (820s left) i915_pm_rc6_residency (media-rc6-accuracy)
[202.699370] Starting subtest: media-rc6-accuracy
[202.701395] Subtest media-rc6-accuracy: SKIP (0.000s)
[202.843482] [051/131] (819s left) kms_plane_cursor (viewport)
[203.045163] Starting subtest: viewport
[203.047354] Starting dynamic subtest: pipe-A-DP-4-size-64
[206.553532] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.508s)
[206.665966] Starting dynamic subtest: pipe-A-DP-4-size-128
[210.137060] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.515s)
[210.247833] Starting dynamic subtest: pipe-A-DP-4-size-256
[213.737064] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.531s)
[213.910541] Starting dynamic subtest: pipe-B-DP-4-size-64
[217.447427] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.550s)
[217.514328] Starting dynamic subtest: pipe-B-DP-4-size-128
[220.914369] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.415s)
[220.979572] Starting dynamic subtest: pipe-B-DP-4-size-256
[224.397878] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.432s)
[224.556371] Starting dynamic subtest: pipe-C-DP-4-size-64
[228.073615] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.531s)
[228.135915] Starting dynamic subtest: pipe-C-DP-4-size-128
[231.590389] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.466s)
[231.681278] Starting dynamic subtest: pipe-C-DP-4-size-256
[235.124268] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.482s)
[235.282484] Starting dynamic subtest: pipe-D-DP-4-size-64
[238.889057] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.621s)
[238.975945] Starting dynamic subtest: pipe-D-DP-4-size-128
[242.389066] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.449s)
[242.450897] Starting dynamic subtest: pipe-D-DP-4-size-256
[245.889566] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.450s)
[246.001043] Subtest viewport: SUCCESS (42.955s)
[246.281761] [052/131] (776s left) api_intel_bb (blit-reloc-keep-cache)
[246.354368] Starting subtest: blit-reloc-keep-cache
[246.356364] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[246.539278] [053/131] (776s left) gem_exec_schedule (preempt-queue-chain)
[246.625157] Subtest preempt-queue-chain: SKIP (0.000s)
[246.999393] [054/131] (776s left) gem_pxp (display-protected-crc)
[249.599209] Starting subtest: display-protected-crc
[249.601225] Subtest display-protected-crc: SKIP (0.000s)
[249.696650] [055/131] (773s left) kms_atomic_transition (plane-all-transition-fencing)
[249.901930] Starting subtest: plane-all-transition-fencing
[249.902910] Starting dynamic subtest: pipe-A-DP-4
[253.626292] Dynamic subtest pipe-A-DP-4: SUCCESS (3.726s)
[253.741156] Starting dynamic subtest: pipe-B-DP-4
[257.498296] Dynamic subtest pipe-B-DP-4: SUCCESS (3.796s)
[257.550118] Subtest plane-all-transition-fencing: SUCCESS (7.652s)
[257.813196] [056/131] (765s left) gem_render_copy (yf-tiled-ccs-to-linear)
[257.894464] Starting subtest: yf-tiled-ccs-to-linear
[257.896590] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[258.103658] [057/131] (765s left) vkms/vkms_configfs (enable-no-planes)
[258.152176] Subtest enable-no-planes: SKIP (0.000s)
[258.248287] [058/131] (765s left) gem_ctx_isolation (preservation-s3)
[258.332448] Starting subtest: preservation-S3
[258.333401] Starting dynamic subtest: rcs0
[277.573499] Dynamic subtest rcs0: SUCCESS (4.163s)
[277.587396] Starting dynamic subtest: bcs0
[297.561445] Dynamic subtest bcs0: SUCCESS (3.801s)
[297.575256] Starting dynamic subtest: vcs0
[317.570369] Dynamic subtest vcs0: SUCCESS (3.808s)
[317.583997] Starting dynamic subtest: vcs1
[337.556597] Dynamic subtest vcs1: SUCCESS (3.779s)
[337.570860] Starting dynamic subtest: vecs0
[357.579904] Dynamic subtest vecs0: SUCCESS (3.794s)
[357.593720] Starting dynamic subtest: vecs1
[377.544748] Dynamic subtest vecs1: SUCCESS (3.750s)
[377.559347] Starting dynamic subtest: ccs0
[397.570510] Dynamic subtest ccs0: SUCCESS (3.847s)
[397.571378] Subtest preservation-S3: SUCCESS (26.949s)
[402.822777] [059/131] (737s left) api_intel_bb (object-reloc-keep-cache)
[402.896618] Starting subtest: object-reloc-keep-cache
[402.900213] Subtest object-reloc-keep-cache: SKIP (0.002s)
[403.102814] [060/131] (737s left) kms_cursor_crc (cursor-onscreen-512x170)
[403.523526] Starting subtest: cursor-onscreen-512x170
[403.525322] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[403.747524] [061/131] (737s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[403.949510] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[403.950434] Starting dynamic subtest: pipe-A-valid-mode
[404.025588] Dynamic subtest pipe-A-valid-mode: SKIP (0.074s)
[404.027371] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.076s)
[404.245435] [062/131] (736s left) kms_properties (invalid-properties-atomic)
[404.449027] Starting subtest: invalid-properties-atomic
[404.809287] Subtest invalid-properties-atomic: SUCCESS (0.361s)
[404.895482] [063/131] (736s left) i915_hangman (engine-engine-error)
[404.981343] Starting subtest: engine-engine-error
[404.982626] Starting dynamic subtest: rcs0
[405.776689] Dynamic subtest rcs0: SUCCESS (0.796s)
[405.794458] Starting dynamic subtest: bcs0
[406.504750] Dynamic subtest bcs0: SUCCESS (0.727s)
[406.523383] Starting dynamic subtest: vcs0
[407.202522] Dynamic subtest vcs0: SUCCESS (0.696s)
[407.217554] Starting dynamic subtest: vcs1
[407.895292] Dynamic subtest vcs1: SUCCESS (0.692s)
[407.909561] Starting dynamic subtest: vecs0
[408.661115] Dynamic subtest vecs0: SUCCESS (0.736s)
[408.697677] Starting dynamic subtest: vecs1
[409.438535] Dynamic subtest vecs1: SUCCESS (0.745s)
[409.456501] Starting dynamic subtest: ccs0
[410.233582] Dynamic subtest ccs0: SUCCESS (0.765s)
[410.234603] Subtest engine-engine-error: SUCCESS (5.166s)
[410.378543] [064/131] (730s left) kms_psr2_su (page_flip-nv12)
[410.456770] Subtest page_flip-NV12: SKIP (0.000s)
[410.528346] [065/131] (730s left) syncobj_timeline (single-wait-all-available-submitted)
[410.600266] Starting subtest: single-wait-all-available-submitted
[410.601179] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[410.771672] [066/131] (730s left) kms_flip (2x-plain-flip)
[410.982348] Starting subtest: 2x-plain-flip
[410.995028] Subtest 2x-plain-flip: SKIP (0.013s)
[411.096742] [067/131] (730s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[411.303415] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[443.471892] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.938s)
[443.729060] [068/131] (697s left) kms_psr (pr-primary-render)
[443.929319] Subtest pr-primary-render: SKIP (0.000s)
[443.980114] [069/131] (697s left) kms_flip (bo-too-big)
[444.182882] Starting subtest: bo-too-big
[444.188840] Starting dynamic subtest: A-DP4
[444.512220] Dynamic subtest A-DP4: SUCCESS (0.322s)
[444.562892] Starting dynamic subtest: B-DP4
[444.790615] Dynamic subtest B-DP4: SUCCESS (0.273s)
[444.836322] Starting dynamic subtest: C-DP4
[445.076429] Dynamic subtest C-DP4: SUCCESS (0.282s)
[445.116307] Starting dynamic subtest: D-DP4
[445.335904] Dynamic subtest D-DP4: SUCCESS (0.256s)
[445.342044] Subtest bo-too-big: SUCCESS (1.157s)
[445.765073] [070/131] (695s left) perf_pmu (busy)
[445.828578] Starting subtest: busy
[445.829558] Starting dynamic subtest: rcs0
[446.459023] Dynamic subtest rcs0: SUCCESS (0.629s)
[446.477536] Starting dynamic subtest: bcs0
[447.023193] Dynamic subtest bcs0: SUCCESS (0.559s)
[447.041757] Starting dynamic subtest: vcs0
[447.586242] Dynamic subtest vcs0: SUCCESS (0.558s)
[447.604649] Starting dynamic subtest: vcs1
[448.149267] Dynamic subtest vcs1: SUCCESS (0.558s)
[448.167939] Starting dynamic subtest: vecs0
[448.710293] Dynamic subtest vecs0: SUCCESS (0.556s)
[448.728741] Starting dynamic subtest: vecs1
[449.275120] Dynamic subtest vecs1: SUCCESS (0.560s)
[449.293568] Starting dynamic subtest: ccs0
[449.837095] Dynamic subtest ccs0: SUCCESS (0.557s)
[449.842146] Subtest busy: SUCCESS (4.010s)
[449.982100] [071/131] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[450.193495] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[452.068813] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.875s)
[452.250196] [072/131] (689s left) kms_vblank (ts-continuation-modeset-rpm)
[452.461818] Starting subtest: ts-continuation-modeset-rpm
[452.462711] Starting dynamic subtest: pipe-A-DP-4
[454.226699] Dynamic subtest pipe-A-DP-4: SUCCESS (1.763s)
[454.251841] Starting dynamic subtest: pipe-D-DP-4
[455.177606] Dynamic subtest pipe-D-DP-4: SUCCESS (0.944s)
[455.178584] Subtest ts-continuation-modeset-rpm: SUCCESS (2.715s)
[455.417932] [073/131] (686s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[455.621105] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[455.622993] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[455.925083] [074/131] (686s left) gem_exec_whisper (basic-contexts-priority-all)
[456.009656] Starting subtest: basic-contexts-priority-all
[478.324593] Subtest basic-contexts-priority-all: SUCCESS (22.305s)
[478.552110] [075/131] (663s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[478.756143] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[478.757906] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[478.902342] [076/131] (663s left) gem_ctx_param (invalid-ctx-get)
[478.972786] Starting subtest: invalid-ctx-get
[478.973682] Subtest invalid-ctx-get: SUCCESS (0.000s)
[479.086892] [077/131] (663s left) gem_mmap_gtt (cpuset-basic-small-copy)
[479.158544] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[479.257635] [078/131] (663s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[479.331897] Starting subtest: framebuffer-vs-set-tiling
[479.333644] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[479.594465] [079/131] (662s left) kms_psr (fbc-psr2-primary-blt)
[479.800044] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[479.852702] [080/131] (662s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[480.058313] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[480.060159] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[480.220507] [081/131] (662s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[480.431629] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[480.488600] [082/131] (662s left) sysfs_preempt_timeout (invalid)
[480.566532] Starting subtest: invalid
[480.568811] Starting dynamic subtest: vecs0
[480.569718] Dynamic subtest vecs0: SUCCESS (0.000s)
[480.584743] Starting dynamic subtest: ccs0
[480.585896] Dynamic subtest ccs0: SUCCESS (0.000s)
[480.600818] Starting dynamic subtest: vcs0
[480.601945] Dynamic subtest vcs0: SUCCESS (0.000s)
[480.616957] Starting dynamic subtest: bcs0
[480.618073] Dynamic subtest bcs0: SUCCESS (0.000s)
[480.632716] Starting dynamic subtest: vecs1
[480.633764] Dynamic subtest vecs1: SUCCESS (0.000s)
[480.649199] Starting dynamic subtest: rcs0
[480.650286] Dynamic subtest rcs0: SUCCESS (0.000s)
[480.664854] Starting dynamic subtest: vcs1
[480.665934] Dynamic subtest vcs1: SUCCESS (0.000s)
[480.666970] Subtest invalid: SUCCESS (0.010s)
[480.710699] [083/131] (661s left) kms_writeback (writeback-invalid-parameters)
[480.913994] Subtest writeback-invalid-parameters: SKIP (0.000s)
[480.970552] [084/131] (661s left) template (b)
[481.041436] Starting subtest: B
[481.042386] Subtest B: SUCCESS (0.000s)
[481.201838] [085/131] (661s left) drm_fdinfo (memory-info-shared)
[481.267063] Starting subtest: memory-info-shared
[481.268100] Starting dynamic subtest: lmem0
[481.371851] Dynamic subtest lmem0: SUCCESS (0.104s)
[481.388662] Starting dynamic subtest: smem0
[481.430865] Dynamic subtest smem0: SUCCESS (0.058s)
[481.431994] Subtest memory-info-shared: SUCCESS (0.165s)
[481.526436] [086/131] (661s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[481.729433] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[483.768722] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.039s)
[483.961740] [087/131] (658s left) kms_psr (pr-cursor-plane-onoff)
[484.161951] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[484.222740] [088/131] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[484.425918] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[484.427566] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[484.534274] [089/131] (658s left) kms_chamelium_frames (hdmi-aspect-ratio)
[484.822732] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[484.978770] [090/131] (658s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[485.191750] Starting subtest: x-tiled-16bpp-rotate-270
[485.235823] Subtest x-tiled-16bpp-rotate-270: SKIP (0.043s)
[485.449805] [091/131] (657s left) kms_psr (psr-primary-blt)
[485.651095] Subtest psr-primary-blt: SKIP (0.000s)
[485.711893] [092/131] (657s left) prime_vgem (shrink)
[485.867624] Starting subtest: shrink
[485.875289] Subtest shrink: SUCCESS (0.006s)
[486.061524] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[486.063933] [093/131] (657s left) gem_ctx_engines (none)
[486.151383] Starting subtest: none
[486.153795] Subtest none: SUCCESS (0.002s)
[486.363721] [094/131] (656s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[486.579205] Starting subtest: y-tiled-32bpp-rotate-180
[486.581068] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[486.727492] [095/131] (656s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[486.808342] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[486.921501] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[487.034473] [096/131] (656s left) kms_chamelium_color (ctm-red-to-blue)
[487.253165] Subtest ctm-red-to-blue: SKIP (0.000s)
[487.314234] [097/131] (656s left) gem_mmap_offset (clear-via-pagefault)
[487.394895] Starting subtest: clear-via-pagefault
[487.396880] Starting dynamic subtest: lmem0
[509.393903] Dynamic subtest lmem0: SUCCESS (21.991s)
[509.409663] Starting dynamic subtest: smem0
[533.721330] Dynamic subtest smem0: SUCCESS (24.329s)
[533.722575] Subtest clear-via-pagefault: SUCCESS (46.322s)
[533.846571] [098/131] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[534.064267] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[534.066053] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[534.185771] [099/131] (609s left) perf (buffer-fill)
[534.547038] Starting subtest: buffer-fill
[534.547948] Starting dynamic subtest: 0-rcs0
[536.707386] Dynamic subtest 0-rcs0: SUCCESS (2.159s)
[536.708369] Subtest buffer-fill: SUCCESS (2.161s)
[536.771615] [100/131] (606s left) gem_render_copy_redux (interruptible)
[536.857901] Starting subtest: interruptible
[537.537568] Subtest interruptible: SUCCESS (0.680s)
[537.729176] [101/131] (606s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[537.937452] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[537.939237] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[538.080704] [102/131] (605s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[538.171096] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[538.171992] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[538.345104] [103/131] (605s left) kms_color (legacy-gamma-reset)
[538.563625] Starting subtest: legacy-gamma-reset
[538.564634] Starting dynamic subtest: pipe-A-DP-4
[538.769776] Dynamic subtest pipe-A-DP-4: SUCCESS (0.207s)
[538.788210] Starting dynamic subtest: pipe-B-DP-4
[538.790625] Dynamic subtest pipe-B-DP-4: SUCCESS (0.019s)
[538.805262] Starting dynamic subtest: pipe-C-DP-4
[538.807708] Dynamic subtest pipe-C-DP-4: SUCCESS (0.017s)
[538.822412] Starting dynamic subtest: pipe-D-DP-4
[538.825558] Dynamic subtest pipe-D-DP-4: SUCCESS (0.017s)
[538.826534] Subtest legacy-gamma-reset: SUCCESS (0.264s)
[539.045150] [104/131] (604s left) kms_atomic (plane-cursor-legacy)
[539.256758] Starting subtest: plane-cursor-legacy
[539.257655] Starting dynamic subtest: pipe-A-DP-4
[539.763422] Dynamic subtest pipe-A-DP-4: SUCCESS (0.506s)
[539.764534] Subtest plane-cursor-legacy: SUCCESS (0.508s)
[540.077621] [105/131] (604s left) kms_draw_crc (draw-method-pwrite)
[540.287307] Starting subtest: draw-method-pwrite
[540.288227] Starting dynamic subtest: xrgb8888-untiled
[540.707211] Dynamic subtest xrgb8888-untiled: SUCCESS (0.419s)
[540.738699] Starting dynamic subtest: rgb565-untiled
[541.140334] Dynamic subtest rgb565-untiled: SUCCESS (0.432s)
[541.158131] Starting dynamic subtest: xrgb2101010-untiled
[541.542749] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.400s)
[541.591673] Starting dynamic subtest: xbgr16161616f-untiled
[541.974889] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.427s)
[542.022802] Starting dynamic subtest: xrgb8888-xtiled
[542.575273] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.596s)
[542.594310] Starting dynamic subtest: rgb565-xtiled
[543.174264] Dynamic subtest rgb565-xtiled: SUCCESS (0.595s)
[543.202395] Starting dynamic subtest: xrgb2101010-xtiled
[543.724824] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.548s)
[543.776740] Starting dynamic subtest: xbgr16161616f-xtiled
[544.392092] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.663s)
[544.415850] Starting dynamic subtest: xrgb8888-4tiled
[544.840980] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.445s)
[544.868456] Starting dynamic subtest: rgb565-4tiled
[545.192346] Dynamic subtest rgb565-4tiled: SUCCESS (0.349s)
[545.243211] Starting dynamic subtest: xrgb2101010-4tiled
[545.642544] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.445s)
[545.691594] Starting dynamic subtest: xbgr16161616f-4tiled
[546.308948] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.661s)
[546.315268] Subtest draw-method-pwrite: SUCCESS (6.022s)
[546.462870] [106/131] (597s left) kms_feature_discovery (psr2)
[546.677298] Starting subtest: psr2
[546.679161] Subtest psr2: SKIP (0.000s)
[546.775670] [107/131] (597s left) prime_vgem (fence-read-hang)
[546.874936] Subtest fence-read-hang: SKIP (0.000s)
[547.066708] [108/131] (597s left) perf (missing-sample-flags)
[547.255256] Starting subtest: missing-sample-flags
[547.256301] Subtest missing-sample-flags: SUCCESS (0.000s)
[547.307845] [109/131] (597s left) gem_workarounds (suspend-resume-fd)
[547.400556] Starting subtest: suspend-resume-fd
[566.405195] Subtest suspend-resume-fd: SUCCESS (3.739s)
[570.535953] [110/131] (593s left) gem_exec_params (rel-constants-invalid)
[570.625046] Starting subtest: rel-constants-invalid
[570.625932] Subtest rel-constants-invalid: SUCCESS (0.000s)
[570.756305] [111/131] (593s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[570.970337] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[570.972022] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[571.114958] [112/131] (592s left) kms_addfb_basic (unused-handle)
[571.192953] Starting subtest: unused-handle
[571.193881] Subtest unused-handle: SUCCESS (0.000s)
[571.491439] [113/131] (592s left) gem_reg_read (timestamp-monotonic)
[571.574892] Starting subtest: timestamp-monotonic
[575.985760] Subtest timestamp-monotonic: SUCCESS (4.410s)
[576.073799] [114/131] (587s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[576.288622] Starting subtest: fbc-tiling-linear
[578.609894] Subtest fbc-tiling-linear: SUCCESS (2.321s)
[578.829442] [115/131] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[579.049941] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[579.051885] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[579.235133] [116/131] (584s left) kms_pm_rpm (basic-rte)
[579.285392] Starting subtest: basic-rte
[582.142408] Subtest basic-rte: SUCCESS (2.850s)
[582.926736] [117/131] (581s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[583.008822] Starting subtest: invalid-multi-wait-unsubmitted
[583.009799] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[583.190450] [118/131] (581s left) gem_exec_reloc (basic-softpin)
[583.278030] Subtest basic-softpin: SKIP (0.000s)
[583.369910] [119/131] (581s left) kms_rotation_crc (exhaust-fences)
[583.597400] Starting subtest: exhaust-fences
[583.599650] Subtest exhaust-fences: SKIP (0.000s)
[583.703070] [120/131] (580s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[583.923759] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[583.924730] Starting dynamic subtest: pipe-A-DP-4
[583.933722] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[583.949566] Starting dynamic subtest: pipe-B-DP-4
[583.958773] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[583.973991] Starting dynamic subtest: pipe-C-DP-4
[583.982886] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[583.998312] Starting dynamic subtest: pipe-D-DP-4
[584.008572] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[584.010760] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[584.395120] [121/131] (580s left) syncobj_wait (multi-wait-for-submit-submitted)
[584.478764] Starting subtest: multi-wait-for-submit-submitted
[584.580755] Subtest multi-wait-for-submit-submitted: SUCCESS (0.098s)
[584.737029] [122/131] (579s left) syncobj_timeline (single-wait-available-submitted)
[584.814050] Starting subtest: single-wait-available-submitted
[584.814987] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[584.948661] [123/131] (579s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[585.171067] Starting subtest: fbc-indfb-scaledprimary
[588.859774] Subtest fbc-indfb-scaledprimary: SUCCESS (3.602s)
[589.065045] [124/131] (575s left) syncobj_wait (wait-for-submit-snapshot)
[589.148654] Starting subtest: wait-for-submit-snapshot
[589.232156] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[589.353448] [125/131] (575s left) kms_lease (lease-uevent)
[589.566680] Starting subtest: lease-uevent
[590.580416] Subtest lease-uevent: SUCCESS (0.998s)
[590.673049] [126/131] (574s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[590.883527] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[590.884273] Starting dynamic subtest: pipe-A
[591.280043] Dynamic subtest pipe-A: SUCCESS (0.391s)
[591.315345] Starting dynamic subtest: pipe-B
[591.772739] Dynamic subtest pipe-B: SUCCESS (0.484s)
[591.809135] Starting dynamic subtest: pipe-C
[592.264235] Dynamic subtest pipe-C: SUCCESS (0.483s)
[592.302746] Starting dynamic subtest: pipe-D
[592.776051] Dynamic subtest pipe-D: SUCCESS (0.503s)
[592.777252] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.870s)
[593.123664] [127/131] (572s left) gem_spin_batch (legacy-resubmit-new)
[593.217556] Starting subtest: legacy-resubmit-new
[593.218582] Starting dynamic subtest: default
[593.244521] Dynamic subtest default: SUCCESS (0.026s)
[593.262998] Starting dynamic subtest: render
[593.263943] Dynamic subtest render: SUCCESS (0.003s)
[593.279975] Starting dynamic subtest: bsd
[593.281024] Dynamic subtest bsd: SUCCESS (0.004s)
[593.296327] Starting dynamic subtest: bsd1
[593.297277] Dynamic subtest bsd1: SUCCESS (0.003s)
[593.312367] Starting dynamic subtest: bsd2
[593.313512] Dynamic subtest bsd2: SUCCESS (0.007s)
[593.328344] Starting dynamic subtest: blt
[593.329519] Dynamic subtest blt: SUCCESS (0.005s)
[593.344306] Starting dynamic subtest: vebox
[593.345457] Dynamic subtest vebox: SUCCESS (0.003s)
[593.346604] Subtest legacy-resubmit-new: SUCCESS (0.060s)
[593.598111] [128/131] (571s left) gem_mmap_gtt (basic-small-copy-xy)
[593.679770] Subtest basic-small-copy-XY: SKIP (0.000s)
[593.745216] [129/131] (571s left) kms_content_protection (dp-mst-type-0)
[594.016060] Starting subtest: dp-mst-type-0
[594.018011] Subtest dp-mst-type-0: SKIP (0.000s)
[594.225342] [130/131] (571s left) gem_exec_big (single)
[594.312922] Starting subtest: single
[599.598071] Subtest single: SUCCESS (5.243s)
[600.245668] [131/131] (565s left) gem_exec_balancer (full-late)
[600.381845] Starting subtest: full-late
[602.146873] Subtest full-late: SUCCESS (1.758s)
[602.551390] Closing watchdogs
Done.