[60.411590] Initializing watchdogs
[60.411654]   /dev/watchdog0
[60.431091] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.441604] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.445743] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.448145] [001/133] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[60.628575] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[60.629482] Starting dynamic subtest: pipe-A-DP-3
[60.637933] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[60.645326] Starting dynamic subtest: pipe-B-DP-3
[60.653571] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[60.660858] Starting dynamic subtest: pipe-C-DP-3
[60.669051] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[60.676269] Starting dynamic subtest: pipe-D-DP-3
[60.685132] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[60.687024] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[61.088613] [002/133] (959s left) gen7_exec_parse (load-register-reg)
[61.166515] Subtest load-register-reg: SKIP (0.000s)
[61.214741] [003/133] (959s left) gem_mmap (big-bo)
[61.283948] Subtest big-bo: SKIP (0.000s)
[61.350962] [004/133] (959s left) dumb_buffer (map-invalid-size)
[61.421977] Starting subtest: map-invalid-size
[61.423169] Subtest map-invalid-size: SUCCESS (0.000s)
[61.616207] [005/133] (959s left) gem_exec_reloc (basic-gtt-read-active)
[61.693587] Subtest basic-gtt-read-active: SKIP (0.000s)
[61.768094] [006/133] (959s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[61.944897] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[61.945786] Starting dynamic subtest: pipe-A-DP-3
[61.953889] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[61.961282] Starting dynamic subtest: pipe-B-DP-3
[61.969322] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[61.976503] Starting dynamic subtest: pipe-C-DP-3
[61.984545] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[61.991733] Starting dynamic subtest: pipe-D-DP-3
[62.000958] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[62.002641] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[62.416910] [007/133] (958s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[62.596591] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[62.643655] [008/133] (958s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[62.822186] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[62.856108] Starting dynamic subtest: pipe-A-plane-0
[62.858233] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[62.865862] Starting dynamic subtest: pipe-A-plane-3
[62.868188] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[62.876796] Starting dynamic subtest: pipe-A-plane-5
[62.878539] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[63.089557] Starting dynamic subtest: pipe-B-plane-0
[63.092056] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[63.106053] Starting dynamic subtest: pipe-B-plane-3
[63.108264] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[63.121840] Starting dynamic subtest: pipe-B-plane-5
[63.123884] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[63.186160] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.362s)
[63.442943] [009/133] (958s left) gem_pxp (fail-invalid-protected-context)
[66.036483] Starting subtest: fail-invalid-protected-context
[66.038399] Subtest fail-invalid-protected-context: SKIP (0.000s)
[66.171654] [010/133] (955s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[66.348963] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[66.349914] Starting dynamic subtest: pipe-A-valid-mode
[68.825685] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.475s)
[68.827265] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (2.476s)
[69.124099] [011/133] (952s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[69.193957] Starting subtest: multi-wait-all-for-submit-available-signaled
[69.194914] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[69.373347] [012/133] (952s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[69.550373] Starting subtest: basic-modeset-with-all-modifiers-formats
[69.780636] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[70.036742] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.256s)
[70.049174] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[70.069546] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[70.089189] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[70.102813] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.033s)
[70.122368] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[70.136133] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.033s)
[70.151843] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[70.169228] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.033s)
[70.182564] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[70.202674] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.033s)
[70.216317] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[70.236164] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.033s)
[70.249621] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[70.269219] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.033s)
[70.283020] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[70.302793] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.033s)
[70.320254] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[70.502378] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.199s)
[70.510580] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[70.535791] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.033s)
[70.547805] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[70.569263] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.033s)
[70.587987] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[70.602726] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.033s)
[70.622070] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[70.635803] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.033s)
[70.651182] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[70.669157] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.033s)
[70.684474] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[70.702815] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.033s)
[70.713421] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[70.735830] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.033s)
[70.746662] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[70.769316] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.033s)
[70.785307] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[70.970388] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.201s)
[70.978509] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[71.004459] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.034s)
[71.012941] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[71.038626] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.033s)
[71.071148] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[71.072246] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[71.087198] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[71.104508] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.033s)
[71.114573] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[71.138063] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.033s)
[71.149189] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[71.171211] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.033s)
[71.183361] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[71.204582] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.033s)
[71.219625] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[71.238168] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.033s)
[71.509950] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.959s)
[71.864622] [013/133] (949s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[72.053537] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[73.167754] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.114s)
[73.428958] [014/133] (948s left) gem_watchdog (default-virtual)
[73.509578] Starting subtest: default-virtual
[80.589563] Subtest default-virtual: SUCCESS (7.079s)
[80.713824] [015/133] (941s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[80.898383] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[80.899248] Starting dynamic subtest: pipe-A-DP-3
[80.907734] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[80.915924] Starting dynamic subtest: pipe-B-DP-3
[80.924254] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[80.932236] Starting dynamic subtest: pipe-C-DP-3
[80.940291] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[80.948155] Starting dynamic subtest: pipe-D-DP-3
[80.956195] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[80.957775] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[81.354959] [016/133] (940s left) kms_psr (pr-cursor-plane-move)
[81.539719] Subtest pr-cursor-plane-move: SKIP (0.000s)
[81.598087] [017/133] (940s left) gem_exec_fence (syncobj-invalid-flags)
[82.115584] Starting subtest: syncobj-invalid-flags
[82.116467] Subtest syncobj-invalid-flags: SUCCESS (0.001s)
[82.503901] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[82.505573] [018/133] (939s left) gem_softpin (32b-excludes-last-page)
[82.590363] Starting subtest: 32b-excludes-last-page
[82.598727] Subtest 32b-excludes-last-page: SUCCESS (0.008s)
[82.823753] [019/133] (939s left) kms_flip (wf_vblank-ts-check)
[83.007161] Starting subtest: wf_vblank-ts-check
[83.011154] Starting dynamic subtest: A-DP3
[91.154019] Dynamic subtest A-DP3: SUCCESS (8.142s)
[91.164222] Starting dynamic subtest: B-DP3
[99.215298] Dynamic subtest B-DP3: SUCCESS (8.060s)
[99.224806] Starting dynamic subtest: C-DP3
[107.266026] Dynamic subtest C-DP3: SUCCESS (8.050s)
[107.275283] Starting dynamic subtest: D-DP3
[115.324059] Dynamic subtest D-DP3: SUCCESS (8.057s)
[115.326039] Subtest wf_vblank-ts-check: SUCCESS (32.317s)
[115.648978] [020/133] (906s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[115.832956] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[115.834780] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[116.162425] [021/133] (906s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[116.344958] Starting subtest: pixel-format-linear-modifier-source-clamping
[116.382215] Starting dynamic subtest: pipe-A-plane-0
[122.565849] Dynamic subtest pipe-A-plane-0: SUCCESS (6.184s)
[122.574995] Starting dynamic subtest: pipe-A-plane-3
[125.666244] Dynamic subtest pipe-A-plane-3: SUCCESS (3.100s)
[125.676657] Starting dynamic subtest: pipe-A-plane-5
[125.678752] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[125.923270] Starting dynamic subtest: pipe-B-plane-0
[131.699412] Dynamic subtest pipe-B-plane-0: SUCCESS (5.784s)
[131.710179] Starting dynamic subtest: pipe-B-plane-3
[134.865941] Dynamic subtest pipe-B-plane-3: SUCCESS (3.166s)
[134.874870] Starting dynamic subtest: pipe-B-plane-5
[134.877078] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[134.958195] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (18.612s)
[135.320061] [022/133] (887s left) kms_universal_plane (universal-plane-sanity)
[135.503844] Starting subtest: universal-plane-sanity
[135.505846] Starting dynamic subtest: pipe-A-DP-3
[136.129490] Dynamic subtest pipe-A-DP-3: SUCCESS (0.624s)
[136.142058] Starting dynamic subtest: pipe-B-DP-3
[136.616493] Dynamic subtest pipe-B-DP-3: SUCCESS (0.458s)
[136.634135] Starting dynamic subtest: pipe-C-DP-3
[137.070417] Dynamic subtest pipe-C-DP-3: SUCCESS (0.479s)
[137.082130] Starting dynamic subtest: pipe-D-DP-3
[137.558314] Dynamic subtest pipe-D-DP-3: SUCCESS (0.486s)
[137.559315] Subtest universal-plane-sanity: SUCCESS (2.054s)
[137.875821] [023/133] (884s left) gem_exec_reloc (basic-cpu-read)
[137.965756] Subtest basic-cpu-read: SKIP (0.000s)
[138.050731] [024/133] (884s left) i915_query (query-topology-kernel-writes)
[138.123062] Starting subtest: query-topology-kernel-writes
[138.124009] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[138.261350] [025/133] (884s left) gem_mmap_gtt (hang-busy)
[138.341884] Subtest hang-busy: SKIP (0.000s)
[138.415424] [026/133] (884s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[138.492277] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[138.493208] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[138.668310] [027/133] (884s left) kms_vrr (seamless-rr-switch-virtual)
[138.863864] Starting subtest: seamless-rr-switch-virtual
[138.866435] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[139.022828] [028/133] (883s left) gem_exec_store (basic)
[139.110667] Starting subtest: basic
[139.251383] Subtest basic: SUCCESS (0.140s)
[139.551118] [029/133] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[139.745499] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[139.747193] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[139.910089] [030/133] (882s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[140.102450] Starting subtest: fbc-modesetfrombusy
[141.418602] Subtest fbc-modesetfrombusy: SUCCESS (1.317s)
[141.632535] [031/133] (881s left) api_intel_allocator (fork-simple-once)
[141.707386] Starting subtest: fork-simple-once
[141.746138] Subtest fork-simple-once: SUCCESS (0.039s)
[141.947600] [032/133] (881s left) gem_exec_schedule (preempt-queue-contexts)
[142.049551] Subtest preempt-queue-contexts: SKIP (0.000s)
[142.391924] [033/133] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[142.586575] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[142.588308] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[142.782062] [034/133] (880s left) i915_pm_rps (thresholds-idle)
[142.865282] Starting subtest: thresholds-idle
[142.867152] Subtest thresholds-idle: SKIP (0.000s)
[142.974033] [035/133] (880s left) gem_exec_reloc (basic-wc-gtt)
[143.066166] Subtest basic-wc-gtt: SKIP (0.000s)
[143.142612] [036/133] (880s left) kms_pm_rpm (system-suspend-idle)
[145.076892] Starting subtest: system-suspend-idle
[165.019881] Subtest system-suspend-idle: SUCCESS (5.282s)
[165.431085] [037/133] (857s left) gem_ctx_exec (basic)
[165.520438] Starting subtest: basic
[165.525182] Subtest basic: SUCCESS (0.006s)
[165.741136] [038/133] (857s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[165.932599] Starting subtest: fbcpsr-tiling-y
[165.934280] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[166.134162] [039/133] (857s left) drm_read (short-buffer-nonblock)
[166.388000] Starting subtest: short-buffer-nonblock
[166.388892] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[166.653528] [040/133] (856s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[166.840367] Starting subtest: basic-max-pipe-crc-check
[166.842989] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[166.896538] [041/133] (856s left) kms_psr (psr2-sprite-mmap-cpu)
[167.083436] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[167.147087] [042/133] (856s left) perf_pmu (init-sema)
[167.217852] Starting subtest: init-sema
[167.218760] Starting dynamic subtest: rcs0
[167.220571] Dynamic subtest rcs0: SUCCESS (0.002s)
[167.230580] Starting dynamic subtest: bcs0
[167.231476] Dynamic subtest bcs0: SUCCESS (0.001s)
[167.241483] Starting dynamic subtest: vcs0
[167.242345] Dynamic subtest vcs0: SUCCESS (0.000s)
[167.252420] Starting dynamic subtest: vcs1
[167.253532] Dynamic subtest vcs1: SUCCESS (0.001s)
[167.263489] Starting dynamic subtest: vecs0
[167.264696] Dynamic subtest vecs0: SUCCESS (0.000s)
[167.274692] Starting dynamic subtest: vecs1
[167.275568] Dynamic subtest vecs1: SUCCESS (0.001s)
[167.285693] Starting dynamic subtest: ccs0
[167.286846] Dynamic subtest ccs0: SUCCESS (0.001s)
[167.287723] Subtest init-sema: SUCCESS (0.009s)
[167.444457] [043/133] (856s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[167.628234] Starting subtest: cursorB-vs-flipB-atomic
[167.629997] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[167.748707] [044/133] (856s left) kms_psr (fbc-psr-dpms)
[167.938424] Subtest fbc-psr-dpms: SKIP (0.000s)
[167.998538] [045/133] (855s left) kms_properties (plane-properties-legacy)
[168.179967] Starting subtest: plane-properties-legacy
[168.180974] Starting dynamic subtest: pipe-A-DP-3
[168.687768] Dynamic subtest pipe-A-DP-3: SUCCESS (0.506s)
[168.709831] Starting dynamic subtest: pipe-B-DP-3
[169.225261] Dynamic subtest pipe-B-DP-3: SUCCESS (0.535s)
[169.238323] Starting dynamic subtest: pipe-C-DP-3
[169.748862] Dynamic subtest pipe-C-DP-3: SUCCESS (0.521s)
[169.766495] Starting dynamic subtest: pipe-D-DP-3
[170.283300] Dynamic subtest pipe-D-DP-3: SUCCESS (0.532s)
[170.284252] Subtest plane-properties-legacy: SUCCESS (2.102s)
[170.556358] [046/133] (853s left) gem_sync (basic-many-each)
[170.644165] Starting subtest: basic-many-each
[173.092205] Subtest basic-many-each: SUCCESS (2.447s)
[173.383204] [047/133] (850s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[173.566312] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[173.568064] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[173.901320] [048/133] (850s left) gem_mmap_gtt (medium-copy-xy)
[173.978113] Subtest medium-copy-XY: SKIP (0.000s)
[174.053590] [049/133] (850s left) gem_cs_tlb (engines)
[174.140495] Starting subtest: engines
[174.141439] Starting dynamic subtest: rcs0
[176.296423] Dynamic subtest rcs0: SUCCESS (2.154s)
[176.306620] Starting dynamic subtest: bcs0
[178.451211] Dynamic subtest bcs0: SUCCESS (2.153s)
[178.461393] Starting dynamic subtest: vcs0
[180.604037] Dynamic subtest vcs0: SUCCESS (2.152s)
[180.614513] Starting dynamic subtest: vcs1
[182.759937] Dynamic subtest vcs1: SUCCESS (2.155s)
[182.770183] Starting dynamic subtest: vecs0
[184.914757] Dynamic subtest vecs0: SUCCESS (2.154s)
[184.924933] Starting dynamic subtest: vecs1
[187.068832] Dynamic subtest vecs1: SUCCESS (2.153s)
[187.079029] Starting dynamic subtest: ccs0
[189.222420] Dynamic subtest ccs0: SUCCESS (2.153s)
[189.223312] Subtest engines: SUCCESS (15.077s)
[189.414138] [050/133] (834s left) gem_userptr_blits (forbidden-operations)
[189.500024] Starting subtest: forbidden-operations
[189.501890] Subtest forbidden-operations: SKIP (0.000s)
[189.749663] [051/133] (834s left) gem_exec_fence (syncobj-wait)
[190.305472] Starting subtest: syncobj-wait
[190.438411] Subtest syncobj-wait: SUCCESS (0.133s)
[190.874125] [052/133] (833s left) kms_psr (fbc-psr2-primary-blt)
[191.061254] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[191.118534] [053/133] (833s left) syncobj_eventfd (binary-wait-signaled)
[191.193179] Starting subtest: binary-wait-signaled
[191.194100] Subtest binary-wait-signaled: SUCCESS (0.000s)
[191.373804] [054/133] (833s left) kms_draw_crc (draw-method-mmap-gtt)
[191.559197] Starting subtest: draw-method-mmap-gtt
[191.560993] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[191.755796] [055/133] (832s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[191.938323] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[191.939234] Starting dynamic subtest: pipe-A-valid-mode
[196.701526] Dynamic subtest pipe-A-valid-mode: SUCCESS (4.760s)
[196.703158] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (4.763s)
[197.020210] [056/133] (827s left) gem_exec_flush (basic-wb-ro-default)
[197.109282] Subtest basic-wb-ro-default: SKIP (0.000s)
[197.186356] [057/133] (827s left) kms_vblank (ts-continuation-modeset-rpm)
[197.377305] Starting subtest: ts-continuation-modeset-rpm
[197.378218] Starting dynamic subtest: pipe-A-DP-3
[199.269311] Dynamic subtest pipe-A-DP-3: SUCCESS (1.888s)
[199.293305] Starting dynamic subtest: pipe-D-DP-3
[200.083428] Dynamic subtest pipe-D-DP-3: SUCCESS (0.805s)
[200.084495] Subtest ts-continuation-modeset-rpm: SUCCESS (2.706s)
[200.390260] [058/133] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[200.580954] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[200.582695] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[200.774010] [059/133] (824s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[200.966322] Starting subtest: cursorB-vs-flipB-legacy
[200.968138] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[201.085376] [060/133] (823s left) gem_exec_await (wide-contexts)
[201.342456] Starting subtest: wide-contexts
[223.486673] Subtest wide-contexts: SUCCESS (22.142s)
[223.747231] [061/133] (801s left) gem_lmem_swapping (verify)
[226.593597] Starting subtest: verify
[226.594483] Starting dynamic subtest: lmem0
[262.718278] Dynamic subtest lmem0: SUCCESS (36.124s)
[262.719244] Subtest verify: SUCCESS (36.125s)
[264.131938] [FACT gem_lmem_swapping (verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[264.132920] [FACT gem_lmem_swapping (verify)] deleted: kernel.kmod_is_loaded.i915: true
[264.134853] [062/133] (760s left) prime_vgem (busy)
[265.763198] Starting subtest: busy
[265.764168] Starting dynamic subtest: rcs0
[265.829203] Dynamic subtest rcs0: SUCCESS (0.066s)
[265.841216] Starting dynamic subtest: bcs0
[265.875461] Dynamic subtest bcs0: SUCCESS (0.045s)
[265.887518] Starting dynamic subtest: vcs0
[265.918631] Dynamic subtest vcs0: SUCCESS (0.042s)
[265.937555] Starting dynamic subtest: vcs1
[265.961259] Dynamic subtest vcs1: SUCCESS (0.041s)
[265.981435] Starting dynamic subtest: vecs0
[266.007573] Dynamic subtest vecs0: SUCCESS (0.045s)
[266.035914] Starting dynamic subtest: vecs1
[266.050886] Dynamic subtest vecs1: SUCCESS (0.041s)
[266.070711] Starting dynamic subtest: ccs0
[266.091843] Dynamic subtest ccs0: SUCCESS (0.040s)
[266.092854] Subtest busy: SUCCESS (0.330s)
[266.232561] [FACT prime_vgem (busy)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[266.235084] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.i915: true
[266.237991] [063/133] (758s left) i915_module_load (reload)
[266.284833] Starting subtest: reload
[271.274459] Subtest reload: SUCCESS (4.990s)
[271.321355] [064/133] (753s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[271.623973] Starting subtest: fbc-rgb565-draw-blt
[274.325514] Subtest fbc-rgb565-draw-blt: SUCCESS (2.702s)
[274.573939] [065/133] (750s left) gem_exec_balancer (bonded-chain)
[274.668553] Starting subtest: bonded-chain
[288.436698] Subtest bonded-chain: SUCCESS (13.769s)
[288.856475] [066/133] (736s left) gem_mmap_gtt (basic-write-read)
[288.932230] Subtest basic-write-read: SKIP (0.000s)
[289.001517] [067/133] (736s left) gem_exec_reloc (basic-write-read-active)
[289.083215] Subtest basic-write-read-active: SKIP (0.000s)
[289.174061] [068/133] (736s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[289.372530] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[289.374342] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[289.568750] [069/133] (736s left) gem_lmem_swapping (heavy-verify-random-ccs)
[292.222266] Starting subtest: heavy-verify-random-ccs
[292.223312] Starting dynamic subtest: lmem0
[306.676972] Dynamic subtest lmem0: SUCCESS (14.454s)
[306.677883] Subtest heavy-verify-random-ccs: SUCCESS (14.455s)
[308.351648] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[308.353034] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[308.355601] [070/133] (717s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[310.089083] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[310.090948] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[310.300989] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[310.303630] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[310.306673] [071/133] (715s left) kms_getfb (getfb-handle-closed)
[310.502459] Starting subtest: getfb-handle-closed
[310.503385] Subtest getfb-handle-closed: SUCCESS (0.000s)
[310.717141] [072/133] (715s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[310.906362] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[310.908160] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[311.051500] [073/133] (714s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[311.243303] Starting subtest: fbc-rgb565-draw-mmap-cpu
[313.682976] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.440s)
[313.895319] [074/133] (712s left) gem_exec_create (forked)
[313.986156] Starting subtest: forked
[313.987177] Starting dynamic subtest: smem
[334.135031] Dynamic subtest smem: SUCCESS (20.148s)
[334.154374] Starting dynamic subtest: lmem0
[354.290431] Dynamic subtest lmem0: SUCCESS (20.153s)
[354.291455] Subtest forked: SUCCESS (40.303s)
[354.573418] [075/133] (671s left) kms_chamelium_color (ctm-red-to-blue)
[354.758963] Subtest ctm-red-to-blue: SKIP (0.000s)
[354.811438] [076/133] (671s left) syncobj_wait (single-wait-for-submit-signaled)
[354.886595] Starting subtest: single-wait-for-submit-signaled
[354.887514] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[355.065554] [077/133] (671s left) kms_cursor_crc (cursor-offscreen-32x32)
[355.351547] Starting subtest: cursor-offscreen-32x32
[355.404287] Subtest cursor-offscreen-32x32: SKIP (0.050s)
[355.915801] [078/133] (670s left) prime_vgem (basic-fence-flip)
[356.030465] Starting subtest: basic-fence-flip
[356.161992] Subtest basic-fence-flip: SKIP (0.131s)
[356.365290] [079/133] (669s left) syncobj_wait (wait-any-snapshot)
[356.442506] Starting subtest: wait-any-snapshot
[356.525128] Subtest wait-any-snapshot: SUCCESS (0.082s)
[356.698710] [080/133] (669s left) gem_ctx_freq (sysfs)
[356.785006] Starting subtest: sysfs
[356.786016] Starting dynamic subtest: gt0
[362.466576] Dynamic subtest gt0: SUCCESS (5.680s)
[362.472635] Subtest sysfs: SUCCESS (5.683s)
[362.686046] [081/133] (663s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[363.048801] Starting subtest: cursor-rapid-movement-128x128
[363.053941] Starting dynamic subtest: pipe-A-DP-3
[363.551714] Dynamic subtest pipe-A-DP-3: SUCCESS (0.497s)
[363.601757] Starting dynamic subtest: pipe-D-DP-3
[363.966488] Dynamic subtest pipe-D-DP-3: SUCCESS (0.374s)
[363.967508] Subtest cursor-rapid-movement-128x128: SUCCESS (0.916s)
[364.475644] [082/133] (662s left) gem_fence_thrash (bo-copy)
[364.523370] Starting subtest: bo-copy
[364.550460] Subtest bo-copy: SKIP (0.027s)
[364.620245] [083/133] (662s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[364.700433] Starting subtest: multi-wait-available-submitted-signaled
[364.701370] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[364.893934] [084/133] (661s left) kms_flip_tiling (flip-change-tiling)
[365.093461] Starting subtest: flip-change-tiling
[365.094372] Starting dynamic subtest: pipe-A-DP-3-4-to-4
[365.349414] Dynamic subtest pipe-A-DP-3-4-to-4: SUCCESS (0.248s)
[365.387665] Starting dynamic subtest: pipe-A-DP-3-4-to-x
[365.559018] Dynamic subtest pipe-A-DP-3-4-to-x: SUCCESS (0.212s)
[365.576577] Starting dynamic subtest: pipe-A-DP-3-4-to-linear
[365.743288] Dynamic subtest pipe-A-DP-3-4-to-linear: SUCCESS (0.182s)
[365.788942] Starting dynamic subtest: pipe-A-DP-3-x-to-4
[365.960121] Dynamic subtest pipe-A-DP-3-x-to-4: SUCCESS (0.212s)
[366.004357] Starting dynamic subtest: pipe-A-DP-3-x-to-x
[366.143206] Dynamic subtest pipe-A-DP-3-x-to-x: SUCCESS (0.178s)
[366.188419] Starting dynamic subtest: pipe-A-DP-3-x-to-linear
[366.368892] Dynamic subtest pipe-A-DP-3-x-to-linear: SUCCESS (0.212s)
[366.406034] Starting dynamic subtest: pipe-A-DP-3-linear-to-4
[366.576686] Dynamic subtest pipe-A-DP-3-linear-to-4: SUCCESS (0.212s)
[366.592417] Starting dynamic subtest: pipe-A-DP-3-linear-to-x
[366.765681] Dynamic subtest pipe-A-DP-3-linear-to-x: SUCCESS (0.179s)
[366.805062] Starting dynamic subtest: pipe-A-DP-3-linear-to-linear
[366.943136] Dynamic subtest pipe-A-DP-3-linear-to-linear: SUCCESS (0.179s)
[367.009642] Starting dynamic subtest: pipe-B-DP-3-4-to-4
[367.329554] Dynamic subtest pipe-B-DP-3-4-to-4: SUCCESS (0.328s)
[367.367150] Starting dynamic subtest: pipe-B-DP-3-4-to-x
[367.489284] Dynamic subtest pipe-B-DP-3-4-to-x: SUCCESS (0.162s)
[367.515527] Starting dynamic subtest: pipe-B-DP-3-4-to-linear
[367.639340] Dynamic subtest pipe-B-DP-3-4-to-linear: SUCCESS (0.148s)
[367.669596] Starting dynamic subtest: pipe-B-DP-3-x-to-4
[367.789276] Dynamic subtest pipe-B-DP-3-x-to-4: SUCCESS (0.148s)
[367.805738] Starting dynamic subtest: pipe-B-DP-3-x-to-x
[367.922626] Dynamic subtest pipe-B-DP-3-x-to-x: SUCCESS (0.131s)
[367.949329] Starting dynamic subtest: pipe-B-DP-3-x-to-linear
[368.072627] Dynamic subtest pipe-B-DP-3-x-to-linear: SUCCESS (0.148s)
[368.103063] Starting dynamic subtest: pipe-B-DP-3-linear-to-4
[368.222625] Dynamic subtest pipe-B-DP-3-linear-to-4: SUCCESS (0.148s)
[368.248739] Starting dynamic subtest: pipe-B-DP-3-linear-to-x
[368.372524] Dynamic subtest pipe-B-DP-3-linear-to-x: SUCCESS (0.148s)
[368.398824] Starting dynamic subtest: pipe-B-DP-3-linear-to-linear
[368.522832] Dynamic subtest pipe-B-DP-3-linear-to-linear: SUCCESS (0.148s)
[368.597106] Starting dynamic subtest: pipe-C-DP-3-4-to-4
[368.925966] Dynamic subtest pipe-C-DP-3-4-to-4: SUCCESS (0.357s)
[368.963365] Starting dynamic subtest: pipe-C-DP-3-4-to-x
[369.085345] Dynamic subtest pipe-C-DP-3-4-to-x: SUCCESS (0.162s)
[369.116876] Starting dynamic subtest: pipe-C-DP-3-4-to-linear
[369.235002] Dynamic subtest pipe-C-DP-3-4-to-linear: SUCCESS (0.148s)
[369.259109] Starting dynamic subtest: pipe-C-DP-3-x-to-4
[369.385459] Dynamic subtest pipe-C-DP-3-x-to-4: SUCCESS (0.148s)
[369.403315] Starting dynamic subtest: pipe-C-DP-3-x-to-x
[369.518650] Dynamic subtest pipe-C-DP-3-x-to-x: SUCCESS (0.131s)
[369.544900] Starting dynamic subtest: pipe-C-DP-3-x-to-linear
[369.668660] Dynamic subtest pipe-C-DP-3-x-to-linear: SUCCESS (0.148s)
[369.699065] Starting dynamic subtest: pipe-C-DP-3-linear-to-4
[369.818474] Dynamic subtest pipe-C-DP-3-linear-to-4: SUCCESS (0.148s)
[369.841673] Starting dynamic subtest: pipe-C-DP-3-linear-to-x
[369.968873] Dynamic subtest pipe-C-DP-3-linear-to-x: SUCCESS (0.148s)
[369.999275] Starting dynamic subtest: pipe-C-DP-3-linear-to-linear
[370.118655] Dynamic subtest pipe-C-DP-3-linear-to-linear: SUCCESS (0.148s)
[370.165012] Starting dynamic subtest: pipe-D-DP-3-4-to-4
[370.486911] Dynamic subtest pipe-D-DP-3-4-to-4: SUCCESS (0.328s)
[370.532880] Starting dynamic subtest: pipe-D-DP-3-4-to-x
[370.651893] Dynamic subtest pipe-D-DP-3-4-to-x: SUCCESS (0.162s)
[370.678914] Starting dynamic subtest: pipe-D-DP-3-4-to-linear
[370.781459] Dynamic subtest pipe-D-DP-3-4-to-linear: SUCCESS (0.132s)
[370.811635] Starting dynamic subtest: pipe-D-DP-3-x-to-4
[370.948498] Dynamic subtest pipe-D-DP-3-x-to-4: SUCCESS (0.165s)
[370.985247] Starting dynamic subtest: pipe-D-DP-3-x-to-x
[371.115002] Dynamic subtest pipe-D-DP-3-x-to-x: SUCCESS (0.164s)
[371.156300] Starting dynamic subtest: pipe-D-DP-3-x-to-linear
[371.281572] Dynamic subtest pipe-D-DP-3-x-to-linear: SUCCESS (0.164s)
[371.299415] Starting dynamic subtest: pipe-D-DP-3-linear-to-4
[371.414698] Dynamic subtest pipe-D-DP-3-linear-to-4: SUCCESS (0.131s)
[371.437584] Starting dynamic subtest: pipe-D-DP-3-linear-to-x
[371.565001] Dynamic subtest pipe-D-DP-3-linear-to-x: SUCCESS (0.148s)
[371.595879] Starting dynamic subtest: pipe-D-DP-3-linear-to-linear
[371.714975] Dynamic subtest pipe-D-DP-3-linear-to-linear: SUCCESS (0.148s)
[371.747967] Subtest flip-change-tiling: SUCCESS (6.655s)
[372.096332] [085/133] (654s left) gem_ccs (block-copy-uncompressed)
[372.178260] Starting subtest: block-copy-uncompressed
[372.180506] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[372.225098] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.046s)
[372.237002] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-lmem0
[372.241489] Dynamic subtest linear-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.015s)
[372.255452] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-smem
[372.352520] Dynamic subtest linear-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s)
[372.365968] Starting dynamic subtest: linear-uncompressed-compfmt0-lmem0-lmem0
[372.460221] Dynamic subtest linear-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.107s)
[372.473332] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[372.476773] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[372.489919] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-lmem0
[372.492241] Dynamic subtest xmajor-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[372.505417] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-smem
[372.597627] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.104s)
[372.610896] Starting dynamic subtest: xmajor-uncompressed-compfmt0-lmem0-lmem0
[372.703378] Dynamic subtest xmajor-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.105s)
[372.716448] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[372.719757] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[372.732701] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-lmem0
[372.735039] Dynamic subtest tile4-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[372.748212] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-smem
[372.846030] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.110s)
[372.859670] Starting dynamic subtest: tile4-uncompressed-compfmt0-lmem0-lmem0
[372.949592] Dynamic subtest tile4-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.102s)
[372.962595] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[372.965733] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.015s)
[372.979101] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-lmem0
[372.981219] Dynamic subtest tile64-uncompressed-compfmt0-smem-lmem0: SUCCESS (0.014s)
[372.994513] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-smem
[373.095312] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-smem: SUCCESS (0.113s)
[373.108998] Starting dynamic subtest: tile64-uncompressed-compfmt0-lmem0-lmem0
[373.201510] Dynamic subtest tile64-uncompressed-compfmt0-lmem0-lmem0: SUCCESS (0.105s)
[373.202441] Subtest block-copy-uncompressed: SUCCESS (1.024s)
[373.416800] [086/133] (653s left) kms_pm_rpm (dpms-lpsp)
[375.720156] Starting subtest: dpms-lpsp
[375.723777] Subtest dpms-lpsp: SKIP (0.001s)
[376.133509] [087/133] (650s left) kms_chamelium_hpd (common-hpd-after-suspend)
[376.397193] Subtest common-hpd-after-suspend: SKIP (0.000s)
[376.547600] [088/133] (650s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[376.731587] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[376.732517] Starting dynamic subtest: pipe-A
[377.322743] Dynamic subtest pipe-A: SUCCESS (0.590s)
[377.354760] Starting dynamic subtest: pipe-B
[377.969580] Dynamic subtest pipe-B: SUCCESS (0.645s)
[377.984725] Starting dynamic subtest: pipe-C
[378.600356] Dynamic subtest pipe-C: SUCCESS (0.629s)
[378.618396] Starting dynamic subtest: pipe-D
[379.232529] Dynamic subtest pipe-D: SUCCESS (0.630s)
[379.233675] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (2.502s)
[379.586861] [089/133] (647s left) kms_cursor_edge_walk (64x64-left-edge)
[379.775069] Starting subtest: 64x64-left-edge
[379.777307] Starting dynamic subtest: pipe-A-DP-3
[383.251723] Dynamic subtest pipe-A-DP-3: SUCCESS (3.474s)
[383.267634] Starting dynamic subtest: pipe-D-DP-3
[386.577901] Dynamic subtest pipe-D-DP-3: SUCCESS (3.323s)
[386.578894] Subtest 64x64-left-edge: SUCCESS (6.802s)
[386.861521] [090/133] (640s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[387.057170] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[388.330081] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.272s)
[388.599638] [091/133] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[388.791335] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[388.793088] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[388.980469] [092/133] (638s left) kms_lease (lease-uevent)
[389.166462] Starting subtest: lease-uevent
[390.185641] Subtest lease-uevent: SUCCESS (1.020s)
[390.354741] [093/133] (637s left) gem_exec_schedule (u-semaphore-resolve)
[390.446531] Starting subtest: u-semaphore-resolve
[390.528205] Subtest u-semaphore-resolve: SUCCESS (0.081s)
[390.943994] [094/133] (636s left) kms_force_connector_basic (prune-stale-modes)
[391.049348] Starting subtest: prune-stale-modes
[391.071859] Subtest prune-stale-modes: SUCCESS (0.023s)
[391.395186] [095/133] (636s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[391.581476] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[391.582396] Starting dynamic subtest: pipe-A-DP-3
[391.585928] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[391.598030] Starting dynamic subtest: pipe-B-DP-3
[391.601474] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[391.613270] Starting dynamic subtest: pipe-C-DP-3
[391.616503] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[391.628128] Starting dynamic subtest: pipe-D-DP-3
[391.631548] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[391.633221] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[392.073356] [096/133] (635s left) kms_content_protection (content-type-change)
[392.331824] Starting subtest: content-type-change
[392.339050] Subtest content-type-change: SKIP (0.003s)
[392.558600] [097/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[392.751037] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[392.752840] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[392.940878] [098/133] (634s left) i915_pm_rps (min-max-config-loaded)
[393.029438] Starting subtest: min-max-config-loaded
[393.031389] Subtest min-max-config-loaded: SKIP (0.000s)
[393.193668] [099/133] (634s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[393.384114] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[396.107010] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.724s)
[396.357560] [100/133] (631s left) gem_ctx_persistence (legacy-engines-cleanup)
[396.441144] Starting subtest: legacy-engines-cleanup
[396.442258] Starting dynamic subtest: render
[396.553439] Dynamic subtest render: SUCCESS (0.111s)
[396.577994] Starting dynamic subtest: bsd1
[396.614116] Dynamic subtest bsd1: SUCCESS (0.058s)
[396.658727] Starting dynamic subtest: bsd2
[396.692530] Dynamic subtest bsd2: SUCCESS (0.074s)
[396.713964] Starting dynamic subtest: blt
[396.755970] Dynamic subtest blt: SUCCESS (0.061s)
[396.776161] Starting dynamic subtest: vebox
[396.814434] Dynamic subtest vebox: SUCCESS (0.055s)
[396.815482] Subtest legacy-engines-cleanup: SUCCESS (0.374s)
[397.025295] [101/133] (631s left) perf (rc6-disable)
[397.451317] Starting subtest: rc6-disable
[397.640343] Subtest rc6-disable: SUCCESS (0.188s)
[397.724942] [102/133] (630s left) kms_color (legacy-gamma-reset)
[397.910752] Starting subtest: legacy-gamma-reset
[397.911674] Starting dynamic subtest: pipe-A-DP-3
[398.144940] Dynamic subtest pipe-A-DP-3: SUCCESS (0.234s)
[398.159215] Starting dynamic subtest: pipe-B-DP-3
[398.166999] Dynamic subtest pipe-B-DP-3: SUCCESS (0.021s)
[398.180472] Starting dynamic subtest: pipe-C-DP-3
[398.188228] Dynamic subtest pipe-C-DP-3: SUCCESS (0.020s)
[398.201422] Starting dynamic subtest: pipe-D-DP-3
[398.209248] Dynamic subtest pipe-D-DP-3: SUCCESS (0.020s)
[398.210203] Subtest legacy-gamma-reset: SUCCESS (0.299s)
[398.466470] [103/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[398.657273] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[398.659015] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[398.880434] [104/133] (629s left) gem_exec_alignment (forked)
[398.962032] Starting subtest: forked
[443.093803] Subtest forked: SUCCESS (44.132s)
[443.647264] [105/133] (584s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[443.883618] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[443.974807] [106/133] (584s left) gem_exec_fence (concurrent)
[444.185649] Starting subtest: concurrent
[444.187747] Subtest concurrent: SKIP (0.000s)
[444.968167] [107/133] (583s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[445.160509] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[445.241417] [108/133] (583s left) prime_self_import (reimport-vs-gem_close-race)
[445.290532] Starting subtest: reimport-vs-gem_close-race
[450.388414] Subtest reimport-vs-gem_close-race: SUCCESS (5.098s)
[450.560720] [109/133] (578s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[450.778252] Starting subtest: plane-downscale-factor-0-5-with-rotation
[450.779063] Starting dynamic subtest: pipe-A
[451.150456] Dynamic subtest pipe-A: SUCCESS (0.372s)
[451.181167] Starting dynamic subtest: pipe-B
[451.649465] Dynamic subtest pipe-B: SUCCESS (0.496s)
[451.679096] Starting dynamic subtest: pipe-C
[452.127631] Dynamic subtest pipe-C: SUCCESS (0.476s)
[452.155569] Starting dynamic subtest: pipe-D
[452.607606] Dynamic subtest pipe-D: SUCCESS (0.478s)
[452.608580] Subtest plane-downscale-factor-0-5-with-rotation: SUCCESS (1.831s)
[452.971893] [110/133] (575s left) kms_invalid_mode (uint-max-clock)
[453.160182] Starting subtest: uint-max-clock
[453.162008] Starting dynamic subtest: pipe-A-DP-3
[453.249731] Dynamic subtest pipe-A-DP-3: SUCCESS (0.088s)
[453.270427] Starting dynamic subtest: pipe-B-DP-3
[453.271493] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[453.288452] Starting dynamic subtest: pipe-C-DP-3
[453.289437] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[453.302056] Starting dynamic subtest: pipe-D-DP-3
[453.302889] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[453.303718] Subtest uint-max-clock: SUCCESS (0.101s)
[453.534405] [111/133] (575s left) syncobj_timeline (signal-array)
[453.629754] Starting subtest: signal-array
[453.630653] Subtest signal-array: SUCCESS (0.000s)
[453.856879] [112/133] (575s left) kms_big_fb (linear-8bpp-rotate-0)
[454.056976] Starting subtest: linear-8bpp-rotate-0
[455.634467] Subtest linear-8bpp-rotate-0: SUCCESS (1.577s)
[455.837187] [113/133] (573s left) gem_pxp (verify-pxp-stale-buf-execution)
[458.445215] Starting subtest: verify-pxp-stale-buf-execution
[458.447372] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[458.584573] [114/133] (570s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[458.770393] Starting subtest: 2x-long-cursor-vs-flip-atomic
[458.773343] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[458.909343] [115/133] (570s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[459.104573] Starting subtest: x-tiled-32bpp-rotate-270
[459.168643] Subtest x-tiled-32bpp-rotate-270: SKIP (0.063s)
[459.386614] [116/133] (569s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[459.573327] Starting subtest: primary-x-tiled-reflect-x-180
[469.938883] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.365s)
[470.350591] [117/133] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[470.541049] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[470.542672] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[470.727562] [118/133] (558s left) kms_atomic_transition (modeset-transition)
[470.917431] Starting subtest: modeset-transition
[470.918305] Starting dynamic subtest: 1x-outputs
[473.529812] Dynamic subtest 1x-outputs: SUCCESS (2.612s)
[473.530673] Subtest modeset-transition: SUCCESS (2.613s)
[473.804678] [119/133] (555s left) i915_drm_fdinfo (busy)
[473.876385] Starting subtest: busy
[473.877454] Starting dynamic subtest: rcs0
[473.897325] Dynamic subtest rcs0: SKIP (0.021s)
[473.910077] Starting dynamic subtest: bcs0
[473.911762] Dynamic subtest bcs0: SKIP (0.000s)
[473.924616] Starting dynamic subtest: vcs0
[473.927117] Dynamic subtest vcs0: SKIP (0.000s)
[473.939227] Starting dynamic subtest: vcs1
[473.941650] Dynamic subtest vcs1: SKIP (0.000s)
[473.953583] Starting dynamic subtest: vecs0
[473.955844] Dynamic subtest vecs0: SKIP (0.000s)
[473.967834] Starting dynamic subtest: vecs1
[473.970695] Dynamic subtest vecs1: SKIP (0.000s)
[473.984270] Starting dynamic subtest: ccs0
[473.986645] Dynamic subtest ccs0: SKIP (0.000s)
[473.988915] Subtest busy: SKIP (0.030s)
[474.036083] [120/133] (555s left) api_intel_bb (object-noreloc-keep-cache-simple)
[474.111544] Starting subtest: object-noreloc-keep-cache-simple
[474.141007] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.030s)
[474.345743] [121/133] (555s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[474.540328] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[474.542163] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[474.713228] [122/133] (555s left) gem_userptr_blits (stress-mm-invalidate-close)
[474.801783] Starting subtest: stress-mm-invalidate-close
[476.950155] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[477.149355] [123/133] (552s left) gem_exec_capture (userptr)
[477.240030] Starting subtest: userptr
[478.207537] Subtest userptr: SUCCESS (0.968s)
[478.389220] [124/133] (551s left) gem_softpin (allocator-nopin)
[478.472043] Starting subtest: allocator-nopin
[478.711284] Subtest allocator-nopin: SUCCESS (0.239s)
[478.899347] [125/133] (551s left) syncobj_timeline (wait-delayed-signal)
[478.975393] Starting subtest: wait-delayed-signal
[479.079112] Subtest wait-delayed-signal: SUCCESS (0.103s)
[479.279873] [126/133] (550s left) gem_ctx_bad_destroy (invalid-pad)
[479.360896] Starting subtest: invalid-pad
[479.361795] Subtest invalid-pad: SUCCESS (0.000s)
[479.516151] [127/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[479.705200] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[479.706902] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[479.888824] [128/133] (550s left) kms_dp_link_training (uhbr-mst)
[480.074292] Starting subtest: uhbr-mst
[480.075913] Subtest uhbr-mst: SKIP (0.000s)
[480.214755] [129/133] (550s left) vgem_basic (unload)
[480.262187] Starting subtest: unload
[509.346548] Subtest unload: SUCCESS (29.083s)
[509.521997] [130/133] (520s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[509.605620] Starting subtest: y-tiled-ccs-to-x-tiled
[509.607662] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[509.841848] [131/133] (520s left) kms_scaling_modes (scaling-mode-none)
[510.024918] Starting subtest: scaling-mode-none
[510.029903] Subtest scaling-mode-none: SKIP (0.001s)
[510.187959] [132/133] (520s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[510.381966] Starting subtest: y-tiled-addfb-size-offset-overflow
[510.383628] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[510.576852] [133/133] (520s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[510.771467] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[510.787116] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[510.938081] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gen7_exec_parse
results: parsing output: 2/ for test: gem_mmap
results: parsing output: 3/ for test: dumb_buffer
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_async_flips
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: gem_watchdog
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: gem_softpin
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_universal_plane
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_vrr
results: parsing output: 27/ for test: gem_exec_store
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: api_intel_allocator
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: i915_pm_rps
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: gem_ctx_exec
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: drm_read
results: parsing output: 39/ for test: kms_multipipe_modeset
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_properties
results: parsing output: 45/ for test: gem_sync
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: gem_cs_tlb
results: parsing output: 49/ for test: gem_userptr_blits
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: syncobj_eventfd
results: parsing output: 53/ for test: kms_draw_crc
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: gem_exec_await
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: prime_vgem
results: parsing output: 62/ for test: i915_module_load
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_getfb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_create
results: parsing output: 74/ for test: kms_chamelium_color
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: prime_vgem
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_ctx_freq
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: gem_fence_thrash
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_flip_tiling
results: parsing output: 84/ for test: gem_ccs
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: kms_chamelium_hpd
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_cursor_edge_walk
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_lease
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_force_connector_basic
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_ctx_persistence
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_color
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_alignment
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_exec_fence
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_self_import
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: kms_invalid_mode
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_pxp
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: i915_drm_fdinfo
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gem_ctx_bad_destroy
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_dp_link_training
results: parsing output: 128/ for test: vgem_basic
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_flip
Done.