[61.997631] Initializing watchdogs
[61.997697]   /dev/watchdog0
[62.017770] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.028981] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.032799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.035801] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[62.219173] Starting subtest: flip-vs-expired-vblank
[62.223053] Starting dynamic subtest: A-DP3
[70.124987] Dynamic subtest A-DP3: SUCCESS (7.902s)
[70.137077] Starting dynamic subtest: B-DP3
[77.916538] Dynamic subtest B-DP3: SUCCESS (7.791s)
[77.925379] Starting dynamic subtest: C-DP3
[85.691650] Dynamic subtest C-DP3: SUCCESS (7.774s)
[85.700174] Starting dynamic subtest: D-DP3
[93.465498] Dynamic subtest D-DP3: SUCCESS (7.773s)
[93.467358] Subtest flip-vs-expired-vblank: SUCCESS (31.248s)
[93.845286] [002/132] (928s left) gem_exec_whisper (basic-contexts-forked)
[93.932392] Starting subtest: basic-contexts-forked
[116.438580] Subtest basic-contexts-forked: SUCCESS (22.505s)
[116.691056] [003/132] (905s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[116.885886] Starting subtest: 4-tiled-16bpp-rotate-0
[118.633161] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.747s)
[118.857417] [004/132] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[119.081197] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[120.333173] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.252s)
[120.541996] [005/132] (902s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[120.613043] Starting subtest: etime-multi-wait-for-submit-submitted
[120.720607] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.105s)
[120.895227] [006/132] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[121.081675] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[121.083408] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.280189] [007/132] (901s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[121.357926] Starting subtest: multi-wait-all-for-submit-signaled
[121.358844] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[121.540637] [008/132] (901s left) core_setmaster (master-drop-set-user)
[121.715375] Starting subtest: master-drop-set-user
[121.752249] Subtest master-drop-set-user: SUCCESS (0.037s)
[121.795139] [009/132] (901s left) kms_pm_rpm (system-suspend-idle)
[124.095036] Starting subtest: system-suspend-idle
[143.803174] Subtest system-suspend-idle: SUCCESS (5.673s)
[144.148584] [010/132] (878s left) gem_exec_schedule (pi-ringfull)
[144.355997] Starting subtest: pi-ringfull
[144.357052] Starting dynamic subtest: rcs0
[144.442096] Dynamic subtest rcs0: SUCCESS (0.087s)
[144.452709] Starting dynamic subtest: bcs0
[144.472572] Dynamic subtest bcs0: SUCCESS (0.030s)
[144.483439] Starting dynamic subtest: vcs0
[144.502114] Dynamic subtest vcs0: SUCCESS (0.029s)
[144.513035] Starting dynamic subtest: vcs1
[144.532026] Dynamic subtest vcs1: SUCCESS (0.030s)
[144.542860] Starting dynamic subtest: vecs0
[144.562353] Dynamic subtest vecs0: SUCCESS (0.030s)
[144.573168] Starting dynamic subtest: vecs1
[144.593602] Dynamic subtest vecs1: SUCCESS (0.031s)
[144.604501] Starting dynamic subtest: ccs0
[144.624206] Dynamic subtest ccs0: SUCCESS (0.030s)
[144.625042] Subtest pi-ringfull: SUCCESS (0.269s)
[144.932391] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[144.934295] [011/132] (878s left) kms_flip (bo-too-big-interruptible)
[145.125615] Starting subtest: bo-too-big-interruptible
[145.130066] Starting dynamic subtest: A-DP3
[145.454914] Dynamic subtest A-DP3: SUCCESS (0.324s)
[145.495616] Starting dynamic subtest: B-DP3
[145.695182] Dynamic subtest B-DP3: SUCCESS (0.238s)
[145.732457] Starting dynamic subtest: C-DP3
[145.940869] Dynamic subtest C-DP3: SUCCESS (0.244s)
[145.981470] Starting dynamic subtest: D-DP3
[146.185236] Dynamic subtest D-DP3: SUCCESS (0.243s)
[146.190174] Subtest bo-too-big-interruptible: SUCCESS (1.064s)
[146.613674] [012/132] (876s left) gem_pread (exhaustion)
[146.699324] Subtest exhaustion: SKIP (0.000s)
[146.775255] [013/132] (876s left) kms_plane_scaling (2x-scaler-multi-pipe)
[146.967287] Starting subtest: 2x-scaler-multi-pipe
[146.969058] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[147.182831] [014/132] (876s left) api_intel_bb (blit-reloc-purge-cache)
[147.259373] Starting subtest: blit-reloc-purge-cache
[147.261211] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[147.478588] [015/132] (876s left) syncobj_timeline (single-wait-all-available-submitted)
[147.564113] Starting subtest: single-wait-all-available-submitted
[147.565307] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[147.763356] [016/132] (875s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[147.959067] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[148.006869] [017/132] (875s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[148.187630] Starting subtest: 2x-long-flip-vs-cursor-atomic
[148.190363] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[148.362949] [018/132] (875s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[148.556050] Starting subtest: 2x-plain-flip-ts-check-interruptible
[148.571318] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.014s)
[148.731699] [019/132] (875s left) gem_exec_nop (basic-sequential)
[148.824645] Starting subtest: basic-sequential
[153.291750] Subtest basic-sequential: SUCCESS (4.466s)
[153.579096] [020/132] (870s left) gem_fence_thrash (bo-write-verify-threaded-none)
[153.625204] Starting subtest: bo-write-verify-threaded-none
[153.664978] Subtest bo-write-verify-threaded-none: SKIP (0.039s)
[153.741299] [021/132] (870s left) prime_mmap_kms (buffer-sharing)
[153.927073] Starting subtest: buffer-sharing
[154.274871] Subtest buffer-sharing: SUCCESS (0.347s)
[154.613148] [022/132] (869s left) gem_userptr_blits (stress-mm)
[154.704004] Starting subtest: stress-mm
[160.073186] Subtest stress-mm: SUCCESS (5.369s)
[160.288745] [023/132] (863s left) kms_pm_backlight (fade)
[160.482824] Subtest fade: SKIP (0.000s)
[160.538633] [024/132] (863s left) gem_exec_params (rs-invalid)
[160.619952] Starting subtest: rs-invalid
[160.622713] Subtest rs-invalid: SUCCESS (0.002s)
[160.807408] [025/132] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[160.998722] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[161.000423] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[161.191145] [026/132] (863s left) gem_fence_thrash (bo-write-verify-none)
[161.237523] Starting subtest: bo-write-verify-none
[161.267241] Subtest bo-write-verify-none: SKIP (0.029s)
[161.342844] [027/132] (862s left) gem_workarounds (suspend-resume-context)
[161.442899] Starting subtest: suspend-resume-context
[180.348829] Subtest suspend-resume-context: SUCCESS (3.830s)
[181.519798] [028/132] (843s left) syncobj_wait (wait-all-delayed-signal)
[181.607469] Starting subtest: wait-all-delayed-signal
[181.711323] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[181.859283] [029/132] (843s left) gem_softpin (evict-active-interruptible)
[181.944535] Starting subtest: evict-active-interruptible
[181.966492] Subtest evict-active-interruptible: SUCCESS (0.022s)
[182.182120] [030/132] (843s left) i915_query (query-regions-garbage-items)
[182.257182] Starting subtest: query-regions-garbage-items
[182.258096] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[182.401971] [031/132] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[182.591629] Starting subtest: compare-crc-sanitycheck-xr24
[182.593628] Starting dynamic subtest: pipe-A-DP-3
[183.123278] Dynamic subtest pipe-A-DP-3: SUCCESS (0.530s)
[183.144302] Starting dynamic subtest: pipe-B-DP-3
[183.601711] Dynamic subtest pipe-B-DP-3: SUCCESS (0.477s)
[183.615275] Starting dynamic subtest: pipe-C-DP-3
[184.028334] Dynamic subtest pipe-C-DP-3: SUCCESS (0.426s)
[184.044665] Starting dynamic subtest: pipe-D-DP-3
[184.497650] Dynamic subtest pipe-D-DP-3: SUCCESS (0.468s)
[184.498554] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.906s)
[184.810554] [032/132] (840s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[184.996466] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[185.054902] [033/132] (840s left) gem_ctx_exec (basic-nohangcheck)
[185.135083] Starting subtest: basic-nohangcheck
[185.456308] Subtest basic-nohangcheck: SUCCESS (0.321s)
[185.645079] [034/132] (840s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[185.729622] Starting subtest: x-tiled-to-vebox-yf-tiled
[185.731424] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[186.007920] [035/132] (839s left) i915_drm_fdinfo (virtual-busy)
[186.078122] Starting subtest: virtual-busy
[186.080058] Subtest virtual-busy: SKIP (0.000s)
[186.245706] [036/132] (839s left) prime_vgem (busy)
[186.346836] Starting subtest: busy
[186.347654] Starting dynamic subtest: rcs0
[186.417929] Dynamic subtest rcs0: SUCCESS (0.071s)
[186.429863] Starting dynamic subtest: bcs0
[186.484115] Dynamic subtest bcs0: SUCCESS (0.066s)
[186.504983] Starting dynamic subtest: vcs0
[186.527889] Dynamic subtest vcs0: SUCCESS (0.043s)
[186.548665] Starting dynamic subtest: vcs1
[186.567692] Dynamic subtest vcs1: SUCCESS (0.039s)
[186.585688] Starting dynamic subtest: vecs0
[186.609066] Dynamic subtest vecs0: SUCCESS (0.041s)
[186.627090] Starting dynamic subtest: vecs1
[186.650982] Dynamic subtest vecs1: SUCCESS (0.041s)
[186.669023] Starting dynamic subtest: ccs0
[186.692660] Dynamic subtest ccs0: SUCCESS (0.041s)
[186.693758] Subtest busy: SUCCESS (0.346s)
[186.912355] [037/132] (839s left) kms_big_fb (linear-16bpp-rotate-180)
[187.114468] Starting subtest: linear-16bpp-rotate-180
[188.926749] Subtest linear-16bpp-rotate-180: SUCCESS (1.812s)
[189.195355] [038/132] (836s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[189.383559] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[189.384498] Starting dynamic subtest: pipe-A-valid-mode
[189.471511] Dynamic subtest pipe-A-valid-mode: SKIP (0.086s)
[189.473339] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.087s)
[189.731114] [039/132] (836s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[189.927601] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[189.928477] Starting dynamic subtest: pipe-A-DP-3
[189.936950] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[189.948383] Starting dynamic subtest: pipe-B-DP-3
[189.956699] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[189.968002] Starting dynamic subtest: pipe-C-DP-3
[189.976094] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[189.987568] Starting dynamic subtest: pipe-D-DP-3
[189.998104] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[190.000187] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[190.426816] [040/132] (835s left) gem_softpin (evict-prime)
[190.512068] Starting subtest: evict-prime
[190.513235] Starting dynamic subtest: rcs0
[191.705681] Dynamic subtest rcs0: SUCCESS (1.193s)
[191.717775] Starting dynamic subtest: bcs0
[192.856685] Dynamic subtest bcs0: SUCCESS (1.151s)
[192.869605] Starting dynamic subtest: vcs0
[194.012525] Dynamic subtest vcs0: SUCCESS (1.155s)
[194.024444] Starting dynamic subtest: vcs1
[195.184524] Dynamic subtest vcs1: SUCCESS (1.172s)
[195.202926] Starting dynamic subtest: vecs0
[196.355408] Dynamic subtest vecs0: SUCCESS (1.170s)
[196.367764] Starting dynamic subtest: vecs1
[197.561343] Dynamic subtest vecs1: SUCCESS (1.204s)
[197.573510] Starting dynamic subtest: ccs0
[198.681658] Dynamic subtest ccs0: SUCCESS (1.122s)
[198.693889] Starting dynamic subtest: all
[199.854513] Dynamic subtest all: SUCCESS (1.173s)
[199.855754] Subtest evict-prime: SUCCESS (9.343s)
[200.046428] [041/132] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[200.237679] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[200.239398] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[200.439790] [042/132] (826s left) kms_plane_alpha_blend (alpha-opaque-fb)
[200.626295] Starting subtest: alpha-opaque-fb
[200.878794] Starting dynamic subtest: pipe-A-DP-3
[201.382878] Dynamic subtest pipe-A-DP-3: SUCCESS (0.503s)
[201.396649] Starting dynamic subtest: pipe-D-DP-3
[201.959634] Dynamic subtest pipe-D-DP-3: SUCCESS (0.577s)
[201.960522] Subtest alpha-opaque-fb: SUCCESS (1.335s)
[202.275138] [043/132] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[202.469730] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[202.471392] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[202.677586] [044/132] (823s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[202.866049] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[202.866982] Starting dynamic subtest: pipe-A-DP-3
[202.876037] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[202.887628] Starting dynamic subtest: pipe-B-DP-3
[202.896953] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[202.908421] Starting dynamic subtest: pipe-C-DP-3
[202.917404] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[202.928994] Starting dynamic subtest: pipe-D-DP-3
[202.941294] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[202.942866] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[203.354808] [045/132] (823s left) perf_pmu (busy-accuracy-2)
[203.425084] Starting subtest: busy-accuracy-2
[203.426033] Starting dynamic subtest: rcs0
[206.489871] Dynamic subtest rcs0: SUCCESS (3.064s)
[206.502631] Starting dynamic subtest: bcs0
[209.553555] Dynamic subtest bcs0: SUCCESS (3.063s)
[209.566503] Starting dynamic subtest: vcs0
[212.619500] Dynamic subtest vcs0: SUCCESS (3.065s)
[212.632504] Starting dynamic subtest: vcs1
[215.679502] Dynamic subtest vcs1: SUCCESS (3.059s)
[215.693671] Starting dynamic subtest: vecs0
[218.744247] Dynamic subtest vecs0: SUCCESS (3.064s)
[218.757225] Starting dynamic subtest: vecs1
[221.808285] Dynamic subtest vecs1: SUCCESS (3.063s)
[221.821062] Starting dynamic subtest: ccs0
[224.877088] Dynamic subtest ccs0: SUCCESS (3.068s)
[224.877998] Subtest busy-accuracy-2: SUCCESS (21.451s)
[225.073612] [046/132] (801s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[225.151483] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[225.152363] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[225.356954] [047/132] (801s left) kms_content_protection (srm)
[225.608629] Starting subtest: srm
[225.638074] Starting dynamic subtest: pipe-A-DP-3
[346.720978] Dynamic subtest pipe-A-DP-3: FAIL (120.917s)
[346.721915] Subtest srm: FAIL (121.041s)
[346.957977] [048/132] (680s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[347.143895] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[347.144765] Starting dynamic subtest: pipe-A-DP-3
[347.153175] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[347.166232] Starting dynamic subtest: pipe-B-DP-3
[347.174567] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[347.187177] Starting dynamic subtest: pipe-C-DP-3
[347.195401] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[347.208170] Starting dynamic subtest: pipe-D-DP-3
[347.219021] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[347.221241] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[347.633946] [049/132] (679s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[347.824708] Starting subtest: psr-rgb565-draw-mmap-gtt
[347.826424] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[348.030875] [050/132] (679s left) kms_cursor_crc (cursor-onscreen-32x10)
[348.334314] Starting subtest: cursor-onscreen-32x10
[348.386155] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[348.814816] [051/132] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[349.004111] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[349.005911] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[349.200067] [052/132] (678s left) gem_ctx_bad_destroy (double-destroy)
[349.281576] Starting subtest: double-destroy
[349.282492] Subtest double-destroy: SUCCESS (0.000s)
[349.418505] [053/132] (677s left) gem_lmem_swapping (basic)
[352.196558] Starting subtest: basic
[352.198460] Starting dynamic subtest: lmem0
[372.926299] Dynamic subtest lmem0: SUCCESS (20.731s)
[372.927235] Subtest basic: SUCCESS (20.732s)
[375.095036] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[375.096319] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[375.098289] [054/132] (652s left) gen9_exec_parse (bb-start-cmd)
[376.803363] Subtest bb-start-cmd: SKIP (0.000s)
[376.854731] [FACT gen9_exec_parse (bb-start-cmd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[376.857607] [FACT gen9_exec_parse (bb-start-cmd)] new: kernel.kmod_is_loaded.i915: true
[376.860297] [055/132] (650s left) sw_sync (sync_multi_timeline_wait)
[376.908914] Starting subtest: sync_multi_timeline_wait
[376.909726] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[377.067015] [056/132] (650s left) i915_pm_rc6_residency (rc6-accuracy)
[377.149536] Starting subtest: rc6-accuracy
[377.150448] Starting dynamic subtest: gt0
[380.352305] Dynamic subtest gt0: FAIL (3.180s)
[380.353442] Subtest rc6-accuracy: FAIL (3.181s)
[380.467037] [057/132] (647s left) api_intel_bb (simple-bb-ctx)
[380.551941] Starting subtest: simple-bb-ctx
[380.595953] Subtest simple-bb-ctx: SUCCESS (0.044s)
[380.841653] [058/132] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[381.033010] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[381.034935] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[381.231940] [059/132] (646s left) kms_vblank (crtc-id)
[381.420990] Starting subtest: crtc-id
[381.423069] Starting dynamic subtest: pipe-A-DP-3
[381.830705] Dynamic subtest pipe-A-DP-3: SUCCESS (0.406s)
[381.854310] Starting dynamic subtest: pipe-D-DP-3
[382.277050] Dynamic subtest pipe-D-DP-3: SUCCESS (0.437s)
[382.278780] Subtest crtc-id: SUCCESS (0.854s)
[382.666664] [060/132] (645s left) gem_basic (bad-close)
[382.743250] Starting subtest: bad-close
[382.744812] Subtest bad-close: SUCCESS (0.000s)
[382.932332] [061/132] (645s left) kms_flip (dpms-vs-vblank-race-interruptible)
[383.121806] Starting subtest: dpms-vs-vblank-race-interruptible
[383.126390] Starting dynamic subtest: A-DP3
[386.605284] Dynamic subtest A-DP3: SUCCESS (3.477s)
[386.633663] Starting dynamic subtest: B-DP3
[389.762657] Dynamic subtest B-DP3: SUCCESS (3.156s)
[389.778170] Starting dynamic subtest: C-DP3
[392.839241] Dynamic subtest C-DP3: SUCCESS (3.074s)
[392.852006] Starting dynamic subtest: D-DP3
[395.874067] Dynamic subtest D-DP3: SUCCESS (3.035s)
[395.876370] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.754s)
[396.215248] [062/132] (631s left) kms_vblank (wait-forked-busy)
[396.405554] Starting subtest: wait-forked-busy
[396.406424] Starting dynamic subtest: pipe-A-DP-3
[398.938154] Dynamic subtest pipe-A-DP-3: SUCCESS (2.532s)
[398.959884] Starting dynamic subtest: pipe-D-DP-3
[401.405622] Dynamic subtest pipe-D-DP-3: SUCCESS (2.462s)
[401.406540] Subtest wait-forked-busy: SUCCESS (5.002s)
[401.691506] [063/132] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[401.890517] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[401.892167] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[402.092248] [064/132] (626s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[402.295625] Starting subtest: 4-tiled-64bpp-rotate-180
[404.288485] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.992s)
[404.529877] [065/132] (623s left) kms_flip (absolute-wf_vblank-interruptible)
[404.725416] Starting subtest: absolute-wf_vblank-interruptible
[404.728991] Starting dynamic subtest: A-DP3
[412.564856] Dynamic subtest A-DP3: SUCCESS (7.835s)
[412.581553] Starting dynamic subtest: B-DP3
[420.315613] Dynamic subtest B-DP3: SUCCESS (7.748s)
[420.330823] Starting dynamic subtest: C-DP3
[428.062911] Dynamic subtest C-DP3: SUCCESS (7.746s)
[428.078262] Starting dynamic subtest: D-DP3
[435.811988] Dynamic subtest D-DP3: SUCCESS (7.747s)
[435.814427] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.089s)
[436.196085] [066/132] (592s left) gem_exec_flush (basic-uc-prw-default)
[436.282747] Subtest basic-uc-prw-default: SKIP (0.000s)
[436.414476] [067/132] (592s left) vgem_basic (busy-fence)
[436.476065] Starting subtest: busy-fence
[436.477049] Subtest busy-fence: SUCCESS (0.000s)
[436.601735] [068/132] (591s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[436.796128] Starting subtest: psr-rgb565-draw-render
[436.798018] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[437.000171] [069/132] (591s left) kms_dp_link_training (uhbr-sst)
[437.186645] Starting subtest: uhbr-sst
[437.188378] Subtest uhbr-sst: SKIP (0.000s)
[437.341646] [070/132] (591s left) kms_universal_plane (disable-primary-vs-flip)
[437.530574] Starting subtest: disable-primary-vs-flip
[437.531519] Starting dynamic subtest: pipe-A-DP-3
[438.114636] Dynamic subtest pipe-A-DP-3: SUCCESS (0.583s)
[438.136489] Starting dynamic subtest: pipe-B-DP-3
[438.636320] Dynamic subtest pipe-B-DP-3: SUCCESS (0.520s)
[438.650321] Starting dynamic subtest: pipe-C-DP-3
[439.092788] Dynamic subtest pipe-C-DP-3: SUCCESS (0.454s)
[439.117666] Starting dynamic subtest: pipe-D-DP-3
[439.576211] Dynamic subtest pipe-D-DP-3: SUCCESS (0.479s)
[439.577095] Subtest disable-primary-vs-flip: SUCCESS (2.047s)
[439.865192] [071/132] (588s left) gem_exec_balancer (invalid-balancer)
[439.956596] Starting subtest: invalid-balancer
[441.560809] Subtest invalid-balancer: SUCCESS (1.605s)
[441.994245] [072/132] (586s left) gem_mmap_offset (bad-extensions)
[442.070490] Starting subtest: bad-extensions
[442.071400] Subtest bad-extensions: SUCCESS (0.000s)
[442.279982] [073/132] (586s left) kms_atomic_transition (plane-all-transition)
[442.467402] Starting subtest: plane-all-transition
[442.468306] Starting dynamic subtest: pipe-A-DP-3
[446.246796] Dynamic subtest pipe-A-DP-3: SUCCESS (3.778s)
[446.388009] Starting dynamic subtest: pipe-B-DP-3
[450.276665] Dynamic subtest pipe-B-DP-3: SUCCESS (3.903s)
[450.382209] Subtest plane-all-transition: SUCCESS (7.915s)
[450.663546] [074/132] (578s left) kms_rotation_crc (multiplane-rotation)
[450.861872] Starting subtest: multiplane-rotation
[480.012856] Subtest multiplane-rotation: SUCCESS (29.150s)
[480.262968] [075/132] (548s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[480.466565] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[480.468404] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[480.681928] [076/132] (548s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[480.874384] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[480.968928] [077/132] (548s left) kms_psr (pr-sprite-blt)
[481.158258] Subtest pr-sprite-blt: SKIP (0.000s)
[481.253061] [078/132] (548s left) kms_psr (pr-cursor-render)
[481.440173] Subtest pr-cursor-render: SKIP (0.000s)
[481.507395] [079/132] (547s left) syncobj_wait (single-wait-all-signaled)
[481.588578] Starting subtest: single-wait-all-signaled
[481.589730] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[481.796810] [080/132] (547s left) kms_chamelium_hpd (dp-hpd-storm)
[482.071259] Subtest dp-hpd-storm: SKIP (0.000s)
[482.226513] [081/132] (547s left) gem_mmap_gtt (basic-write-gtt)
[482.306278] Subtest basic-write-gtt: SKIP (0.000s)
[482.383355] [082/132] (547s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[482.571482] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[482.572322] Starting dynamic subtest: pipe-A
[483.148631] Dynamic subtest pipe-A: SUCCESS (0.578s)
[483.170834] Starting dynamic subtest: pipe-B
[483.796696] Dynamic subtest pipe-B: SUCCESS (0.646s)
[483.827538] Starting dynamic subtest: pipe-C
[484.442776] Dynamic subtest pipe-C: SUCCESS (0.643s)
[484.475796] Starting dynamic subtest: pipe-D
[485.087748] Dynamic subtest pipe-D: SUCCESS (0.642s)
[485.091072] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.518s)
[485.453013] [083/132] (544s left) gem_exec_schedule (thriceslice)
[485.544347] Starting subtest: thriceslice
[485.545262] Starting dynamic subtest: rcs0
[485.577117] Dynamic subtest rcs0: SUCCESS (0.032s)
[485.591382] Starting dynamic subtest: bcs0
[485.628705] Dynamic subtest bcs0: SUCCESS (0.050s)
[485.651060] Starting dynamic subtest: vcs0
[485.689094] Dynamic subtest vcs0: SUCCESS (0.058s)
[485.732127] Starting dynamic subtest: vcs1
[485.763033] Dynamic subtest vcs1: SUCCESS (0.071s)
[485.784453] Starting dynamic subtest: vecs0
[485.819852] Dynamic subtest vecs0: SUCCESS (0.055s)
[485.857574] Starting dynamic subtest: vecs1
[485.866117] Dynamic subtest vecs1: SUCCESS (0.044s)
[485.891119] Starting dynamic subtest: ccs0
[485.925928] Dynamic subtest ccs0: SUCCESS (0.057s)
[485.930208] Subtest thriceslice: SUCCESS (0.383s)
[486.384156] [084/132] (543s left) gem_exec_fence (nb-await)
[486.597200] Starting subtest: nb-await
[486.598190] Starting dynamic subtest: rcs0
[486.689053] Dynamic subtest rcs0: SUCCESS (0.098s)
[486.706864] Starting dynamic subtest: bcs0
[486.755191] Dynamic subtest bcs0: SUCCESS (0.064s)
[486.794601] Starting dynamic subtest: vcs0
[486.839889] Dynamic subtest vcs0: SUCCESS (0.081s)
[486.869475] Starting dynamic subtest: vcs1
[486.914567] Dynamic subtest vcs1: SUCCESS (0.072s)
[486.954346] Starting dynamic subtest: vecs0
[486.999377] Dynamic subtest vecs0: SUCCESS (0.081s)
[487.019251] Starting dynamic subtest: vecs1
[487.067173] Dynamic subtest vecs1: SUCCESS (0.065s)
[487.096793] Starting dynamic subtest: ccs0
[487.142092] Dynamic subtest ccs0: SUCCESS (0.072s)
[487.148902] Subtest nb-await: SUCCESS (0.554s)
[487.969537] [085/132] (541s left) gem_userptr_blits (set-cache-level)
[488.057300] Starting subtest: set-cache-level
[488.058187] Subtest set-cache-level: SUCCESS (0.000s)
[488.252767] [086/132] (541s left) gem_ctx_persistence (hang)
[488.340550] Starting subtest: hang
[488.342588] Subtest hang: SKIP (0.000s)
[488.536530] [087/132] (541s left) kms_psr (psr-cursor-mmap-gtt)
[488.722483] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[488.781070] [088/132] (541s left) gem_eio (in-flight-contexts-immediate)
[489.047566] Starting subtest: in-flight-contexts-immediate
[503.011634] Subtest in-flight-contexts-immediate: SUCCESS (13.964s)
[503.288672] [089/132] (526s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[503.479493] Starting subtest: basic-modeset-with-all-modifiers-formats
[503.728330] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[503.988447] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.260s)
[504.014948] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[504.021439] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.031s)
[504.045942] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[504.054697] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.031s)
[504.070315] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[504.088072] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[504.102943] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[504.121354] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[504.136400] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[504.154626] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[504.169009] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[504.188037] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[504.202975] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[504.221344] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[504.236237] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[504.254654] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[504.269020] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[504.437866] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[504.452773] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[504.471354] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[504.489216] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[504.504640] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[504.522712] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[504.538150] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[504.556351] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[504.571439] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[504.589677] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[504.604628] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[504.622692] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[504.638084] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[504.656073] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[504.671358] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[504.689433] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[504.704620] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[504.721697] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[504.889251] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s)
[504.903779] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[504.923378] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[504.939599] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[504.956807] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[504.973332] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[504.989987] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[505.006077] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[505.023313] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[505.038679] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[505.056690] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[505.071577] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[505.090176] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[505.104861] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[505.123348] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[505.137719] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[505.156704] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[505.431323] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.953s)
[505.747533] [090/132] (524s left) kms_color (ctm-max)
[505.933891] Starting subtest: ctm-max
[505.934747] Starting dynamic subtest: pipe-A-DP-3
[506.594542] Dynamic subtest pipe-A-DP-3: SUCCESS (0.658s)
[506.624076] Starting dynamic subtest: pipe-B-DP-3
[507.228310] Dynamic subtest pipe-B-DP-3: SUCCESS (0.632s)
[507.242047] Starting dynamic subtest: pipe-C-DP-3
[507.819578] Dynamic subtest pipe-C-DP-3: SUCCESS (0.589s)
[507.842904] Starting dynamic subtest: pipe-D-DP-3
[508.412644] Dynamic subtest pipe-D-DP-3: SUCCESS (0.591s)
[508.413710] Subtest ctm-max: SUCCESS (2.478s)
[508.752277] [091/132] (521s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[508.948513] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[508.950249] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[509.137783] [092/132] (521s left) gem_render_copy (linear)
[509.226072] Starting subtest: linear
[509.227020] Starting dynamic subtest: smem
[509.333695] Dynamic subtest smem: SUCCESS (0.106s)
[509.347467] Starting dynamic subtest: lmem0
[509.612879] Dynamic subtest lmem0: SUCCESS (0.279s)
[509.613745] Subtest linear: SUCCESS (0.387s)
[509.912137] [093/132] (520s left) gem_userptr_blits (access-control)
[510.014853] Starting subtest: access-control
[510.016576] Subtest access-control: SKIP (0.000s)
[510.233453] [094/132] (520s left) kms_flip (2x-nonexisting-fb)
[510.426081] Starting subtest: 2x-nonexisting-fb
[510.441232] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[510.637577] [095/132] (520s left) gem_ccs (block-copy-compressed)
[510.726898] Starting subtest: block-copy-compressed
[510.729256] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[510.773839] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.046s)
[510.789065] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[510.888419] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.113s)
[510.903713] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[510.906569] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[510.921648] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[511.023200] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s)
[511.038114] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[511.041270] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[511.056267] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[511.156602] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s)
[511.171669] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[511.176282] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[511.191762] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[511.289737] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.112s)
[511.290613] Subtest block-copy-compressed: SUCCESS (0.563s)
[511.523732] [096/132] (519s left) prime_mmap (test_invalid_sync_flags)
[511.604789] Starting subtest: test_invalid_sync_flags
[511.605680] Starting dynamic subtest: test_invalid_sync_flags-smem
[511.606563] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[511.620517] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[511.621765] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[511.622908] Subtest test_invalid_sync_flags: SUCCESS (0.003s)
[511.804986] [097/132] (519s left) gem_exec_params (invalid-bsd-ring)
[511.890421] Starting subtest: invalid-bsd-ring
[511.891561] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[512.085029] [098/132] (518s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[512.276997] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[512.278613] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[512.477951] [099/132] (518s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[512.671402] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[512.673033] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[512.872279] [100/132] (518s left) kms_plane (planar-pixel-format-settings)
[513.062451] Starting subtest: planar-pixel-format-settings
[513.112829] Subtest planar-pixel-format-settings: SUCCESS (0.052s)
[513.322252] [101/132] (517s left) syncobj_timeline (wait-for-submit-delayed-submit)
[513.401636] Starting subtest: wait-for-submit-delayed-submit
[513.505498] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[513.693257] [102/132] (517s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[514.198503] Starting subtest: cursor-rapid-movement-max-size
[514.201158] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[514.469648] [103/132] (516s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[514.656999] Starting subtest: modeset-atomic-cursor-hotspot
[514.658704] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[514.821869] [104/132] (516s left) gem_exec_balancer (parallel-keep-submit-fence)
[515.177394] Starting subtest: parallel-keep-submit-fence
[517.540157] Subtest parallel-keep-submit-fence: SUCCESS (2.363s)
[517.719561] [105/132] (513s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[517.998708] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[518.164246] [106/132] (513s left) kms_getfb (getfb-addfb-different-handles)
[518.359486] Starting subtest: getfb-addfb-different-handles
[518.360378] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[518.601497] [107/132] (513s left) gem_ctx_sseu (invalid-args)
[518.689511] Subtest invalid-args: SKIP (0.000s)
[518.778739] [108/132] (513s left) gem_lmem_swapping (parallel-random-verify)
[521.501178] Starting subtest: parallel-random-verify
[521.502006] Starting dynamic subtest: lmem0
[578.516421] Dynamic subtest lmem0: SUCCESS (57.018s)
[578.517364] Subtest parallel-random-verify: SUCCESS (57.019s)
[579.607060] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[579.608044] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[579.610075] [109/132] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[581.367366] Starting subtest: psr-2p-primscrn-spr-indfb-move
[581.369085] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[581.570631] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[581.573041] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[581.575831] [110/132] (450s left) gem_exec_reloc (basic-write-cpu-noreloc)
[581.671725] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[581.754080] [111/132] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[581.834052] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[581.835009] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[582.039751] [112/132] (450s left) i915_hangman (gt-engine-hang)
[582.143337] Starting subtest: gt-engine-hang
[582.144357] Starting dynamic subtest: rcs0
[583.012801] Dynamic subtest rcs0: SUCCESS (0.869s)
[583.030467] Starting dynamic subtest: bcs0
[583.860004] Dynamic subtest bcs0: SUCCESS (0.845s)
[583.877262] Starting dynamic subtest: vcs0
[584.673370] Dynamic subtest vcs0: SUCCESS (0.812s)
[584.687243] Starting dynamic subtest: vcs1
[585.477539] Dynamic subtest vcs1: SUCCESS (0.803s)
[585.491263] Starting dynamic subtest: vecs0
[586.321035] Dynamic subtest vecs0: SUCCESS (0.841s)
[586.342406] Starting dynamic subtest: vecs1
[587.132490] Dynamic subtest vecs1: SUCCESS (0.807s)
[587.146419] Starting dynamic subtest: ccs0
[588.010380] Dynamic subtest ccs0: SUCCESS (0.877s)
[588.011364] Subtest gt-engine-hang: SUCCESS (5.868s)
[588.206789] [113/132] (443s left) gem_mmap (bad-object)
[588.286341] Subtest bad-object: SKIP (0.000s)
[588.395029] [114/132] (443s left) kms_feature_discovery (psr1)
[588.587850] Starting subtest: psr1
[588.589561] Subtest psr1: SKIP (0.000s)
[588.741563] [115/132] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[588.935311] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[588.937046] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[589.128710] [116/132] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[589.321296] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[589.323049] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[589.525861] [117/132] (442s left) gem_mmap_gtt (fault-concurrent)
[589.606332] Subtest fault-concurrent: SKIP (0.000s)
[589.689055] [118/132] (442s left) kms_pm_rpm (legacy-planes-dpms)
[592.212240] Starting subtest: legacy-planes-dpms
[592.214089] Starting dynamic subtest: plane-63
[594.917693] Dynamic subtest plane-63: SUCCESS (2.706s)
[594.964855] Starting dynamic subtest: plane-93
[597.763337] Dynamic subtest plane-93: SUCCESS (2.841s)
[597.811359] Starting dynamic subtest: plane-123
[600.710569] Dynamic subtest plane-123: SUCCESS (2.942s)
[600.756636] Starting dynamic subtest: plane-133
[603.553802] Dynamic subtest plane-133: SUCCESS (2.838s)
[603.559657] Subtest legacy-planes-dpms: SUCCESS (11.348s)
[603.999853] [119/132] (428s left) kms_chamelium_color (ctm-negative)
[604.188589] Subtest ctm-negative: SKIP (0.000s)
[604.245456] [120/132] (428s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[604.430554] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[604.431445] Starting dynamic subtest: pipe-A-valid-mode
[604.510778] Dynamic subtest pipe-A-valid-mode: SKIP (0.078s)
[604.512587] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.079s)
[604.770519] [121/132] (428s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[604.966689] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[606.267125] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.300s)
[606.536046] [122/132] (426s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[606.722461] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[606.723340] Starting dynamic subtest: pipe-A-DP-3
[606.726743] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[606.739267] Starting dynamic subtest: pipe-B-DP-3
[606.742711] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[606.755025] Starting dynamic subtest: pipe-C-DP-3
[606.758383] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[606.770627] Starting dynamic subtest: pipe-D-DP-3
[606.774078] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[606.775982] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[607.215406] [123/132] (425s left) kms_invalid_mode (overflow-vrefresh)
[607.403311] Starting subtest: overflow-vrefresh
[607.404252] Starting dynamic subtest: pipe-A-DP-3
[607.487440] Dynamic subtest pipe-A-DP-3: SUCCESS (0.083s)
[607.506201] Starting dynamic subtest: pipe-B-DP-3
[607.507367] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[607.523494] Starting dynamic subtest: pipe-C-DP-3
[607.524472] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[607.537169] Starting dynamic subtest: pipe-D-DP-3
[607.538138] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[607.539066] Subtest overflow-vrefresh: SUCCESS (0.096s)
[607.779618] [124/132] (425s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[607.977507] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[607.979319] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[608.188658] [125/132] (424s left) kms_psr (fbc-pr-cursor-plane-move)
[608.378301] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[608.437478] [126/132] (424s left) prime_busy (before)
[608.521308] Starting subtest: before
[608.526313] Starting dynamic subtest: rcs0
[608.585186] Dynamic subtest rcs0: SUCCESS (0.059s)
[608.598937] Starting dynamic subtest: bcs0
[608.640780] Dynamic subtest bcs0: SUCCESS (0.054s)
[608.662045] Starting dynamic subtest: vcs0
[608.681725] Dynamic subtest vcs0: SUCCESS (0.039s)
[608.703564] Starting dynamic subtest: vcs1
[608.722617] Dynamic subtest vcs1: SUCCESS (0.039s)
[608.744347] Starting dynamic subtest: vecs0
[608.764010] Dynamic subtest vecs0: SUCCESS (0.040s)
[608.783034] Starting dynamic subtest: vecs1
[608.805237] Dynamic subtest vecs1: SUCCESS (0.040s)
[608.824149] Starting dynamic subtest: ccs0
[608.854042] Dynamic subtest ccs0: SUCCESS (0.040s)
[608.955363] Subtest before: SUCCESS (0.434s)
[609.143544] [127/132] (424s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[609.342362] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[609.344196] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[609.543348] [128/132] (423s left) kms_hdr (invalid-metadata-sizes)
[609.728708] Starting subtest: invalid-metadata-sizes
[610.301760] Starting dynamic subtest: pipe-A-DP-3
[610.307341] Dynamic subtest pipe-A-DP-3: SUCCESS (0.003s)
[610.309198] Subtest invalid-metadata-sizes: SUCCESS (0.578s)
[610.637568] [129/132] (422s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[610.728800] Starting subtest: y-tiled-ccs-to-yf-tiled
[610.730716] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[611.021761] [130/132] (422s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[611.213368] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[611.215109] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[611.411894] [131/132] (422s left) gem_userptr_blits (unsync-unmap)
[611.503272] Subtest unsync-unmap: SKIP (0.000s)
[611.749361] [132/132] (422s left) gem_ccs (suspend-resume)
[611.836792] Starting subtest: suspend-resume
[611.839168] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[629.653134] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.016s)
[629.667284] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[647.712690] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.694s)
[647.726680] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[665.642987] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.614s)
[665.657873] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[683.708738] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.675s)
[683.722684] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[701.602789] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.611s)
[701.617163] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[719.681840] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.672s)
[719.696151] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[737.651354] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.632s)
[737.666533] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[755.665081] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.637s)
[755.665945] Subtest suspend-resume: SUCCESS (29.563s)
[755.873286] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: core_setmaster
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_nop
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: prime_mmap_kms
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fence_thrash
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_alpha_blend
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_ctx_bad_destroy
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: i915_pm_rc6_residency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dp_link_training
results: parsing output: 69/ for test: kms_universal_plane
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_ccs
Done.