[62.352289] Initializing watchdogs
[62.352359]   /dev/watchdog0
[62.372788] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.383496] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.387923] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.390376] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[62.576592] Starting subtest: flip-vs-expired-vblank
[62.580504] Starting dynamic subtest: A-DP3
[70.458984] Dynamic subtest A-DP3: SUCCESS (7.878s)
[70.468281] Starting dynamic subtest: B-DP3
[78.233290] Dynamic subtest B-DP3: SUCCESS (7.773s)
[78.248065] Starting dynamic subtest: C-DP3
[86.000253] Dynamic subtest C-DP3: SUCCESS (7.765s)
[86.027021] Starting dynamic subtest: D-DP3
[93.788495] Dynamic subtest D-DP3: SUCCESS (7.787s)
[93.790329] Subtest flip-vs-expired-vblank: SUCCESS (31.213s)
[94.131363] [002/132] (928s left) gem_exec_whisper (basic-contexts-forked)
[94.221293] Starting subtest: basic-contexts-forked
[116.776138] Subtest basic-contexts-forked: SUCCESS (22.553s)
[117.064207] [003/132] (905s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[117.256601] Starting subtest: 4-tiled-16bpp-rotate-0
[119.005107] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.748s)
[119.244613] [004/132] (903s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[119.434182] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[120.705157] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.271s)
[120.915147] [005/132] (902s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[120.985285] Starting subtest: etime-multi-wait-for-submit-submitted
[121.094974] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[121.268307] [006/132] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[121.450425] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[121.452106] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[121.651794] [007/132] (901s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[121.725922] Starting subtest: multi-wait-all-for-submit-signaled
[121.726857] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[121.914490] [008/132] (901s left) core_setmaster (master-drop-set-user)
[122.087374] Starting subtest: master-drop-set-user
[122.125114] Subtest master-drop-set-user: SUCCESS (0.038s)
[122.168814] [009/132] (901s left) kms_pm_rpm (system-suspend-idle)
[124.062254] Starting subtest: system-suspend-idle
[144.228015] Subtest system-suspend-idle: SUCCESS (5.423s)
[144.631127] [010/132] (878s left) gem_exec_schedule (pi-ringfull)
[144.832600] Starting subtest: pi-ringfull
[144.833507] Starting dynamic subtest: rcs0
[144.920383] Dynamic subtest rcs0: SUCCESS (0.088s)
[144.930554] Starting dynamic subtest: bcs0
[144.952223] Dynamic subtest bcs0: SUCCESS (0.032s)
[144.962285] Starting dynamic subtest: vcs0
[144.983015] Dynamic subtest vcs0: SUCCESS (0.031s)
[144.993358] Starting dynamic subtest: vcs1
[145.013560] Dynamic subtest vcs1: SUCCESS (0.030s)
[145.024004] Starting dynamic subtest: vecs0
[145.043965] Dynamic subtest vecs0: SUCCESS (0.030s)
[145.054269] Starting dynamic subtest: vecs1
[145.073665] Dynamic subtest vecs1: SUCCESS (0.029s)
[145.084026] Starting dynamic subtest: ccs0
[145.102963] Dynamic subtest ccs0: SUCCESS (0.029s)
[145.103741] Subtest pi-ringfull: SUCCESS (0.271s)
[145.412460] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[145.414274] [011/132] (878s left) kms_flip (bo-too-big-interruptible)
[145.609726] Starting subtest: bo-too-big-interruptible
[145.614710] Starting dynamic subtest: A-DP3
[145.909475] Dynamic subtest A-DP3: SUCCESS (0.294s)
[145.950252] Starting dynamic subtest: B-DP3
[146.150438] Dynamic subtest B-DP3: SUCCESS (0.239s)
[146.178971] Starting dynamic subtest: C-DP3
[146.373552] Dynamic subtest C-DP3: SUCCESS (0.222s)
[146.408492] Starting dynamic subtest: D-DP3
[146.619973] Dynamic subtest D-DP3: SUCCESS (0.245s)
[146.624195] Subtest bo-too-big-interruptible: SUCCESS (1.014s)
[147.048993] [012/132] (876s left) gem_pread (exhaustion)
[147.128864] Subtest exhaustion: SKIP (0.000s)
[147.219474] [013/132] (876s left) kms_plane_scaling (2x-scaler-multi-pipe)
[147.407411] Starting subtest: 2x-scaler-multi-pipe
[147.410235] Subtest 2x-scaler-multi-pipe: SKIP (0.002s)
[147.614905] [014/132] (876s left) api_intel_bb (blit-reloc-purge-cache)
[147.701989] Starting subtest: blit-reloc-purge-cache
[147.703754] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[147.896448] [015/132] (875s left) syncobj_timeline (single-wait-all-available-submitted)
[147.975023] Starting subtest: single-wait-all-available-submitted
[147.976000] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[148.164661] [016/132] (875s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[148.360416] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[148.409725] [017/132] (875s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[148.598886] Starting subtest: 2x-long-flip-vs-cursor-atomic
[148.600668] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[148.774169] [018/132] (875s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[148.971261] Starting subtest: 2x-plain-flip-ts-check-interruptible
[148.986771] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.015s)
[149.176422] [019/132] (875s left) gem_exec_nop (basic-sequential)
[149.266421] Starting subtest: basic-sequential
[153.718665] Subtest basic-sequential: SUCCESS (4.450s)
[154.051054] [020/132] (870s left) gem_fence_thrash (bo-write-verify-threaded-none)
[154.097404] Starting subtest: bo-write-verify-threaded-none
[154.128765] Subtest bo-write-verify-threaded-none: SKIP (0.030s)
[154.217788] [021/132] (870s left) prime_mmap_kms (buffer-sharing)
[154.401006] Starting subtest: buffer-sharing
[154.811883] Subtest buffer-sharing: SUCCESS (0.409s)
[155.134446] [022/132] (869s left) gem_userptr_blits (stress-mm)
[155.226312] Starting subtest: stress-mm
[160.596954] Subtest stress-mm: SUCCESS (5.369s)
[160.778421] [023/132] (863s left) kms_pm_backlight (fade)
[160.968750] Subtest fade: SKIP (0.000s)
[161.043582] [024/132] (863s left) gem_exec_params (rs-invalid)
[161.128301] Starting subtest: rs-invalid
[161.131121] Subtest rs-invalid: SUCCESS (0.002s)
[161.347021] [025/132] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[161.536250] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[161.537969] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[161.738262] [026/132] (862s left) gem_fence_thrash (bo-write-verify-none)
[161.786497] Starting subtest: bo-write-verify-none
[161.817426] Subtest bo-write-verify-none: SKIP (0.032s)
[161.917839] [027/132] (862s left) gem_workarounds (suspend-resume-context)
[162.015255] Starting subtest: suspend-resume-context
[181.111697] Subtest suspend-resume-context: SUCCESS (3.823s)
[181.269211] [028/132] (843s left) syncobj_wait (wait-all-delayed-signal)
[181.350501] Starting subtest: wait-all-delayed-signal
[181.454026] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[181.650072] [029/132] (843s left) gem_softpin (evict-active-interruptible)
[181.737736] Starting subtest: evict-active-interruptible
[181.757290] Subtest evict-active-interruptible: SUCCESS (0.019s)
[181.918164] [030/132] (843s left) i915_query (query-regions-garbage-items)
[181.998287] Starting subtest: query-regions-garbage-items
[181.999252] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[182.183277] [031/132] (842s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[182.365727] Starting subtest: compare-crc-sanitycheck-xr24
[182.367758] Starting dynamic subtest: pipe-A-DP-3
[182.918442] Dynamic subtest pipe-A-DP-3: SUCCESS (0.551s)
[182.943182] Starting dynamic subtest: pipe-B-DP-3
[183.405541] Dynamic subtest pipe-B-DP-3: SUCCESS (0.484s)
[183.418748] Starting dynamic subtest: pipe-C-DP-3
[183.854700] Dynamic subtest pipe-C-DP-3: SUCCESS (0.446s)
[183.868074] Starting dynamic subtest: pipe-D-DP-3
[184.319052] Dynamic subtest pipe-D-DP-3: SUCCESS (0.465s)
[184.319944] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.953s)
[184.643461] [032/132] (840s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[184.835595] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s)
[184.914008] [033/132] (840s left) gem_ctx_exec (basic-nohangcheck)
[184.993548] Starting subtest: basic-nohangcheck
[185.308127] Subtest basic-nohangcheck: SUCCESS (0.314s)
[185.491875] [034/132] (839s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[185.583849] Starting subtest: x-tiled-to-vebox-yf-tiled
[185.586019] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[185.852956] [035/132] (839s left) i915_drm_fdinfo (virtual-busy)
[185.923633] Starting subtest: virtual-busy
[185.925393] Subtest virtual-busy: SKIP (0.000s)
[186.109569] [036/132] (839s left) prime_vgem (busy)
[186.225851] Starting subtest: busy
[186.226764] Starting dynamic subtest: rcs0
[186.319079] Dynamic subtest rcs0: SUCCESS (0.093s)
[186.330600] Starting dynamic subtest: bcs0
[186.379805] Dynamic subtest bcs0: SUCCESS (0.060s)
[186.398860] Starting dynamic subtest: vcs0
[186.424930] Dynamic subtest vcs0: SUCCESS (0.044s)
[186.451513] Starting dynamic subtest: vcs1
[186.466590] Dynamic subtest vcs1: SUCCESS (0.041s)
[186.485011] Starting dynamic subtest: vecs0
[186.508156] Dynamic subtest vecs0: SUCCESS (0.041s)
[186.524012] Starting dynamic subtest: vecs1
[186.549641] Dynamic subtest vecs1: SUCCESS (0.041s)
[186.567513] Starting dynamic subtest: ccs0
[186.592168] Dynamic subtest ccs0: SUCCESS (0.042s)
[186.593208] Subtest busy: SUCCESS (0.366s)
[186.824471] [037/132] (838s left) kms_big_fb (linear-16bpp-rotate-180)
[187.020054] Starting subtest: linear-16bpp-rotate-180
[188.826311] Subtest linear-16bpp-rotate-180: SUCCESS (1.805s)
[189.057350] [038/132] (836s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[189.245429] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[189.246333] Starting dynamic subtest: pipe-A-valid-mode
[189.338908] Dynamic subtest pipe-A-valid-mode: SKIP (0.092s)
[189.340879] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.093s)
[189.601030] [039/132] (836s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[189.802316] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[189.803261] Starting dynamic subtest: pipe-A-DP-3
[189.811577] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[189.822901] Starting dynamic subtest: pipe-B-DP-3
[189.831528] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[189.842694] Starting dynamic subtest: pipe-C-DP-3
[189.850788] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[189.861887] Starting dynamic subtest: pipe-D-DP-3
[189.872738] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[189.874799] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[190.295486] [040/132] (835s left) gem_softpin (evict-prime)
[190.380950] Starting subtest: evict-prime
[190.381973] Starting dynamic subtest: rcs0
[191.609879] Dynamic subtest rcs0: SUCCESS (1.228s)
[191.661092] Starting dynamic subtest: bcs0
[192.795764] Dynamic subtest bcs0: SUCCESS (1.185s)
[192.812629] Starting dynamic subtest: vcs0
[193.945071] Dynamic subtest vcs0: SUCCESS (1.149s)
[193.956533] Starting dynamic subtest: vcs1
[195.136892] Dynamic subtest vcs1: SUCCESS (1.191s)
[195.157043] Starting dynamic subtest: vecs0
[196.300790] Dynamic subtest vecs0: SUCCESS (1.163s)
[196.312694] Starting dynamic subtest: vecs1
[197.466712] Dynamic subtest vecs1: SUCCESS (1.165s)
[197.481501] Starting dynamic subtest: ccs0
[198.597813] Dynamic subtest ccs0: SUCCESS (1.131s)
[198.609612] Starting dynamic subtest: all
[199.745136] Dynamic subtest all: SUCCESS (1.147s)
[199.746167] Subtest evict-prime: SUCCESS (9.364s)
[199.935401] [041/132] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[200.126121] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[200.127800] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[200.314164] [042/132] (825s left) kms_plane_alpha_blend (alpha-opaque-fb)
[200.498573] Starting subtest: alpha-opaque-fb
[200.749322] Starting dynamic subtest: pipe-A-DP-3
[201.270569] Dynamic subtest pipe-A-DP-3: SUCCESS (0.520s)
[201.283571] Starting dynamic subtest: pipe-D-DP-3
[201.865997] Dynamic subtest pipe-D-DP-3: SUCCESS (0.595s)
[201.866876] Subtest alpha-opaque-fb: SUCCESS (1.367s)
[202.198619] [043/132] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[202.391788] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[202.393474] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[202.597118] [044/132] (823s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[202.781852] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[202.782785] Starting dynamic subtest: pipe-A-DP-3
[202.792064] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[202.803416] Starting dynamic subtest: pipe-B-DP-3
[202.812748] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[202.823804] Starting dynamic subtest: pipe-C-DP-3
[202.832796] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[202.843868] Starting dynamic subtest: pipe-D-DP-3
[202.853216] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[202.861684] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[203.274687] [045/132] (822s left) perf_pmu (busy-accuracy-2)
[203.346623] Starting subtest: busy-accuracy-2
[203.347552] Starting dynamic subtest: rcs0
[206.413470] Dynamic subtest rcs0: SUCCESS (3.066s)
[206.425954] Starting dynamic subtest: bcs0
[209.478412] Dynamic subtest bcs0: SUCCESS (3.064s)
[209.491218] Starting dynamic subtest: vcs0
[212.548179] Dynamic subtest vcs0: SUCCESS (3.069s)
[212.560938] Starting dynamic subtest: vcs1
[215.614968] Dynamic subtest vcs1: SUCCESS (3.066s)
[215.627919] Starting dynamic subtest: vecs0
[218.678918] Dynamic subtest vecs0: SUCCESS (3.063s)
[218.691850] Starting dynamic subtest: vecs1
[221.740780] Dynamic subtest vecs1: SUCCESS (3.061s)
[221.753575] Starting dynamic subtest: ccs0
[224.801856] Dynamic subtest ccs0: SUCCESS (3.061s)
[224.802790] Subtest busy-accuracy-2: SUCCESS (21.454s)
[225.036229] [046/132] (801s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[225.115478] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[225.116405] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[225.324107] [047/132] (801s left) kms_content_protection (srm)
[225.574778] Starting subtest: srm
[225.606526] Starting dynamic subtest: pipe-A-DP-3
[346.434857] Dynamic subtest pipe-A-DP-3: FAIL (120.659s)
[346.436594] Subtest srm: FAIL (120.793s)
[346.704489] [048/132] (679s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[346.893535] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[346.894525] Starting dynamic subtest: pipe-A-DP-3
[346.903020] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[346.915582] Starting dynamic subtest: pipe-B-DP-3
[346.923683] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[346.935658] Starting dynamic subtest: pipe-C-DP-3
[346.944325] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[346.957185] Starting dynamic subtest: pipe-D-DP-3
[346.968566] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[346.970924] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[347.383162] [049/132] (679s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[347.583326] Starting subtest: psr-rgb565-draw-mmap-gtt
[347.585062] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[347.779461] [050/132] (678s left) kms_cursor_crc (cursor-onscreen-32x10)
[348.086829] Starting subtest: cursor-onscreen-32x10
[348.139220] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[348.562177] [051/132] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[348.771255] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[348.772862] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[348.978913] [052/132] (677s left) gem_ctx_bad_destroy (double-destroy)
[349.056130] Starting subtest: double-destroy
[349.056939] Subtest double-destroy: SUCCESS (0.000s)
[349.194549] [053/132] (677s left) gem_lmem_swapping (basic)
[352.020784] Starting subtest: basic
[352.021544] Starting dynamic subtest: lmem0
[372.912568] Dynamic subtest lmem0: SUCCESS (20.893s)
[372.913510] Subtest basic: SUCCESS (20.894s)
[375.112231] [FACT gem_lmem_swapping (basic)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[375.113254] [FACT gem_lmem_swapping (basic)] deleted: kernel.kmod_is_loaded.i915: true
[375.114950] [054/132] (651s left) gen9_exec_parse (bb-start-cmd)
[376.768924] Subtest bb-start-cmd: SKIP (0.000s)
[376.831464] [FACT gen9_exec_parse (bb-start-cmd)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[376.833879] [FACT gen9_exec_parse (bb-start-cmd)] new: kernel.kmod_is_loaded.i915: true
[376.836835] [055/132] (650s left) sw_sync (sync_multi_timeline_wait)
[376.888644] Starting subtest: sync_multi_timeline_wait
[376.889865] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[377.050453] [056/132] (649s left) i915_pm_rc6_residency (rc6-accuracy)
[377.128692] Starting subtest: rc6-accuracy
[377.129605] Starting dynamic subtest: gt0
[380.364941] Dynamic subtest gt0: FAIL (3.211s)
[380.366310] Subtest rc6-accuracy: FAIL (3.213s)
[380.490165] [057/132] (646s left) api_intel_bb (simple-bb-ctx)
[380.569961] Starting subtest: simple-bb-ctx
[380.611635] Subtest simple-bb-ctx: SUCCESS (0.041s)
[380.845439] [058/132] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[381.039283] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[381.041149] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[381.244772] [059/132] (645s left) kms_vblank (crtc-id)
[381.428639] Starting subtest: crtc-id
[381.429562] Starting dynamic subtest: pipe-A-DP-3
[381.838602] Dynamic subtest pipe-A-DP-3: SUCCESS (0.408s)
[381.860211] Starting dynamic subtest: pipe-D-DP-3
[382.155924] Dynamic subtest pipe-D-DP-3: SUCCESS (0.313s)
[382.156799] Subtest crtc-id: SUCCESS (0.728s)
[382.446780] [060/132] (644s left) gem_basic (bad-close)
[382.530640] Starting subtest: bad-close
[382.532711] Subtest bad-close: SUCCESS (0.000s)
[382.692031] [061/132] (644s left) kms_flip (dpms-vs-vblank-race-interruptible)
[382.883121] Starting subtest: dpms-vs-vblank-race-interruptible
[382.887731] Starting dynamic subtest: A-DP3
[386.132942] Dynamic subtest A-DP3: SUCCESS (3.245s)
[386.156477] Starting dynamic subtest: B-DP3
[389.190977] Dynamic subtest B-DP3: SUCCESS (3.055s)
[389.203597] Starting dynamic subtest: C-DP3
[392.262389] Dynamic subtest C-DP3: SUCCESS (3.070s)
[392.277743] Starting dynamic subtest: D-DP3
[395.296899] Dynamic subtest D-DP3: SUCCESS (3.032s)
[395.299400] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.415s)
[395.624402] [062/132] (631s left) kms_vblank (wait-forked-busy)
[395.814952] Starting subtest: wait-forked-busy
[395.817358] Starting dynamic subtest: pipe-A-DP-3
[398.349740] Dynamic subtest pipe-A-DP-3: SUCCESS (2.533s)
[398.374484] Starting dynamic subtest: pipe-D-DP-3
[400.789612] Dynamic subtest pipe-D-DP-3: SUCCESS (2.433s)
[400.790568] Subtest wait-forked-busy: SUCCESS (4.975s)
[401.081468] [063/132] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[401.274574] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[401.276334] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[401.482142] [064/132] (626s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[401.679770] Starting subtest: 4-tiled-64bpp-rotate-180
[403.596417] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.915s)
[403.849911] [065/132] (623s left) kms_flip (absolute-wf_vblank-interruptible)
[404.044518] Starting subtest: absolute-wf_vblank-interruptible
[404.049414] Starting dynamic subtest: A-DP3
[411.871604] Dynamic subtest A-DP3: SUCCESS (7.821s)
[411.892572] Starting dynamic subtest: B-DP3
[419.617166] Dynamic subtest B-DP3: SUCCESS (7.738s)
[419.633581] Starting dynamic subtest: C-DP3
[427.362065] Dynamic subtest C-DP3: SUCCESS (7.739s)
[427.378617] Starting dynamic subtest: D-DP3
[435.105590] Dynamic subtest D-DP3: SUCCESS (7.738s)
[435.107803] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.060s)
[435.455428] [066/132] (592s left) gem_exec_flush (basic-uc-prw-default)
[435.541812] Subtest basic-uc-prw-default: SKIP (0.000s)
[435.641832] [067/132] (592s left) vgem_basic (busy-fence)
[435.701996] Starting subtest: busy-fence
[435.702857] Subtest busy-fence: SUCCESS (0.000s)
[435.857798] [068/132] (592s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[436.051226] Starting subtest: psr-rgb565-draw-render
[436.052870] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[436.274550] [069/132] (591s left) kms_dp_link_training (uhbr-sst)
[436.462326] Starting subtest: uhbr-sst
[436.464163] Subtest uhbr-sst: SKIP (0.000s)
[436.617344] [070/132] (591s left) kms_universal_plane (disable-primary-vs-flip)
[436.805321] Starting subtest: disable-primary-vs-flip
[436.807627] Starting dynamic subtest: pipe-A-DP-3
[437.381949] Dynamic subtest pipe-A-DP-3: SUCCESS (0.575s)
[437.399931] Starting dynamic subtest: pipe-B-DP-3
[437.866791] Dynamic subtest pipe-B-DP-3: SUCCESS (0.481s)
[437.879402] Starting dynamic subtest: pipe-C-DP-3
[438.325402] Dynamic subtest pipe-C-DP-3: SUCCESS (0.457s)
[438.348271] Starting dynamic subtest: pipe-D-DP-3
[438.815662] Dynamic subtest pipe-D-DP-3: SUCCESS (0.486s)
[438.816553] Subtest disable-primary-vs-flip: SUCCESS (2.009s)
[439.105641] [071/132] (589s left) gem_exec_balancer (invalid-balancer)
[439.199009] Starting subtest: invalid-balancer
[440.788289] Subtest invalid-balancer: SUCCESS (1.589s)
[441.233730] [072/132] (587s left) gem_mmap_offset (bad-extensions)
[441.313914] Starting subtest: bad-extensions
[441.314787] Subtest bad-extensions: SUCCESS (0.000s)
[441.515727] [073/132] (586s left) kms_atomic_transition (plane-all-transition)
[441.709642] Starting subtest: plane-all-transition
[441.710549] Starting dynamic subtest: pipe-A-DP-3
[445.501951] Dynamic subtest pipe-A-DP-3: SUCCESS (3.791s)
[445.646644] Starting dynamic subtest: pipe-B-DP-3
[449.537993] Dynamic subtest pipe-B-DP-3: SUCCESS (3.908s)
[449.644659] Subtest plane-all-transition: SUCCESS (7.935s)
[449.921073] [074/132] (578s left) kms_rotation_crc (multiplane-rotation)
[450.108787] Starting subtest: multiplane-rotation
[478.902311] Subtest multiplane-rotation: SUCCESS (28.792s)
[479.139292] [075/132] (549s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[479.339218] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[479.340957] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[479.543327] [076/132] (549s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[479.736787] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[479.799830] [077/132] (548s left) kms_psr (pr-sprite-blt)
[479.986488] Subtest pr-sprite-blt: SKIP (0.000s)
[480.049658] [078/132] (548s left) kms_psr (pr-cursor-render)
[480.238939] Subtest pr-cursor-render: SKIP (0.000s)
[480.300206] [079/132] (548s left) syncobj_wait (single-wait-all-signaled)
[480.385734] Starting subtest: single-wait-all-signaled
[480.386646] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[480.602839] [080/132] (548s left) kms_chamelium_hpd (dp-hpd-storm)
[480.863543] Subtest dp-hpd-storm: SKIP (0.000s)
[481.021279] [081/132] (547s left) gem_mmap_gtt (basic-write-gtt)
[481.119633] Subtest basic-write-gtt: SKIP (0.000s)
[481.219064] [082/132] (547s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[481.414691] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[481.415465] Starting dynamic subtest: pipe-A
[481.987859] Dynamic subtest pipe-A: SUCCESS (0.574s)
[482.011678] Starting dynamic subtest: pipe-B
[482.635768] Dynamic subtest pipe-B: SUCCESS (0.646s)
[482.663823] Starting dynamic subtest: pipe-C
[483.281781] Dynamic subtest pipe-C: SUCCESS (0.644s)
[483.311615] Starting dynamic subtest: pipe-D
[483.928017] Dynamic subtest pipe-D: SUCCESS (0.644s)
[483.929259] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (2.515s)
[484.284077] [083/132] (544s left) gem_exec_schedule (thriceslice)
[484.375552] Starting subtest: thriceslice
[484.376526] Starting dynamic subtest: rcs0
[484.409076] Dynamic subtest rcs0: SUCCESS (0.033s)
[484.423171] Starting dynamic subtest: bcs0
[484.461151] Dynamic subtest bcs0: SUCCESS (0.051s)
[484.483331] Starting dynamic subtest: vcs0
[484.522433] Dynamic subtest vcs0: SUCCESS (0.059s)
[484.542076] Starting dynamic subtest: vcs1
[484.559443] Dynamic subtest vcs1: SUCCESS (0.034s)
[484.574860] Starting dynamic subtest: vecs0
[484.613729] Dynamic subtest vecs0: SUCCESS (0.053s)
[484.645757] Starting dynamic subtest: vecs1
[484.681411] Dynamic subtest vecs1: SUCCESS (0.065s)
[484.725870] Starting dynamic subtest: ccs0
[484.760418] Dynamic subtest ccs0: SUCCESS (0.075s)
[484.761469] Subtest thriceslice: SUCCESS (0.386s)
[485.189141] [084/132] (544s left) gem_exec_fence (nb-await)
[485.427841] Starting subtest: nb-await
[485.429240] Starting dynamic subtest: rcs0
[485.534835] Dynamic subtest rcs0: SUCCESS (0.109s)
[485.550577] Starting dynamic subtest: bcs0
[485.599372] Dynamic subtest bcs0: SUCCESS (0.063s)
[485.620618] Starting dynamic subtest: vcs0
[485.668114] Dynamic subtest vcs0: SUCCESS (0.067s)
[485.710132] Starting dynamic subtest: vcs1
[485.755258] Dynamic subtest vcs1: SUCCESS (0.084s)
[485.772926] Starting dynamic subtest: vecs0
[485.821793] Dynamic subtest vecs0: SUCCESS (0.064s)
[485.849342] Starting dynamic subtest: vecs1
[485.899491] Dynamic subtest vecs1: SUCCESS (0.075s)
[485.941015] Starting dynamic subtest: ccs0
[485.987950] Dynamic subtest ccs0: SUCCESS (0.084s)
[485.988977] Subtest nb-await: SUCCESS (0.565s)
[486.829523] [085/132] (542s left) gem_userptr_blits (set-cache-level)
[486.919649] Starting subtest: set-cache-level
[486.920547] Subtest set-cache-level: SUCCESS (0.000s)
[487.159308] [086/132] (542s left) gem_ctx_persistence (hang)
[487.245420] Starting subtest: hang
[487.247524] Subtest hang: SKIP (0.000s)
[487.423579] [087/132] (542s left) kms_psr (psr-cursor-mmap-gtt)
[487.619284] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[487.688028] [088/132] (541s left) gem_eio (in-flight-contexts-immediate)
[487.952164] Starting subtest: in-flight-contexts-immediate
[501.929929] Subtest in-flight-contexts-immediate: SUCCESS (13.977s)
[502.218579] [089/132] (527s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[502.406697] Starting subtest: basic-modeset-with-all-modifiers-formats
[502.632910] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[502.887387] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.254s)
[502.910541] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[502.920585] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[502.943279] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[502.953822] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.031s)
[502.971532] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[502.987065] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[503.001989] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[503.020466] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[503.035563] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[503.053738] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[503.068728] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[503.087086] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[503.104263] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[503.120464] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[503.135420] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[503.153848] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[503.168885] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[503.337105] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[503.351820] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[503.370466] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[503.387261] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[503.403923] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[503.421020] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[503.437138] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[503.454208] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[503.470528] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[503.486034] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[503.503736] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[503.519593] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[503.537156] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[503.555566] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[503.570559] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[503.589122] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[503.603832] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[503.622448] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[503.771762] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.166s)
[503.786282] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[503.805860] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[503.821752] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[503.839248] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[503.854993] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[503.872545] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[503.888314] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[503.905787] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[503.920940] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[503.939104] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[503.953745] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[503.972558] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[503.986861] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[504.005860] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[504.020760] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[504.039221] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[504.312532] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.906s)
[504.624936] [090/132] (525s left) kms_color (ctm-max)
[504.809920] Starting subtest: ctm-max
[504.810841] Starting dynamic subtest: pipe-A-DP-3
[505.524962] Dynamic subtest pipe-A-DP-3: SUCCESS (0.713s)
[505.556215] Starting dynamic subtest: pipe-B-DP-3
[506.111961] Dynamic subtest pipe-B-DP-3: SUCCESS (0.583s)
[506.133419] Starting dynamic subtest: pipe-C-DP-3
[506.711421] Dynamic subtest pipe-C-DP-3: SUCCESS (0.598s)
[506.730027] Starting dynamic subtest: pipe-D-DP-3
[507.293732] Dynamic subtest pipe-D-DP-3: SUCCESS (0.581s)
[507.294639] Subtest ctm-max: SUCCESS (2.483s)
[507.608904] [091/132] (522s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[507.805287] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[507.807163] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[508.009930] [092/132] (521s left) gem_render_copy (linear)
[508.095141] Starting subtest: linear
[508.096043] Starting dynamic subtest: smem
[508.200610] Dynamic subtest smem: SUCCESS (0.105s)
[508.215614] Starting dynamic subtest: lmem0
[508.490975] Dynamic subtest lmem0: SUCCESS (0.289s)
[508.491813] Subtest linear: SUCCESS (0.396s)
[508.841960] [093/132] (521s left) gem_userptr_blits (access-control)
[508.942757] Starting subtest: access-control
[508.944545] Subtest access-control: SKIP (0.000s)
[509.156724] [094/132] (520s left) kms_flip (2x-nonexisting-fb)
[509.343537] Starting subtest: 2x-nonexisting-fb
[509.358806] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[509.530828] [095/132] (520s left) gem_ccs (block-copy-compressed)
[509.617658] Starting subtest: block-copy-compressed
[509.619847] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[509.663851] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.045s)
[509.678936] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[509.779655] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.115s)
[509.794235] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[509.798128] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.017s)
[509.812539] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[509.894427] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.095s)
[509.908725] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[509.911935] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.016s)
[509.926474] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[510.008693] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.095s)
[510.023382] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[510.027982] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.018s)
[510.042303] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[510.130093] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.101s)
[510.130946] Subtest block-copy-compressed: SUCCESS (0.513s)
[510.323646] [096/132] (519s left) prime_mmap (test_invalid_sync_flags)
[510.401057] Starting subtest: test_invalid_sync_flags
[510.401932] Starting dynamic subtest: test_invalid_sync_flags-smem
[510.402772] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[510.416511] Starting dynamic subtest: test_invalid_sync_flags-lmem0
[510.417730] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s)
[510.418993] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[510.617002] [097/132] (519s left) gem_exec_params (invalid-bsd-ring)
[510.704205] Starting subtest: invalid-bsd-ring
[510.705132] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[510.872155] [098/132] (519s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[511.062643] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[511.064330] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.258983] [099/132] (519s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[511.459746] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[511.461515] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[511.658458] [100/132] (518s left) kms_plane (planar-pixel-format-settings)
[511.845053] Starting subtest: planar-pixel-format-settings
[511.900173] Subtest planar-pixel-format-settings: SUCCESS (0.055s)
[512.073969] [101/132] (518s left) syncobj_timeline (wait-for-submit-delayed-submit)
[512.149945] Starting subtest: wait-for-submit-delayed-submit
[512.254041] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[512.439890] [102/132] (518s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[512.949334] Starting subtest: cursor-rapid-movement-max-size
[512.952080] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[513.196463] [103/132] (517s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[513.384788] Starting subtest: modeset-atomic-cursor-hotspot
[513.386543] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[513.538903] [104/132] (517s left) gem_exec_balancer (parallel-keep-submit-fence)
[513.933340] Starting subtest: parallel-keep-submit-fence
[516.266451] Subtest parallel-keep-submit-fence: SUCCESS (2.333s)
[516.456781] [105/132] (514s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[516.734279] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[516.900551] [106/132] (514s left) kms_getfb (getfb-addfb-different-handles)
[517.088697] Starting subtest: getfb-addfb-different-handles
[517.089577] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[517.303232] [107/132] (513s left) gem_ctx_sseu (invalid-args)
[517.387532] Subtest invalid-args: SKIP (0.000s)
[517.469508] [108/132] (513s left) gem_lmem_swapping (parallel-random-verify)
[520.254018] Starting subtest: parallel-random-verify
[520.256054] Starting dynamic subtest: lmem0
[577.519782] Dynamic subtest lmem0: SUCCESS (57.263s)
[577.520752] Subtest parallel-random-verify: SUCCESS (57.265s)
[578.655076] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[578.656218] [FACT gem_lmem_swapping (parallel-random-verify)] deleted: kernel.kmod_is_loaded.i915: true
[578.659067] [109/132] (452s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[580.422505] Starting subtest: psr-2p-primscrn-spr-indfb-move
[580.424224] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[580.630760] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[580.633234] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)] new: kernel.kmod_is_loaded.i915: true
[580.636327] [110/132] (450s left) gem_exec_reloc (basic-write-cpu-noreloc)
[580.731681] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[580.830055] [111/132] (450s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[580.908811] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[580.909700] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[581.070145] [112/132] (450s left) i915_hangman (gt-engine-hang)
[581.169471] Starting subtest: gt-engine-hang
[581.170358] Starting dynamic subtest: rcs0
[582.001018] Dynamic subtest rcs0: SUCCESS (0.831s)
[582.017746] Starting dynamic subtest: bcs0
[582.785965] Dynamic subtest bcs0: SUCCESS (0.782s)
[582.801267] Starting dynamic subtest: vcs0
[583.541727] Dynamic subtest vcs0: SUCCESS (0.754s)
[583.555344] Starting dynamic subtest: vcs1
[584.372174] Dynamic subtest vcs1: SUCCESS (0.829s)
[584.387664] Starting dynamic subtest: vecs0
[585.129718] Dynamic subtest vecs0: SUCCESS (0.756s)
[585.143454] Starting dynamic subtest: vecs1
[585.937066] Dynamic subtest vecs1: SUCCESS (0.806s)
[585.950892] Starting dynamic subtest: ccs0
[586.768956] Dynamic subtest ccs0: SUCCESS (0.831s)
[586.769891] Subtest gt-engine-hang: SUCCESS (5.601s)
[587.000887] [113/132] (444s left) gem_mmap (bad-object)
[587.079540] Subtest bad-object: SKIP (0.000s)
[587.166049] [114/132] (444s left) kms_feature_discovery (psr1)
[587.359897] Starting subtest: psr1
[587.361590] Subtest psr1: SKIP (0.000s)
[587.514979] [115/132] (444s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[587.708620] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[587.710335] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[587.917133] [116/132] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[588.115315] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[588.117057] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[588.316981] [117/132] (443s left) gem_mmap_gtt (fault-concurrent)
[588.394533] Subtest fault-concurrent: SKIP (0.000s)
[588.479785] [118/132] (443s left) kms_pm_rpm (legacy-planes-dpms)
[590.080312] Starting subtest: legacy-planes-dpms
[590.087340] Starting dynamic subtest: plane-63
[594.015470] Dynamic subtest plane-63: SUCCESS (3.933s)
[594.059743] Starting dynamic subtest: plane-93
[596.938479] Dynamic subtest plane-93: SUCCESS (2.918s)
[596.954264] Starting dynamic subtest: plane-123
[599.895140] Dynamic subtest plane-123: SUCCESS (2.952s)
[599.942208] Starting dynamic subtest: plane-133
[602.733401] Dynamic subtest plane-133: SUCCESS (2.833s)
[602.739356] Subtest legacy-planes-dpms: SUCCESS (12.656s)
[603.121474] [119/132] (428s left) kms_chamelium_color (ctm-negative)
[603.308787] Subtest ctm-negative: SKIP (0.000s)
[603.381535] [120/132] (428s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[603.567044] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[603.569523] Starting dynamic subtest: pipe-A-valid-mode
[603.645441] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[603.647380] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.078s)
[603.902770] [121/132] (428s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[604.107772] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[605.386715] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.278s)
[605.601679] [122/132] (426s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[605.790090] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[605.792522] Starting dynamic subtest: pipe-A-DP-3
[605.795886] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[605.807930] Starting dynamic subtest: pipe-B-DP-3
[605.811520] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[605.823487] Starting dynamic subtest: pipe-C-DP-3
[605.826932] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[605.838630] Starting dynamic subtest: pipe-D-DP-3
[605.841975] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[605.843589] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[606.282282] [123/132] (425s left) kms_invalid_mode (overflow-vrefresh)
[606.469756] Starting subtest: overflow-vrefresh
[606.470632] Starting dynamic subtest: pipe-A-DP-3
[606.559178] Dynamic subtest pipe-A-DP-3: SUCCESS (0.087s)
[606.577699] Starting dynamic subtest: pipe-B-DP-3
[606.578930] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[606.594876] Starting dynamic subtest: pipe-C-DP-3
[606.595830] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[606.608338] Starting dynamic subtest: pipe-D-DP-3
[606.609307] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[606.610246] Subtest overflow-vrefresh: SUCCESS (0.099s)
[606.846083] [124/132] (425s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[607.046251] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[607.047953] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[607.261855] [125/132] (425s left) kms_psr (fbc-pr-cursor-plane-move)
[607.448797] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[607.507840] [126/132] (424s left) prime_busy (before)
[607.593785] Starting subtest: before
[607.599115] Starting dynamic subtest: rcs0
[607.661844] Dynamic subtest rcs0: SUCCESS (0.063s)
[607.675852] Starting dynamic subtest: bcs0
[607.716848] Dynamic subtest bcs0: SUCCESS (0.054s)
[607.732941] Starting dynamic subtest: vcs0
[607.757444] Dynamic subtest vcs0: SUCCESS (0.039s)
[607.778155] Starting dynamic subtest: vcs1
[607.797436] Dynamic subtest vcs1: SUCCESS (0.038s)
[607.818866] Starting dynamic subtest: vecs0
[607.837473] Dynamic subtest vecs0: SUCCESS (0.038s)
[607.858862] Starting dynamic subtest: vecs1
[607.877441] Dynamic subtest vecs1: SUCCESS (0.038s)
[607.896220] Starting dynamic subtest: ccs0
[607.919148] Dynamic subtest ccs0: SUCCESS (0.040s)
[608.034437] Subtest before: SUCCESS (0.434s)
[608.247481] [127/132] (424s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[608.443357] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[608.445004] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[608.646923] [128/132] (423s left) kms_hdr (invalid-metadata-sizes)
[608.834801] Starting subtest: invalid-metadata-sizes
[609.395532] Starting dynamic subtest: pipe-A-DP-3
[609.401322] Dynamic subtest pipe-A-DP-3: SUCCESS (0.003s)
[609.403174] Subtest invalid-metadata-sizes: SUCCESS (0.566s)
[609.722556] [129/132] (423s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[609.812951] Starting subtest: y-tiled-ccs-to-yf-tiled
[609.814958] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[610.055409] [130/132] (422s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[610.248213] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[610.249824] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[610.529215] [131/132] (422s left) gem_userptr_blits (unsync-unmap)
[610.620360] Subtest unsync-unmap: SKIP (0.000s)
[610.819431] [132/132] (422s left) gem_ccs (suspend-resume)
[610.908418] Starting subtest: suspend-resume
[610.910798] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[629.337666] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.962s)
[629.350137] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[647.439958] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.665s)
[647.454834] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[665.385732] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.623s)
[665.400156] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[683.448212] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.654s)
[683.462392] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[701.347094] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.617s)
[701.361942] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[719.438908] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.750s)
[719.453670] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[737.379501] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.623s)
[737.392599] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[755.431081] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.719s)
[755.431929] Subtest suspend-resume: SUCCESS (29.624s)
[755.622948] 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.