[63.370077] Initializing watchdogs
[63.370143]   /dev/watchdog0
[63.389414] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[63.400863] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.404379] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.406703] [001/133] (960s left) kms_pm_rpm (pc8-residency)
[65.046152] Starting subtest: pc8-residency
[65.049632] Subtest pc8-residency: SKIP (0.000s)
[65.383315] [002/133] (958s left) gem_exec_schedule (preempt-other)
[65.490054] Starting subtest: preempt-other
[65.491039] Starting dynamic subtest: rcs0
[66.046817] Dynamic subtest rcs0: SUCCESS (0.556s)
[66.055510] Starting dynamic subtest: bcs0
[66.581663] Dynamic subtest bcs0: SUCCESS (0.534s)
[66.590051] Starting dynamic subtest: vcs0
[67.164419] Dynamic subtest vcs0: SUCCESS (0.582s)
[67.173022] Starting dynamic subtest: vcs1
[67.712769] Dynamic subtest vcs1: SUCCESS (0.547s)
[67.720908] Starting dynamic subtest: vecs0
[68.252268] Dynamic subtest vecs0: SUCCESS (0.538s)
[68.260153] Starting dynamic subtest: vecs1
[68.777489] Dynamic subtest vecs1: SUCCESS (0.524s)
[68.785784] Starting dynamic subtest: ccs0
[69.641605] Dynamic subtest ccs0: SUCCESS (0.863s)
[69.642618] Subtest preempt-other: SUCCESS (4.146s)
[70.069614] [003/133] (953s left) sw_sync (alloc_merge_fence)
[70.113011] Starting subtest: alloc_merge_fence
[70.114032] Subtest alloc_merge_fence: SUCCESS (0.000s)
[70.235651] [004/133] (953s left) i915_pm_rps (thresholds)
[70.313633] Starting subtest: thresholds
[70.315594] Subtest thresholds: SKIP (0.000s)
[70.452933] [005/133] (953s left) gem_softpin (noreloc)
[70.529993] Starting subtest: noreloc
[76.009629] Subtest noreloc: SUCCESS (5.475s)
[76.174159] [006/133] (948s left) kms_big_fb (linear-8bpp-rotate-180)
[76.367127] Starting subtest: linear-8bpp-rotate-180
[77.953902] Subtest linear-8bpp-rotate-180: SUCCESS (1.585s)
[78.198488] [007/133] (946s left) syncobj_timeline (wait-zero-handles)
[78.266890] Starting subtest: wait-zero-handles
[78.267808] Subtest wait-zero-handles: SUCCESS (0.000s)
[78.448282] [008/133] (945s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[78.625889] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[78.627601] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[78.779935] [009/133] (945s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[78.963633] Starting subtest: pipe-fbc-rte
[78.968520] Subtest pipe-fbc-rte: SKIP (0.000s)
[79.146626] [010/133] (945s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[79.323212] Starting subtest: plane-upscale-20x20-with-pixel-format
[79.324017] Starting dynamic subtest: pipe-A
[80.936588] Dynamic subtest pipe-A: SUCCESS (1.613s)
[80.956527] Starting dynamic subtest: pipe-B
[82.650520] Dynamic subtest pipe-B: SUCCESS (1.713s)
[82.669435] Starting dynamic subtest: pipe-C
[82.963889] Dynamic subtest pipe-C: SUCCESS (0.313s)
[82.976557] Starting dynamic subtest: pipe-D
[83.260486] Dynamic subtest pipe-D: SUCCESS (0.296s)
[83.261666] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (3.936s)
[83.619491] [011/133] (940s left) gem_exec_balancer (bonded-chain)
[83.704387] Starting subtest: bonded-chain
[97.410876] Subtest bonded-chain: SUCCESS (13.704s)
[97.835939] [012/133] (926s left) kms_plane (pixel-format-yf-tiled-modifier)
[98.013906] Starting subtest: pixel-format-yf-tiled-modifier
[98.043067] Starting dynamic subtest: pipe-A-plane-0
[98.045138] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[98.053655] Starting dynamic subtest: pipe-A-plane-3
[98.055878] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[98.063908] Starting dynamic subtest: pipe-A-plane-5
[98.065583] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[98.272570] Starting dynamic subtest: pipe-B-plane-0
[98.274837] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[98.290066] Starting dynamic subtest: pipe-B-plane-3
[98.292271] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[98.307289] Starting dynamic subtest: pipe-B-plane-5
[98.309295] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[98.353075] Subtest pixel-format-yf-tiled-modifier: SKIP (0.338s)
[98.636059] [013/133] (926s left) gem_create (create-ext-set-pat)
[98.822064] Starting subtest: create-ext-set-pat
[98.824260] Subtest create-ext-set-pat: SKIP (0.000s)
[98.984568] [014/133] (925s left) kms_cursor_crc (cursor-onscreen-64x64)
[99.293095] Starting subtest: cursor-onscreen-64x64
[99.297055] Starting dynamic subtest: pipe-A-DP-3
[102.112319] Dynamic subtest pipe-A-DP-3: SUCCESS (2.814s)
[102.162550] Starting dynamic subtest: pipe-D-DP-3
[104.827934] Dynamic subtest pipe-D-DP-3: SUCCESS (2.672s)
[104.828961] Subtest cursor-onscreen-64x64: SUCCESS (5.534s)
[105.334667] [015/133] (919s left) kms_psr (pr-sprite-mmap-cpu)
[105.514753] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[105.572708] [016/133] (919s left) syncobj_timeline (etime-multi-wait-all-submitted)
[105.638065] Starting subtest: etime-multi-wait-all-submitted
[105.741146] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s)
[105.902999] [017/133] (919s left) gem_exec_fence (syncobj-signal)
[106.494641] Starting subtest: syncobj-signal
[106.523579] Subtest syncobj-signal: SUCCESS (0.029s)
[106.982322] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[106.983981] [018/133] (918s left) i915_hangman (gt-engine-hang)
[107.082069] Starting subtest: gt-engine-hang
[107.082991] Starting dynamic subtest: rcs0
[107.935145] Dynamic subtest rcs0: SUCCESS (0.853s)
[107.946384] Starting dynamic subtest: bcs0
[108.742440] Dynamic subtest bcs0: SUCCESS (0.807s)
[108.751132] Starting dynamic subtest: vcs0
[109.545368] Dynamic subtest vcs0: SUCCESS (0.802s)
[109.555988] Starting dynamic subtest: vcs1
[110.386604] Dynamic subtest vcs1: SUCCESS (0.841s)
[110.397452] Starting dynamic subtest: vecs0
[111.191366] Dynamic subtest vecs0: SUCCESS (0.804s)
[111.200231] Starting dynamic subtest: vecs1
[112.024502] Dynamic subtest vecs1: SUCCESS (0.833s)
[112.034113] Starting dynamic subtest: ccs0
[112.853363] Dynamic subtest ccs0: SUCCESS (0.828s)
[112.854343] Subtest gt-engine-hang: SUCCESS (5.771s)
[113.013637] [019/133] (912s left) kms_addfb_basic (addfb25-bad-modifier)
[113.197421] Starting subtest: addfb25-bad-modifier
[113.198357] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[113.386253] [020/133] (911s left) kms_tiled_display (basic-test-pattern)
[113.648762] Subtest basic-test-pattern: SKIP (0.000s)
[113.710516] [021/133] (911s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[113.900933] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[113.902702] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[114.101590] [022/133] (911s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[114.287362] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[114.343913] [023/133] (911s left) perf_pmu (interrupts-sync)
[114.414869] Starting subtest: interrupts-sync
[115.593374] Subtest interrupts-sync: SUCCESS (1.177s)
[115.751558] [024/133] (909s left) gem_exec_balancer (smoke)
[115.842735] Starting subtest: smoke
[139.331662] Subtest smoke: SUCCESS (23.487s)
[140.234726] [025/133] (885s left) gem_exec_reloc (basic-write-wc-noreloc)
[140.317469] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[140.396550] [026/133] (885s left) gem_exec_capture (userptr)
[140.481431] Starting subtest: userptr
[141.435527] Subtest userptr: SUCCESS (0.954s)
[141.630240] [027/133] (884s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[141.816362] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[141.817980] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[142.018464] [028/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[142.208543] Starting subtest: psr-1p-primscrn-spr-indfb-move
[142.210211] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[142.405516] [029/133] (883s left) gem_exec_schedule (submit-early-slice)
[142.494373] Starting subtest: submit-early-slice
[142.495305] Starting dynamic subtest: rcs0
[142.571445] Dynamic subtest rcs0: SUCCESS (0.077s)
[142.581083] Starting dynamic subtest: bcs0
[142.624266] Dynamic subtest bcs0: SUCCESS (0.053s)
[142.634116] Starting dynamic subtest: vcs0
[142.675065] Dynamic subtest vcs0: SUCCESS (0.050s)
[142.684524] Starting dynamic subtest: vcs1
[142.729779] Dynamic subtest vcs1: SUCCESS (0.054s)
[142.739254] Starting dynamic subtest: vecs0
[142.780944] Dynamic subtest vecs0: SUCCESS (0.051s)
[142.790150] Starting dynamic subtest: vecs1
[142.833312] Dynamic subtest vecs1: SUCCESS (0.052s)
[142.843477] Starting dynamic subtest: ccs0
[142.885160] Dynamic subtest ccs0: SUCCESS (0.051s)
[142.886135] Subtest submit-early-slice: SUCCESS (0.391s)
[143.367710] [030/133] (882s left) kms_cursor_legacy (single-bo)
[143.550849] Starting subtest: single-bo
[143.551762] Starting dynamic subtest: pipe-A
[148.931373] Dynamic subtest pipe-A: SUCCESS (5.379s)
[148.941153] Starting dynamic subtest: pipe-B
[154.310469] Dynamic subtest pipe-B: SUCCESS (5.378s)
[154.319814] Starting dynamic subtest: pipe-C
[159.689559] Dynamic subtest pipe-C: SUCCESS (5.379s)
[159.698817] Starting dynamic subtest: pipe-D
[165.068413] Dynamic subtest pipe-D: SUCCESS (5.378s)
[165.078059] Starting dynamic subtest: all-pipes
[170.447951] Dynamic subtest all-pipes: SUCCESS (5.379s)
[170.448964] Subtest single-bo: SUCCESS (26.895s)
[170.554800] [031/133] (855s left) kms_plane_alpha_blend (alpha-opaque-fb)
[170.739383] Starting subtest: alpha-opaque-fb
[170.989030] Starting dynamic subtest: pipe-A-DP-3
[171.498626] Dynamic subtest pipe-A-DP-3: SUCCESS (0.509s)
[171.509025] Starting dynamic subtest: pipe-D-DP-3
[172.095358] Dynamic subtest pipe-D-DP-3: SUCCESS (0.595s)
[172.096221] Subtest alpha-opaque-fb: SUCCESS (1.355s)
[172.409869] [032/133] (853s left) kms_rotation_crc (sprite-rotation-90)
[172.598185] Starting subtest: sprite-rotation-90
[172.599987] Subtest sprite-rotation-90: SKIP (0.001s)
[172.746532] [033/133] (853s left) kms_content_protection (lic-type-0)
[172.991153] Starting subtest: lic-type-0
[173.017446] Starting dynamic subtest: pipe-A-DP-3
[294.205128] Dynamic subtest pipe-A-DP-3: FAIL (121.017s)
[294.206033] Subtest lic-type-0: FAIL (121.137s)
[294.432732] [034/133] (731s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[294.621009] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[294.672751] [035/133] (731s left) gem_softpin (evict-single-offset)
[294.753343] Starting subtest: evict-single-offset
[328.217164] Subtest evict-single-offset: SUCCESS (33.463s)
[328.347763] [036/133] (697s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[328.449525] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[328.556259] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[328.661452] [037/133] (697s left) gem_tiling_max_stride
[328.838988] [038/133] (697s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[329.057178] Starting subtest: 4-tiled-32bpp-rotate-0
[330.865036] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.808s)
[331.063759] [039/133] (695s left) kms_flip (2x-flip-vs-rmfb)
[331.246394] Starting subtest: 2x-flip-vs-rmfb
[331.261218] Subtest 2x-flip-vs-rmfb: SKIP (0.014s)
[331.447068] [040/133] (695s left) gem_pxp (fail-invalid-protected-context)
[334.049066] Starting subtest: fail-invalid-protected-context
[334.051979] Subtest fail-invalid-protected-context: SKIP (0.000s)
[334.195081] [041/133] (692s left) syncobj_timeline (invalid-wait-illegal-handle)
[334.275160] Starting subtest: invalid-wait-illegal-handle
[334.276160] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[334.465174] [042/133] (692s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[334.545992] Starting subtest: y-tiled-ccs-to-x-tiled
[334.548169] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[334.796576] [043/133] (691s left) i915_pm_rpm (sysfs-read)
[337.010259] Starting subtest: sysfs-read
[337.348618] Subtest sysfs-read: SUCCESS (0.336s)
[337.818786] [044/133] (688s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[338.010638] Starting subtest: psr-rgb101010-draw-render
[338.012383] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[338.203547] [045/133] (688s left) kms_flip (2x-wf_vblank-ts-check)
[338.398657] Starting subtest: 2x-wf_vblank-ts-check
[338.413610] Subtest 2x-wf_vblank-ts-check: SKIP (0.015s)
[338.571856] [046/133] (688s left) kms_busy (basic)
[338.764059] Starting subtest: basic
[338.765071] Starting dynamic subtest: flip
[339.414845] Dynamic subtest flip: SUCCESS (0.650s)
[339.430546] Starting dynamic subtest: modeset
[340.374055] Dynamic subtest modeset: SUCCESS (0.959s)
[340.375250] Subtest basic: SUCCESS (1.611s)
[340.697797] [047/133] (686s left) gem_exec_params (dr4-dirt)
[340.779274] Starting subtest: DR4-dirt
[340.780471] Subtest DR4-dirt: SUCCESS (0.000s)
[340.930821] [048/133] (686s left) prime_busy (before)
[341.016461] Starting subtest: before
[341.021213] Starting dynamic subtest: rcs0
[341.074500] Dynamic subtest rcs0: SUCCESS (0.053s)
[341.085273] Starting dynamic subtest: bcs0
[341.146936] Dynamic subtest bcs0: SUCCESS (0.072s)
[341.183083] Starting dynamic subtest: vcs0
[341.190296] Dynamic subtest vcs0: SUCCESS (0.042s)
[341.208799] Starting dynamic subtest: vcs1
[341.230669] Dynamic subtest vcs1: SUCCESS (0.040s)
[341.242180] Starting dynamic subtest: vecs0
[341.270624] Dynamic subtest vecs0: SUCCESS (0.039s)
[341.288906] Starting dynamic subtest: vecs1
[341.311867] Dynamic subtest vecs1: SUCCESS (0.040s)
[341.333601] Starting dynamic subtest: ccs0
[341.353419] Dynamic subtest ccs0: SUCCESS (0.041s)
[341.461108] Subtest before: SUCCESS (0.444s)
[341.682702] [049/133] (685s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[341.875241] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[343.150110] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.274s)
[343.407111] [050/133] (683s left) kms_prop_blob (invalid-set-prop-any)
[343.484161] Starting subtest: invalid-set-prop-any
[343.485134] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[343.630749] [051/133] (683s left) kms_flip (flip-vs-modeset-vs-hang)
[343.810424] Starting subtest: flip-vs-modeset-vs-hang
[343.812467] Starting dynamic subtest: A-DP3
[395.519865] Dynamic subtest A-DP3: SUCCESS (51.706s)
[395.530840] Starting dynamic subtest: D-DP3
[445.500530] Dynamic subtest D-DP3: SUCCESS (49.978s)
[445.501440] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.689s)
[445.768798] [052/133] (581s left) kms_cursor_crc (cursor-random-512x170)
[446.237195] Starting subtest: cursor-random-512x170
[446.239050] Subtest cursor-random-512x170: SKIP (0.001s)
[446.524573] [053/133] (580s left) syncobj_wait (wait-all-for-submit-complex)
[446.609287] Starting subtest: wait-all-for-submit-complex
[446.827888] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[446.950965] [054/133] (580s left) gem_exec_whisper (basic-normal)
[447.044480] Starting subtest: basic-normal
[450.275700] Subtest basic-normal: SUCCESS (3.230s)
[450.534727] [055/133] (576s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[450.723925] Starting subtest: plane-lut1d-ctm3x4
[450.755455] Starting dynamic subtest: pipe-A-DP-3
[451.138181] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s)
[451.340776] Starting dynamic subtest: pipe-B-DP-3
[451.696545] Dynamic subtest pipe-B-DP-3: SUCCESS (0.365s)
[451.896619] Starting dynamic subtest: pipe-C-DP-3
[452.234922] Dynamic subtest pipe-C-DP-3: SUCCESS (0.349s)
[452.450637] Starting dynamic subtest: pipe-D-DP-3
[452.788664] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[452.848273] Subtest plane-lut1d-ctm3x4: SUCCESS (2.123s)
[453.167747] [056/133] (574s left) gem_lmem_swapping (basic)
[455.922527] Starting subtest: basic
[455.923415] Starting dynamic subtest: lmem0
[476.478352] Dynamic subtest lmem0: SUCCESS (20.551s)
[476.479299] Subtest basic: SUCCESS (20.552s)
[478.563457] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[478.564456] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[478.566208] [057/133] (549s left) gem_mmap_gtt (big-bo-tiledx)
[480.166246] Subtest big-bo-tiledX: SKIP (0.000s)
[480.238933] [FACT gem_mmap_gtt (big-bo-tiledx)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[480.241286] [FACT gem_mmap_gtt (big-bo-tiledx)] new: kernel.kmod_is_loaded.i915: true
[480.244490] [058/133] (547s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[480.441151] Starting subtest: fbc-farfromfence-mmap-gtt
[480.442996] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[480.601555] [059/133] (547s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[480.786169] Starting subtest: cursorB-vs-flipB-legacy
[480.787928] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[480.956496] [060/133] (546s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[481.146180] Starting subtest: flip-vs-cursor-toggle
[493.161170] Subtest flip-vs-cursor-toggle: SUCCESS (12.015s)
[493.489746] [061/133] (534s left) kms_addfb_basic (small-bo)
[493.676211] Starting subtest: small-bo
[493.677160] Subtest small-bo: SUCCESS (0.000s)
[493.848904] [062/133] (534s left) gem_tiled_fence_blits (basic)
[493.937748] Subtest basic: SKIP (0.000s)
[494.002218] [063/133] (534s left) device_reset (unbind-reset-rebind)
[494.085464] Starting subtest: unbind-reset-rebind
[496.651861] Subtest unbind-reset-rebind: SUCCESS (2.565s)
[496.704310] [064/133] (531s left) tools_test (sysfs_l3_parity)
[496.758266] Starting subtest: sysfs_l3_parity
[496.827686] Subtest sysfs_l3_parity: SKIP (0.076s)
[496.972659] [065/133] (531s left) kms_big_fb (y-tiled-addfb)
[497.168152] Starting subtest: y-tiled-addfb
[497.170135] Subtest y-tiled-addfb: SKIP (0.000s)
[497.327491] [066/133] (530s left) gem_mmap_offset (partial-unmap)
[497.405292] Starting subtest: partial-unmap
[497.406254] Starting dynamic subtest: lmem0
[497.419129] Dynamic subtest lmem0: SUCCESS (0.014s)
[497.429980] Starting dynamic subtest: smem0
[497.431096] Dynamic subtest smem0: SUCCESS (0.004s)
[497.432382] Subtest partial-unmap: SUCCESS (0.019s)
[497.588471] [067/133] (530s left) kms_vrr (seamless-rr-switch-vrr)
[497.778424] Starting subtest: seamless-rr-switch-vrr
[497.781139] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[497.954272] [068/133] (530s left) kms_joiner (basic-max-non-joiner)
[498.146578] Starting subtest: basic-max-non-joiner
[498.148291] Subtest basic-max-non-joiner: SKIP (0.000s)
[498.280236] [069/133] (530s left) gem_ctx_exec (basic-norecovery)
[498.359116] Starting subtest: basic-norecovery
[498.683077] Subtest basic-norecovery: SUCCESS (0.323s)
[498.856598] [070/133] (529s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[499.051861] Starting subtest: x-tiled-16bpp-rotate-180
[500.810909] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.758s)
[501.060601] [071/133] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[501.249975] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[501.251588] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[501.414435] [072/133] (527s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[501.603928] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[502.684661] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.080s)
[503.014912] [073/133] (525s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[503.094364] Starting subtest: single-wait-all-for-submit-signaled
[503.095344] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[503.239899] [074/133] (525s left) kms_flip (dpms-vs-vblank-race-interruptible)
[503.437198] Starting subtest: dpms-vs-vblank-race-interruptible
[503.440778] Starting dynamic subtest: A-DP3
[506.698094] Dynamic subtest A-DP3: SUCCESS (3.256s)
[506.717607] Starting dynamic subtest: B-DP3
[509.712669] Dynamic subtest B-DP3: SUCCESS (3.013s)
[509.725375] Starting dynamic subtest: C-DP3
[512.772401] Dynamic subtest C-DP3: SUCCESS (3.057s)
[512.785748] Starting dynamic subtest: D-DP3
[515.794452] Dynamic subtest D-DP3: SUCCESS (3.021s)
[515.795342] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.359s)
[516.102243] [075/133] (512s left) gem_userptr_blits (sd-probe)
[516.191528] Starting subtest: sd-probe
[516.193281] Subtest sd-probe: SKIP (0.000s)
[516.386570] [076/133] (512s left) kms_psr (fbc-pr-cursor-blt)
[516.574672] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[516.627749] [077/133] (512s left) kms_chamelium_frames (vga-frame-dump)
[516.896131] Subtest vga-frame-dump: SKIP (0.000s)
[517.046633] [078/133] (512s left) kms_chamelium_frames (dp-crc-single)
[517.322557] Subtest dp-crc-single: SKIP (0.000s)
[517.480427] [079/133] (511s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[517.666735] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[517.669300] Starting dynamic subtest: pipe-A-DP-3
[517.672907] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[517.683818] Starting dynamic subtest: pipe-B-DP-3
[517.687303] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[517.698037] Starting dynamic subtest: pipe-C-DP-3
[517.701566] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[517.712133] Starting dynamic subtest: pipe-D-DP-3
[517.715578] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[517.717253] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[518.182679] [080/133] (511s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[518.379271] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[518.381045] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[518.567095] [081/133] (510s left) kms_lease (page-flip-implicit-plane)
[518.756648] Starting subtest: page-flip-implicit-plane
[518.759175] Starting dynamic subtest: pipe-A-DP-3
[519.162832] Dynamic subtest pipe-A-DP-3: SUCCESS (0.404s)
[519.181706] Starting dynamic subtest: pipe-B-DP-3
[519.507218] Dynamic subtest pipe-B-DP-3: SUCCESS (0.342s)
[519.522689] Starting dynamic subtest: pipe-C-DP-3
[519.837013] Dynamic subtest pipe-C-DP-3: SUCCESS (0.326s)
[519.853847] Starting dynamic subtest: pipe-D-DP-3
[520.170024] Dynamic subtest pipe-D-DP-3: SUCCESS (0.331s)
[520.171044] Subtest page-flip-implicit-plane: SUCCESS (1.414s)
[520.493617] [082/133] (508s left) gen7_exec_parse (cmd-crossing-page)
[520.582430] Subtest cmd-crossing-page: SKIP (0.000s)
[520.673539] [083/133] (508s left) kms_vblank (ts-continuation-modeset-rpm)
[520.859978] Starting subtest: ts-continuation-modeset-rpm
[520.862357] Starting dynamic subtest: pipe-A-DP-3
[523.363836] Dynamic subtest pipe-A-DP-3: SUCCESS (2.502s)
[523.386241] Starting dynamic subtest: pipe-D-DP-3
[524.241281] Dynamic subtest pipe-D-DP-3: SUCCESS (0.870s)
[524.242157] Subtest ts-continuation-modeset-rpm: SUCCESS (3.380s)
[524.520290] [084/133] (505s left) kms_psr (psr-cursor-plane-onoff)
[524.706544] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[524.762274] [085/133] (504s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[524.946432] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[524.968748] Starting dynamic subtest: pipe-A-plane-0
[524.970468] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[524.981315] Starting dynamic subtest: pipe-A-plane-3
[524.982995] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[524.995255] Starting dynamic subtest: pipe-A-plane-5
[524.997095] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.186489] Starting dynamic subtest: pipe-B-plane-0
[525.188488] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[525.206559] Starting dynamic subtest: pipe-B-plane-3
[525.208457] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[525.221604] Starting dynamic subtest: pipe-B-plane-5
[525.223914] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[525.259937] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.313s)
[525.540622] [086/133] (504s left) gem_exec_flush (basic-wb-prw-default)
[525.625502] Subtest basic-wb-prw-default: SKIP (0.000s)
[525.697876] [087/133] (504s left) gem_ctx_persistence (legacy-engines-mixed)
[525.782536] Starting subtest: legacy-engines-mixed
[525.783485] Starting dynamic subtest: render
[525.902389] Dynamic subtest render: SUCCESS (0.119s)
[525.922423] Starting dynamic subtest: bsd1
[525.968025] Dynamic subtest bsd1: SUCCESS (0.063s)
[526.011379] Starting dynamic subtest: bsd2
[526.057663] Dynamic subtest bsd2: SUCCESS (0.085s)
[526.093020] Starting dynamic subtest: blt
[526.132601] Dynamic subtest blt: SUCCESS (0.072s)
[526.158686] Starting dynamic subtest: vebox
[526.202604] Dynamic subtest vebox: SUCCESS (0.067s)
[526.203973] Subtest legacy-engines-mixed: SUCCESS (0.421s)
[526.439408] [088/133] (503s left) syncobj_basic (bad-flags-fd-to-handle)
[526.512550] Starting subtest: bad-flags-fd-to-handle
[526.513471] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[526.690444] [089/133] (503s left) api_intel_bb (crc32)
[526.763937] Starting subtest: crc32
[526.764875] Starting dynamic subtest: rcs0-lmem0
[527.048167] Dynamic subtest rcs0-lmem0: SUCCESS (0.282s)
[527.064952] Starting dynamic subtest: rcs0-smem0
[527.392725] Dynamic subtest rcs0-smem0: SUCCESS (0.340s)
[527.412513] Starting dynamic subtest: bcs0-lmem0
[527.666607] Dynamic subtest bcs0-lmem0: SUCCESS (0.269s)
[527.683582] Starting dynamic subtest: bcs0-smem0
[528.045916] Dynamic subtest bcs0-smem0: SUCCESS (0.374s)
[528.060790] Starting dynamic subtest: vcs0-lmem0
[528.439077] Dynamic subtest vcs0-lmem0: SUCCESS (0.388s)
[528.455977] Starting dynamic subtest: vcs0-smem0
[528.951200] Dynamic subtest vcs0-smem0: SUCCESS (0.507s)
[528.966365] Starting dynamic subtest: vcs1-lmem0
[529.339389] Dynamic subtest vcs1-lmem0: SUCCESS (0.383s)
[529.356656] Starting dynamic subtest: vcs1-smem0
[529.851196] Dynamic subtest vcs1-smem0: SUCCESS (0.506s)
[529.865958] Starting dynamic subtest: vecs0-lmem0
[530.240062] Dynamic subtest vecs0-lmem0: SUCCESS (0.384s)
[530.284640] Starting dynamic subtest: vecs0-smem0
[530.793584] Dynamic subtest vecs0-smem0: SUCCESS (0.546s)
[530.805227] Starting dynamic subtest: vecs1-lmem0
[531.194283] Dynamic subtest vecs1-lmem0: SUCCESS (0.399s)
[531.209107] Starting dynamic subtest: vecs1-smem0
[531.702380] Dynamic subtest vecs1-smem0: SUCCESS (0.504s)
[531.716961] Starting dynamic subtest: ccs0-lmem0
[531.983197] Dynamic subtest ccs0-lmem0: SUCCESS (0.276s)
[532.002973] Starting dynamic subtest: ccs0-smem0
[532.387619] Dynamic subtest ccs0-smem0: SUCCESS (0.399s)
[532.391521] Subtest crc32: SUCCESS (5.625s)
[532.572074] [090/133] (497s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[532.654576] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[532.656528] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[532.938347] [091/133] (497s left) gem_close_race (basic-process)
[533.055181] Starting subtest: basic-process
[533.124594] Subtest basic-process: SUCCESS (0.069s)
[533.421499] [092/133] (496s left) kms_plane_multiple (tiling-4)
[533.606785] Starting subtest: tiling-4
[533.609358] Starting dynamic subtest: pipe-A-DP-3
[534.768771] Dynamic subtest pipe-A-DP-3: SUCCESS (1.160s)
[534.783877] Starting dynamic subtest: pipe-B-DP-3
[535.863204] Dynamic subtest pipe-B-DP-3: SUCCESS (1.092s)
[535.874682] Starting dynamic subtest: pipe-C-DP-3
[536.939208] Dynamic subtest pipe-C-DP-3: SUCCESS (1.074s)
[536.950463] Starting dynamic subtest: pipe-D-DP-3
[538.010194] Dynamic subtest pipe-D-DP-3: SUCCESS (1.070s)
[538.011537] Subtest tiling-4: SUCCESS (4.403s)
[538.344590] [093/133] (491s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[538.536072] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[541.261720] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.726s)
[541.490653] [094/133] (488s left) gem_ccs (ctrl-surf-copy-new-ctx)
[541.575830] Starting subtest: ctrl-surf-copy-new-ctx
[541.578295] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[541.639283] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.062s)
[541.652179] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[541.881876] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.231s)
[541.893288] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[541.901720] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s)
[541.915062] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[542.144874] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.234s)
[542.156299] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[542.167487] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.029s)
[542.180369] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[542.403249] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.229s)
[542.414575] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[542.429141] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.030s)
[542.442144] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[542.659912] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.229s)
[542.660826] Subtest ctrl-surf-copy-new-ctx: SUCCESS (1.085s)
[542.845275] [095/133] (487s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[543.040253] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[543.042008] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[543.245794] [096/133] (487s left) gem_pxp (reject-modify-context-protection-off-1)
[545.850078] Starting subtest: reject-modify-context-protection-off-1
[545.852273] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[545.993977] [097/133] (484s left) kms_feature_discovery (display-2x)
[546.180455] Starting subtest: display-2x
[546.182256] Subtest display-2x: SKIP (0.000s)
[546.314202] [098/133] (484s left) prime_vgem (basic-gtt)
[546.413983] Starting subtest: basic-gtt
[546.416414] Subtest basic-gtt: SKIP (0.000s)
[546.611473] [099/133] (484s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[546.800924] Starting subtest: fbcpsr-rgb565-draw-pwrite
[546.802630] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[546.992350] [100/133] (483s left) kms_rotation_crc (sprite-rotation-180)
[547.178942] Starting subtest: sprite-rotation-180
[557.361728] Subtest sprite-rotation-180: SUCCESS (10.182s)
[557.796796] [101/133] (473s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[557.880910] Starting subtest: rel-constants-invalid-rel-gen5
[557.881874] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[558.085110] [102/133] (472s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[558.283982] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[558.285814] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[558.467731] [103/133] (472s left) perf_pmu (render-node-busy)
[558.566865] Starting subtest: render-node-busy
[558.567782] Starting dynamic subtest: rcs0
[559.160533] Dynamic subtest rcs0: SUCCESS (0.592s)
[559.175683] Starting dynamic subtest: bcs0
[559.718473] Dynamic subtest bcs0: SUCCESS (0.553s)
[559.733875] Starting dynamic subtest: vcs0
[560.277535] Dynamic subtest vcs0: SUCCESS (0.554s)
[560.292901] Starting dynamic subtest: vcs1
[560.841575] Dynamic subtest vcs1: SUCCESS (0.559s)
[560.856560] Starting dynamic subtest: vecs0
[561.402507] Dynamic subtest vecs0: SUCCESS (0.556s)
[561.417748] Starting dynamic subtest: vecs1
[561.964594] Dynamic subtest vecs1: SUCCESS (0.557s)
[561.979938] Starting dynamic subtest: ccs0
[562.525638] Dynamic subtest ccs0: SUCCESS (0.556s)
[562.530523] Subtest render-node-busy: SUCCESS (3.960s)
[562.688898] [104/133] (468s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[562.880278] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[562.882070] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[563.069546] [105/133] (468s left) kms_async_flips (invalid-async-flip-atomic)
[563.266911] Starting subtest: invalid-async-flip-atomic
[563.496395] Starting dynamic subtest: pipe-A-DP-3
[563.874850] Dynamic subtest pipe-A-DP-3: SUCCESS (0.378s)
[564.087443] Starting dynamic subtest: pipe-B-DP-3
[564.243512] Dynamic subtest pipe-B-DP-3: SUCCESS (0.168s)
[564.450154] Starting dynamic subtest: pipe-C-DP-3
[564.597650] Dynamic subtest pipe-C-DP-3: SUCCESS (0.159s)
[564.799509] Starting dynamic subtest: pipe-D-DP-3
[564.957641] Dynamic subtest pipe-D-DP-3: SUCCESS (0.171s)
[564.958707] Subtest invalid-async-flip-atomic: SUCCESS (1.692s)
[565.487926] [106/133] (465s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[567.100388] Starting subtest: dpms-mode-unset-non-lpsp
[568.477409] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.377s)
[568.899399] [107/133] (462s left) kms_psr (fbc-psr2-sprite-blt)
[569.085476] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[569.150020] [108/133] (462s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[569.333297] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[569.505844] [109/133] (462s left) gem_ctx_bad_destroy (invalid-default-ctx)
[569.580814] Starting subtest: invalid-default-ctx
[569.581760] Subtest invalid-default-ctx: SUCCESS (0.000s)
[569.728144] [110/133] (461s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[569.914172] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[569.929549] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[570.042841] [111/133] (461s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[570.234416] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[570.236144] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[570.437617] [112/133] (461s left) kms_chamelium_audio (hdmi-audio)
[570.721287] Subtest hdmi-audio: SKIP (0.000s)
[570.881711] [113/133] (460s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[571.071230] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[571.076055] Starting dynamic subtest: A-DP3
[572.009955] Dynamic subtest A-DP3: SUCCESS (0.932s)
[572.022969] Starting dynamic subtest: B-DP3
[572.732951] Dynamic subtest B-DP3: SUCCESS (0.723s)
[572.744429] Starting dynamic subtest: C-DP3
[573.467438] Dynamic subtest C-DP3: SUCCESS (0.732s)
[573.487578] Starting dynamic subtest: D-DP3
[574.207993] Dynamic subtest D-DP3: SUCCESS (0.739s)
[574.210327] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.138s)
[574.511425] [114/133] (457s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[574.699461] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[574.701258] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[574.862781] [115/133] (457s left) syncobj_timeline (reset-during-wait-for-submit)
[574.945491] Starting subtest: reset-during-wait-for-submit
[575.049678] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[575.233216] [116/133] (456s left) gem_lmem_swapping (verify-ccs)
[577.892115] Starting subtest: verify-ccs
[577.893180] Starting dynamic subtest: lmem0
[621.919566] Dynamic subtest lmem0: SUCCESS (44.026s)
[621.920461] Subtest verify-ccs: SUCCESS (44.027s)
[623.956535] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[623.957920] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[623.960493] [117/133] (408s left) api_intel_bb (object-reloc-keep-cache)
[625.601032] Starting subtest: object-reloc-keep-cache
[625.612308] Subtest object-reloc-keep-cache: SKIP (0.008s)
[625.718473] [FACT api_intel_bb (object-reloc-keep-cache)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[625.720750] [FACT api_intel_bb (object-reloc-keep-cache)] new: kernel.kmod_is_loaded.i915: true
[625.724173] [118/133] (406s left) gem_madvise (dontneed-before-pwrite)
[625.772274] Starting subtest: dontneed-before-pwrite
[625.801211] Subtest dontneed-before-pwrite: SKIP (0.029s)
[625.872698] [119/133] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[626.070516] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[626.072229] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[626.278572] [120/133] (406s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[626.474129] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[626.475981] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[626.632935] [121/133] (405s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[626.828329] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[626.829260] Starting dynamic subtest: pipe-A-DP-3
[626.851378] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[626.861472] Starting dynamic subtest: pipe-B-DP-3
[626.883267] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[626.892997] Starting dynamic subtest: pipe-C-DP-3
[626.918882] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[626.928615] Starting dynamic subtest: pipe-D-DP-3
[626.952354] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[626.954777] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.015s)
[627.349554] [122/133] (405s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[627.540545] Starting subtest: primary-y-tiled-reflect-x-0
[627.639583] Subtest primary-y-tiled-reflect-x-0: SKIP (0.098s)
[627.823553] [123/133] (404s left) kms_getfb (getfb-handle-closed)
[628.009432] Starting subtest: getfb-handle-closed
[628.010395] Subtest getfb-handle-closed: SUCCESS (0.000s)
[628.238335] [124/133] (404s left) gem_ctx_shared (q-promotion)
[628.348663] Starting subtest: Q-promotion
[628.349605] Starting dynamic subtest: rcs0
[628.638222] Dynamic subtest rcs0: SUCCESS (0.289s)
[628.650842] Starting dynamic subtest: bcs0
[628.831572] Dynamic subtest bcs0: SUCCESS (0.192s)
[628.842750] Starting dynamic subtest: vcs0
[629.035872] Dynamic subtest vcs0: SUCCESS (0.203s)
[629.047034] Starting dynamic subtest: vcs1
[629.236467] Dynamic subtest vcs1: SUCCESS (0.199s)
[629.247534] Starting dynamic subtest: vecs0
[629.437214] Dynamic subtest vecs0: SUCCESS (0.199s)
[629.448094] Starting dynamic subtest: vecs1
[629.634177] Dynamic subtest vecs1: SUCCESS (0.196s)
[629.645133] Starting dynamic subtest: ccs0
[629.836273] Dynamic subtest ccs0: SUCCESS (0.201s)
[629.837236] Subtest Q-promotion: SUCCESS (1.488s)
[630.122943] [125/133] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[630.320363] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[630.322139] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[630.524777] [126/133] (402s left) i915_drm_fdinfo (busy-idle)
[630.594368] Starting subtest: busy-idle
[630.595543] Starting dynamic subtest: rcs0
[630.626558] Dynamic subtest rcs0: SKIP (0.031s)
[630.638179] Starting dynamic subtest: bcs0
[630.640956] Dynamic subtest bcs0: SKIP (0.000s)
[630.651693] Starting dynamic subtest: vcs0
[630.654165] Dynamic subtest vcs0: SKIP (0.000s)
[630.664825] Starting dynamic subtest: vcs1
[630.667164] Dynamic subtest vcs1: SKIP (0.000s)
[630.677706] Starting dynamic subtest: vecs0
[630.680217] Dynamic subtest vecs0: SKIP (0.000s)
[630.690669] Starting dynamic subtest: vecs1
[630.693053] Dynamic subtest vecs1: SKIP (0.000s)
[630.703215] Starting dynamic subtest: ccs0
[630.706229] Dynamic subtest ccs0: SKIP (0.000s)
[630.708828] Subtest busy-idle: SKIP (0.041s)
[630.753390] [127/133] (402s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[630.938569] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[630.940923] Starting dynamic subtest: pipe-A-DP-3
[630.949448] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[630.959839] Starting dynamic subtest: pipe-B-DP-3
[630.968409] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[630.978565] Starting dynamic subtest: pipe-C-DP-3
[630.986932] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[630.997173] Starting dynamic subtest: pipe-D-DP-3
[631.007379] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[631.009410] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[631.433402] [128/133] (401s left) kms_cursor_edge_walk (128x128-top-edge)
[631.624484] Starting subtest: 128x128-top-edge
[631.625415] Starting dynamic subtest: pipe-A-DP-3
[635.112960] Dynamic subtest pipe-A-DP-3: SUCCESS (3.487s)
[635.130768] Starting dynamic subtest: pipe-D-DP-3
[638.444513] Dynamic subtest pipe-D-DP-3: SUCCESS (3.329s)
[638.445532] Subtest 128x128-top-edge: SUCCESS (6.821s)
[638.757164] [129/133] (394s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[638.950382] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[638.951314] Starting dynamic subtest: pipe-A-DP-3
[638.959860] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[638.970236] Starting dynamic subtest: pipe-B-DP-3
[638.978961] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[638.989155] Starting dynamic subtest: pipe-C-DP-3
[638.997551] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[639.007640] Starting dynamic subtest: pipe-D-DP-3
[639.019379] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[639.021185] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[639.435460] [130/133] (393s left) gem_exec_fence (basic-wait-all)
[639.526607] Starting subtest: basic-wait-all
[639.648841] Subtest basic-wait-all: SUCCESS (0.122s)
[640.466682] [131/133] (392s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[640.665049] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[640.666743] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[640.871968] [132/133] (392s left) kms_psr (psr-sprite-plane-move)
[641.056570] Subtest psr-sprite-plane-move: SKIP (0.000s)
[641.112711] [133/133] (392s left) gem_exec_params (larger-than-life-batch)
[641.197306] Starting subtest: larger-than-life-batch
[650.740893] Subtest larger-than-life-batch: SUCCESS (9.544s)
[651.237934] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: i915_pm_rps
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: gem_create
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: i915_hangman
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_tiled_display
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: gem_exec_capture
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_plane_alpha_blend
results: parsing output: 31/ for test: kms_rotation_crc
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_softpin
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_tiling_max_stride
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_pxp
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: i915_pm_rpm
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_busy
results: parsing output: 46/ for test: gem_exec_params
results: parsing output: 47/ for test: prime_busy
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_prop_blob
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_color_pipeline
results: parsing output: 55/ for test: gem_lmem_swapping
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_tiled_fence_blits
results: parsing output: 62/ for test: device_reset
results: parsing output: 63/ for test: tools_test
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_mmap_offset
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_joiner
results: parsing output: 68/ for test: gem_ctx_exec
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_chamelium_frames
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: gen7_exec_parse
results: parsing output: 82/ for test: kms_vblank
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: api_intel_bb
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: gem_close_race
results: parsing output: 91/ for test: kms_plane_multiple
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pxp
results: parsing output: 96/ for test: kms_feature_discovery
results: parsing output: 97/ for test: prime_vgem
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_async_flips
results: parsing output: 105/ for test: kms_pm_rpm
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_chamelium_audio
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: gem_madvise
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: kms_getfb
results: parsing output: 123/ for test: gem_ctx_shared
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: gem_exec_fence
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: gem_exec_params
Done.