[58.454672] Initializing watchdogs
[58.454747]   /dev/watchdog0
[58.476068] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.486823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[58.490826] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.493327] [001/130] (960s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[58.677583] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[58.679284] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[58.991010] [002/130] (960s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[59.264457] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[59.422955] [003/130] (959s left) kms_vblank (ts-continuation-modeset-rpm)
[59.605277] Starting subtest: ts-continuation-modeset-rpm
[59.606216] Starting dynamic subtest: pipe-A-DP-3
[61.432078] Dynamic subtest pipe-A-DP-3: SUCCESS (1.830s)
[61.447341] Starting dynamic subtest: pipe-D-DP-3
[62.333637] Dynamic subtest pipe-D-DP-3: SUCCESS (0.906s)
[62.334533] Subtest ts-continuation-modeset-rpm: SUCCESS (2.742s)
[62.622091] [004/130] (956s left) gem_linear_blits (basic)
[62.908920] Starting subtest: basic
[62.941380] Subtest basic: SUCCESS (0.033s)
[63.158948] [005/130] (956s left) kms_atomic_transition (plane-all-transition-nonblocking)
[63.392831] Starting subtest: plane-all-transition-nonblocking
[63.393732] Starting dynamic subtest: pipe-A-DP-3
[67.174514] Dynamic subtest pipe-A-DP-3: SUCCESS (3.806s)
[67.260665] Starting dynamic subtest: pipe-B-DP-3
[71.230056] Dynamic subtest pipe-B-DP-3: SUCCESS (3.994s)
[71.336300] Subtest plane-all-transition-nonblocking: SUCCESS (7.985s)
[71.591422] [006/130] (947s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[71.795827] Starting subtest: x-tiled-16bpp-rotate-90
[71.857804] Subtest x-tiled-16bpp-rotate-90: SKIP (0.062s)
[72.085202] [007/130] (947s left) api_intel_bb (full-batch)
[72.155035] Starting subtest: full-batch
[72.185901] Subtest full-batch: SUCCESS (0.032s)
[72.340856] [008/130] (947s left) kms_lease (atomic-implicit-crtc)
[72.521457] Starting subtest: atomic-implicit-crtc
[72.522396] Starting dynamic subtest: pipe-A-DP-3
[72.526831] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[72.535058] Starting dynamic subtest: pipe-B-DP-3
[72.539047] Dynamic subtest pipe-B-DP-3: SUCCESS (0.011s)
[72.547194] Starting dynamic subtest: pipe-C-DP-3
[72.551356] Dynamic subtest pipe-C-DP-3: SUCCESS (0.011s)
[72.559356] Starting dynamic subtest: pipe-D-DP-3
[72.563296] Dynamic subtest pipe-D-DP-3: SUCCESS (0.011s)
[72.564162] Subtest atomic-implicit-crtc: SUCCESS (0.040s)
[72.753518] [009/130] (946s left) kms_psr (fbc-psr-cursor-plane-move)
[72.938508] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[72.991756] [010/130] (946s left) gem_exec_fence (submit67)
[73.189896] Starting subtest: submit67
[73.192352] Subtest submit67: SKIP (0.000s)
[73.884119] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[73.886037] [011/130] (945s left) kms_async_flips (test-cursor)
[74.079572] Starting subtest: test-cursor
[74.301893] Starting dynamic subtest: pipe-A-DP-3
[74.621960] Dynamic subtest pipe-A-DP-3: SUCCESS (0.321s)
[74.863466] Starting dynamic subtest: pipe-B-DP-3
[74.977437] Dynamic subtest pipe-B-DP-3: SUCCESS (0.123s)
[75.220920] Starting dynamic subtest: pipe-C-DP-3
[75.345459] Dynamic subtest pipe-C-DP-3: SUCCESS (0.134s)
[75.551802] Starting dynamic subtest: pipe-D-DP-3
[75.681378] Dynamic subtest pipe-D-DP-3: SUCCESS (0.137s)
[75.682364] Subtest test-cursor: SUCCESS (1.605s)
[76.190851] [012/130] (943s left) gem_bad_reloc (negative-reloc)
[76.276754] Subtest negative-reloc: SKIP (0.000s)
[76.345087] [013/130] (943s left) kms_flip (2x-flip-vs-fences)
[76.537069] Starting subtest: 2x-flip-vs-fences
[76.538874] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[76.739399] [014/130] (943s left) core_debugfs (read-all-entries)
[76.821049] Starting subtest: read-all-entries
[76.906182] Subtest read-all-entries: SUCCESS (0.084s)
[77.039428] [015/130] (942s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[77.228931] Starting subtest: cursorB-vs-flipA-legacy
[77.231531] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[77.387661] [016/130] (942s left) gem_mmap_offset (ptrace)
[77.466053] Starting subtest: ptrace
[77.469461] Starting dynamic subtest: lmem0-fixed
[77.591799] Dynamic subtest lmem0-fixed: SUCCESS (0.116s)
[77.600429] Starting dynamic subtest: smem0-fixed
[77.604317] Dynamic subtest smem0-fixed: SUCCESS (0.015s)
[77.605241] Subtest ptrace: SUCCESS (0.139s)
[77.774263] [017/130] (942s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[77.965892] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[77.967551] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[78.152428] [018/130] (942s left) api_intel_allocator (default-alignment)
[78.227125] Starting subtest: default-alignment
[78.233068] Subtest default-alignment: SUCCESS (0.006s)
[78.416492] [019/130] (941s left) gem_ctx_param (invalid-param-set)
[78.494419] Starting subtest: invalid-param-set
[78.495352] Subtest invalid-param-set: SUCCESS (0.000s)
[78.632843] [020/130] (941s left) kms_cursor_legacy (forked-bo)
[78.836390] Starting subtest: forked-bo
[78.837560] Starting dynamic subtest: pipe-A
[84.274053] Dynamic subtest pipe-A: SUCCESS (5.441s)
[84.289637] Starting dynamic subtest: pipe-B
[89.694928] Dynamic subtest pipe-B: SUCCESS (5.422s)
[89.716206] Starting dynamic subtest: pipe-C
[95.132491] Dynamic subtest pipe-C: SUCCESS (5.437s)
[95.154926] Starting dynamic subtest: pipe-D
[100.572093] Dynamic subtest pipe-D: SUCCESS (5.438s)
[100.599319] Starting dynamic subtest: all-pipes
[106.000621] Dynamic subtest all-pipes: SUCCESS (5.428s)
[106.001516] Subtest forked-bo: SUCCESS (27.171s)
[106.149230] [021/130] (914s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[106.348629] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[106.404960] [022/130] (914s left) gem_exec_schedule (preempt-other-chain)
[106.499154] Starting subtest: preempt-other-chain
[106.500129] Starting dynamic subtest: rcs0
[106.952086] Dynamic subtest rcs0: SUCCESS (0.452s)
[106.961256] Starting dynamic subtest: bcs0
[107.376587] Dynamic subtest bcs0: SUCCESS (0.424s)
[107.385986] Starting dynamic subtest: vcs0
[107.791725] Dynamic subtest vcs0: SUCCESS (0.415s)
[107.801020] Starting dynamic subtest: vcs1
[108.215073] Dynamic subtest vcs1: SUCCESS (0.423s)
[108.224483] Starting dynamic subtest: vecs0
[108.632292] Dynamic subtest vecs0: SUCCESS (0.417s)
[108.641596] Starting dynamic subtest: vecs1
[109.051967] Dynamic subtest vecs1: SUCCESS (0.419s)
[109.061404] Starting dynamic subtest: ccs0
[109.467673] Dynamic subtest ccs0: SUCCESS (0.415s)
[109.468651] Subtest preempt-other-chain: SUCCESS (2.968s)
[109.873856] [023/130] (910s left) gem_softpin (evict-active-interruptible)
[109.963422] Starting subtest: evict-active-interruptible
[109.979275] Subtest evict-active-interruptible: SUCCESS (0.015s)
[110.167636] [024/130] (910s left) gem_exec_balancer (bonded-sync)
[110.255512] Starting subtest: bonded-sync
[110.257534] Subtest bonded-sync: SKIP (0.000s)
[110.684552] [025/130] (909s left) gem_sync (basic-store-all)
[110.774145] Starting subtest: basic-store-all
[115.471933] Subtest basic-store-all: SUCCESS (4.698s)
[115.766100] [026/130] (904s left) kms_flip (dpms-vs-vblank-race)
[115.964950] Starting subtest: dpms-vs-vblank-race
[115.967943] Starting dynamic subtest: A-DP3
[119.151551] Dynamic subtest A-DP3: SUCCESS (3.182s)
[119.168754] Starting dynamic subtest: B-DP3
[122.355551] Dynamic subtest B-DP3: SUCCESS (3.204s)
[122.366542] Starting dynamic subtest: C-DP3
[125.349231] Dynamic subtest C-DP3: SUCCESS (2.991s)
[125.361952] Starting dynamic subtest: D-DP3
[128.537130] Dynamic subtest D-DP3: SUCCESS (3.186s)
[128.538136] Subtest dpms-vs-vblank-race: SUCCESS (12.574s)
[128.846214] [027/130] (891s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[129.039594] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[129.042030] Starting dynamic subtest: pipe-A-DP-3
[129.050498] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[129.059777] Starting dynamic subtest: pipe-B-DP-3
[129.068233] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[129.077056] Starting dynamic subtest: pipe-C-DP-3
[129.085236] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[129.094154] Starting dynamic subtest: pipe-D-DP-3
[129.105046] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[129.107020] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[129.522486] [028/130] (891s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[129.601251] Starting subtest: multi-wait-all-for-submit-signaled
[129.602185] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[129.808783] [029/130] (891s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[130.001106] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[130.005774] Starting dynamic subtest: A-DP3
[130.834489] Dynamic subtest A-DP3: SUCCESS (0.827s)
[130.854338] Starting dynamic subtest: B-DP3
[131.628617] Dynamic subtest B-DP3: SUCCESS (0.791s)
[131.637820] Starting dynamic subtest: C-DP3
[132.398547] Dynamic subtest C-DP3: SUCCESS (0.768s)
[132.418671] Starting dynamic subtest: D-DP3
[133.225306] Dynamic subtest D-DP3: SUCCESS (0.825s)
[133.229576] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.228s)
[133.562134] [030/130] (887s left) kms_chamelium_frames (vga-frame-dump)
[133.834699] Subtest vga-frame-dump: SKIP (0.000s)
[133.988865] [031/130] (887s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[134.067153] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[134.153279] [032/130] (886s left) prime_self_import (basic-with_one_bo)
[134.201392] Starting subtest: basic-with_one_bo
[134.247858] Subtest basic-with_one_bo: SUCCESS (0.048s)
[134.429638] [033/130] (886s left) syncobj_wait (single-wait-submitted)
[134.508482] Starting subtest: single-wait-submitted
[134.610516] Subtest single-wait-submitted: SUCCESS (0.102s)
[134.715365] [034/130] (886s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[134.905914] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[134.908325] Starting dynamic subtest: pipe-A-DP-3
[134.916394] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[134.925543] Starting dynamic subtest: pipe-B-DP-3
[134.933952] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[134.943031] Starting dynamic subtest: pipe-C-DP-3
[134.951194] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[134.960493] Starting dynamic subtest: pipe-D-DP-3
[134.970959] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[134.972992] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[135.386494] [035/130] (885s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[135.574952] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[135.575888] Starting dynamic subtest: pipe-A
[135.665460] Dynamic subtest pipe-A: SUCCESS (0.090s)
[135.674404] Starting dynamic subtest: pipe-B
[135.885119] Dynamic subtest pipe-B: SUCCESS (0.219s)
[135.898629] Starting dynamic subtest: pipe-C
[136.104211] Dynamic subtest pipe-C: SUCCESS (0.218s)
[136.120510] Starting dynamic subtest: pipe-D
[136.321262] Dynamic subtest pipe-D: SUCCESS (0.215s)
[136.322318] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.747s)
[136.670899] [036/130] (884s left) kms_flip (flip-vs-absolute-wf_vblank)
[136.866855] Starting subtest: flip-vs-absolute-wf_vblank
[136.871402] Starting dynamic subtest: A-DP3
[145.010672] Dynamic subtest A-DP3: SUCCESS (8.138s)
[145.024247] Starting dynamic subtest: B-DP3
[153.065080] Dynamic subtest B-DP3: SUCCESS (8.050s)
[153.076128] Starting dynamic subtest: C-DP3
[161.120163] Dynamic subtest C-DP3: SUCCESS (8.053s)
[161.130982] Starting dynamic subtest: D-DP3
[169.177259] Dynamic subtest D-DP3: SUCCESS (8.055s)
[169.179544] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.312s)
[169.507875] [037/130] (852s left) gem_eio (suspend)
[169.790664] Starting subtest: suspend
[183.457510] Subtest suspend: SUCCESS (13.667s)
[202.773837] [038/130] (837s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[202.975431] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[202.976384] Starting dynamic subtest: pipe-A-valid-mode
[204.852995] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.877s)
[204.853997] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (1.879s)
[205.158571] [039/130] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[205.356986] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[205.358508] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[205.553455] [040/130] (835s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[205.750032] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[205.751999] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[205.946342] [041/130] (834s left) sw_sync (sync_busy)
[205.995410] Starting subtest: sync_busy
[205.997793] Subtest sync_busy: SUCCESS (0.003s)
[206.084597] [042/130] (834s left) gem_exec_params (no-bsd)
[206.167393] Starting subtest: no-bsd
[206.169727] Subtest no-bsd: SUCCESS (0.001s)
[206.387676] [043/130] (834s left) gem_pxp (protected-raw-src-copy-not-readible)
[208.993233] Starting subtest: protected-raw-src-copy-not-readible
[208.995303] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[209.135076] [044/130] (831s left) perf_pmu (all-busy-idle-check-all)
[209.208387] Starting subtest: all-busy-idle-check-all
[209.907861] Subtest all-busy-idle-check-all: SUCCESS (0.700s)
[210.092743] [045/130] (831s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[210.294274] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[210.295992] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[210.509467] [046/130] (830s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[210.710377] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[212.792119] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.082s)
[213.025259] [047/130] (828s left) i915_query (query-topology-known-pci-ids)
[213.101352] Starting subtest: query-topology-known-pci-ids
[213.103176] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[213.292167] [048/130] (828s left) kms_chamelium_audio (hdmi-audio-edid)
[213.565702] Subtest hdmi-audio-edid: SKIP (0.000s)
[213.721468] [049/130] (827s left) i915_pm_rps (engine-order)
[213.814405] Starting subtest: engine-order
[224.799803] Subtest engine-order: SUCCESS (10.985s)
[225.009426] [050/130] (816s left) gem_exec_fence (syncobj-invalid-flags)
[225.505356] Starting subtest: syncobj-invalid-flags
[225.506252] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[225.933277] [051/130] (815s left) kms_flip (2x-flip-vs-suspend)
[226.125834] Starting subtest: 2x-flip-vs-suspend
[226.141192] Subtest 2x-flip-vs-suspend: SKIP (0.015s)
[226.324658] [052/130] (815s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[226.401430] Starting subtest: etime-single-wait-for-submit-submitted
[226.507080] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s)
[226.674925] [053/130] (815s left) gem_ctx_exec (basic-close-race)
[226.760580] Starting subtest: basic-close-race
[232.284131] Subtest basic-close-race: SUCCESS (5.522s)
[232.498975] [054/130] (809s left) gem_exec_reloc (basic-wc-active)
[232.581387] Subtest basic-wc-active: SKIP (0.000s)
[232.659515] [055/130] (809s left) gem_exec_balancer (individual)
[232.748973] Starting subtest: individual
[234.725608] Subtest individual: SUCCESS (1.976s)
[235.183054] [056/130] (806s left) gem_ctx_shared (q-out-order)
[235.277529] Starting subtest: Q-out-order
[235.278445] Starting dynamic subtest: rcs0
[235.539935] Dynamic subtest rcs0: SUCCESS (0.262s)
[235.552163] Starting dynamic subtest: bcs0
[235.720891] Dynamic subtest bcs0: SUCCESS (0.180s)
[235.733396] Starting dynamic subtest: vcs0
[235.912702] Dynamic subtest vcs0: SUCCESS (0.190s)
[235.925056] Starting dynamic subtest: vcs1
[236.103407] Dynamic subtest vcs1: SUCCESS (0.190s)
[236.115886] Starting dynamic subtest: vecs0
[236.292360] Dynamic subtest vecs0: SUCCESS (0.188s)
[236.304450] Starting dynamic subtest: vecs1
[236.482612] Dynamic subtest vecs1: SUCCESS (0.189s)
[236.494945] Starting dynamic subtest: ccs0
[236.669457] Dynamic subtest ccs0: SUCCESS (0.186s)
[236.670336] Subtest Q-out-order: SUCCESS (1.392s)
[237.046554] [057/130] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[237.240552] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[237.242235] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[237.422086] [058/130] (804s left) kms_dp_linktrain_fallback (dsc-fallback)
[237.623997] Starting subtest: dsc-fallback
[237.627074] Subtest dsc-fallback: SKIP (0.000s)
[237.754709] [059/130] (804s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[237.843235] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[237.845110] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[238.116588] [060/130] (804s left) gem_exec_schedule (in-order)
[238.209544] Starting subtest: in-order
[238.210404] Starting dynamic subtest: rcs0
[238.490574] Dynamic subtest rcs0: SUCCESS (0.280s)
[238.502165] Starting dynamic subtest: bcs0
[238.692782] Dynamic subtest bcs0: SUCCESS (0.201s)
[238.704442] Starting dynamic subtest: vcs0
[238.910477] Dynamic subtest vcs0: SUCCESS (0.216s)
[238.922170] Starting dynamic subtest: vcs1
[239.125522] Dynamic subtest vcs1: SUCCESS (0.214s)
[239.137140] Starting dynamic subtest: vecs0
[239.339228] Dynamic subtest vecs0: SUCCESS (0.212s)
[239.350727] Starting dynamic subtest: vecs1
[239.551860] Dynamic subtest vecs1: SUCCESS (0.212s)
[239.563466] Starting dynamic subtest: ccs0
[239.766251] Dynamic subtest ccs0: SUCCESS (0.210s)
[239.770259] Subtest in-order: SUCCESS (1.554s)
[240.163728] [061/130] (802s left) gem_eio (reset-stress)
[240.445022] Starting subtest: reset-stress
[282.734497] Subtest reset-stress: SUCCESS (42.290s)
[283.069038] [062/130] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[283.263971] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[283.265601] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[283.469089] [063/130] (759s left) kms_psr (fbc-pr-cursor-blt)
[283.665365] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[283.726870] [064/130] (758s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render)
[283.921154] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render
[283.922885] Subtest psr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s)
[284.088434] [065/130] (758s left) i915_hangman (gt-engine-error)
[284.183860] Starting subtest: gt-engine-error
[284.184770] Starting dynamic subtest: rcs0
[284.993592] Dynamic subtest rcs0: SUCCESS (0.809s)
[285.008616] Starting dynamic subtest: bcs0
[285.742536] Dynamic subtest bcs0: SUCCESS (0.748s)
[285.758216] Starting dynamic subtest: vcs0
[286.472458] Dynamic subtest vcs0: SUCCESS (0.728s)
[286.487135] Starting dynamic subtest: vcs1
[287.207570] Dynamic subtest vcs1: SUCCESS (0.734s)
[287.221571] Starting dynamic subtest: vecs0
[287.918428] Dynamic subtest vecs0: SUCCESS (0.710s)
[287.931753] Starting dynamic subtest: vecs1
[288.648616] Dynamic subtest vecs1: SUCCESS (0.729s)
[288.664638] Starting dynamic subtest: ccs0
[289.402384] Dynamic subtest ccs0: SUCCESS (0.752s)
[289.403333] Subtest gt-engine-error: SUCCESS (5.219s)
[289.572179] [066/130] (753s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[289.774084] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[289.775696] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[289.927877] [067/130] (752s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[290.005394] Starting subtest: single-wait-all-for-submit-signaled
[290.006402] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[290.204023] [068/130] (752s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[290.393705] Starting subtest: 2x-cursor-vs-flip-atomic
[290.396972] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.002s)
[290.548931] [069/130] (752s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[290.753177] Starting subtest: yf-tiled-8bpp-rotate-0
[290.755023] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[290.969546] [070/130] (752s left) gem_exec_whisper (basic-queues-priority-all)
[291.058715] Starting subtest: basic-queues-priority-all
[313.057637] Subtest basic-queues-priority-all: SUCCESS (21.998s)
[313.336522] [071/130] (729s left) kms_color (ctm-max)
[313.528963] Starting subtest: ctm-max
[313.529948] Starting dynamic subtest: pipe-A-DP-3
[314.208682] Dynamic subtest pipe-A-DP-3: SUCCESS (0.678s)
[314.220561] Starting dynamic subtest: pipe-B-DP-3
[314.831843] Dynamic subtest pipe-B-DP-3: SUCCESS (0.621s)
[314.846571] Starting dynamic subtest: pipe-C-DP-3
[315.457885] Dynamic subtest pipe-C-DP-3: SUCCESS (0.625s)
[315.471668] Starting dynamic subtest: pipe-D-DP-3
[316.092460] Dynamic subtest pipe-D-DP-3: SUCCESS (0.633s)
[316.093454] Subtest ctm-max: SUCCESS (2.563s)
[316.414050] [072/130] (726s left) kms_addfb_basic (master-rmfb)
[316.490364] Starting subtest: master-rmfb
[316.505309] Subtest master-rmfb: SUCCESS (0.015s)
[316.808906] [073/130] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[317.004233] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[317.005964] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[317.195916] [074/130] (726s left) perf (unprivileged-single-ctx-counters)
[317.639783] Starting subtest: unprivileged-single-ctx-counters
[317.641384] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[317.694444] [075/130] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[317.892367] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[317.894117] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.081920] [076/130] (725s left) gem_busy (parallel)
[318.314094] Starting subtest: parallel
[318.315205] Starting dynamic subtest: rcs0
[318.413399] Dynamic subtest rcs0: SUCCESS (0.099s)
[318.436148] Starting dynamic subtest: bcs0
[318.485569] Dynamic subtest bcs0: SUCCESS (0.071s)
[318.509917] Starting dynamic subtest: vcs0
[318.560218] Dynamic subtest vcs0: SUCCESS (0.073s)
[318.576524] Starting dynamic subtest: vcs1
[318.623113] Dynamic subtest vcs1: SUCCESS (0.061s)
[318.642378] Starting dynamic subtest: vecs0
[318.694124] Dynamic subtest vecs0: SUCCESS (0.070s)
[318.716619] Starting dynamic subtest: vecs1
[318.763433] Dynamic subtest vecs1: SUCCESS (0.068s)
[318.790677] Starting dynamic subtest: ccs0
[318.841843] Dynamic subtest ccs0: SUCCESS (0.076s)
[318.842833] Subtest parallel: SUCCESS (0.528s)
[319.207216] [077/130] (724s left) gem_wait (write-busy)
[319.297651] Starting subtest: write-busy
[319.298568] Starting dynamic subtest: all-engines
[319.901393] Dynamic subtest all-engines: SUCCESS (0.603s)
[319.916319] Starting dynamic subtest: rcs0
[320.447427] Dynamic subtest rcs0: SUCCESS (0.545s)
[320.460197] Starting dynamic subtest: bcs0
[320.989383] Dynamic subtest bcs0: SUCCESS (0.541s)
[321.002157] Starting dynamic subtest: vcs0
[321.531365] Dynamic subtest vcs0: SUCCESS (0.541s)
[321.544044] Starting dynamic subtest: vcs1
[322.073387] Dynamic subtest vcs1: SUCCESS (0.541s)
[322.086156] Starting dynamic subtest: vecs0
[322.614113] Dynamic subtest vecs0: SUCCESS (0.540s)
[322.626636] Starting dynamic subtest: vecs1
[323.154301] Dynamic subtest vecs1: SUCCESS (0.539s)
[323.166956] Starting dynamic subtest: ccs0
[323.696422] Dynamic subtest ccs0: SUCCESS (0.541s)
[323.697267] Subtest write-busy: SUCCESS (4.399s)
[323.996267] [078/130] (719s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[324.189034] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[324.190880] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[324.399304] [079/130] (719s left) kms_cursor_crc (cursor-random-32x32)
[324.698564] Starting subtest: cursor-random-32x32
[324.754200] Subtest cursor-random-32x32: SKIP (0.054s)
[325.247736] [080/130] (718s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[325.439353] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[325.440158] Starting dynamic subtest: pipe-A
[325.529493] Dynamic subtest pipe-A: SUCCESS (0.091s)
[325.544771] Starting dynamic subtest: pipe-B
[325.746418] Dynamic subtest pipe-B: SUCCESS (0.216s)
[325.773806] Starting dynamic subtest: pipe-C
[325.962206] Dynamic subtest pipe-C: SUCCESS (0.214s)
[325.984130] Starting dynamic subtest: pipe-D
[326.178401] Dynamic subtest pipe-D: SUCCESS (0.215s)
[326.179465] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.741s)
[326.533775] [081/130] (717s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[326.731848] Starting subtest: stress-xrgb8888-xtiled
[334.775970] Subtest stress-xrgb8888-xtiled: SUCCESS (8.044s)
[335.046161] [082/130] (709s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[335.241149] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[335.292962] [083/130] (708s left) kms_plane_cursor (primary)
[335.499500] Starting subtest: primary
[335.501277] Starting dynamic subtest: pipe-A-DP-3-size-64
[339.046579] Dynamic subtest pipe-A-DP-3-size-64: SUCCESS (3.546s)
[339.111581] Starting dynamic subtest: pipe-A-DP-3-size-128
[342.614389] Dynamic subtest pipe-A-DP-3-size-128: SUCCESS (3.516s)
[342.677500] Starting dynamic subtest: pipe-A-DP-3-size-256
[346.146705] Dynamic subtest pipe-A-DP-3-size-256: SUCCESS (3.482s)
[346.314542] Starting dynamic subtest: pipe-B-DP-3-size-64
[349.823406] Dynamic subtest pipe-B-DP-3-size-64: SUCCESS (3.531s)
[349.869110] Starting dynamic subtest: pipe-B-DP-3-size-128
[353.306947] Dynamic subtest pipe-B-DP-3-size-128: SUCCESS (3.450s)
[353.375536] Starting dynamic subtest: pipe-B-DP-3-size-256
[356.839996] Dynamic subtest pipe-B-DP-3-size-256: SUCCESS (3.498s)
[356.975062] Starting dynamic subtest: pipe-C-DP-3-size-64
[360.552155] Dynamic subtest pipe-C-DP-3-size-64: SUCCESS (3.596s)
[360.598297] Starting dynamic subtest: pipe-C-DP-3-size-128
[364.052328] Dynamic subtest pipe-C-DP-3-size-128: SUCCESS (3.466s)
[364.098660] Starting dynamic subtest: pipe-C-DP-3-size-256
[367.552391] Dynamic subtest pipe-C-DP-3-size-256: SUCCESS (3.466s)
[367.696654] Starting dynamic subtest: pipe-D-DP-3-size-64
[371.224403] Dynamic subtest pipe-D-DP-3-size-64: SUCCESS (3.546s)
[371.305068] Starting dynamic subtest: pipe-D-DP-3-size-128
[374.807399] Dynamic subtest pipe-D-DP-3-size-128: SUCCESS (3.547s)
[374.856926] Starting dynamic subtest: pipe-D-DP-3-size-256
[378.307610] Dynamic subtest pipe-D-DP-3-size-256: SUCCESS (3.464s)
[378.403750] Subtest primary: SUCCESS (42.903s)
[378.733368] [084/130] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[378.931351] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[378.933117] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[379.131785] [085/130] (665s left) syncobj_basic (bad-fd-to-handle)
[379.207369] Starting subtest: bad-fd-to-handle
[379.208277] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[379.352410] [086/130] (664s left) kms_hdr (bpc-switch)
[379.542682] Starting subtest: bpc-switch
[382.952289] Starting dynamic subtest: pipe-A-DP-3
[384.106591] Dynamic subtest pipe-A-DP-3: SUCCESS (1.154s)
[384.107829] Subtest bpc-switch: SUCCESS (4.565s)
[384.480084] [087/130] (659s left) gem_exec_schedule (u-lateslice)
[384.570257] Starting subtest: u-lateslice
[384.571189] Starting dynamic subtest: rcs0
[384.621517] Dynamic subtest rcs0: SUCCESS (0.051s)
[384.635123] Starting dynamic subtest: bcs0
[384.642962] Dynamic subtest bcs0: SUCCESS (0.020s)
[384.655309] Starting dynamic subtest: vcs0
[384.663501] Dynamic subtest vcs0: SUCCESS (0.020s)
[384.677827] Starting dynamic subtest: vcs1
[384.686370] Dynamic subtest vcs1: SUCCESS (0.022s)
[384.699130] Starting dynamic subtest: vecs0
[384.707439] Dynamic subtest vecs0: SUCCESS (0.020s)
[384.721052] Starting dynamic subtest: vecs1
[384.731082] Dynamic subtest vecs1: SUCCESS (0.022s)
[384.743507] Starting dynamic subtest: ccs0
[384.752426] Dynamic subtest ccs0: SUCCESS (0.020s)
[384.753360] Subtest u-lateslice: SUCCESS (0.183s)
[385.202785] [088/130] (659s left) i915_drm_fdinfo (busy)
[385.271772] Starting subtest: busy
[385.272681] Starting dynamic subtest: rcs0
[385.297286] Dynamic subtest rcs0: SKIP (0.024s)
[385.310936] Starting dynamic subtest: bcs0
[385.313390] Dynamic subtest bcs0: SKIP (0.000s)
[385.326835] Starting dynamic subtest: vcs0
[385.329186] Dynamic subtest vcs0: SKIP (0.000s)
[385.342619] Starting dynamic subtest: vcs1
[385.344850] Dynamic subtest vcs1: SKIP (0.000s)
[385.356808] Starting dynamic subtest: vecs0
[385.359134] Dynamic subtest vecs0: SKIP (0.000s)
[385.371662] Starting dynamic subtest: vecs1
[385.373925] Dynamic subtest vecs1: SKIP (0.000s)
[385.385621] Starting dynamic subtest: ccs0
[385.387856] Dynamic subtest ccs0: SKIP (0.000s)
[385.390055] Subtest busy: SKIP (0.034s)
[385.437588] [089/130] (659s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[385.710311] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[385.764602] [090/130] (658s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[385.966994] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[386.685020] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.718s)
[386.938578] [091/130] (657s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[387.131425] Starting subtest: cursorA-vs-flipA-legacy
[398.096517] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.965s)
[398.414927] [092/130] (646s left) gem_madvise (dontneed-before-pwrite)
[398.473777] Starting subtest: dontneed-before-pwrite
[398.518269] Subtest dontneed-before-pwrite: SKIP (0.046s)
[398.589905] [093/130] (646s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[398.674592] Starting subtest: yf-tiled-to-vebox-x-tiled
[398.676602] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[398.963953] [094/130] (645s left) kms_cursor_crc (cursor-suspend)
[399.224989] Starting subtest: cursor-suspend
[399.227444] Starting dynamic subtest: pipe-A-DP-3
[437.608991] Dynamic subtest pipe-A-DP-3: SUCCESS (8.027s)
[437.635691] Starting dynamic subtest: pipe-D-DP-3
[476.626279] Dynamic subtest pipe-D-DP-3: SUCCESS (7.589s)
[476.627323] Subtest cursor-suspend: SUCCESS (15.622s)
[497.228492] [095/130] (567s left) syncobj_wait (single-wait-signaled)
[497.316197] Starting subtest: single-wait-signaled
[497.317222] Subtest single-wait-signaled: SUCCESS (0.000s)
[497.447012] [096/130] (567s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[497.642616] Starting subtest: basic-flip-before-cursor-varying-size
[498.757958] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.093s)
[499.085731] [097/130] (566s left) kms_joiner (basic-force-big-joiner)
[499.282365] Starting subtest: basic-force-big-joiner
[499.283226] Starting dynamic subtest: single
[500.081923] Dynamic subtest single: SUCCESS (0.787s)
[500.083104] Subtest basic-force-big-joiner: SUCCESS (0.788s)
[500.515759] [098/130] (564s left) gem_mmap_wc (write)
[500.595072] Subtest write: SKIP (0.000s)
[500.670653] [099/130] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[500.870242] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[500.872004] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[501.086022] [100/130] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[501.286191] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[501.287936] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[501.491619] [101/130] (564s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[501.570194] Starting subtest: etime-multi-wait-all-submitted-signaled
[501.676522] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[501.791576] [102/130] (563s left) perf_pmu (busy-check-all)
[501.862907] Starting subtest: busy-check-all
[501.863920] Starting dynamic subtest: rcs0
[502.467221] Dynamic subtest rcs0: SUCCESS (0.596s)
[502.484352] Starting dynamic subtest: bcs0
[503.027177] Dynamic subtest bcs0: SUCCESS (0.551s)
[503.043385] Starting dynamic subtest: vcs0
[503.585296] Dynamic subtest vcs0: SUCCESS (0.551s)
[503.601453] Starting dynamic subtest: vcs1
[504.144868] Dynamic subtest vcs1: SUCCESS (0.551s)
[504.162393] Starting dynamic subtest: vecs0
[504.705345] Dynamic subtest vecs0: SUCCESS (0.551s)
[504.721366] Starting dynamic subtest: vecs1
[505.263319] Dynamic subtest vecs1: SUCCESS (0.551s)
[505.279496] Starting dynamic subtest: ccs0
[505.822507] Dynamic subtest ccs0: SUCCESS (0.552s)
[505.825148] Subtest busy-check-all: SUCCESS (3.921s)
[505.985851] [103/130] (559s left) sw_sync (alloc_timeline)
[506.036793] Starting subtest: alloc_timeline
[506.037763] Subtest alloc_timeline: SUCCESS (0.000s)
[506.156188] [104/130] (559s left) perf (oa-formats)
[506.383396] Starting subtest: oa-formats
[506.384282] Starting dynamic subtest: 0-rcs0
[506.409872] Dynamic subtest 0-rcs0: SUCCESS (0.026s)
[506.410886] Subtest oa-formats: SUCCESS (0.027s)
[506.468146] [105/130] (559s left) perf_pmu (rc6-suspend)
[506.538363] Starting subtest: rc6-suspend
[531.588626] Subtest rc6-suspend: SUCCESS (9.888s)
[546.320496] [106/130] (533s left) gem_mmap_gtt (cpuset-big-copy-xy)
[546.419267] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[546.481825] [107/130] (533s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[546.686329] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[547.699914] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.999s)
[547.945025] [108/130] (532s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[548.140575] Starting subtest: crc-primary-basic-y-tiled-ccs
[548.141523] Starting dynamic subtest: pipe-A-DP-3
[548.150080] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[548.163460] Starting dynamic subtest: pipe-B-DP-3
[548.172031] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[548.185199] Starting dynamic subtest: pipe-C-DP-3
[548.193663] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[548.206843] Starting dynamic subtest: pipe-D-DP-3
[548.217314] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[548.219571] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.009s)
[548.666025] [109/130] (531s left) kms_content_protection (legacy)
[548.924839] Starting subtest: legacy
[549.213810] Starting dynamic subtest: pipe-A-DP-3
[672.943920] Dynamic subtest pipe-A-DP-3: FAIL (123.349s)
[672.945018] Subtest legacy: FAIL (123.746s)
[673.125349] [110/130] (407s left) kms_psr (psr-sprite-blt)
[673.314499] Subtest psr-sprite-blt: SKIP (0.000s)
[673.382874] [111/130] (406s left) gem_lmem_swapping (massive-random)
[676.371790] Starting subtest: massive-random
[676.373188] Starting dynamic subtest: lmem0
[676.658501] Dynamic subtest lmem0: SUCCESS (0.286s)
[676.659394] Subtest massive-random: SUCCESS (0.287s)
[678.055206] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[678.056683] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[678.058608] [112/130] (402s left) i915_pm_rpm (gem-execbuf-stress)
[681.924952] Starting subtest: gem-execbuf-stress
[681.927896] Starting dynamic subtest: lmem0
[685.329444] Dynamic subtest lmem0: SUCCESS (3.402s)
[685.382263] Starting dynamic subtest: extra-wait-lmem0
[738.940295] Dynamic subtest extra-wait-lmem0: SUCCESS (53.595s)
[738.955926] Starting dynamic subtest: smem0
[742.301305] Dynamic subtest smem0: SUCCESS (3.356s)
[742.352849] Starting dynamic subtest: extra-wait-smem0
[795.528202] Dynamic subtest extra-wait-smem0: SUCCESS (53.220s)
[795.530406] Subtest gem-execbuf-stress: SUCCESS (113.593s)
[795.952392] [FACT i915_pm_rpm (gem-execbuf-stress)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card1
[795.954758] [FACT i915_pm_rpm (gem-execbuf-stress)] new: kernel.kmod_is_loaded.i915: true
[795.957655] [113/130] (284s left) syncobj_wait (single-wait-for-submit-signaled)
[796.040883] Starting subtest: single-wait-for-submit-signaled
[796.041755] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[796.247125] [114/130] (284s left) gem_exec_create (madvise)
[796.334184] Starting subtest: madvise
[796.335159] Starting dynamic subtest: smem
[816.474988] Dynamic subtest smem: SUCCESS (20.142s)
[816.488148] Starting dynamic subtest: lmem0
[836.784024] Dynamic subtest lmem0: SUCCESS (20.308s)
[836.785014] Subtest madvise: SUCCESS (40.452s)
[837.793523] [115/130] (242s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[837.990012] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[837.991631] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[838.194471] [116/130] (242s left) gem_spin_batch (engines)
[838.283023] Starting subtest: engines
[838.283998] Starting dynamic subtest: rcs0
[841.545300] Dynamic subtest rcs0: SUCCESS (3.259s)
[841.562344] Starting dynamic subtest: bcs0
[844.782707] Dynamic subtest bcs0: SUCCESS (3.232s)
[844.799504] Starting dynamic subtest: vcs0
[848.019357] Dynamic subtest vcs0: SUCCESS (3.231s)
[848.036698] Starting dynamic subtest: vcs1
[851.254154] Dynamic subtest vcs1: SUCCESS (3.231s)
[851.270721] Starting dynamic subtest: vecs0
[854.492786] Dynamic subtest vecs0: SUCCESS (3.235s)
[854.509554] Starting dynamic subtest: vecs1
[857.729861] Dynamic subtest vecs1: SUCCESS (3.232s)
[857.746880] Starting dynamic subtest: ccs0
[860.966974] Dynamic subtest ccs0: SUCCESS (3.232s)
[860.968542] Subtest engines: SUCCESS (22.682s)
[861.246319] [117/130] (219s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[861.448348] Starting subtest: 4-tiled-8bpp-rotate-270
[861.513391] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.064s)
[861.714475] [118/130] (219s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[861.907443] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[861.908342] Starting dynamic subtest: pipe-A-valid-mode
[864.334237] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.424s)
[864.335570] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SUCCESS (2.427s)
[864.650975] [119/130] (216s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[864.741412] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[864.742349] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[864.900136] [120/130] (215s left) kms_psr (fbc-psr-primary-render)
[865.089364] Subtest fbc-psr-primary-render: SKIP (0.000s)
[865.147560] [121/130] (215s left) syncobj_eventfd (binary-wait)
[865.224507] Starting subtest: binary-wait
[865.235288] Subtest binary-wait: SUCCESS (0.011s)
[865.423419] [122/130] (215s left) syncobj_wait (reset-during-wait-for-submit)
[865.500609] Starting subtest: reset-during-wait-for-submit
[865.602689] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[865.731559] [123/130] (215s left) kms_pm_rpm (modeset-lpsp)
[867.955633] Starting subtest: modeset-lpsp
[868.345304] Subtest modeset-lpsp: SKIP (0.384s)
[868.761604] [124/130] (212s left) gem_ctx_persistence (legacy-engines-cleanup)
[868.846047] Starting subtest: legacy-engines-cleanup
[868.847014] Starting dynamic subtest: render
[868.944444] Dynamic subtest render: SUCCESS (0.098s)
[868.961952] Starting dynamic subtest: bsd1
[868.987534] Dynamic subtest bsd1: SUCCESS (0.041s)
[869.003428] Starting dynamic subtest: bsd2
[869.007384] Dynamic subtest bsd2: SUCCESS (0.018s)
[869.020849] Starting dynamic subtest: blt
[869.076627] Dynamic subtest blt: SUCCESS (0.068s)
[869.093022] Starting dynamic subtest: vebox
[869.100339] Dynamic subtest vebox: SUCCESS (0.022s)
[869.101259] Subtest legacy-engines-cleanup: SUCCESS (0.255s)
[869.312475] [125/130] (211s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[869.510276] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[872.141304] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.630s)
[872.397393] [126/130] (208s left) kms_pm_rpm (modeset-stress-extra-wait)
[873.915058] Starting subtest: modeset-stress-extra-wait
[926.282154] Subtest modeset-stress-extra-wait: SUCCESS (52.360s)
[926.512002] [127/130] (154s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[926.704364] Starting subtest: fbc-rgb101010-draw-blt
[929.610858] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.906s)
[929.810544] [128/130] (151s left) perf_pmu (frequency)
[929.882013] Starting subtest: frequency
[929.885479] Starting dynamic subtest: gt0
[932.192167] Dynamic subtest gt0: FAIL (2.222s)
[932.235870] Starting dynamic subtest: idle-gt0
[932.615561] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[932.618429] Subtest frequency: FAIL (2.735s)
[932.796880] [129/130] (148s left) kms_psr (psr2-dpms)
[932.986435] Subtest psr2-dpms: SKIP (0.000s)
[933.041469] [130/130] (148s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[933.239513] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[933.241310] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[933.448493] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_chamelium_edid
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: gem_linear_blits
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: kms_async_flips
results: parsing output: 11/ for test: gem_bad_reloc
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: core_debugfs
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_mmap_offset
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: gem_sync
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_ccs
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_chamelium_frames
results: parsing output: 30/ for test: kms_psr_stress_test
results: parsing output: 31/ for test: prime_self_import
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: gem_eio
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: gem_pxp
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_chamelium_audio
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: gem_ctx_exec
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_dp_linktrain_fallback
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: gem_eio
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_hangman
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: perf
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_busy
results: parsing output: 76/ for test: gem_wait
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_pipe_stress
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_plane_cursor
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: syncobj_basic
results: parsing output: 85/ for test: kms_hdr
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_tiled_display
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_madvise
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_joiner
results: parsing output: 97/ for test: gem_mmap_wc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_lmem_swapping
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: gem_exec_create
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_spin_batch
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_big_fb
Done.