[61.785443] Initializing watchdogs
[61.785509]   /dev/watchdog0
[61.806662] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.817984] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.822157] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.825056] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[62.005277] Starting subtest: flip-vs-expired-vblank
[62.009170] Starting dynamic subtest: A-DP3
[69.919543] Dynamic subtest A-DP3: SUCCESS (7.919s)
[69.932157] Starting dynamic subtest: B-DP3
[77.693314] Dynamic subtest B-DP3: SUCCESS (7.776s)
[77.702229] Starting dynamic subtest: C-DP3
[85.473466] Dynamic subtest C-DP3: SUCCESS (7.777s)
[85.508875] Starting dynamic subtest: D-DP3
[93.283687] Dynamic subtest D-DP3: SUCCESS (7.806s)
[93.287736] Subtest flip-vs-expired-vblank: SUCCESS (31.292s)
[93.645396] [002/132] (928s left) gem_exec_whisper (basic-contexts-forked)
[93.731569] Starting subtest: basic-contexts-forked
[116.145145] Subtest basic-contexts-forked: SUCCESS (22.410s)
[116.421603] [003/132] (906s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[116.612566] Starting subtest: 4-tiled-16bpp-rotate-0
[118.418930] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.806s)
[118.627155] [004/132] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[118.813947] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[120.085708] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.271s)
[120.279686] [005/132] (902s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[120.354407] Starting subtest: etime-multi-wait-for-submit-submitted
[120.455523] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[120.639721] [006/132] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[120.820595] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[120.822268] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.005994] [007/132] (901s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[121.073958] Starting subtest: multi-wait-all-for-submit-signaled
[121.074883] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[121.227664] [008/132] (901s left) core_setmaster (master-drop-set-user)
[121.384880] Starting subtest: master-drop-set-user
[121.421929] Subtest master-drop-set-user: SUCCESS (0.037s)
[121.471131] [009/132] (901s left) kms_pm_rpm (system-suspend-idle)
[123.073190] Starting subtest: system-suspend-idle
[142.970464] Subtest system-suspend-idle: SUCCESS (5.627s)
[143.396438] [010/132] (879s left) gem_exec_schedule (pi-ringfull)
[143.594272] Starting subtest: pi-ringfull
[143.595235] Starting dynamic subtest: rcs0
[143.688084] Dynamic subtest rcs0: SUCCESS (0.095s)
[143.698916] Starting dynamic subtest: bcs0
[143.718121] Dynamic subtest bcs0: SUCCESS (0.030s)
[143.728817] Starting dynamic subtest: vcs0
[143.747531] Dynamic subtest vcs0: SUCCESS (0.030s)
[143.758134] Starting dynamic subtest: vcs1
[143.776913] Dynamic subtest vcs1: SUCCESS (0.029s)
[143.787539] Starting dynamic subtest: vecs0
[143.807659] Dynamic subtest vecs0: SUCCESS (0.030s)
[143.818354] Starting dynamic subtest: vecs1
[143.838965] Dynamic subtest vecs1: SUCCESS (0.032s)
[143.849656] Starting dynamic subtest: ccs0
[143.869629] Dynamic subtest ccs0: SUCCESS (0.031s)
[143.870389] Subtest pi-ringfull: SUCCESS (0.280s)
[144.190962] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[144.192956] [011/132] (878s left) kms_flip (bo-too-big-interruptible)
[144.380920] Starting subtest: bo-too-big-interruptible
[144.385177] Starting dynamic subtest: A-DP3
[144.695364] Dynamic subtest A-DP3: SUCCESS (0.313s)
[144.735329] Starting dynamic subtest: B-DP3
[144.934656] Dynamic subtest B-DP3: SUCCESS (0.240s)
[144.969987] Starting dynamic subtest: C-DP3
[145.176125] Dynamic subtest C-DP3: SUCCESS (0.243s)
[145.211199] Starting dynamic subtest: D-DP3
[145.418987] Dynamic subtest D-DP3: SUCCESS (0.244s)
[145.423519] Subtest bo-too-big-interruptible: SUCCESS (1.053s)
[145.831116] [012/132] (877s left) gem_pread (exhaustion)
[145.908511] Subtest exhaustion: SKIP (0.000s)
[145.985514] [013/132] (877s left) kms_plane_scaling (2x-scaler-multi-pipe)
[146.175658] Starting subtest: 2x-scaler-multi-pipe
[146.178201] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[146.348986] [014/132] (876s left) api_intel_bb (blit-reloc-purge-cache)
[146.434201] Starting subtest: blit-reloc-purge-cache
[146.436027] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[146.655194] [015/132] (876s left) syncobj_timeline (single-wait-all-available-submitted)
[146.731014] Starting subtest: single-wait-all-available-submitted
[146.731797] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[146.898104] [016/132] (876s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[147.092318] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[147.142104] [017/132] (876s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[147.330654] Starting subtest: 2x-long-flip-vs-cursor-atomic
[147.333349] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[147.507044] [018/132] (876s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[147.696132] Starting subtest: 2x-plain-flip-ts-check-interruptible
[147.711541] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[147.889717] [019/132] (875s left) gem_exec_nop (basic-sequential)
[147.984024] Starting subtest: basic-sequential
[152.410999] Subtest basic-sequential: SUCCESS (4.450s)
[152.736346] [020/132] (870s left) gem_fence_thrash (bo-write-verify-threaded-none)
[152.782358] Starting subtest: bo-write-verify-threaded-none
[152.818543] Subtest bo-write-verify-threaded-none: SKIP (0.036s)
[152.903329] [021/132] (870s left) prime_mmap_kms (buffer-sharing)
[153.088716] Starting subtest: buffer-sharing
[153.463923] Subtest buffer-sharing: SUCCESS (0.375s)
[153.800410] [022/132] (870s left) gem_userptr_blits (stress-mm)
[153.891955] Starting subtest: stress-mm
[159.246952] Subtest stress-mm: SUCCESS (5.369s)
[159.461244] [023/132] (864s left) kms_pm_backlight (fade)
[159.649906] Subtest fade: SKIP (0.000s)
[159.713716] [024/132] (864s left) gem_exec_params (rs-invalid)
[159.798159] Starting subtest: rs-invalid
[159.801018] Subtest rs-invalid: SUCCESS (0.002s)
[160.012399] [025/132] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[160.206600] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[160.208197] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[160.372185] [026/132] (863s left) gem_fence_thrash (bo-write-verify-none)
[160.417747] Starting subtest: bo-write-verify-none
[160.450704] Subtest bo-write-verify-none: SKIP (0.032s)
[160.530468] [027/132] (863s left) gem_workarounds (suspend-resume-context)
[160.634176] Starting subtest: suspend-resume-context
[179.710022] Subtest suspend-resume-context: SUCCESS (3.849s)
[179.862255] [028/132] (844s left) syncobj_wait (wait-all-delayed-signal)
[179.951893] Starting subtest: wait-all-delayed-signal
[180.054406] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[180.257139] [029/132] (844s left) gem_softpin (evict-active-interruptible)
[180.342020] Starting subtest: evict-active-interruptible
[180.362848] Subtest evict-active-interruptible: SUCCESS (0.021s)
[180.574179] [030/132] (843s left) i915_query (query-regions-garbage-items)
[180.647602] Starting subtest: query-regions-garbage-items
[180.648671] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[180.808625] [031/132] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[181.008096] Starting subtest: compare-crc-sanitycheck-xr24
[181.008970] Starting dynamic subtest: pipe-A-DP-3
[181.589245] Dynamic subtest pipe-A-DP-3: SUCCESS (0.580s)
[181.613487] Starting dynamic subtest: pipe-B-DP-3
[182.069527] Dynamic subtest pipe-B-DP-3: SUCCESS (0.477s)
[182.083209] Starting dynamic subtest: pipe-C-DP-3
[182.528126] Dynamic subtest pipe-C-DP-3: SUCCESS (0.458s)
[182.542613] Starting dynamic subtest: pipe-D-DP-3
[182.998189] Dynamic subtest pipe-D-DP-3: SUCCESS (0.468s)
[182.999169] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.990s)
[183.265281] [032/132] (841s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[183.452904] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[183.511017] [033/132] (841s left) gem_ctx_exec (basic-nohangcheck)
[183.594530] Starting subtest: basic-nohangcheck
[183.905924] Subtest basic-nohangcheck: SUCCESS (0.312s)
[184.116286] [034/132] (840s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[184.197000] Starting subtest: x-tiled-to-vebox-yf-tiled
[184.198958] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[184.502865] [035/132] (840s left) i915_drm_fdinfo (virtual-busy)
[184.572112] Starting subtest: virtual-busy
[184.573973] Subtest virtual-busy: SKIP (0.000s)
[184.706040] [036/132] (840s left) prime_vgem (busy)
[184.818031] Starting subtest: busy
[184.818944] Starting dynamic subtest: rcs0
[184.878586] Dynamic subtest rcs0: SUCCESS (0.060s)
[184.890458] Starting dynamic subtest: bcs0
[184.930207] Dynamic subtest bcs0: SUCCESS (0.051s)
[184.943980] Starting dynamic subtest: vcs0
[184.972199] Dynamic subtest vcs0: SUCCESS (0.041s)
[184.996396] Starting dynamic subtest: vcs1
[185.015774] Dynamic subtest vcs1: SUCCESS (0.043s)
[185.039923] Starting dynamic subtest: vecs0
[185.056127] Dynamic subtest vecs0: SUCCESS (0.040s)
[185.074011] Starting dynamic subtest: vecs1
[185.097481] Dynamic subtest vecs1: SUCCESS (0.041s)
[185.113477] Starting dynamic subtest: ccs0
[185.138615] Dynamic subtest ccs0: SUCCESS (0.041s)
[185.139670] Subtest busy: SUCCESS (0.321s)
[185.360934] [037/132] (839s left) kms_big_fb (linear-16bpp-rotate-180)
[185.562283] Starting subtest: linear-16bpp-rotate-180
[187.384889] Subtest linear-16bpp-rotate-180: SUCCESS (1.820s)
[187.580941] [038/132] (837s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[187.789167] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[187.790060] Starting dynamic subtest: pipe-A-valid-mode
[187.876036] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s)
[187.877859] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.086s)
[188.131773] [039/132] (836s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[188.317625] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[188.318615] Starting dynamic subtest: pipe-A-DP-3
[188.326923] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[188.338572] Starting dynamic subtest: pipe-B-DP-3
[188.347067] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[188.358354] Starting dynamic subtest: pipe-C-DP-3
[188.366579] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[188.378156] Starting dynamic subtest: pipe-D-DP-3
[188.389247] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[188.391519] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[188.809176] [040/132] (836s left) gem_softpin (evict-prime)
[188.892253] Starting subtest: evict-prime
[188.893180] Starting dynamic subtest: rcs0
[190.152143] Dynamic subtest rcs0: SUCCESS (1.260s)
[190.166592] Starting dynamic subtest: bcs0
[191.362926] Dynamic subtest bcs0: SUCCESS (1.211s)
[191.374997] Starting dynamic subtest: vcs0
[192.520788] Dynamic subtest vcs0: SUCCESS (1.150s)
[192.535273] Starting dynamic subtest: vcs1
[193.664142] Dynamic subtest vcs1: SUCCESS (1.151s)
[193.676613] Starting dynamic subtest: vecs0
[194.798480] Dynamic subtest vecs0: SUCCESS (1.134s)
[194.810701] Starting dynamic subtest: vecs1
[195.981056] Dynamic subtest vecs1: SUCCESS (1.183s)
[195.995847] Starting dynamic subtest: ccs0
[197.115157] Dynamic subtest ccs0: SUCCESS (1.134s)
[197.127099] Starting dynamic subtest: all
[198.318355] Dynamic subtest all: SUCCESS (1.203s)
[198.319269] Subtest evict-prime: SUCCESS (9.431s)
[198.499157] [041/132] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[198.688106] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[198.689760] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[198.889700] [042/132] (826s left) kms_plane_alpha_blend (alpha-opaque-fb)
[199.072798] Starting subtest: alpha-opaque-fb
[199.326004] Starting dynamic subtest: pipe-A-DP-3
[199.845168] Dynamic subtest pipe-A-DP-3: SUCCESS (0.519s)
[199.857587] Starting dynamic subtest: pipe-D-DP-3
[200.406098] Dynamic subtest pipe-D-DP-3: SUCCESS (0.560s)
[200.406992] Subtest alpha-opaque-fb: SUCCESS (1.334s)
[200.735415] [043/132] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[200.928038] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[200.929685] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[201.127023] [044/132] (824s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[201.311817] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[201.312689] Starting dynamic subtest: pipe-A-DP-3
[201.321911] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[201.333776] Starting dynamic subtest: pipe-B-DP-3
[201.342844] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[201.354156] Starting dynamic subtest: pipe-C-DP-3
[201.363092] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[201.374514] Starting dynamic subtest: pipe-D-DP-3
[201.385991] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[201.388032] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[201.803724] [045/132] (823s left) perf_pmu (busy-accuracy-2)
[201.877933] Starting subtest: busy-accuracy-2
[201.878868] Starting dynamic subtest: rcs0
[204.946053] Dynamic subtest rcs0: SUCCESS (3.069s)
[204.959296] Starting dynamic subtest: bcs0
[208.012455] Dynamic subtest bcs0: SUCCESS (3.067s)
[208.025748] Starting dynamic subtest: vcs0
[211.077916] Dynamic subtest vcs0: SUCCESS (3.066s)
[211.091082] Starting dynamic subtest: vcs1
[214.142780] Dynamic subtest vcs1: SUCCESS (3.064s)
[214.156144] Starting dynamic subtest: vecs0
[217.205972] Dynamic subtest vecs0: SUCCESS (3.061s)
[217.219441] Starting dynamic subtest: vecs1
[220.269779] Dynamic subtest vecs1: SUCCESS (3.062s)
[220.283210] Starting dynamic subtest: ccs0
[223.333482] Dynamic subtest ccs0: SUCCESS (3.063s)
[223.334348] Subtest busy-accuracy-2: SUCCESS (21.457s)
[223.568064] [046/132] (802s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[223.643778] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[223.644752] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[223.817702] [047/132] (801s left) kms_content_protection (srm)
[224.072779] Starting subtest: srm
[224.099913] Starting dynamic subtest: pipe-A-DP-3
[344.959170] Dynamic subtest pipe-A-DP-3: FAIL (120.693s)
[344.960584] Subtest srm: FAIL (120.822s)
[345.218787] [048/132] (680s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[345.413326] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[345.414213] Starting dynamic subtest: pipe-A-DP-3
[345.422583] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[345.435211] Starting dynamic subtest: pipe-B-DP-3
[345.443559] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[345.456006] Starting dynamic subtest: pipe-C-DP-3
[345.464179] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[345.476792] Starting dynamic subtest: pipe-D-DP-3
[345.486992] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[345.489131] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[345.897418] [049/132] (679s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[346.090557] Starting subtest: psr-rgb565-draw-mmap-gtt
[346.092293] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[346.297234] [050/132] (679s left) kms_cursor_crc (cursor-onscreen-32x10)
[346.599484] Starting subtest: cursor-onscreen-32x10
[346.649801] Subtest cursor-onscreen-32x10: SKIP (0.049s)
[347.081287] [051/132] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[347.272436] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[347.274015] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[347.478426] [052/132] (678s left) gem_ctx_bad_destroy (double-destroy)
[347.559126] Starting subtest: double-destroy
[347.560060] Subtest double-destroy: SUCCESS (0.000s)
[347.748697] [053/132] (678s left) gem_lmem_swapping (basic)
[350.530853] Starting subtest: basic
[350.531853] Starting dynamic subtest: lmem0
[371.211020] Dynamic subtest lmem0: SUCCESS (20.686s)
[371.211940] Subtest basic: SUCCESS (20.686s)
[373.447193] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[373.448161] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[373.449780] [054/132] (652s left) gen9_exec_parse (bb-start-cmd)
[375.169988] Subtest bb-start-cmd: SKIP (0.000s)
[375.235141] [FACT gen9_exec_parse (bb-start-cmd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[375.237591] [FACT gen9_exec_parse (bb-start-cmd)] new: kernel.kmod_is_loaded.i915: true
[375.240493] [055/132] (651s left) sw_sync (sync_multi_timeline_wait)
[375.289671] Starting subtest: sync_multi_timeline_wait
[375.290615] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[375.441707] [056/132] (650s left) i915_pm_rc6_residency (rc6-accuracy)
[375.518033] Starting subtest: rc6-accuracy
[375.518869] Starting dynamic subtest: gt0
[378.725579] Dynamic subtest gt0: FAIL (3.187s)
[378.726700] Subtest rc6-accuracy: FAIL (3.187s)
[378.843311] [057/132] (647s left) api_intel_bb (simple-bb-ctx)
[378.918012] Starting subtest: simple-bb-ctx
[378.960010] Subtest simple-bb-ctx: SUCCESS (0.042s)
[379.205125] [058/132] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[379.401433] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[379.403010] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[379.595399] [059/132] (647s left) kms_vblank (crtc-id)
[379.782021] Starting subtest: crtc-id
[379.784052] Starting dynamic subtest: pipe-A-DP-3
[380.276299] Dynamic subtest pipe-A-DP-3: SUCCESS (0.491s)
[380.322921] Starting dynamic subtest: pipe-D-DP-3
[380.759551] Dynamic subtest pipe-D-DP-3: SUCCESS (0.468s)
[380.761124] Subtest crtc-id: SUCCESS (0.977s)
[381.190874] [060/132] (645s left) gem_basic (bad-close)
[381.266945] Starting subtest: bad-close
[381.268868] Subtest bad-close: SUCCESS (0.000s)
[381.435301] [061/132] (645s left) kms_flip (dpms-vs-vblank-race-interruptible)
[381.625002] Starting subtest: dpms-vs-vblank-race-interruptible
[381.629574] Starting dynamic subtest: A-DP3
[384.841234] Dynamic subtest A-DP3: SUCCESS (3.212s)
[384.868349] Starting dynamic subtest: B-DP3
[387.971125] Dynamic subtest B-DP3: SUCCESS (3.128s)
[387.986389] Starting dynamic subtest: C-DP3
[390.971433] Dynamic subtest C-DP3: SUCCESS (2.999s)
[390.984164] Starting dynamic subtest: D-DP3
[394.025701] Dynamic subtest D-DP3: SUCCESS (3.055s)
[394.027965] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.406s)
[394.339996] [062/132] (632s left) kms_vblank (wait-forked-busy)
[394.531056] Starting subtest: wait-forked-busy
[394.531920] Starting dynamic subtest: pipe-A-DP-3
[397.050793] Dynamic subtest pipe-A-DP-3: SUCCESS (2.519s)
[397.078294] Starting dynamic subtest: pipe-D-DP-3
[399.525708] Dynamic subtest pipe-D-DP-3: SUCCESS (2.468s)
[399.526749] Subtest wait-forked-busy: SUCCESS (4.997s)
[399.809192] [063/132] (627s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[400.011354] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[400.013045] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[400.219005] [064/132] (626s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[400.416871] Starting subtest: 4-tiled-64bpp-rotate-180
[402.304810] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.888s)
[402.587613] [065/132] (624s left) kms_flip (absolute-wf_vblank-interruptible)
[402.785820] Starting subtest: absolute-wf_vblank-interruptible
[402.790710] Starting dynamic subtest: A-DP3
[410.611881] Dynamic subtest A-DP3: SUCCESS (7.819s)
[410.627786] Starting dynamic subtest: B-DP3
[418.369185] Dynamic subtest B-DP3: SUCCESS (7.752s)
[418.383996] Starting dynamic subtest: C-DP3
[426.127328] Dynamic subtest C-DP3: SUCCESS (7.753s)
[426.149910] Starting dynamic subtest: D-DP3
[433.870138] Dynamic subtest D-DP3: SUCCESS (7.735s)
[433.872561] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.077s)
[434.225971] [066/132] (593s left) gem_exec_flush (basic-uc-prw-default)
[434.310838] Subtest basic-uc-prw-default: SKIP (0.000s)
[434.428275] [067/132] (592s left) vgem_basic (busy-fence)
[434.483158] Starting subtest: busy-fence
[434.484003] Subtest busy-fence: SUCCESS (0.000s)
[434.631763] [068/132] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[434.825624] Starting subtest: psr-rgb565-draw-render
[434.827389] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[435.018810] [069/132] (592s left) kms_dp_link_training (uhbr-sst)
[435.205382] Starting subtest: uhbr-sst
[435.207082] Subtest uhbr-sst: SKIP (0.000s)
[435.367686] [070/132] (592s left) kms_universal_plane (disable-primary-vs-flip)
[435.556925] Starting subtest: disable-primary-vs-flip
[435.557837] Starting dynamic subtest: pipe-A-DP-3
[436.123893] Dynamic subtest pipe-A-DP-3: SUCCESS (0.566s)
[436.144191] Starting dynamic subtest: pipe-B-DP-3
[436.608718] Dynamic subtest pipe-B-DP-3: SUCCESS (0.482s)
[436.622702] Starting dynamic subtest: pipe-C-DP-3
[437.061129] Dynamic subtest pipe-C-DP-3: SUCCESS (0.450s)
[437.083592] Starting dynamic subtest: pipe-D-DP-3
[437.558084] Dynamic subtest pipe-D-DP-3: SUCCESS (0.493s)
[437.558980] Subtest disable-primary-vs-flip: SUCCESS (2.001s)
[437.876625] [071/132] (589s left) gem_exec_balancer (invalid-balancer)
[437.964636] Starting subtest: invalid-balancer
[439.569457] Subtest invalid-balancer: SUCCESS (1.604s)
[440.007283] [072/132] (587s left) gem_mmap_offset (bad-extensions)
[440.090289] Starting subtest: bad-extensions
[440.091197] Subtest bad-extensions: SUCCESS (0.000s)
[440.250559] [073/132] (587s left) kms_atomic_transition (plane-all-transition)
[440.439936] Starting subtest: plane-all-transition
[440.440841] Starting dynamic subtest: pipe-A-DP-3
[444.241493] Dynamic subtest pipe-A-DP-3: SUCCESS (3.800s)
[444.387854] Starting dynamic subtest: pipe-B-DP-3
[448.294368] Dynamic subtest pipe-B-DP-3: SUCCESS (3.924s)
[448.400577] Subtest plane-all-transition: SUCCESS (7.960s)
[448.676027] [074/132] (579s left) kms_rotation_crc (multiplane-rotation)
[448.869034] Starting subtest: multiplane-rotation
[477.743104] Subtest multiplane-rotation: SUCCESS (28.873s)
[477.959365] [075/132] (549s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[478.160916] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[478.162695] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[478.372588] [076/132] (549s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[478.566031] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[478.645782] [077/132] (549s left) kms_psr (pr-sprite-blt)
[478.830180] Subtest pr-sprite-blt: SKIP (0.000s)
[478.889354] [078/132] (549s left) kms_psr (pr-cursor-render)
[479.077807] Subtest pr-cursor-render: SKIP (0.000s)
[479.139860] [079/132] (549s left) syncobj_wait (single-wait-all-signaled)
[479.220052] Starting subtest: single-wait-all-signaled
[479.220924] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[479.433276] [080/132] (548s left) kms_chamelium_hpd (dp-hpd-storm)
[479.702989] Subtest dp-hpd-storm: SKIP (0.000s)
[479.856689] [081/132] (548s left) gem_mmap_gtt (basic-write-gtt)
[479.936887] Subtest basic-write-gtt: SKIP (0.000s)
[480.015947] [082/132] (548s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[480.202227] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[480.203127] Starting dynamic subtest: pipe-A
[480.796766] Dynamic subtest pipe-A: SUCCESS (0.594s)
[480.821784] Starting dynamic subtest: pipe-B
[481.443299] Dynamic subtest pipe-B: SUCCESS (0.644s)
[481.477664] Starting dynamic subtest: pipe-C
[482.089256] Dynamic subtest pipe-C: SUCCESS (0.643s)
[482.120056] Starting dynamic subtest: pipe-D
[482.735381] Dynamic subtest pipe-D: SUCCESS (0.644s)
[482.738825] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.534s)
[483.082541] [083/132] (545s left) gem_exec_schedule (thriceslice)
[483.173038] Starting subtest: thriceslice
[483.173988] Starting dynamic subtest: rcs0
[483.204817] Dynamic subtest rcs0: SUCCESS (0.031s)
[483.219060] Starting dynamic subtest: bcs0
[483.257014] Dynamic subtest bcs0: SUCCESS (0.051s)
[483.282319] Starting dynamic subtest: vcs0
[483.297359] Dynamic subtest vcs0: SUCCESS (0.038s)
[483.321978] Starting dynamic subtest: vcs1
[483.336022] Dynamic subtest vcs1: SUCCESS (0.037s)
[483.356956] Starting dynamic subtest: vecs0
[483.371928] Dynamic subtest vecs0: SUCCESS (0.034s)
[483.390506] Starting dynamic subtest: vecs1
[483.428834] Dynamic subtest vecs1: SUCCESS (0.055s)
[483.457138] Starting dynamic subtest: ccs0
[483.490523] Dynamic subtest ccs0: SUCCESS (0.059s)
[483.495822] Subtest thriceslice: SUCCESS (0.319s)
[483.929219] [084/132] (544s left) gem_exec_fence (nb-await)
[484.139450] Starting subtest: nb-await
[484.140357] Starting dynamic subtest: rcs0
[484.231193] Dynamic subtest rcs0: SUCCESS (0.097s)
[484.247256] Starting dynamic subtest: bcs0
[484.297010] Dynamic subtest bcs0: SUCCESS (0.064s)
[484.325467] Starting dynamic subtest: vcs0
[484.371209] Dynamic subtest vcs0: SUCCESS (0.071s)
[484.416677] Starting dynamic subtest: vcs1
[484.461969] Dynamic subtest vcs1: SUCCESS (0.086s)
[484.481052] Starting dynamic subtest: vecs0
[484.528264] Dynamic subtest vecs0: SUCCESS (0.064s)
[484.553420] Starting dynamic subtest: vecs1
[484.598032] Dynamic subtest vecs1: SUCCESS (0.068s)
[484.645912] Starting dynamic subtest: ccs0
[484.691196] Dynamic subtest ccs0: SUCCESS (0.089s)
[484.692202] Subtest nb-await: SUCCESS (0.559s)
[485.467725] [085/132] (543s left) gem_userptr_blits (set-cache-level)
[485.553848] Starting subtest: set-cache-level
[485.554822] Subtest set-cache-level: SUCCESS (0.000s)
[485.812710] [086/132] (542s left) gem_ctx_persistence (hang)
[485.897813] Starting subtest: hang
[485.899850] Subtest hang: SKIP (0.000s)
[486.067274] [087/132] (542s left) kms_psr (psr-cursor-mmap-gtt)
[486.253796] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[486.328199] [088/132] (542s left) gem_eio (in-flight-contexts-immediate)
[486.597267] Starting subtest: in-flight-contexts-immediate
[500.465404] Subtest in-flight-contexts-immediate: SUCCESS (13.869s)
[500.755658] [089/132] (528s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[500.939071] Starting subtest: basic-modeset-with-all-modifiers-formats
[501.167959] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[501.423692] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.256s)
[501.447670] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[501.456934] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[501.480178] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[501.490139] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.031s)
[501.506487] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[501.523545] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[501.538429] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[501.556825] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[501.571554] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[501.590118] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[501.604987] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[501.623541] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[501.638238] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[501.656824] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[501.671709] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[501.690168] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[501.704631] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[501.873259] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[501.888544] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[501.906774] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[501.923417] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[501.940170] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[501.956902] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[501.973435] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[501.990112] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[502.006795] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[502.023467] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[502.040098] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[502.056815] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[502.073412] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[502.090081] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[502.106702] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[502.123273] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[502.140070] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[502.156670] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[502.324731] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.183s)
[502.339833] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[502.358878] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[502.376080] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[502.392011] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[502.407209] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[502.425549] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[502.440940] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[502.458829] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[502.473842] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[502.492110] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[502.506956] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[502.525424] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[502.540260] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[502.558845] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[502.573706] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[502.592103] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[502.865717] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.928s)
[503.172345] [090/132] (525s left) kms_color (ctm-max)
[503.355079] Starting subtest: ctm-max
[503.356087] Starting dynamic subtest: pipe-A-DP-3
[504.054919] Dynamic subtest pipe-A-DP-3: SUCCESS (0.697s)
[504.072634] Starting dynamic subtest: pipe-B-DP-3
[504.641202] Dynamic subtest pipe-B-DP-3: SUCCESS (0.585s)
[504.656169] Starting dynamic subtest: pipe-C-DP-3
[505.233094] Dynamic subtest pipe-C-DP-3: SUCCESS (0.591s)
[505.254227] Starting dynamic subtest: pipe-D-DP-3
[505.821853] Dynamic subtest pipe-D-DP-3: SUCCESS (0.587s)
[505.822921] Subtest ctm-max: SUCCESS (2.468s)
[506.156340] [091/132] (523s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[506.351807] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[506.353491] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[506.615053] [092/132] (522s left) gem_render_copy (linear)
[506.701622] Starting subtest: linear
[506.702505] Starting dynamic subtest: smem
[506.805917] Dynamic subtest smem: SUCCESS (0.104s)
[506.821109] Starting dynamic subtest: lmem0
[507.085079] Dynamic subtest lmem0: SUCCESS (0.278s)
[507.085973] Subtest linear: SUCCESS (0.384s)
[507.375479] [093/132] (521s left) gem_userptr_blits (access-control)
[507.478550] Starting subtest: access-control
[507.480362] Subtest access-control: SKIP (0.000s)
[507.688411] [094/132] (521s left) kms_flip (2x-nonexisting-fb)
[507.873607] Starting subtest: 2x-nonexisting-fb
[507.888938] Subtest 2x-nonexisting-fb: SKIP (0.015s)
[508.056685] [095/132] (521s left) gem_ccs (block-copy-compressed)
[508.139000] Starting subtest: block-copy-compressed
[508.141269] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[508.187691] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.047s)
[508.202718] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[508.304095] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s)
[508.319170] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[508.322584] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[508.337607] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[508.420028] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.096s)
[508.435129] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[508.438301] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[508.453295] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[508.534965] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.095s)
[508.550047] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[508.554693] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[508.569709] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[508.657135] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[508.658001] Subtest block-copy-compressed: SUCCESS (0.519s)
[508.890596] [096/132] (520s left) prime_mmap (test_invalid_sync_flags)
[508.973270] Starting subtest: test_invalid_sync_flags
[508.974160] Starting dynamic subtest: test_invalid_sync_flags-smem
[508.975050] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[508.988902] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[508.990208] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[508.991477] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[509.138811] [097/132] (520s left) gem_exec_params (invalid-bsd-ring)
[509.222861] Starting subtest: invalid-bsd-ring
[509.223872] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[509.435127] [098/132] (520s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[509.633761] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[509.635460] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[509.838886] [099/132] (520s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[510.028609] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[510.030323] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[510.227923] [100/132] (519s left) kms_plane (planar-pixel-format-settings)
[510.416911] Starting subtest: planar-pixel-format-settings
[510.481736] Subtest planar-pixel-format-settings: SUCCESS (0.065s)
[510.691608] [101/132] (519s left) syncobj_timeline (wait-for-submit-delayed-submit)
[510.771087] Starting subtest: wait-for-submit-delayed-submit
[510.874485] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[511.017667] [102/132] (519s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[511.516401] Starting subtest: cursor-rapid-movement-max-size
[511.518942] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[511.766465] [103/132] (518s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[511.953930] Starting subtest: modeset-atomic-cursor-hotspot
[511.955707] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[512.129310] [104/132] (518s left) gem_exec_balancer (parallel-keep-submit-fence)
[512.485492] Starting subtest: parallel-keep-submit-fence
[514.853323] Subtest parallel-keep-submit-fence: SUCCESS (2.368s)
[515.063750] [105/132] (515s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[515.353093] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[515.515068] [106/132] (514s left) kms_getfb (getfb-addfb-different-handles)
[515.706996] Starting subtest: getfb-addfb-different-handles
[515.707865] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[515.924033] [107/132] (514s left) gem_ctx_sseu (invalid-args)
[516.024537] Subtest invalid-args: SKIP (0.000s)
[516.149630] [108/132] (514s left) gem_lmem_swapping (parallel-random-verify)
[518.880776] Starting subtest: parallel-random-verify
[518.881625] Starting dynamic subtest: lmem0
[575.780630] Dynamic subtest lmem0: SUCCESS (56.911s)
[575.782318] Subtest parallel-random-verify: SUCCESS (56.913s)
[576.869734] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[576.870708] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[576.872800] [109/132] (453s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[578.659797] Starting subtest: psr-2p-primscrn-spr-indfb-move
[578.661574] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[578.874635] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[578.877273] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[578.880099] [110/132] (451s left) gem_exec_reloc (basic-write-cpu-noreloc)
[578.978177] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[579.071059] [111/132] (451s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[579.156157] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[579.157044] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[579.319526] [112/132] (451s left) i915_hangman (gt-engine-hang)
[579.433571] Starting subtest: gt-engine-hang
[579.434534] Starting dynamic subtest: rcs0
[580.322138] Dynamic subtest rcs0: SUCCESS (0.889s)
[580.338844] Starting dynamic subtest: bcs0
[581.155018] Dynamic subtest bcs0: SUCCESS (0.831s)
[581.172933] Starting dynamic subtest: vcs0
[581.946323] Dynamic subtest vcs0: SUCCESS (0.790s)
[581.970534] Starting dynamic subtest: vcs1
[582.749233] Dynamic subtest vcs1: SUCCESS (0.801s)
[582.762936] Starting dynamic subtest: vecs0
[583.565999] Dynamic subtest vecs0: SUCCESS (0.815s)
[583.587072] Starting dynamic subtest: vecs1
[584.386014] Dynamic subtest vecs1: SUCCESS (0.816s)
[584.399730] Starting dynamic subtest: ccs0
[585.245375] Dynamic subtest ccs0: SUCCESS (0.857s)
[585.248556] Subtest gt-engine-hang: SUCCESS (5.816s)
[585.451926] [113/132] (445s left) gem_mmap (bad-object)
[585.531911] Subtest bad-object: SKIP (0.000s)
[585.598399] [114/132] (445s left) kms_feature_discovery (psr1)
[585.792108] Starting subtest: psr1
[585.793989] Subtest psr1: SKIP (0.000s)
[585.956493] [115/132] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[586.148787] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[586.150448] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[586.357344] [116/132] (444s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[586.550757] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[586.552358] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[586.754165] [117/132] (444s left) gem_mmap_gtt (fault-concurrent)
[586.834866] Subtest fault-concurrent: SKIP (0.000s)
[586.943387] [118/132] (444s left) kms_pm_rpm (legacy-planes-dpms)
[588.465967] Starting subtest: legacy-planes-dpms
[588.467215] Starting dynamic subtest: plane-63
[591.336701] Dynamic subtest plane-63: SUCCESS (2.870s)
[591.382699] Starting dynamic subtest: plane-93
[594.226330] Dynamic subtest plane-93: SUCCESS (2.885s)
[594.272124] Starting dynamic subtest: plane-123
[597.049101] Dynamic subtest plane-123: SUCCESS (2.818s)
[597.065013] Starting dynamic subtest: plane-133
[599.867171] Dynamic subtest plane-133: SUCCESS (2.814s)
[599.873204] Subtest legacy-planes-dpms: SUCCESS (11.406s)
[600.319408] [119/132] (431s left) kms_chamelium_color (ctm-negative)
[600.504675] Subtest ctm-negative: SKIP (0.000s)
[600.562317] [120/132] (430s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[600.747378] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[600.749819] Starting dynamic subtest: pipe-A-valid-mode
[600.825427] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[600.827102] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.078s)
[601.082987] [121/132] (430s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[601.308567] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[602.629994] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.321s)
[602.846360] [122/132] (428s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[603.030196] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[603.032556] Starting dynamic subtest: pipe-A-DP-3
[603.035951] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[603.048209] Starting dynamic subtest: pipe-B-DP-3
[603.051797] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[603.063840] Starting dynamic subtest: pipe-C-DP-3
[603.068623] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[603.081342] Starting dynamic subtest: pipe-D-DP-3
[603.084976] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[603.087160] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[603.524722] [123/132] (428s left) kms_invalid_mode (overflow-vrefresh)
[603.716846] Starting subtest: overflow-vrefresh
[603.717795] Starting dynamic subtest: pipe-A-DP-3
[603.798621] Dynamic subtest pipe-A-DP-3: SUCCESS (0.082s)
[603.817543] Starting dynamic subtest: pipe-B-DP-3
[603.818757] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[603.835015] Starting dynamic subtest: pipe-C-DP-3
[603.835985] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[603.848637] Starting dynamic subtest: pipe-D-DP-3
[603.849581] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[603.850562] Subtest overflow-vrefresh: SUCCESS (0.094s)
[604.084459] [124/132] (427s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[604.277948] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[604.279738] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[604.469116] [125/132] (427s left) kms_psr (fbc-pr-cursor-plane-move)
[604.655039] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[604.711662] [126/132] (427s left) prime_busy (before)
[604.802275] Starting subtest: before
[604.807833] Starting dynamic subtest: rcs0
[604.867474] Dynamic subtest rcs0: SUCCESS (0.060s)
[604.881397] Starting dynamic subtest: bcs0
[604.924181] Dynamic subtest bcs0: SUCCESS (0.056s)
[604.945696] Starting dynamic subtest: vcs0
[604.966974] Dynamic subtest vcs0: SUCCESS (0.041s)
[604.989194] Starting dynamic subtest: vcs1
[605.009455] Dynamic subtest vcs1: SUCCESS (0.041s)
[605.032039] Starting dynamic subtest: vecs0
[605.050054] Dynamic subtest vecs0: SUCCESS (0.039s)
[605.072697] Starting dynamic subtest: vecs1
[605.092028] Dynamic subtest vecs1: SUCCESS (0.040s)
[605.114433] Starting dynamic subtest: ccs0
[605.134163] Dynamic subtest ccs0: SUCCESS (0.040s)
[605.258397] Subtest before: SUCCESS (0.446s)
[605.469166] [127/132] (426s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[605.671032] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[605.672787] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[605.884959] [128/132] (426s left) kms_hdr (invalid-metadata-sizes)
[606.072046] Starting subtest: invalid-metadata-sizes
[606.668124] Starting dynamic subtest: pipe-A-DP-3
[606.672682] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[606.674166] Subtest invalid-metadata-sizes: SUCCESS (0.601s)
[606.995042] [129/132] (425s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[607.090863] Starting subtest: y-tiled-ccs-to-yf-tiled
[607.092922] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[607.332656] [130/132] (424s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[607.525844] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[607.527623] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[607.730210] [131/132] (424s left) gem_userptr_blits (unsync-unmap)
[607.818776] Subtest unsync-unmap: SKIP (0.000s)
[608.044607] [132/132] (424s left) gem_ccs (suspend-resume)
[608.142957] Starting subtest: suspend-resume
[608.143851] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[626.100646] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.943s)
[626.114908] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[644.149398] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.746s)
[644.163647] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[662.070978] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.726s)
[662.084975] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[680.169643] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.750s)
[680.184177] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[698.043656] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.589s)
[698.058537] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[716.122232] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.709s)
[716.136452] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[734.027530] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.509s)
[734.042388] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[752.149780] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.663s)
[752.150637] Subtest suspend-resume: SUCCESS (29.646s)
[752.367303] 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.