[62.191559] Initializing watchdogs
[62.191626]   /dev/watchdog0
[62.211531] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.222683] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.226213] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.229134] [001/130] (960s left) kms_cursor_legacy (torture-bo)
[62.409982] Starting subtest: torture-bo
[62.410940] Starting dynamic subtest: pipe-A
[67.946071] Dynamic subtest pipe-A: SUCCESS (5.529s)
[67.953639] Starting dynamic subtest: pipe-B
[73.500572] Dynamic subtest pipe-B: SUCCESS (5.552s)
[73.508132] Starting dynamic subtest: pipe-C
[79.074707] Dynamic subtest pipe-C: SUCCESS (5.572s)
[79.082262] Starting dynamic subtest: pipe-D
[84.506478] Dynamic subtest pipe-D: SUCCESS (5.430s)
[84.515852] Starting dynamic subtest: all-pipes
[89.968819] Dynamic subtest all-pipes: SUCCESS (5.461s)
[89.969671] Subtest torture-bo: SUCCESS (27.547s)
[90.125264] [002/130] (932s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[90.353486] Starting subtest: blocking-absolute-wf_vblank-interruptible
[90.357885] Starting dynamic subtest: A-DP3
[98.205879] Dynamic subtest A-DP3: SUCCESS (7.846s)
[98.216104] Starting dynamic subtest: B-DP3
[105.946937] Dynamic subtest B-DP3: SUCCESS (7.739s)
[105.956216] Starting dynamic subtest: C-DP3
[113.698068] Dynamic subtest C-DP3: SUCCESS (7.750s)
[113.706760] Starting dynamic subtest: D-DP3
[121.444730] Dynamic subtest D-DP3: SUCCESS (7.746s)
[121.446484] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.091s)
[121.822959] [003/130] (901s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[122.005368] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[122.006272] Starting dynamic subtest: pipe-A-DP-3
[122.015068] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[122.022782] Starting dynamic subtest: pipe-B-DP-3
[122.031195] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[122.038932] Starting dynamic subtest: pipe-C-DP-3
[122.047228] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[122.054626] Starting dynamic subtest: pipe-D-DP-3
[122.063559] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[122.065361] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[122.485408] [004/130] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[122.668396] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[122.670120] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[122.866668] [005/130] (900s left) kms_pm_rpm (package-g7)
[124.990699] Starting subtest: package-g7
[124.993116] Subtest package-g7: SKIP (0.000s)
[125.366774] [006/130] (897s left) kms_getfb (getfb-repeated-different-handles)
[125.550413] Starting subtest: getfb-repeated-different-handles
[125.551336] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[125.768257] [007/130] (897s left) kms_psr (pr-primary-blt)
[125.947892] Subtest pr-primary-blt: SKIP (0.000s)
[126.007986] [008/130] (897s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[126.184752] Starting subtest: cursorB-vs-flipB-varying-size
[126.187387] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[126.354790] [009/130] (896s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[126.533575] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[126.534435] Starting dynamic subtest: pipe-A-DP-3
[126.555771] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[126.563889] Starting dynamic subtest: pipe-B-DP-3
[126.585243] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[126.593211] Starting dynamic subtest: pipe-C-DP-3
[126.619160] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[126.627143] Starting dynamic subtest: pipe-D-DP-3
[126.649116] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[126.650710] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.012s)
[127.022281] [010/130] (896s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[127.205993] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[127.251192] [011/130] (896s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[127.432289] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[127.433202] Starting dynamic subtest: pipe-A-DP-3
[127.441800] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[127.449586] Starting dynamic subtest: pipe-B-DP-3
[127.457896] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[127.465535] Starting dynamic subtest: pipe-C-DP-3
[127.473820] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[127.481443] Starting dynamic subtest: pipe-D-DP-3
[127.490470] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[127.492529] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[127.917363] [012/130] (895s left) i915_drm_fdinfo (virtual-busy-idle-all)
[127.985191] Starting subtest: virtual-busy-idle-all
[127.986994] Subtest virtual-busy-idle-all: SKIP (0.000s)
[128.150638] [013/130] (895s left) gem_userptr_blits (userfault)
[128.227817] Starting subtest: userfault
[128.230529] Subtest userfault: SUCCESS (0.005s)
[128.451937] [014/130] (895s left) kms_flip (flip-vs-expired-vblank)
[128.633236] Starting subtest: flip-vs-expired-vblank
[128.637178] Starting dynamic subtest: A-DP3
[136.528987] Dynamic subtest A-DP3: FAIL (7.787s)
[136.537087] Starting dynamic subtest: B-DP3
[144.253673] Dynamic subtest B-DP3: SUCCESS (7.827s)
[144.262544] Starting dynamic subtest: C-DP3
[152.031643] Dynamic subtest C-DP3: SUCCESS (7.777s)
[152.041364] Starting dynamic subtest: D-DP3
[159.805533] Dynamic subtest D-DP3: SUCCESS (7.773s)
[159.807442] Subtest flip-vs-expired-vblank: FAIL (31.173s)
[160.149407] [015/130] (863s left) gem_render_copy_redux (flink)
[160.224480] Starting subtest: flink
[163.049592] Subtest flink: SUCCESS (2.825s)
[163.268167] [016/130] (860s left) kms_big_fb (linear-32bpp-rotate-180)
[163.459423] Starting subtest: linear-32bpp-rotate-180
[165.487035] Subtest linear-32bpp-rotate-180: SUCCESS (2.027s)
[165.695955] [017/130] (858s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[165.873501] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[165.874331] Starting dynamic subtest: pipe-A
[165.985228] Dynamic subtest pipe-A: SUCCESS (0.111s)
[165.995476] Starting dynamic subtest: pipe-B
[166.181748] Dynamic subtest pipe-B: SUCCESS (0.196s)
[166.192745] Starting dynamic subtest: pipe-C
[166.380025] Dynamic subtest pipe-C: SUCCESS (0.198s)
[166.393705] Starting dynamic subtest: pipe-D
[166.592814] Dynamic subtest pipe-D: SUCCESS (0.212s)
[166.593910] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.719s)
[166.932751] [018/130] (857s left) gem_eio (unwedge-stress)
[167.217829] Starting subtest: unwedge-stress
[167.218669] Starting dynamic subtest: render
[184.933727] Dynamic subtest render: SUCCESS (17.714s)
[184.946833] Starting dynamic subtest: bsd1
[202.956596] Dynamic subtest bsd1: SUCCESS (18.020s)
[202.970220] Starting dynamic subtest: bsd2
[220.968055] Dynamic subtest bsd2: SUCCESS (18.010s)
[220.977638] Starting dynamic subtest: blt
[238.951709] Dynamic subtest blt: SUCCESS (17.983s)
[238.961384] Starting dynamic subtest: vebox
[256.929224] Dynamic subtest vebox: SUCCESS (17.977s)
[256.930150] Subtest unwedge-stress: SUCCESS (89.709s)
[257.257577] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[257.259645] [019/130] (766s left) kms_dsc (dsc-fractional-bpp)
[257.445514] Starting subtest: dsc-fractional-bpp
[257.450570] Subtest dsc-fractional-bpp: SKIP (0.001s)
[257.613425] [020/130] (766s left) kms_cursor_edge_walk (256x256-top-bottom)
[257.799495] Starting subtest: 256x256-top-bottom
[257.801426] Starting dynamic subtest: pipe-A-DP-3
[261.267950] Dynamic subtest pipe-A-DP-3: SUCCESS (3.466s)
[261.279543] Starting dynamic subtest: pipe-D-DP-3
[264.595175] Dynamic subtest pipe-D-DP-3: SUCCESS (3.326s)
[264.596130] Subtest 256x256-top-bottom: SUCCESS (6.796s)
[264.907088] [021/130] (759s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[265.100461] Starting subtest: fbc-2p-pri-indfb-multidraw
[265.102145] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[265.302834] [022/130] (758s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[265.386437] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[265.388481] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[265.673709] [023/130] (758s left) kms_flip (flip-vs-suspend-interruptible)
[265.865365] Starting subtest: flip-vs-suspend-interruptible
[265.869755] Starting dynamic subtest: A-DP3
[305.655118] Dynamic subtest A-DP3: SUCCESS (7.870s)
[305.667076] Starting dynamic subtest: B-DP3
[344.730183] Dynamic subtest B-DP3: SUCCESS (7.213s)
[344.743128] Starting dynamic subtest: C-DP3
[383.867022] Dynamic subtest C-DP3: SUCCESS (7.329s)
[383.881149] Starting dynamic subtest: D-DP3
[422.883795] Dynamic subtest D-DP3: SUCCESS (7.257s)
[422.887885] Subtest flip-vs-suspend-interruptible: SUCCESS (29.678s)
[423.178967] [024/130] (601s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[423.366087] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[423.367014] Starting dynamic subtest: pipe-A-valid-mode
[423.458432] Dynamic subtest pipe-A-valid-mode: SKIP (0.090s)
[423.460637] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.091s)
[423.720384] [025/130] (600s left) gem_exec_basic (basic)
[423.805810] Starting subtest: basic
[423.806696] Starting dynamic subtest: rcs0-smem
[423.810919] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[423.822222] Starting dynamic subtest: bcs0-smem
[423.823210] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[423.834142] Starting dynamic subtest: vcs0-smem
[423.835319] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[423.846129] Starting dynamic subtest: vcs1-smem
[423.847385] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[423.857867] Starting dynamic subtest: vecs0-smem
[423.858935] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[423.869251] Starting dynamic subtest: vecs1-smem
[423.870363] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[423.880703] Starting dynamic subtest: ccs0-smem
[423.881797] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[423.892364] Starting dynamic subtest: rcs0-lmem0
[423.893620] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[423.904008] Starting dynamic subtest: bcs0-lmem0
[423.905080] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[423.915725] Starting dynamic subtest: vcs0-lmem0
[423.916954] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[423.927230] Starting dynamic subtest: vcs1-lmem0
[423.928178] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[423.939022] Starting dynamic subtest: vecs0-lmem0
[423.940144] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[423.950721] Starting dynamic subtest: vecs1-lmem0
[423.951707] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[423.962833] Starting dynamic subtest: ccs0-lmem0
[423.964001] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[423.965201] Subtest basic: SUCCESS (0.018s)
[424.093374] [026/130] (600s left) gem_exec_fence (syncobj-wait)
[424.628309] Starting subtest: syncobj-wait
[424.767464] Subtest syncobj-wait: SUCCESS (0.139s)
[425.202100] [027/130] (599s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[425.287303] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[425.367465] [028/130] (599s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[425.567584] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[425.582919] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.015s)
[425.768981] [029/130] (599s left) kms_chamelium_color (ctm-negative)
[425.956067] Subtest ctm-negative: SKIP (0.000s)
[426.013053] [030/130] (598s left) gem_eio (wait-1us)
[426.290411] Starting subtest: wait-1us
[426.926337] Subtest wait-1us: SUCCESS (0.637s)
[427.216482] [031/130] (597s left) gem_busy (busy)
[427.306119] Starting subtest: busy
[427.307056] Starting dynamic subtest: all-engines
[427.403068] Dynamic subtest all-engines: SUCCESS (0.096s)
[427.414554] Starting dynamic subtest: rcs0
[427.534092] Dynamic subtest rcs0: SUCCESS (0.130s)
[427.545980] Starting dynamic subtest: bcs0
[427.575880] Dynamic subtest bcs0: SUCCESS (0.041s)
[427.590734] Starting dynamic subtest: vcs0
[427.617396] Dynamic subtest vcs0: SUCCESS (0.041s)
[427.641346] Starting dynamic subtest: vcs1
[427.659044] Dynamic subtest vcs1: SUCCESS (0.040s)
[427.682050] Starting dynamic subtest: vecs0
[427.698632] Dynamic subtest vecs0: SUCCESS (0.038s)
[427.713639] Starting dynamic subtest: vecs1
[427.738609] Dynamic subtest vecs1: SUCCESS (0.039s)
[427.753729] Starting dynamic subtest: ccs0
[427.778019] Dynamic subtest ccs0: SUCCESS (0.039s)
[427.779110] Subtest busy: SUCCESS (0.472s)
[428.231069] [032/130] (596s left) kms_psr (fbc-psr-dpms)
[428.428824] Subtest fbc-psr-dpms: SKIP (0.000s)
[428.497672] [033/130] (596s left) gem_mmap_gtt (ptrace)
[428.583180] Subtest ptrace: SKIP (0.000s)
[428.695024] [034/130] (596s left) gem_ctx_persistence (legacy-engines-persistence)
[428.785762] Starting subtest: legacy-engines-persistence
[428.786665] Starting dynamic subtest: render
[429.617674] Dynamic subtest render: SUCCESS (0.831s)
[429.632777] Starting dynamic subtest: bsd1
[430.373558] Dynamic subtest bsd1: SUCCESS (0.754s)
[430.389301] Starting dynamic subtest: bsd2
[431.142446] Dynamic subtest bsd2: SUCCESS (0.766s)
[431.157346] Starting dynamic subtest: blt
[431.918511] Dynamic subtest blt: SUCCESS (0.772s)
[431.933388] Starting dynamic subtest: vebox
[432.652700] Dynamic subtest vebox: SUCCESS (0.731s)
[432.653855] Subtest legacy-engines-persistence: SUCCESS (3.868s)
[432.852049] [035/130] (592s left) kms_pm_dc (dc5-psr)
[434.047329] Starting subtest: dc5-psr
[434.049103] Subtest dc5-psr: SKIP (0.000s)
[434.204116] [036/130] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[434.394776] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[434.396412] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.607011] [037/130] (590s left) gem_exec_reloc (basic-write-read-noreloc)
[434.693483] Subtest basic-write-read-noreloc: SKIP (0.000s)
[434.784082] [038/130] (590s left) gem_ctx_param (set-priority-not-supported)
[434.874769] Starting subtest: set-priority-not-supported
[434.876517] Subtest set-priority-not-supported: SKIP (0.000s)
[435.015595] [039/130] (590s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[435.204293] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[435.205176] Starting dynamic subtest: pipe-A-DP-3
[435.213454] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[435.224663] Starting dynamic subtest: pipe-B-DP-3
[435.233278] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[435.244354] Starting dynamic subtest: pipe-C-DP-3
[435.252709] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[435.263909] Starting dynamic subtest: pipe-D-DP-3
[435.274608] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[435.276698] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[435.696887] [040/130] (589s left) gem_exec_whisper (basic-queues)
[435.790337] Starting subtest: basic-queues
[446.182378] Subtest basic-queues: SUCCESS (10.391s)
[446.479944] [041/130] (579s left) sw_sync (sync_merge)
[446.527731] Starting subtest: sync_merge
[446.528616] Subtest sync_merge: SUCCESS (0.000s)
[446.681633] [042/130] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[446.869285] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[446.871096] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[447.058880] [043/130] (578s left) api_intel_bb (intel-bb-blit-y)
[447.137495] Starting subtest: intel-bb-blit-y
[448.261216] Subtest intel-bb-blit-y: SUCCESS (1.124s)
[448.415911] [044/130] (577s left) kms_psr (psr-cursor-plane-onoff)
[448.602710] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[448.659480] [045/130] (577s left) gem_exec_schedule (preempt-queue)
[448.760729] Subtest preempt-queue: SKIP (0.000s)
[449.145024] [046/130] (576s left) kms_lease (lease-again)
[449.330671] Starting subtest: lease-again
[449.332844] Starting dynamic subtest: pipe-A-DP-3
[449.336334] Dynamic subtest pipe-A-DP-3: SUCCESS (0.004s)
[449.348146] Starting dynamic subtest: pipe-B-DP-3
[449.349051] Dynamic subtest pipe-B-DP-3: SUCCESS (0.003s)
[449.360668] Starting dynamic subtest: pipe-C-DP-3
[449.361547] Dynamic subtest pipe-C-DP-3: SUCCESS (0.003s)
[449.372888] Starting dynamic subtest: pipe-D-DP-3
[449.373768] Dynamic subtest pipe-D-DP-3: SUCCESS (0.004s)
[449.374631] Subtest lease-again: SUCCESS (0.021s)
[449.530940] [047/130] (576s left) syncobj_wait (wait-all-interrupted)
[449.610528] Starting subtest: wait-all-interrupted
[449.713507] Subtest wait-all-interrupted: SUCCESS (0.102s)
[449.852473] [048/130] (576s left) syncobj_wait (single-wait-for-submit-signaled)
[449.930542] Starting subtest: single-wait-for-submit-signaled
[449.931445] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[450.115882] [049/130] (576s left) gem_mmap_gtt (cpuset-big-copy-odd)
[450.201540] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[450.278918] [050/130] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[450.478091] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[450.479709] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[450.681935] [051/130] (575s left) kms_content_protection (dp-mst-suspend-resume)
[450.934416] Starting subtest: dp-mst-suspend-resume
[450.936344] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[451.162532] [052/130] (575s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[451.241453] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[451.345199] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[451.533781] [053/130] (575s left) kms_getfb (getfb-handle-not-fb)
[451.721515] Starting subtest: getfb-handle-not-fb
[451.722409] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[451.933558] [054/130] (574s left) kms_frontbuffer_tracking (fbc-2p-rte)
[452.125208] Starting subtest: fbc-2p-rte
[452.126954] Subtest fbc-2p-rte: SKIP (0.000s)
[452.314097] [055/130] (574s left) gem_exec_schedule (smoketest)
[452.525365] Starting subtest: smoketest
[452.526328] Starting dynamic subtest: rcs0
[457.988676] Dynamic subtest rcs0: SUCCESS (5.462s)
[458.000103] Starting dynamic subtest: bcs0
[463.451612] Dynamic subtest bcs0: SUCCESS (5.464s)
[463.463194] Starting dynamic subtest: vcs0
[468.903666] Dynamic subtest vcs0: SUCCESS (5.451s)
[468.916429] Starting dynamic subtest: vcs1
[474.363771] Dynamic subtest vcs1: SUCCESS (5.460s)
[474.376640] Starting dynamic subtest: vecs0
[479.826123] Dynamic subtest vecs0: SUCCESS (5.462s)
[479.838577] Starting dynamic subtest: vecs1
[485.286464] Dynamic subtest vecs1: SUCCESS (5.457s)
[485.299537] Starting dynamic subtest: ccs0
[490.747603] Dynamic subtest ccs0: SUCCESS (5.461s)
[490.748730] Subtest smoketest: SUCCESS (38.223s)
[491.073076] [056/130] (535s left) i915_drm_fdinfo (busy)
[491.144797] Starting subtest: busy
[491.145619] Starting dynamic subtest: rcs0
[491.177410] Dynamic subtest rcs0: SKIP (0.031s)
[491.189419] Starting dynamic subtest: bcs0
[491.191744] Dynamic subtest bcs0: SKIP (0.000s)
[491.203655] Starting dynamic subtest: vcs0
[491.205958] Dynamic subtest vcs0: SKIP (0.000s)
[491.217422] Starting dynamic subtest: vcs1
[491.219997] Dynamic subtest vcs1: SKIP (0.000s)
[491.231302] Starting dynamic subtest: vecs0
[491.233157] Dynamic subtest vecs0: SKIP (0.000s)
[491.244378] Starting dynamic subtest: vecs1
[491.246724] Dynamic subtest vecs1: SKIP (0.000s)
[491.257954] Starting dynamic subtest: ccs0
[491.260378] Dynamic subtest ccs0: SKIP (0.000s)
[491.262716] Subtest busy: SKIP (0.038s)
[491.313842] [057/130] (535s left) kms_plane_alpha_blend (alpha-transparent-fb)
[491.504146] Starting subtest: alpha-transparent-fb
[491.762709] Starting dynamic subtest: pipe-A-DP-3
[492.287600] Dynamic subtest pipe-A-DP-3: SUCCESS (0.524s)
[492.299105] Starting dynamic subtest: pipe-D-DP-3
[492.846224] Dynamic subtest pipe-D-DP-3: SUCCESS (0.557s)
[492.847141] Subtest alpha-transparent-fb: SUCCESS (1.342s)
[493.158633] [058/130] (533s left) kms_psr (fbc-pr-no-drrs)
[493.347631] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[493.402759] [059/130] (533s left) kms_psr (fbc-pr-sprite-plane-move)
[493.590366] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[493.652550] [060/130] (533s left) gem_pxp (create-valid-protected-context)
[496.260366] Starting subtest: create-valid-protected-context
[496.262898] Subtest create-valid-protected-context: SKIP (0.000s)
[496.392250] [061/130] (530s left) kms_rotation_crc (multiplane-rotation)
[496.582077] Starting subtest: multiplane-rotation
[525.224704] Subtest multiplane-rotation: SUCCESS (28.642s)
[525.445549] [062/130] (501s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[525.660922] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[525.662609] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[525.861555] [063/130] (501s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[526.061572] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[526.063279] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[526.259950] [064/130] (501s left) gem_mmap_wc (write-gtt-read-wc)
[526.342724] Subtest write-gtt-read-wc: SKIP (0.000s)
[526.425158] [065/130] (501s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[526.624620] Starting subtest: x-tiled-32bpp-rotate-270
[526.691762] Subtest x-tiled-32bpp-rotate-270: SKIP (0.066s)
[526.927069] [066/130] (500s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[527.114621] Starting subtest: flip-vs-cursor-crc-atomic
[527.693622] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.577s)
[528.044351] [067/130] (499s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[528.241540] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[528.243250] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[528.443513] [068/130] (499s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[528.648282] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[528.650092] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[528.851679] [069/130] (499s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[529.043495] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[529.045315] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[529.243451] [070/130] (498s left) kms_cursor_crc (cursor-offscreen-512x170)
[529.720506] Starting subtest: cursor-offscreen-512x170
[529.722309] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[529.978639] [071/130] (498s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[530.257452] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[530.420733] [072/130] (497s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[530.605114] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[530.607582] Starting dynamic subtest: pipe-A-DP-3
[530.615947] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[530.627455] Starting dynamic subtest: pipe-B-DP-3
[530.635719] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[530.647090] Starting dynamic subtest: pipe-C-DP-3
[530.655283] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[530.666702] Starting dynamic subtest: pipe-D-DP-3
[530.676521] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[530.678688] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[531.108723] [073/130] (497s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[531.301408] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[531.303139] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[531.509727] [074/130] (496s left) syncobj_timeline (multi-wait-all-available-signaled)
[531.589642] Starting subtest: multi-wait-all-available-signaled
[531.590522] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[531.740643] [075/130] (496s left) gem_create (create-clear)
[531.838880] Starting subtest: create-clear
[531.841962] Starting dynamic subtest: lmem0
[565.626478] Dynamic subtest lmem0: SUCCESS (33.785s)
[565.638341] Starting dynamic subtest: smem0
[600.250072] Dynamic subtest smem0: SUCCESS (34.618s)
[600.250980] Subtest create-clear: SUCCESS (68.406s)
[600.675994] [076/130] (427s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[600.868112] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[605.993915] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (5.126s)
[606.273413] [077/130] (422s left) kms_async_flips (invalid-async-flip)
[606.463598] Starting subtest: invalid-async-flip
[606.699195] Starting dynamic subtest: pipe-A-DP-3
[607.088828] Dynamic subtest pipe-A-DP-3: SUCCESS (0.390s)
[607.300958] Starting dynamic subtest: pipe-B-DP-3
[607.448848] Dynamic subtest pipe-B-DP-3: SUCCESS (0.159s)
[607.659458] Starting dynamic subtest: pipe-C-DP-3
[607.807009] Dynamic subtest pipe-C-DP-3: SUCCESS (0.159s)
[608.030465] Starting dynamic subtest: pipe-D-DP-3
[608.186546] Dynamic subtest pipe-D-DP-3: SUCCESS (0.170s)
[608.187554] Subtest invalid-async-flip: SUCCESS (1.725s)
[608.713681] [078/130] (419s left) device_reset (unbind-cold-reset-rebind)
[608.796331] Starting subtest: unbind-cold-reset-rebind
[608.798323] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[608.971766] [079/130] (419s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[609.158428] Starting subtest: plane-all-modeset-transition-fencing
[609.160574] Starting dynamic subtest: pipe-A-DP-3
[636.013448] Dynamic subtest pipe-A-DP-3: SUCCESS (26.853s)
[636.127392] Starting dynamic subtest: pipe-B-DP-3
[659.424235] Dynamic subtest pipe-B-DP-3: SUCCESS (23.334s)
[659.477030] Subtest plane-all-modeset-transition-fencing: SUCCESS (50.317s)
[659.793188] [080/130] (368s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[659.980489] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[659.981397] Starting dynamic subtest: pipe-A-valid-mode
[660.069152] Dynamic subtest pipe-A-valid-mode: SKIP (0.087s)
[660.071102] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.089s)
[660.336299] [081/130] (368s left) gem_ctx_isolation (preservation)
[660.423359] Starting subtest: preservation
[660.424252] Starting dynamic subtest: rcs0
[660.819448] Dynamic subtest rcs0: SUCCESS (0.395s)
[660.831162] Starting dynamic subtest: bcs0
[661.252535] Dynamic subtest bcs0: SUCCESS (0.432s)
[661.264203] Starting dynamic subtest: vcs0
[661.720634] Dynamic subtest vcs0: SUCCESS (0.467s)
[661.732335] Starting dynamic subtest: vcs1
[662.163368] Dynamic subtest vcs1: SUCCESS (0.441s)
[662.175290] Starting dynamic subtest: vecs0
[662.610456] Dynamic subtest vecs0: SUCCESS (0.446s)
[662.622148] Starting dynamic subtest: vecs1
[663.042820] Dynamic subtest vecs1: SUCCESS (0.431s)
[663.054590] Starting dynamic subtest: ccs0
[663.459935] Dynamic subtest ccs0: SUCCESS (0.416s)
[663.460785] Subtest preservation: SUCCESS (3.037s)
[663.750634] [082/130] (365s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[663.830334] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[663.924883] [083/130] (365s left) intel_hwmon (hwmon-read)
[664.003698] Starting subtest: hwmon-read
[664.006077] Subtest hwmon-read: SUCCESS (0.001s)
[664.191274] [084/130] (364s left) perf_pmu (semaphore-wait)
[664.262622] Starting subtest: semaphore-wait
[664.263574] Starting dynamic subtest: rcs0
[664.801018] Dynamic subtest rcs0: SUCCESS (0.537s)
[664.817241] Starting dynamic subtest: bcs0
[665.314960] Dynamic subtest bcs0: SUCCESS (0.509s)
[665.331249] Starting dynamic subtest: vcs0
[665.830069] Dynamic subtest vcs0: SUCCESS (0.510s)
[665.846430] Starting dynamic subtest: vcs1
[666.345088] Dynamic subtest vcs1: SUCCESS (0.510s)
[666.361592] Starting dynamic subtest: vecs0
[666.859858] Dynamic subtest vecs0: SUCCESS (0.510s)
[666.876512] Starting dynamic subtest: vecs1
[667.373478] Dynamic subtest vecs1: SUCCESS (0.509s)
[667.390302] Starting dynamic subtest: ccs0
[667.887516] Dynamic subtest ccs0: SUCCESS (0.509s)
[667.892319] Subtest semaphore-wait: SUCCESS (3.627s)
[668.113933] [085/130] (360s left) api_intel_allocator (fork-simple-stress)
[668.190766] Starting subtest: fork-simple-stress
[673.600130] Subtest fork-simple-stress: SUCCESS (5.409s)
[673.821906] [086/130] (355s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[673.900691] Starting subtest: etime-single-wait-available-unsubmitted
[674.010277] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.108s)
[674.192103] [087/130] (355s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[674.382186] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[674.383912] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[674.579987] [088/130] (354s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[674.772320] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[674.852519] [089/130] (354s left) gen9_exec_parse (bb-start-cmd)
[674.938464] Subtest bb-start-cmd: SKIP (0.000s)
[675.030666] [090/130] (354s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[675.223074] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[675.224766] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[675.446215] [091/130] (354s left) gem_pxp (protected-raw-src-copy-not-readible)
[678.054204] Starting subtest: protected-raw-src-copy-not-readible
[678.056253] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[678.197417] [092/130] (351s left) i915_pm_rc6_residency (rc6-idle)
[678.285783] Starting subtest: rc6-idle
[678.305593] Starting dynamic subtest: gt0-rcs0
[702.601449] Dynamic subtest gt0-rcs0: SUCCESS (24.295s)
[702.616568] Starting dynamic subtest: gt0-bcs0
[726.830395] Dynamic subtest gt0-bcs0: SUCCESS (24.227s)
[726.844561] Starting dynamic subtest: gt0-vcs0
[751.150369] Dynamic subtest gt0-vcs0: SUCCESS (24.317s)
[751.167062] Starting dynamic subtest: gt0-vecs0
[775.465002] Dynamic subtest gt0-vecs0: SUCCESS (24.310s)
[775.505910] Starting dynamic subtest: gt0-ccs0
[799.788466] Dynamic subtest gt0-ccs0: SUCCESS (24.318s)
[799.792150] Subtest rc6-idle: SUCCESS (121.505s)
[799.990392] [093/130] (229s left) kms_atomic_interruptible (legacy-setmode)
[800.181673] Starting subtest: legacy-setmode
[800.183944] Starting dynamic subtest: pipe-A-DP-3
[806.514941] Dynamic subtest pipe-A-DP-3: SUCCESS (6.330s)
[806.515836] Subtest legacy-setmode: SUCCESS (6.333s)
[806.799151] [094/130] (222s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[806.875655] Starting subtest: etime-multi-wait-all-available-unsubmitted
[806.977462] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[807.161085] [095/130] (222s left) gem_eio (hibernate)
[807.500103] Starting subtest: hibernate
[822.776270] Subtest hibernate: SUCCESS (15.277s)
[830.075511] [096/130] (206s left) kms_flip (flip-vs-panning-interruptible)
[830.268956] Starting subtest: flip-vs-panning-interruptible
[830.273733] Starting dynamic subtest: A-DP3
[838.111055] Dynamic subtest A-DP3: SUCCESS (7.836s)
[838.158227] Starting dynamic subtest: B-DP3
[845.905152] Dynamic subtest B-DP3: SUCCESS (7.788s)
[845.948570] Starting dynamic subtest: C-DP3
[853.708012] Dynamic subtest C-DP3: SUCCESS (7.797s)
[853.746513] Starting dynamic subtest: D-DP3
[861.483069] Dynamic subtest D-DP3: SUCCESS (7.769s)
[861.491270] Subtest flip-vs-panning-interruptible: SUCCESS (31.221s)
[861.883189] [097/130] (175s left) syncobj_basic (illegal-fd-to-handle)
[861.965424] Starting subtest: illegal-fd-to-handle
[861.966360] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[862.166971] [098/130] (174s left) gem_ctx_param (invalid-ctx-set)
[862.246962] Starting subtest: invalid-ctx-set
[862.249178] Subtest invalid-ctx-set: SUCCESS (0.001s)
[862.457116] [099/130] (174s left) kms_chamelium_frames (hdmi-crc-single)
[862.723589] Subtest hdmi-crc-single: SKIP (0.000s)
[862.877806] [100/130] (174s left) syncobj_wait (invalid-wait-bad-flags)
[862.958640] Starting subtest: invalid-wait-bad-flags
[862.959561] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[863.123337] [101/130] (174s left) gem_ctx_shared (q-smoketest)
[863.220695] Starting subtest: Q-smoketest
[863.221646] Starting dynamic subtest: rcs0
[868.676463] Dynamic subtest rcs0: SUCCESS (5.450s)
[868.690223] Starting dynamic subtest: bcs0
[874.093403] Dynamic subtest bcs0: SUCCESS (5.416s)
[874.106542] Starting dynamic subtest: vcs0
[879.517805] Dynamic subtest vcs0: SUCCESS (5.423s)
[879.531063] Starting dynamic subtest: vcs1
[884.936563] Dynamic subtest vcs1: SUCCESS (5.418s)
[884.949708] Starting dynamic subtest: vecs0
[890.363150] Dynamic subtest vecs0: SUCCESS (5.425s)
[890.376541] Starting dynamic subtest: vecs1
[895.785143] Dynamic subtest vecs1: SUCCESS (5.421s)
[895.799226] Starting dynamic subtest: ccs0
[901.206079] Dynamic subtest ccs0: SUCCESS (5.418s)
[901.207399] Subtest Q-smoketest: SUCCESS (37.979s)
[901.548964] [102/130] (135s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[901.741984] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[901.743611] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[901.956463] [103/130] (135s left) kms_cursor_crc (cursor-random-512x512)
[902.414495] Starting subtest: cursor-random-512x512
[902.416328] Subtest cursor-random-512x512: SKIP (0.001s)
[902.730450] [104/130] (134s left) gem_exec_balancer (parallel-balancer)
[903.083294] Starting subtest: parallel-balancer
[904.676535] Subtest parallel-balancer: SUCCESS (1.593s)
[904.852918] [105/130] (132s left) gem_mmap_gtt (basic-read-write)
[904.933345] Subtest basic-read-write: SKIP (0.000s)
[905.020781] [106/130] (132s left) gem_exec_whisper (basic-forked)
[905.111481] Starting subtest: basic-forked
[912.239032] Subtest basic-forked: SUCCESS (7.127s)
[912.539020] [107/130] (125s left) kms_vblank (ts-continuation-idle-hang)
[912.730096] Starting subtest: ts-continuation-idle-hang
[912.732285] Starting dynamic subtest: pipe-A-DP-3
[938.928216] Dynamic subtest pipe-A-DP-3: SUCCESS (26.195s)
[938.943193] Starting dynamic subtest: pipe-D-DP-3
[963.921433] Dynamic subtest pipe-D-DP-3: SUCCESS (24.989s)
[963.922410] Subtest ts-continuation-idle-hang: SUCCESS (51.190s)
[964.235812] [108/130] ( 73s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[964.433153] Starting subtest: fbc-modesetfrombusy
[965.738100] Subtest fbc-modesetfrombusy: SUCCESS (1.306s)
[965.975789] [109/130] ( 72s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[966.175076] Starting subtest: yf-tiled-64bpp-rotate-270
[966.176881] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[966.341951] [110/130] ( 71s left) i915_selftest (perf)
[967.537196] Starting subtest: perf
[967.538227] Starting dynamic subtest: engine_cs
[969.225087] Dynamic subtest engine_cs: SUCCESS (1.687s)
[969.235846] Starting dynamic subtest: request
[973.953133] Dynamic subtest request: SUCCESS (4.727s)
[973.964023] Starting dynamic subtest: migrate
[975.769393] Dynamic subtest migrate: SUCCESS (1.815s)
[975.780341] Starting dynamic subtest: region
[1004.454292] Dynamic subtest region: SUCCESS (28.683s)
[1004.455216] Subtest perf: SUCCESS (36.917s)
[1004.487012] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1004.488013] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[1004.489908] [111/130] ( 33s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[1006.247227] Starting subtest: y-tiled-32bpp-rotate-270
[1006.248988] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[1006.471271] [FACT kms_big_fb (y-tiled-32bpp-rotate-270)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[1006.473952] [FACT kms_big_fb (y-tiled-32bpp-rotate-270)] new: kernel.kmod_is_loaded.i915: true
[1006.476647] [112/130] ( 31s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[1006.677442] Starting subtest: flip-vs-cursor-busy-crc-atomic
[1007.467152] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.788s)
[1007.800720] [113/130] ( 30s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[1007.996494] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[1007.998221] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[1008.155882] [114/130] ( 30s left) kms_vrr (seamless-rr-switch-drrs)
[1008.348584] Starting subtest: seamless-rr-switch-drrs
[1008.351150] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[1008.520646] [115/130] ( 29s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[1008.723313] Starting subtest: 4-tiled-16bpp-rotate-270
[1008.780664] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.057s)
[1009.015133] [116/130] ( 29s left) prime_busy (after-wait)
[1009.104719] Starting subtest: after-wait
[1009.109575] Starting dynamic subtest: rcs0
[1009.180715] Dynamic subtest rcs0: SUCCESS (0.071s)
[1009.193182] Starting dynamic subtest: bcs0
[1009.235698] Dynamic subtest bcs0: SUCCESS (0.054s)
[1009.249803] Starting dynamic subtest: vcs0
[1009.276280] Dynamic subtest vcs0: SUCCESS (0.039s)
[1009.297023] Starting dynamic subtest: vcs1
[1009.316558] Dynamic subtest vcs1: SUCCESS (0.039s)
[1009.338923] Starting dynamic subtest: vecs0
[1009.359162] Dynamic subtest vecs0: SUCCESS (0.041s)
[1009.382010] Starting dynamic subtest: vecs1
[1009.401054] Dynamic subtest vecs1: SUCCESS (0.040s)
[1009.420854] Starting dynamic subtest: ccs0
[1009.442830] Dynamic subtest ccs0: SUCCESS (0.040s)
[1009.552495] Subtest after-wait: SUCCESS (0.447s)
[1009.745804] [117/130] ( 28s left) syncobj_timeline (single-wait-all-signaled)
[1009.830636] Starting subtest: single-wait-all-signaled
[1009.831551] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[1010.056091] [118/130] ( 28s left) gem_exec_create (basic)
[1010.151537] Starting subtest: basic
[1010.152470] Starting dynamic subtest: smem
[1012.249811] Dynamic subtest smem: SUCCESS (2.098s)
[1012.263995] Starting dynamic subtest: lmem0
[1014.354868] Dynamic subtest lmem0: SUCCESS (2.104s)
[1014.355744] Subtest basic: SUCCESS (4.204s)
[1014.612371] [119/130] ( 24s left) kms_selftest (drm_plane_helper)
[1014.664319] Starting subtest: drm_plane_helper
[1014.694566] Starting dynamic subtest: drm_test_check_plane_state
[1014.807503] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.112s)
[1014.820032] Starting dynamic subtest: drm_test_check_invalid_plane_state
[1014.885076] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.075s)
[1014.886505] Subtest drm_plane_helper: SUCCESS (0.220s)
[1015.112372] [120/130] ( 23s left) gem_exec_fence (submit-chain)
[1015.348761] Starting subtest: submit-chain
[1015.408269] Subtest submit-chain: SUCCESS (0.063s)
[1016.166248] [121/130] ( 22s left) sw_sync (sync_expired_merge)
[1016.215488] Starting subtest: sync_expired_merge
[1017.289956] Subtest sync_expired_merge: SUCCESS (1.074s)
[1017.400195] [122/130] ( 21s left) gem_workarounds (basic-read-context)
[1017.493371] Starting subtest: basic-read-context
[1017.536971] Subtest basic-read-context: SUCCESS (0.044s)
[1017.756773] [123/130] ( 21s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[1017.949943] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[1017.951559] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[1018.165589] [124/130] ( 21s left) syncobj_timeline (signal-point-0)
[1018.253688] Starting subtest: signal-point-0
[1018.254804] Subtest signal-point-0: SUCCESS (0.000s)
[1018.462405] [125/130] ( 20s left) kms_plane_multiple (tiling-yf)
[1018.651943] Starting subtest: tiling-yf
[1018.653637] Subtest tiling-yf: SKIP (0.000s)
[1018.820951] [126/130] ( 20s left) gem_mmap (basic-small-bo)
[1018.902358] Subtest basic-small-bo: SKIP (0.000s)
[1018.976237] [127/130] ( 20s left) kms_invalid_mode (bad-vtotal)
[1019.161629] Starting subtest: bad-vtotal
[1019.162588] Starting dynamic subtest: pipe-A-DP-3
[1019.240194] Dynamic subtest pipe-A-DP-3: SUCCESS (0.077s)
[1019.257065] Starting dynamic subtest: pipe-B-DP-3
[1019.258347] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[1019.273367] Starting dynamic subtest: pipe-C-DP-3
[1019.274478] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[1019.286686] Starting dynamic subtest: pipe-D-DP-3
[1019.287584] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[1019.288464] Subtest bad-vtotal: SUCCESS (0.088s)
[1019.527687] [128/130] ( 19s left) gem_softpin (evict-prime-sanity-check)
[1019.612552] Starting subtest: evict-prime-sanity-check
[1019.613511] Starting dynamic subtest: rcs0
[1020.791494] Dynamic subtest rcs0: SUCCESS (1.178s)
[1020.806581] Starting dynamic subtest: bcs0
[1021.906562] Dynamic subtest bcs0: SUCCESS (1.114s)
[1021.920285] Starting dynamic subtest: vcs0
[1023.016436] Dynamic subtest vcs0: SUCCESS (1.109s)
[1023.030285] Starting dynamic subtest: vcs1
[1024.141447] Dynamic subtest vcs1: SUCCESS (1.124s)
[1024.156002] Starting dynamic subtest: vecs0
[1025.255412] Dynamic subtest vecs0: SUCCESS (1.113s)
[1025.269325] Starting dynamic subtest: vecs1
[1026.379595] Dynamic subtest vecs1: SUCCESS (1.123s)
[1026.394834] Starting dynamic subtest: ccs0
[1027.486449] Dynamic subtest ccs0: SUCCESS (1.106s)
[1027.500144] Starting dynamic subtest: all
[1028.612674] Dynamic subtest all: SUCCESS (1.125s)
[1028.613624] Subtest evict-prime-sanity-check: SUCCESS (9.001s)
[1028.749119] [129/130] ( 10s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[1028.942312] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[1028.944061] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[1029.144946] [130/130] ( 10s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[1029.330994] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[1029.331872] Starting dynamic subtest: pipe-A
[1029.909887] Dynamic subtest pipe-A: SUCCESS (0.578s)
[1029.944320] Starting dynamic subtest: pipe-B
[1030.571694] Dynamic subtest pipe-B: SUCCESS (0.660s)
[1030.591223] Starting dynamic subtest: pipe-C
[1031.201872] Dynamic subtest pipe-C: SUCCESS (0.628s)
[1031.229860] Starting dynamic subtest: pipe-D
[1031.847797] Dynamic subtest pipe-D: SUCCESS (0.644s)
[1031.851502] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (2.518s)
[1032.212077] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: kms_cursor_edge_walk
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_render_copy
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: gem_exec_basic
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: kms_chamelium_color
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_pm_dc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: sw_sync
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: kms_plane_alpha_blend
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_rotation_crc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_cursor_crc
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: gem_create
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: device_reset
results: parsing output: 78/ for test: kms_atomic_transition
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_ctx_isolation
results: parsing output: 81/ for test: kms_pipe_b_c_ivb
results: parsing output: 82/ for test: intel_hwmon
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: api_intel_allocator
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: gen9_exec_parse
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_pxp
results: parsing output: 91/ for test: i915_pm_rc6_residency
results: parsing output: 92/ for test: kms_atomic_interruptible
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: gem_ctx_param
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: gem_ctx_shared
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: gem_exec_whisper
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: i915_selftest
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_vrr
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_exec_create
results: parsing output: 118/ for test: kms_selftest
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: gem_workarounds
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_plane_multiple
results: parsing output: 125/ for test: gem_mmap
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_plane_scaling
Done.