[62.956278] Initializing watchdogs
[62.956343]   /dev/watchdog0
[62.976577] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.987715] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.991850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.994324] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[63.175401] Starting subtest: flip-vs-expired-vblank
[63.179344] Starting dynamic subtest: A-DP3
[71.064795] Dynamic subtest A-DP3: SUCCESS (7.892s)
[71.078862] Starting dynamic subtest: B-DP3
[78.865264] Dynamic subtest B-DP3: SUCCESS (7.802s)
[78.874123] Starting dynamic subtest: C-DP3
[86.641185] Dynamic subtest C-DP3: SUCCESS (7.775s)
[86.652126] Starting dynamic subtest: D-DP3
[94.409264] Dynamic subtest D-DP3: SUCCESS (7.767s)
[94.411165] Subtest flip-vs-expired-vblank: SUCCESS (31.244s)
[94.786463] [002/132] (928s left) gem_exec_whisper (basic-contexts-forked)
[94.875909] Starting subtest: basic-contexts-forked
[117.572486] Subtest basic-contexts-forked: SUCCESS (22.695s)
[117.843550] [003/132] (905s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[118.037972] Starting subtest: 4-tiled-16bpp-rotate-0
[119.808366] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.770s)
[120.017163] [004/132] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[120.208041] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[121.458477] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.250s)
[121.668255] [005/132] (902s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[121.739388] Starting subtest: etime-multi-wait-for-submit-submitted
[121.847618] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[122.021302] [006/132] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[122.204582] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[122.206280] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[122.406656] [007/132] (901s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[122.480133] Starting subtest: multi-wait-all-for-submit-signaled
[122.481058] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[122.667981] [008/132] (901s left) core_setmaster (master-drop-set-user)
[122.840540] Starting subtest: master-drop-set-user
[122.877742] Subtest master-drop-set-user: SUCCESS (0.037s)
[122.919232] [009/132] (901s left) kms_pm_rpm (system-suspend-idle)
[125.051885] Starting subtest: system-suspend-idle
[144.812865] Subtest system-suspend-idle: SUCCESS (5.381s)
[145.210315] [010/132] (878s left) gem_exec_schedule (pi-ringfull)
[145.439759] Starting subtest: pi-ringfull
[145.441166] Starting dynamic subtest: rcs0
[145.537709] Dynamic subtest rcs0: SUCCESS (0.100s)
[145.547709] Starting dynamic subtest: bcs0
[145.567846] Dynamic subtest bcs0: SUCCESS (0.030s)
[145.577472] Starting dynamic subtest: vcs0
[145.599447] Dynamic subtest vcs0: SUCCESS (0.032s)
[145.609499] Starting dynamic subtest: vcs1
[145.630511] Dynamic subtest vcs1: SUCCESS (0.031s)
[145.640488] Starting dynamic subtest: vecs0
[145.659815] Dynamic subtest vecs0: SUCCESS (0.029s)
[145.669947] Starting dynamic subtest: vecs1
[145.689147] Dynamic subtest vecs1: SUCCESS (0.029s)
[145.699276] Starting dynamic subtest: ccs0
[145.718806] Dynamic subtest ccs0: SUCCESS (0.030s)
[145.719829] Subtest pi-ringfull: SUCCESS (0.283s)
[146.014105] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[146.015984] [011/132] (878s left) kms_flip (bo-too-big-interruptible)
[146.204640] Starting subtest: bo-too-big-interruptible
[146.208916] Starting dynamic subtest: A-DP3
[146.506995] Dynamic subtest A-DP3: SUCCESS (0.300s)
[146.544938] Starting dynamic subtest: B-DP3
[146.747909] Dynamic subtest B-DP3: SUCCESS (0.241s)
[146.777904] Starting dynamic subtest: C-DP3
[146.992078] Dynamic subtest C-DP3: SUCCESS (0.245s)
[147.015414] Starting dynamic subtest: D-DP3
[147.220012] Dynamic subtest D-DP3: SUCCESS (0.229s)
[147.224857] Subtest bo-too-big-interruptible: SUCCESS (1.029s)
[147.686007] [012/132] (876s left) gem_pread (exhaustion)
[147.768430] Subtest exhaustion: SKIP (0.000s)
[147.845037] [013/132] (876s left) kms_plane_scaling (2x-scaler-multi-pipe)
[148.043545] Starting subtest: 2x-scaler-multi-pipe
[148.046400] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[148.250109] [014/132] (876s left) api_intel_bb (blit-reloc-purge-cache)
[148.339893] Starting subtest: blit-reloc-purge-cache
[148.345425] Subtest blit-reloc-purge-cache: SKIP (0.002s)
[148.545985] [015/132] (875s left) syncobj_timeline (single-wait-all-available-submitted)
[148.621775] Starting subtest: single-wait-all-available-submitted
[148.622683] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[148.808706] [016/132] (875s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[149.002236] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[149.052888] [017/132] (875s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[149.242403] Starting subtest: 2x-long-flip-vs-cursor-atomic
[149.244186] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[149.420960] [018/132] (875s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[149.612269] Starting subtest: 2x-plain-flip-ts-check-interruptible
[149.627572] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[149.796323] [019/132] (874s left) gem_exec_nop (basic-sequential)
[149.888654] Starting subtest: basic-sequential
[154.333055] Subtest basic-sequential: SUCCESS (4.466s)
[154.579998] [020/132] (870s left) gem_fence_thrash (bo-write-verify-threaded-none)
[154.626254] Starting subtest: bo-write-verify-threaded-none
[154.658280] Subtest bo-write-verify-threaded-none: SKIP (0.031s)
[154.744524] [021/132] (870s left) prime_mmap_kms (buffer-sharing)
[154.927509] Starting subtest: buffer-sharing
[155.309338] Subtest buffer-sharing: SUCCESS (0.382s)
[155.640031] [022/132] (869s left) gem_userptr_blits (stress-mm)
[155.731296] Starting subtest: stress-mm
[161.087727] Subtest stress-mm: SUCCESS (5.369s)
[161.289965] [023/132] (863s left) kms_pm_backlight (fade)
[161.475598] Subtest fade: SKIP (0.000s)
[161.536140] [024/132] (863s left) gem_exec_params (rs-invalid)
[161.622906] Starting subtest: rs-invalid
[161.625646] Subtest rs-invalid: SUCCESS (0.002s)
[161.820579] [025/132] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[162.011753] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[162.013466] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[162.202789] [026/132] (863s left) gem_fence_thrash (bo-write-verify-none)
[162.249691] Starting subtest: bo-write-verify-none
[162.298074] Subtest bo-write-verify-none: SKIP (0.048s)
[162.407053] [027/132] (862s left) gem_workarounds (suspend-resume-context)
[162.498912] Starting subtest: suspend-resume-context
[181.720980] Subtest suspend-resume-context: SUCCESS (3.845s)
[181.876413] [028/132] (843s left) syncobj_wait (wait-all-delayed-signal)
[181.988195] Starting subtest: wait-all-delayed-signal
[182.091813] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[182.264542] [029/132] (843s left) gem_softpin (evict-active-interruptible)
[182.349082] Starting subtest: evict-active-interruptible
[182.372595] Subtest evict-active-interruptible: SUCCESS (0.023s)
[182.541201] [030/132] (842s left) i915_query (query-regions-garbage-items)
[182.622759] Starting subtest: query-regions-garbage-items
[182.623822] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[182.778388] [031/132] (842s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[182.967641] Starting subtest: compare-crc-sanitycheck-xr24
[182.968581] Starting dynamic subtest: pipe-A-DP-3
[183.529493] Dynamic subtest pipe-A-DP-3: SUCCESS (0.560s)
[183.554578] Starting dynamic subtest: pipe-B-DP-3
[183.999167] Dynamic subtest pipe-B-DP-3: SUCCESS (0.468s)
[184.012890] Starting dynamic subtest: pipe-C-DP-3
[184.462575] Dynamic subtest pipe-C-DP-3: SUCCESS (0.462s)
[184.476450] Starting dynamic subtest: pipe-D-DP-3
[184.927465] Dynamic subtest pipe-D-DP-3: SUCCESS (0.464s)
[184.928442] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.962s)
[185.220683] [032/132] (840s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[185.407713] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[185.463687] [033/132] (840s left) gem_ctx_exec (basic-nohangcheck)
[185.544606] Starting subtest: basic-nohangcheck
[185.880930] Subtest basic-nohangcheck: SUCCESS (0.336s)
[186.056495] [034/132] (839s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[186.147111] Starting subtest: x-tiled-to-vebox-yf-tiled
[186.149192] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[186.452266] [035/132] (839s left) i915_drm_fdinfo (virtual-busy)
[186.522073] Starting subtest: virtual-busy
[186.523901] Subtest virtual-busy: SKIP (0.000s)
[186.660222] [036/132] (839s left) prime_vgem (busy)
[186.757587] Starting subtest: busy
[186.758472] Starting dynamic subtest: rcs0
[186.824873] Dynamic subtest rcs0: SUCCESS (0.067s)
[186.836390] Starting dynamic subtest: bcs0
[186.902906] Dynamic subtest bcs0: SUCCESS (0.078s)
[186.914907] Starting dynamic subtest: vcs0
[186.945511] Dynamic subtest vcs0: SUCCESS (0.042s)
[186.971198] Starting dynamic subtest: vcs1
[186.992610] Dynamic subtest vcs1: SUCCESS (0.046s)
[187.017629] Starting dynamic subtest: vecs0
[187.034430] Dynamic subtest vecs0: SUCCESS (0.041s)
[187.052429] Starting dynamic subtest: vecs1
[187.078068] Dynamic subtest vecs1: SUCCESS (0.043s)
[187.093765] Starting dynamic subtest: ccs0
[187.119401] Dynamic subtest ccs0: SUCCESS (0.041s)
[187.120507] Subtest busy: SUCCESS (0.362s)
[187.336333] [037/132] (838s left) kms_big_fb (linear-16bpp-rotate-180)
[187.532241] Starting subtest: linear-16bpp-rotate-180
[189.601194] Subtest linear-16bpp-rotate-180: SUCCESS (2.069s)
[189.854249] [038/132] (836s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[190.039192] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[190.040119] Starting dynamic subtest: pipe-A-valid-mode
[190.128063] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[190.129833] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.088s)
[190.384772] [039/132] (835s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[190.572732] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[190.573654] Starting dynamic subtest: pipe-A-DP-3
[190.581922] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[190.592726] Starting dynamic subtest: pipe-B-DP-3
[190.600878] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[190.611484] Starting dynamic subtest: pipe-C-DP-3
[190.619635] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[190.630558] Starting dynamic subtest: pipe-D-DP-3
[190.640696] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[190.642618] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[191.064191] [040/132] (835s left) gem_softpin (evict-prime)
[191.148411] Starting subtest: evict-prime
[191.149418] Starting dynamic subtest: rcs0
[192.406858] Dynamic subtest rcs0: SUCCESS (1.259s)
[192.418479] Starting dynamic subtest: bcs0
[193.538306] Dynamic subtest bcs0: SUCCESS (1.132s)
[193.550558] Starting dynamic subtest: vcs0
[194.701107] Dynamic subtest vcs0: SUCCESS (1.163s)
[194.713741] Starting dynamic subtest: vcs1
[195.840031] Dynamic subtest vcs1: SUCCESS (1.139s)
[195.851892] Starting dynamic subtest: vecs0
[197.020135] Dynamic subtest vecs0: SUCCESS (1.180s)
[197.031310] Starting dynamic subtest: vecs1
[198.193143] Dynamic subtest vecs1: SUCCESS (1.173s)
[198.205622] Starting dynamic subtest: ccs0
[199.345954] Dynamic subtest ccs0: SUCCESS (1.153s)
[199.358248] Starting dynamic subtest: all
[200.506086] Dynamic subtest all: SUCCESS (1.160s)
[200.507242] Subtest evict-prime: SUCCESS (9.363s)
[200.701204] [041/132] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[200.894095] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[200.895829] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[201.086743] [042/132] (825s left) kms_plane_alpha_blend (alpha-opaque-fb)
[201.271471] Starting subtest: alpha-opaque-fb
[201.525101] Starting dynamic subtest: pipe-A-DP-3
[202.064239] Dynamic subtest pipe-A-DP-3: SUCCESS (0.539s)
[202.075275] Starting dynamic subtest: pipe-D-DP-3
[202.623083] Dynamic subtest pipe-D-DP-3: SUCCESS (0.559s)
[202.623977] Subtest alpha-opaque-fb: SUCCESS (1.353s)
[202.928358] [043/132] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[203.118611] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[203.120281] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.326175] [044/132] (823s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[203.511512] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[203.512502] Starting dynamic subtest: pipe-A-DP-3
[203.521652] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[203.532869] Starting dynamic subtest: pipe-B-DP-3
[203.542122] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[203.552884] Starting dynamic subtest: pipe-C-DP-3
[203.561712] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[203.572608] Starting dynamic subtest: pipe-D-DP-3
[203.583676] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[203.585693] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[204.001769] [045/132] (822s left) perf_pmu (busy-accuracy-2)
[204.072894] Starting subtest: busy-accuracy-2
[204.073859] Starting dynamic subtest: rcs0
[207.137126] Dynamic subtest rcs0: SUCCESS (3.065s)
[207.149207] Starting dynamic subtest: bcs0
[210.200645] Dynamic subtest bcs0: SUCCESS (3.064s)
[210.212907] Starting dynamic subtest: vcs0
[213.270489] Dynamic subtest vcs0: SUCCESS (3.071s)
[213.282869] Starting dynamic subtest: vcs1
[216.339139] Dynamic subtest vcs1: SUCCESS (3.067s)
[216.351390] Starting dynamic subtest: vecs0
[219.405654] Dynamic subtest vecs0: SUCCESS (3.064s)
[219.417848] Starting dynamic subtest: vecs1
[222.467839] Dynamic subtest vecs1: SUCCESS (3.060s)
[222.480128] Starting dynamic subtest: ccs0
[225.531081] Dynamic subtest ccs0: SUCCESS (3.062s)
[225.531973] Subtest busy-accuracy-2: SUCCESS (21.457s)
[225.736312] [046/132] (800s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[225.814824] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[225.815945] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[226.023359] [047/132] (800s left) kms_content_protection (srm)
[226.272794] Starting subtest: srm
[226.302927] Starting dynamic subtest: pipe-A-DP-3
[347.427620] Dynamic subtest pipe-A-DP-3: FAIL (120.941s)
[347.428441] Subtest srm: FAIL (121.062s)
[347.651579] [048/132] (679s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[347.838895] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[347.839829] Starting dynamic subtest: pipe-A-DP-3
[347.847993] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[347.860194] Starting dynamic subtest: pipe-B-DP-3
[347.868498] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[347.880572] Starting dynamic subtest: pipe-C-DP-3
[347.888733] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[347.900506] Starting dynamic subtest: pipe-D-DP-3
[347.910527] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[347.912423] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[348.293820] [049/132] (678s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[348.484546] Starting subtest: psr-rgb565-draw-mmap-gtt
[348.486144] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[348.673350] [050/132] (678s left) kms_cursor_crc (cursor-onscreen-32x10)
[348.976118] Starting subtest: cursor-onscreen-32x10
[349.028628] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[349.442152] [051/132] (677s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[349.633555] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[349.635191] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[349.826993] [052/132] (677s left) gem_ctx_bad_destroy (double-destroy)
[349.905190] Starting subtest: double-destroy
[349.906103] Subtest double-destroy: SUCCESS (0.000s)
[350.093219] [053/132] (677s left) gem_lmem_swapping (basic)
[352.975569] Starting subtest: basic
[352.976417] Starting dynamic subtest: lmem0
[373.847144] Dynamic subtest lmem0: SUCCESS (20.877s)
[373.848062] Subtest basic: SUCCESS (20.878s)
[375.287091] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[375.288054] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[375.290167] [054/132] (652s left) gen9_exec_parse (bb-start-cmd)
[376.952134] Subtest bb-start-cmd: SKIP (0.000s)
[377.004513] [FACT gen9_exec_parse (bb-start-cmd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[377.007353] [FACT gen9_exec_parse (bb-start-cmd)] new: kernel.kmod_is_loaded.i915: true
[377.009817] [055/132] (650s left) sw_sync (sync_multi_timeline_wait)
[377.059584] Starting subtest: sync_multi_timeline_wait
[377.060474] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[377.223740] [056/132] (650s left) i915_pm_rc6_residency (rc6-accuracy)
[377.301227] Starting subtest: rc6-accuracy
[377.302123] Starting dynamic subtest: gt0
[380.513761] Dynamic subtest gt0: FAIL (3.190s)
[380.514844] Subtest rc6-accuracy: FAIL (3.191s)
[380.628940] [057/132] (646s left) api_intel_bb (simple-bb-ctx)
[380.709072] Starting subtest: simple-bb-ctx
[380.752232] Subtest simple-bb-ctx: SUCCESS (0.043s)
[380.933628] [058/132] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[381.128511] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[381.130133] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[381.331489] [059/132] (646s left) kms_vblank (crtc-id)
[381.513438] Starting subtest: crtc-id
[381.515691] Starting dynamic subtest: pipe-A-DP-3
[381.906231] Dynamic subtest pipe-A-DP-3: SUCCESS (0.392s)
[381.929070] Starting dynamic subtest: pipe-D-DP-3
[382.225134] Dynamic subtest pipe-D-DP-3: SUCCESS (0.314s)
[382.226015] Subtest crtc-id: SUCCESS (0.712s)
[382.516520] [060/132] (645s left) gem_basic (bad-close)
[382.592022] Starting subtest: bad-close
[382.593861] Subtest bad-close: SUCCESS (0.000s)
[382.799337] [061/132] (645s left) kms_flip (dpms-vs-vblank-race-interruptible)
[382.994455] Starting subtest: dpms-vs-vblank-race-interruptible
[382.999068] Starting dynamic subtest: A-DP3
[386.303218] Dynamic subtest A-DP3: SUCCESS (3.305s)
[386.326657] Starting dynamic subtest: B-DP3
[389.346276] Dynamic subtest B-DP3: SUCCESS (3.042s)
[389.360731] Starting dynamic subtest: C-DP3
[392.403954] Dynamic subtest C-DP3: SUCCESS (3.057s)
[392.416085] Starting dynamic subtest: D-DP3
[395.421008] Dynamic subtest D-DP3: SUCCESS (3.017s)
[395.421967] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.432s)
[395.759149] [062/132] (632s left) kms_vblank (wait-forked-busy)
[395.948130] Starting subtest: wait-forked-busy
[395.949010] Starting dynamic subtest: pipe-A-DP-3
[398.452536] Dynamic subtest pipe-A-DP-3: SUCCESS (2.503s)
[398.479767] Starting dynamic subtest: pipe-D-DP-3
[400.928224] Dynamic subtest pipe-D-DP-3: SUCCESS (2.469s)
[400.929122] Subtest wait-forked-busy: SUCCESS (4.983s)
[401.196766] [063/132] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[401.399095] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[401.400777] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[401.597299] [064/132] (626s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[401.798113] Starting subtest: 4-tiled-64bpp-rotate-180
[403.709158] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.911s)
[403.909846] [065/132] (624s left) kms_flip (absolute-wf_vblank-interruptible)
[404.101153] Starting subtest: absolute-wf_vblank-interruptible
[404.106065] Starting dynamic subtest: A-DP3
[411.938350] Dynamic subtest A-DP3: SUCCESS (7.831s)
[411.959310] Starting dynamic subtest: B-DP3
[419.690168] Dynamic subtest B-DP3: SUCCESS (7.747s)
[419.704500] Starting dynamic subtest: C-DP3
[427.449283] Dynamic subtest C-DP3: SUCCESS (7.754s)
[427.465678] Starting dynamic subtest: D-DP3
[435.194445] Dynamic subtest D-DP3: SUCCESS (7.738s)
[435.197006] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.086s)
[435.559197] [066/132] (592s left) gem_exec_flush (basic-uc-prw-default)
[435.644115] Subtest basic-uc-prw-default: SKIP (0.000s)
[435.742525] [067/132] (592s left) vgem_basic (busy-fence)
[435.793144] Starting subtest: busy-fence
[435.794005] Subtest busy-fence: SUCCESS (0.000s)
[435.921082] [068/132] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[436.114955] Starting subtest: psr-rgb565-draw-render
[436.116678] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[436.310895] [069/132] (592s left) kms_dp_link_training (uhbr-sst)
[436.503024] Starting subtest: uhbr-sst
[436.504789] Subtest uhbr-sst: SKIP (0.000s)
[436.659717] [070/132] (591s left) kms_universal_plane (disable-primary-vs-flip)
[436.851654] Starting subtest: disable-primary-vs-flip
[436.853903] Starting dynamic subtest: pipe-A-DP-3
[437.438437] Dynamic subtest pipe-A-DP-3: SUCCESS (0.584s)
[437.452309] Starting dynamic subtest: pipe-B-DP-3
[437.920934] Dynamic subtest pipe-B-DP-3: SUCCESS (0.480s)
[437.935080] Starting dynamic subtest: pipe-C-DP-3
[438.408764] Dynamic subtest pipe-C-DP-3: SUCCESS (0.486s)
[438.432434] Starting dynamic subtest: pipe-D-DP-3
[438.891104] Dynamic subtest pipe-D-DP-3: SUCCESS (0.478s)
[438.891981] Subtest disable-primary-vs-flip: SUCCESS (2.038s)
[439.193474] [071/132] (589s left) gem_exec_balancer (invalid-balancer)
[439.286651] Starting subtest: invalid-balancer
[440.888954] Subtest invalid-balancer: SUCCESS (1.602s)
[441.314717] [072/132] (587s left) gem_mmap_offset (bad-extensions)
[441.399244] Starting subtest: bad-extensions
[441.400138] Subtest bad-extensions: SUCCESS (0.000s)
[441.547249] [073/132] (587s left) kms_atomic_transition (plane-all-transition)
[441.734170] Starting subtest: plane-all-transition
[441.735109] Starting dynamic subtest: pipe-A-DP-3
[445.476278] Dynamic subtest pipe-A-DP-3: SUCCESS (3.740s)
[445.610581] Starting dynamic subtest: pipe-B-DP-3
[449.482024] Dynamic subtest pipe-B-DP-3: SUCCESS (3.881s)
[449.570761] Subtest plane-all-transition: SUCCESS (7.836s)
[449.845095] [074/132] (579s left) kms_rotation_crc (multiplane-rotation)
[450.034149] Starting subtest: multiplane-rotation
[478.779654] Subtest multiplane-rotation: SUCCESS (28.745s)
[479.028831] [075/132] (549s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[479.237926] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[479.239660] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[479.448162] [076/132] (549s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[479.641842] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[479.707331] [077/132] (549s left) kms_psr (pr-sprite-blt)
[479.900153] Subtest pr-sprite-blt: SKIP (0.000s)
[479.957541] [078/132] (549s left) kms_psr (pr-cursor-render)
[480.147063] Subtest pr-cursor-render: SKIP (0.000s)
[480.207969] [079/132] (549s left) syncobj_wait (single-wait-all-signaled)
[480.294133] Starting subtest: single-wait-all-signaled
[480.295055] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[480.512167] [080/132] (548s left) kms_chamelium_hpd (dp-hpd-storm)
[480.789156] Subtest dp-hpd-storm: SKIP (0.000s)
[480.949131] [081/132] (548s left) gem_mmap_gtt (basic-write-gtt)
[481.034951] Subtest basic-write-gtt: SKIP (0.000s)
[481.101147] [082/132] (548s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[481.292055] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[481.292825] Starting dynamic subtest: pipe-A
[481.854296] Dynamic subtest pipe-A: SUCCESS (0.563s)
[481.870923] Starting dynamic subtest: pipe-B
[482.484185] Dynamic subtest pipe-B: SUCCESS (0.628s)
[482.508764] Starting dynamic subtest: pipe-C
[483.132426] Dynamic subtest pipe-C: SUCCESS (0.646s)
[483.166343] Starting dynamic subtest: pipe-D
[483.778190] Dynamic subtest pipe-D: SUCCESS (0.643s)
[483.781816] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.489s)
[484.125715] [083/132] (545s left) gem_exec_schedule (thriceslice)
[484.226009] Starting subtest: thriceslice
[484.226945] Starting dynamic subtest: rcs0
[484.257189] Dynamic subtest rcs0: SUCCESS (0.030s)
[484.271010] Starting dynamic subtest: bcs0
[484.289628] Dynamic subtest bcs0: SUCCESS (0.031s)
[484.304159] Starting dynamic subtest: vcs0
[484.343435] Dynamic subtest vcs0: SUCCESS (0.052s)
[484.360370] Starting dynamic subtest: vcs1
[484.377182] Dynamic subtest vcs1: SUCCESS (0.032s)
[484.391815] Starting dynamic subtest: vecs0
[484.433188] Dynamic subtest vecs0: SUCCESS (0.054s)
[484.463982] Starting dynamic subtest: vecs1
[484.475832] Dynamic subtest vecs1: SUCCESS (0.040s)
[484.499779] Starting dynamic subtest: ccs0
[484.536075] Dynamic subtest ccs0: SUCCESS (0.058s)
[484.537106] Subtest thriceslice: SUCCESS (0.311s)
[484.976970] [084/132] (544s left) gem_exec_fence (nb-await)
[485.185229] Starting subtest: nb-await
[485.186167] Starting dynamic subtest: rcs0
[485.278662] Dynamic subtest rcs0: SUCCESS (0.097s)
[485.299020] Starting dynamic subtest: bcs0
[485.347591] Dynamic subtest bcs0: SUCCESS (0.067s)
[485.391952] Starting dynamic subtest: vcs0
[485.440001] Dynamic subtest vcs0: SUCCESS (0.088s)
[485.471064] Starting dynamic subtest: vcs1
[485.516302] Dynamic subtest vcs1: SUCCESS (0.074s)
[485.548925] Starting dynamic subtest: vecs0
[485.594158] Dynamic subtest vecs0: SUCCESS (0.075s)
[485.639258] Starting dynamic subtest: vecs1
[485.685119] Dynamic subtest vecs1: SUCCESS (0.087s)
[485.721490] Starting dynamic subtest: ccs0
[485.767744] Dynamic subtest ccs0: SUCCESS (0.080s)
[485.768861] Subtest nb-await: SUCCESS (0.588s)
[486.540557] [085/132] (543s left) gem_userptr_blits (set-cache-level)
[486.628966] Starting subtest: set-cache-level
[486.629869] Subtest set-cache-level: SUCCESS (0.000s)
[486.869915] [086/132] (542s left) gem_ctx_persistence (hang)
[486.957440] Starting subtest: hang
[486.959461] Subtest hang: SKIP (0.000s)
[487.179165] [087/132] (542s left) kms_psr (psr-cursor-mmap-gtt)
[487.369893] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[487.437656] [088/132] (542s left) gem_eio (in-flight-contexts-immediate)
[487.720258] Starting subtest: in-flight-contexts-immediate
[501.681881] Subtest in-flight-contexts-immediate: SUCCESS (13.963s)
[501.965457] [089/132] (528s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[502.158523] Starting subtest: basic-modeset-with-all-modifiers-formats
[502.392140] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[502.649550] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.257s)
[502.696454] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[502.697572] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.027s)
[502.714232] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[502.715120] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.030s)
[502.728361] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[502.747663] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[502.762527] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[502.780918] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[502.795832] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[502.814221] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[502.829105] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[502.847624] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[502.862297] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[502.880899] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[502.895585] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[502.914302] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[502.929207] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[503.097419] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[503.112303] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[503.130926] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[503.148183] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[503.164178] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[503.181368] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[503.197521] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[503.214758] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[503.231036] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[503.248364] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[503.264208] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[503.281535] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[503.297618] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[503.314948] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[503.330777] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[503.347955] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[503.364153] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[503.381633] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[503.548726] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s)
[503.563287] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[503.582922] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[503.599394] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[503.616189] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[503.632782] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[503.652603] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[503.667469] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[503.682841] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[503.697639] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[503.716188] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[503.730762] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[503.749548] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[503.765005] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[503.782933] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[503.798213] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[503.816184] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[504.088541] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.930s)
[504.395971] [090/132] (525s left) kms_color (ctm-max)
[504.584976] Starting subtest: ctm-max
[504.585865] Starting dynamic subtest: pipe-A-DP-3
[505.265242] Dynamic subtest pipe-A-DP-3: SUCCESS (0.679s)
[505.296763] Starting dynamic subtest: pipe-B-DP-3
[505.873306] Dynamic subtest pipe-B-DP-3: SUCCESS (0.605s)
[505.896033] Starting dynamic subtest: pipe-C-DP-3
[506.474884] Dynamic subtest pipe-C-DP-3: SUCCESS (0.601s)
[506.492171] Starting dynamic subtest: pipe-D-DP-3
[507.072024] Dynamic subtest pipe-D-DP-3: SUCCESS (0.595s)
[507.073004] Subtest ctm-max: SUCCESS (2.488s)
[507.414226] [091/132] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[507.605281] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[507.606973] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[507.814093] [092/132] (522s left) gem_render_copy (linear)
[507.910676] Starting subtest: linear
[507.911642] Starting dynamic subtest: smem
[508.019138] Dynamic subtest smem: SUCCESS (0.108s)
[508.032497] Starting dynamic subtest: lmem0
[508.288755] Dynamic subtest lmem0: SUCCESS (0.268s)
[508.289668] Subtest linear: SUCCESS (0.379s)
[508.628397] [093/132] (521s left) gem_userptr_blits (access-control)
[508.732254] Starting subtest: access-control
[508.734122] Subtest access-control: SKIP (0.000s)
[508.944445] [094/132] (521s left) kms_flip (2x-nonexisting-fb)
[509.133432] Starting subtest: 2x-nonexisting-fb
[509.148627] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[509.306093] [095/132] (521s left) gem_ccs (block-copy-compressed)
[509.394084] Starting subtest: block-copy-compressed
[509.396329] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[509.442631] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.047s)
[509.456972] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[509.557123] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.113s)
[509.571894] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[509.575440] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[509.589991] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[509.689236] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.113s)
[509.704070] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[509.709287] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.019s)
[509.723863] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[509.822544] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.112s)
[509.837177] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[509.841060] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[509.855679] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[509.956178] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.114s)
[509.957098] Subtest block-copy-compressed: SUCCESS (0.563s)
[510.145269] [096/132] (520s left) prime_mmap (test_invalid_sync_flags)
[510.227475] Starting subtest: test_invalid_sync_flags
[510.228344] Starting dynamic subtest: test_invalid_sync_flags-smem
[510.229200] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[510.242549] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[510.243775] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[510.244883] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[510.406579] [097/132] (520s left) gem_exec_params (invalid-bsd-ring)
[510.491967] Starting subtest: invalid-bsd-ring
[510.492924] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[510.703466] [098/132] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[510.900592] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[510.902255] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.095972] [099/132] (519s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[511.286957] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[511.288622] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.494082] [100/132] (519s left) kms_plane (planar-pixel-format-settings)
[511.682295] Starting subtest: planar-pixel-format-settings
[511.738989] Subtest planar-pixel-format-settings: SUCCESS (0.055s)
[511.944025] [101/132] (519s left) syncobj_timeline (wait-for-submit-delayed-submit)
[512.023169] Starting subtest: wait-for-submit-delayed-submit
[512.127076] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[512.267487] [102/132] (518s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[512.779121] Starting subtest: cursor-rapid-movement-max-size
[512.781879] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[513.010276] [103/132] (518s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[513.202202] Starting subtest: modeset-atomic-cursor-hotspot
[513.203967] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[513.360147] [104/132] (517s left) gem_exec_balancer (parallel-keep-submit-fence)
[513.712235] Starting subtest: parallel-keep-submit-fence
[516.052469] Subtest parallel-keep-submit-fence: SUCCESS (2.340s)
[516.226235] [105/132] (515s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[516.503250] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[516.659837] [106/132] (514s left) kms_getfb (getfb-addfb-different-handles)
[516.848659] Starting subtest: getfb-addfb-different-handles
[516.849586] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[517.068693] [107/132] (514s left) gem_ctx_sseu (invalid-args)
[517.157008] Subtest invalid-args: SKIP (0.000s)
[517.248354] [108/132] (514s left) gem_lmem_swapping (parallel-random-verify)
[520.014891] Starting subtest: parallel-random-verify
[520.015787] Starting dynamic subtest: lmem0
[577.459312] Dynamic subtest lmem0: SUCCESS (57.454s)
[577.460219] Subtest parallel-random-verify: SUCCESS (57.456s)
[578.584207] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[578.585690] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[578.588078] [109/132] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[580.357742] Starting subtest: psr-2p-primscrn-spr-indfb-move
[580.359555] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[580.566950] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[580.569394] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[580.572256] [110/132] (451s left) gem_exec_reloc (basic-write-cpu-noreloc)
[580.664238] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[580.747612] [111/132] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[580.827177] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[580.828136] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[581.023046] [112/132] (450s left) i915_hangman (gt-engine-hang)
[581.124919] Starting subtest: gt-engine-hang
[581.125882] Starting dynamic subtest: rcs0
[581.958176] Dynamic subtest rcs0: SUCCESS (0.833s)
[581.972208] Starting dynamic subtest: bcs0
[582.810394] Dynamic subtest bcs0: SUCCESS (0.851s)
[582.826465] Starting dynamic subtest: vcs0
[583.619703] Dynamic subtest vcs0: SUCCESS (0.808s)
[583.632880] Starting dynamic subtest: vcs1
[584.429409] Dynamic subtest vcs1: SUCCESS (0.809s)
[584.443312] Starting dynamic subtest: vecs0
[585.235071] Dynamic subtest vecs0: SUCCESS (0.805s)
[585.248917] Starting dynamic subtest: vecs1
[586.069410] Dynamic subtest vecs1: SUCCESS (0.833s)
[586.085888] Starting dynamic subtest: ccs0
[586.877080] Dynamic subtest ccs0: SUCCESS (0.806s)
[586.877969] Subtest gt-engine-hang: SUCCESS (5.755s)
[587.088088] [113/132] (444s left) gem_mmap (bad-object)
[587.166921] Subtest bad-object: SKIP (0.000s)
[587.254720] [114/132] (444s left) kms_feature_discovery (psr1)
[587.443146] Starting subtest: psr1
[587.444891] Subtest psr1: SKIP (0.000s)
[587.598958] [115/132] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[587.801869] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[587.803577] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[588.014093] [116/132] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[588.207115] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[588.208846] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[588.403360] [117/132] (443s left) gem_mmap_gtt (fault-concurrent)
[588.485953] Subtest fault-concurrent: SKIP (0.000s)
[588.562698] [118/132] (443s left) kms_pm_rpm (legacy-planes-dpms)
[590.787396] Starting subtest: legacy-planes-dpms
[590.790530] Starting dynamic subtest: plane-63
[594.673281] Dynamic subtest plane-63: SUCCESS (3.885s)
[594.719849] Starting dynamic subtest: plane-93
[597.650353] Dynamic subtest plane-93: SUCCESS (2.973s)
[597.697205] Starting dynamic subtest: plane-123
[600.469613] Dynamic subtest plane-123: SUCCESS (2.815s)
[600.485680] Starting dynamic subtest: plane-133
[603.190162] Dynamic subtest plane-133: SUCCESS (2.716s)
[603.195999] Subtest legacy-planes-dpms: SUCCESS (12.408s)
[603.637552] [119/132] (428s left) kms_chamelium_color (ctm-negative)
[603.828160] Subtest ctm-negative: SKIP (0.000s)
[603.894349] [120/132] (428s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[604.084146] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[604.085053] Starting dynamic subtest: pipe-A-valid-mode
[604.178163] Dynamic subtest pipe-A-valid-mode: SKIP (0.093s)
[604.180133] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.096s)
[604.442148] [121/132] (428s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[604.642082] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[605.942282] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.300s)
[606.204629] [122/132] (426s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[606.393986] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[606.394891] Starting dynamic subtest: pipe-A-DP-3
[606.398411] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[606.410419] Starting dynamic subtest: pipe-B-DP-3
[606.413830] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[606.425457] Starting dynamic subtest: pipe-C-DP-3
[606.428875] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[606.440268] Starting dynamic subtest: pipe-D-DP-3
[606.443673] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[606.445257] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[606.893199] [123/132] (425s left) kms_invalid_mode (overflow-vrefresh)
[607.081165] Starting subtest: overflow-vrefresh
[607.083632] Starting dynamic subtest: pipe-A-DP-3
[607.162923] Dynamic subtest pipe-A-DP-3: SUCCESS (0.080s)
[607.179572] Starting dynamic subtest: pipe-B-DP-3
[607.180744] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[607.195218] Starting dynamic subtest: pipe-C-DP-3
[607.196173] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[607.209715] Starting dynamic subtest: pipe-D-DP-3
[607.210627] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[607.211547] Subtest overflow-vrefresh: SUCCESS (0.091s)
[607.452005] [124/132] (425s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[607.648250] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[607.649967] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[607.851851] [125/132] (424s left) kms_psr (fbc-pr-cursor-plane-move)
[608.038978] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[608.110294] [126/132] (424s left) prime_busy (before)
[608.198220] Starting subtest: before
[608.203281] Starting dynamic subtest: rcs0
[608.255362] Dynamic subtest rcs0: SUCCESS (0.052s)
[608.268901] Starting dynamic subtest: bcs0
[608.312768] Dynamic subtest bcs0: SUCCESS (0.056s)
[608.330875] Starting dynamic subtest: vcs0
[608.354369] Dynamic subtest vcs0: SUCCESS (0.040s)
[608.380952] Starting dynamic subtest: vcs1
[608.397251] Dynamic subtest vcs1: SUCCESS (0.041s)
[608.419400] Starting dynamic subtest: vecs0
[608.437238] Dynamic subtest vecs0: SUCCESS (0.038s)
[608.454790] Starting dynamic subtest: vecs1
[608.477211] Dynamic subtest vecs1: SUCCESS (0.039s)
[608.494810] Starting dynamic subtest: ccs0
[608.517719] Dynamic subtest ccs0: SUCCESS (0.039s)
[608.621483] Subtest before: SUCCESS (0.423s)
[608.831392] [127/132] (424s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[609.033112] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[609.034903] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[609.231983] [128/132] (423s left) kms_hdr (invalid-metadata-sizes)
[609.428100] Starting subtest: invalid-metadata-sizes
[609.955388] Starting dynamic subtest: pipe-A-DP-3
[609.958792] Dynamic subtest pipe-A-DP-3: SUCCESS (0.001s)
[609.959940] Subtest invalid-metadata-sizes: SUCCESS (0.531s)
[610.267271] [129/132] (422s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[610.352896] Starting subtest: y-tiled-ccs-to-yf-tiled
[610.355094] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[610.602686] [130/132] (422s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[610.791112] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[610.792859] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[610.996908] [131/132] (422s left) gem_userptr_blits (unsync-unmap)
[611.086856] Subtest unsync-unmap: SKIP (0.000s)
[611.320145] [132/132] (422s left) gem_ccs (suspend-resume)
[611.408303] Starting subtest: suspend-resume
[611.410685] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[630.054949] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.968s)
[630.067038] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[648.122149] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.669s)
[648.135287] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[666.067230] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.541s)
[666.079473] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[684.093169] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.731s)
[684.106570] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[702.056660] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.532s)
[702.071804] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[720.170295] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.645s)
[720.183699] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[738.077295] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.679s)
[738.089612] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[756.170552] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.757s)
[756.171390] Subtest suspend-resume: SUCCESS (29.532s)
[756.382154] 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.