[60.742161] Initializing watchdogs
[60.742208]   /dev/watchdog0
[60.756794] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.761277] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.763540] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.767114] [001/133] (960s left) syncobj_wait (wait-for-submit-snapshot)
[60.851861] Starting subtest: wait-for-submit-snapshot
[60.933245] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[61.021979] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[61.119298] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[61.123588] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[61.225607] [003/133] (960s left) gem_fenced_exec_thrash (too-many-fences)
[61.279740] Subtest too-many-fences: SKIP (0.000s)
[61.341659] [004/133] (960s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[61.386896] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[61.389084] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[61.473568] [005/133] (959s left) gem_exec_balancer (hang)
[61.750964] Starting subtest: hang
[63.349881] Subtest hang: SUCCESS (1.597s)
[63.477868] [006/133] (957s left) gem_workarounds (basic-read-fd)
[63.549618] Starting subtest: basic-read-fd
[63.561307] Subtest basic-read-fd: SUCCESS (0.012s)
[63.692660] [007/133] (957s left) gem_workarounds (suspend-resume-fd)
[63.764607] Starting subtest: suspend-resume-fd
[80.114983] Subtest suspend-resume-fd: SUCCESS (2.486s)
[87.272873] [008/133] (941s left) kms_atomic_transition (modeset-transition-fencing)
[87.404913] Starting subtest: modeset-transition-fencing
[87.406798] Starting dynamic subtest: 1x-outputs
[98.332812] Dynamic subtest 1x-outputs: SUCCESS (10.809s)
[98.335275] Subtest modeset-transition-fencing: SUCCESS (10.810s)
[99.194193] [009/133] (929s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[99.301971] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[100.354475] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.048s)
[100.462911] [010/133] (928s left) gem_lmem_swapping (basic)
[100.504451] Subtest basic: SKIP (0.000s)
[100.574380] [011/133] (928s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[100.668348] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[100.671783] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[100.749986] [012/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[100.840358] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[100.843932] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[100.941745] [013/133] (927s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[101.037362] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[101.039314] Starting dynamic subtest: pipe-A-eDP-1
[103.337503] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.294s)
[103.346197] Starting dynamic subtest: pipe-B-eDP-1
[105.850427] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[105.859046] Starting dynamic subtest: pipe-C-eDP-1
[108.029466] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.174s)
[108.040424] Starting dynamic subtest: pipe-D-eDP-1
[110.249366] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.216s)
[110.251252] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.192s)
[111.456260] [014/133] (917s left) kms_hdmi_inject (inject-4k)
[111.810931] Starting subtest: inject-4k
[112.124604] Subtest inject-4k: SUCCESS (0.315s)
[112.732794] [015/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[112.828125] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[112.832188] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[112.913786] [016/133] (915s left) kms_properties (get_properties-sanity-non-atomic)
[113.003178] Starting subtest: get_properties-sanity-non-atomic
[113.005464] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[113.084752] [017/133] (915s left) gem_userptr_blits (nohangcheck)
[113.150428] Starting subtest: nohangcheck
[114.726242] Subtest nohangcheck: SUCCESS (1.570s)
[114.837140] [018/133] (914s left) perf_pmu (busy-start)
[114.885915] Starting subtest: busy-start
[114.888266] Starting dynamic subtest: rcs0
[117.440908] Dynamic subtest rcs0: SUCCESS (2.551s)
[117.449590] Starting dynamic subtest: bcs0
[119.985924] Dynamic subtest bcs0: SUCCESS (2.546s)
[119.995777] Starting dynamic subtest: vcs0
[122.564189] Dynamic subtest vcs0: FAIL (2.529s)
[122.573898] Starting dynamic subtest: vcs1
[125.096937] Dynamic subtest vcs1: FAIL (2.520s)
[125.106332] Starting dynamic subtest: vecs0
[128.762457] Dynamic subtest vecs0: SUCCESS (3.722s)
[128.772105] Starting dynamic subtest: ccs0
[131.312012] Dynamic subtest ccs0: SUCCESS (2.548s)
[131.314881] Subtest busy-start: FAIL (16.422s)
[131.439120] [019/133] (897s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[131.486193] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[131.591250] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[131.667033] [020/133] (897s left) kms_vblank (query-forked-busy)
[131.771549] Starting subtest: query-forked-busy
[131.773839] Starting dynamic subtest: pipe-A-eDP-1
[133.661594] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[133.675983] Starting dynamic subtest: pipe-D-eDP-1
[136.234730] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[136.237132] Subtest query-forked-busy: SUCCESS (4.462s)
[137.086641] [021/133] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[137.182537] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[144.240288] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.057s)
[144.364900] [022/133] (884s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[144.464545] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[144.469260] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[145.587037] [023/133] (883s left) i915_pm_rps (reset)
[145.646170] Starting subtest: reset
[154.094979] Subtest reset: SUCCESS (8.442s)
[154.233105] [024/133] (874s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[154.367533] Starting subtest: cursorB-vs-flipB-atomic
[154.372153] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[154.512987] [025/133] (874s left) gem_create (create-ext-placement-sanity-check)
[154.683623] Starting subtest: create-ext-placement-sanity-check
[154.686717] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[154.793735] [026/133] (874s left) gem_eio (in-flight-contexts-immediate)
[155.032197] Starting subtest: in-flight-contexts-immediate
[168.797103] Subtest in-flight-contexts-immediate: SUCCESS (13.759s)
[168.970491] [027/133] (860s left) sysfs_preempt_timeout (invalid)
[169.037808] Starting subtest: invalid
[169.040247] Starting dynamic subtest: vecs0
[169.042662] Dynamic subtest vecs0: SUCCESS (0.000s)
[169.053012] Starting dynamic subtest: ccs0
[169.054955] Dynamic subtest ccs0: SUCCESS (0.000s)
[169.063172] Starting dynamic subtest: vcs0
[169.065123] Dynamic subtest vcs0: SUCCESS (0.000s)
[169.073284] Starting dynamic subtest: bcs0
[169.075165] Dynamic subtest bcs0: SUCCESS (0.000s)
[169.083460] Starting dynamic subtest: rcs0
[169.085372] Dynamic subtest rcs0: SUCCESS (0.000s)
[169.094119] Starting dynamic subtest: vcs1
[169.096365] Dynamic subtest vcs1: SUCCESS (0.000s)
[169.098575] Subtest invalid: SUCCESS (0.004s)
[169.159920] [028/133] (860s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[169.261820] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[169.264261] Starting dynamic subtest: A-eDP1
[172.832672] Dynamic subtest A-eDP1: SUCCESS (3.569s)
[172.842601] Starting dynamic subtest: B-eDP1
[176.144416] Dynamic subtest B-eDP1: SUCCESS (3.308s)
[176.153694] Starting dynamic subtest: C-eDP1
[179.434078] Dynamic subtest C-eDP1: SUCCESS (3.289s)
[179.444614] Starting dynamic subtest: D-eDP1
[182.738173] Dynamic subtest D-eDP1: SUCCESS (3.303s)
[182.740667] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.476s)
[183.602957] [029/133] (845s left) syncobj_wait (wait-all-for-submit-snapshot)
[183.653953] Starting subtest: wait-all-for-submit-snapshot
[183.736154] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[183.812109] [030/133] (845s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[183.915444] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[183.919857] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[184.007639] [031/133] (845s left) kms_flip (bo-too-big)
[184.104285] Starting subtest: bo-too-big
[184.106221] Starting dynamic subtest: A-eDP1
[185.430629] Dynamic subtest A-eDP1: SUCCESS (1.327s)
[185.439851] Starting dynamic subtest: B-eDP1
[186.723764] Dynamic subtest B-eDP1: SUCCESS (1.292s)
[186.734595] Starting dynamic subtest: C-eDP1
[188.018200] Dynamic subtest C-eDP1: SUCCESS (1.293s)
[188.029363] Starting dynamic subtest: D-eDP1
[189.333728] Dynamic subtest D-eDP1: SUCCESS (1.315s)
[189.336021] Subtest bo-too-big: SUCCESS (5.237s)
[190.505821] [032/133] (839s left) gem_exec_flush (basic-batch-kernel-default-wb)
[190.569038] Starting subtest: basic-batch-kernel-default-wb
[197.829593] Subtest basic-batch-kernel-default-wb: SUCCESS (7.262s)
[198.018120] [033/133] (831s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[198.405041] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[199.180630] [034/133] (830s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[199.272533] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[199.274699] Starting dynamic subtest: pipe-A-eDP-1
[199.330003] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[199.338398] Starting dynamic subtest: pipe-B-eDP-1
[199.394844] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[199.405270] Starting dynamic subtest: pipe-C-eDP-1
[199.461371] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[199.470705] Starting dynamic subtest: pipe-D-eDP-1
[199.524829] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[199.528792] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[201.492813] [035/133] (828s left) fbdev (unaligned-write)
[201.535442] Starting subtest: unaligned-write
[201.635050] Subtest unaligned-write: SUCCESS (0.100s)
[201.725083] [036/133] (827s left) gem_ctx_param (invalid-set-no-zeromap)
[201.772956] Starting subtest: invalid-set-no-zeromap
[201.775349] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[201.861415] [037/133] (827s left) gem_exec_schedule (pi-ringfull)
[202.035815] Starting subtest: pi-ringfull
[202.037712] Starting dynamic subtest: rcs0
[202.150350] Dynamic subtest rcs0: SUCCESS (0.116s)
[202.164349] Starting dynamic subtest: bcs0
[202.176465] Dynamic subtest bcs0: SUCCESS (0.025s)
[202.190181] Starting dynamic subtest: vcs0
[202.203972] Dynamic subtest vcs0: SUCCESS (0.027s)
[202.217266] Starting dynamic subtest: vcs1
[202.231408] Dynamic subtest vcs1: SUCCESS (0.027s)
[202.244976] Starting dynamic subtest: vecs0
[202.258226] Dynamic subtest vecs0: SUCCESS (0.026s)
[202.272074] Starting dynamic subtest: ccs0
[202.284347] Dynamic subtest ccs0: SUCCESS (0.026s)
[202.286409] Subtest pi-ringfull: SUCCESS (0.251s)
[202.513641] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[202.517410] [038/133] (827s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[202.625007] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[203.647600] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.023s)
[203.764900] [039/133] (826s left) i915_drm_fdinfo (virtual-busy-idle)
[203.802488] Starting subtest: virtual-busy-idle
[203.806804] Subtest virtual-busy-idle: SKIP (0.000s)
[203.868217] [040/133] (825s left) kms_prop_blob (basic)
[203.931143] Starting subtest: basic
[203.933134] Subtest basic: SUCCESS (0.000s)
[204.023604] [041/133] (825s left) kms_psr (psr-dpms)
[204.108600] Starting subtest: psr-dpms
[204.110638] Starting dynamic subtest: eDP-1
[207.082308] Dynamic subtest eDP-1: SUCCESS (2.973s)
[207.084630] Subtest psr-dpms: SUCCESS (2.974s)
[207.897375] [042/133] (822s left) i915_suspend (sysfs-reader)
[207.964343] Starting subtest: sysfs-reader
[226.102297] Subtest sysfs-reader: SUCCESS (3.533s)
[237.207461] [043/133] (803s left) kms_draw_crc (draw-method-mmap-cpu)
[237.316903] Starting subtest: draw-method-mmap-cpu
[237.319100] Starting dynamic subtest: xrgb8888-untiled
[237.589253] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[237.598654] Starting dynamic subtest: rgb565-untiled
[237.815048] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[237.824906] Starting dynamic subtest: xrgb2101010-untiled
[238.041883] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[238.051942] Starting dynamic subtest: xbgr16161616f-untiled
[238.279409] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[238.290401] Starting dynamic subtest: xrgb8888-xtiled
[238.414773] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[238.424376] Starting dynamic subtest: rgb565-xtiled
[238.539802] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[238.549310] Starting dynamic subtest: xrgb2101010-xtiled
[238.663995] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[238.673764] Starting dynamic subtest: xbgr16161616f-xtiled
[238.803461] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[238.813993] Starting dynamic subtest: xrgb8888-4tiled
[238.935545] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[238.944280] Starting dynamic subtest: rgb565-4tiled
[239.082451] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[239.092394] Starting dynamic subtest: xrgb2101010-4tiled
[239.207001] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[239.216193] Starting dynamic subtest: xbgr16161616f-4tiled
[239.353671] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s)
[239.355621] Subtest draw-method-mmap-cpu: SUCCESS (2.001s)
[239.463144] [044/133] (801s left) kms_rotation_crc (primary-rotation-180)
[239.555483] Starting subtest: primary-rotation-180
[246.641042] Subtest primary-rotation-180: SUCCESS (7.013s)
[247.832614] [045/133] (793s left) syncobj_wait (multi-wait-all-submitted-signaled)
[247.890392] Starting subtest: multi-wait-all-submitted-signaled
[247.997546] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[248.088941] [046/133] (793s left) kms_getfb (getfb-handle-zero)
[248.180835] Starting subtest: getfb-handle-zero
[248.182974] Subtest getfb-handle-zero: SUCCESS (0.000s)
[248.277823] [047/133] (792s left) gem_mmap_gtt (flink-race)
[248.330767] Subtest flink-race: SKIP (0.000s)
[248.392178] [048/133] (792s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[248.487400] Starting subtest: stress-xrgb8888-xtiled
[254.488324] Subtest stress-xrgb8888-xtiled: SUCCESS (5.981s)
[254.557242] [049/133] (786s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[254.658040] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[254.668620] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[254.746297] [050/133] (786s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[254.837211] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[254.838976] Starting dynamic subtest: pipe-A-eDP-1
[254.846276] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.855717] Starting dynamic subtest: pipe-B-eDP-1
[254.863081] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.871830] Starting dynamic subtest: pipe-C-eDP-1
[254.879007] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.887507] Starting dynamic subtest: pipe-D-eDP-1
[254.894171] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.897369] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[257.060658] [051/133] (784s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[257.118285] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[257.221868] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[257.299977] [052/133] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[257.396123] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[257.400172] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[257.479100] [053/133] (783s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[257.723985] Starting subtest: cursor-rapid-movement-256x256
[257.728842] Starting dynamic subtest: pipe-A-eDP-1
[258.271023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s)
[258.304881] Starting dynamic subtest: pipe-D-eDP-1
[259.458919] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[259.461097] Subtest cursor-rapid-movement-256x256: SUCCESS (1.732s)
[260.274742] [054/133] (781s left) kms_tiled_display (basic-test-pattern)
[260.381849] Subtest basic-test-pattern: SKIP (0.000s)
[260.427652] [055/133] (781s left) gem_pxp (fail-invalid-protected-context)
[260.543865] Starting subtest: fail-invalid-protected-context
[260.546639] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[260.665944] [056/133] (780s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[260.762224] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[260.764479] Starting dynamic subtest: pipe-A-eDP-1
[260.786561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.797470] Starting dynamic subtest: pipe-B-eDP-1
[260.818142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.827765] Starting dynamic subtest: pipe-C-eDP-1
[260.848772] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.860556] Starting dynamic subtest: pipe-D-eDP-1
[260.882666] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.886696] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[262.981863] [057/133] (778s left) gem_ctx_shared (create-shared-gtt)
[263.049454] Starting subtest: create-shared-gtt
[265.204228] Subtest create-shared-gtt: SUCCESS (2.151s)
[265.625072] [058/133] (776s left) gem_caching (reads)
[265.684028] Subtest reads: SKIP (0.000s)
[265.762379] [059/133] (775s left) prime_vgem (fence-wait)
[265.826502] Starting subtest: fence-wait
[265.828799] Starting dynamic subtest: rcs0
[266.891109] Dynamic subtest rcs0: SUCCESS (1.062s)
[266.903318] Starting dynamic subtest: bcs0
[267.964710] Dynamic subtest bcs0: SUCCESS (1.072s)
[267.976908] Starting dynamic subtest: vcs0
[269.010382] Dynamic subtest vcs0: SUCCESS (1.044s)
[269.023185] Starting dynamic subtest: vcs1
[270.052097] Dynamic subtest vcs1: SUCCESS (1.040s)
[270.063883] Starting dynamic subtest: vecs0
[271.093668] Dynamic subtest vecs0: SUCCESS (1.040s)
[271.105909] Starting dynamic subtest: ccs0
[272.138348] Dynamic subtest ccs0: SUCCESS (1.042s)
[272.141038] Subtest fence-wait: SUCCESS (6.309s)
[272.280030] [060/133] (769s left) kms_psr (psr-cursor-plane-move)
[272.386692] Starting subtest: psr-cursor-plane-move
[272.388719] Starting dynamic subtest: eDP-1
[274.132188] Dynamic subtest eDP-1: SUCCESS (1.744s)
[274.134435] Subtest psr-cursor-plane-move: SUCCESS (1.745s)
[274.976126] [061/133] (766s left) kms_vrr (max-min)
[275.068883] Starting subtest: max-min
[275.075195] Subtest max-min: SKIP (0.000s)
[275.141929] [062/133] (766s left) prime_mmap_kms (buffer-sharing)
[275.234883] Starting subtest: buffer-sharing
[275.689334] Subtest buffer-sharing: SUCCESS (0.454s)
[276.490254] [063/133] (765s left) kms_content_protection (lic-type-0-hdcp14)
[276.631093] Starting subtest: lic-type-0-hdcp14
[276.635693] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[276.758838] [064/133] (765s left) api_intel_allocator (reopen-fork)
[276.823553] Starting subtest: reopen-fork
[280.249814] Subtest reopen-fork: SUCCESS (3.426s)
[280.323420] [065/133] (761s left) gen9_exec_parse (bb-large)
[280.375991] Subtest bb-large: SKIP (0.000s)
[280.449187] [066/133] (761s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[280.843207] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[281.654725] [067/133] (760s left) kms_invalid_mode (int-max-clock)
[281.751988] Starting subtest: int-max-clock
[281.754112] Starting dynamic subtest: pipe-A-eDP-1
[282.039613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[282.049499] Starting dynamic subtest: pipe-B-eDP-1
[282.051389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[282.060531] Starting dynamic subtest: pipe-C-eDP-1
[282.062779] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[282.072177] Starting dynamic subtest: pipe-D-eDP-1
[282.074448] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[282.076579] Subtest int-max-clock: SUCCESS (0.296s)
[282.873770] [068/133] (759s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[282.995349] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[283.954680] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[284.778527] [069/133] (757s left) gem_userptr_blits (process-exit)
[284.846487] Starting subtest: process-exit
[284.854924] Subtest process-exit: SUCCESS (0.009s)
[284.987440] [070/133] (757s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[285.100841] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[285.126346] Starting dynamic subtest: pipe-A-plane-0
[285.414842] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[285.427809] Starting dynamic subtest: pipe-A-plane-3
[285.648543] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[286.729271] Starting dynamic subtest: pipe-B-plane-0
[287.020642] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[287.033090] Starting dynamic subtest: pipe-B-plane-3
[287.253824] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[287.564590] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.464s)
[288.385678] [071/133] (753s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[288.479519] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[288.491425] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[288.573500] [072/133] (753s left) gem_exec_flush (basic-uc-pro-default)
[288.640402] Starting subtest: basic-uc-pro-default
[294.102129] Subtest basic-uc-pro-default: SUCCESS (5.461s)
[294.293915] [073/133] (748s left) kms_psr (pr-sprite-mmap-gtt)
[294.387987] Starting subtest: pr-sprite-mmap-gtt
[294.392548] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[294.474396] [074/133] (747s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[294.567491] Starting subtest: 4-tiled-16bpp-rotate-90
[294.588057] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.020s)
[294.704839] [075/133] (747s left) gem_softpin (evict-single-offset)
[294.753345] Starting subtest: evict-single-offset
[322.378933] Subtest evict-single-offset: SUCCESS (27.614s)
[322.464974] [076/133] (720s left) gem_userptr_blits (sync-overlap)
[322.586877] Starting subtest: sync-overlap
[322.589258] Subtest sync-overlap: SUCCESS (0.000s)
[322.720877] [077/133] (719s left) gem_exec_capture (capture-recoverable)
[322.777991] Starting subtest: capture-recoverable
[322.783019] Subtest capture-recoverable: SUCCESS (0.005s)
[322.904653] [078/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[323.003476] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[330.206604] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.204s)
[330.321749] [079/133] (712s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[330.376922] Starting subtest: yf-tiled-to-vebox-yf-tiled
[330.380954] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[330.562158] [080/133] (712s left) device_reset (cold-reset-bound)
[330.620652] Starting subtest: cold-reset-bound
[330.625014] Subtest cold-reset-bound: SKIP (0.000s)
[330.695087] [081/133] (711s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[330.814632] Starting subtest: 2x-flip-vs-cursor-atomic
[330.819156] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[330.959259] [082/133] (711s left) gem_exec_schedule (fairslice-all)
[331.063037] Starting subtest: fairslice-all
[333.138110] Subtest fairslice-all: SUCCESS (2.070s)
[333.451082] [083/133] (709s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[333.559199] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[333.563515] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[333.647269] [084/133] (709s left) kms_lease (lease-invalid-plane)
[333.753056] Starting subtest: lease-invalid-plane
[333.755217] Starting dynamic subtest: pipe-A-eDP-1
[333.757482] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[333.768439] Starting dynamic subtest: pipe-B-eDP-1
[333.770295] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.780341] Starting dynamic subtest: pipe-C-eDP-1
[333.782508] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.791987] Starting dynamic subtest: pipe-D-eDP-1
[333.794038] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.796072] Subtest lease-invalid-plane: SUCCESS (0.004s)
[333.833871] [085/133] (709s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[333.942531] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[333.946985] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[334.036663] [086/133] (708s left) kms_cursor_crc (cursor-offscreen-64x21)
[334.232337] Starting subtest: cursor-offscreen-64x21
[334.279225] Subtest cursor-offscreen-64x21: SKIP (0.044s)
[334.501616] [087/133] (708s left) gem_exec_store (basic)
[334.560540] Starting subtest: basic
[334.657556] Subtest basic: SUCCESS (0.099s)
[334.854783] [088/133] (708s left) gem_ppgtt (blt-vs-render-ctxn)
[334.928203] Starting subtest: blt-vs-render-ctxN
[367.637442] Subtest blt-vs-render-ctxN: SUCCESS (32.712s)
[367.767402] [089/133] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[367.906666] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[367.911036] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[368.001414] [090/133] (675s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[368.057269] Starting subtest: multi-wait-for-submit-available-signaled
[368.059655] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[368.166208] [091/133] (674s left) kms_addfb_basic (master-rmfb)
[368.223959] Starting subtest: master-rmfb
[368.226198] Subtest master-rmfb: SUCCESS (0.001s)
[368.369457] [092/133] (674s left) kms_flip (plain-flip-fb-recreate)
[368.464100] Starting subtest: plain-flip-fb-recreate
[368.466449] Starting dynamic subtest: A-eDP1
[377.330332] Dynamic subtest A-eDP1: SUCCESS (8.865s)
[377.340705] Starting dynamic subtest: B-eDP1
[386.239379] Dynamic subtest B-eDP1: SUCCESS (8.906s)
[386.253796] Starting dynamic subtest: C-eDP1
[395.125493] Dynamic subtest C-eDP1: SUCCESS (8.882s)
[395.135817] Starting dynamic subtest: D-eDP1
[403.933960] Dynamic subtest D-eDP1: SUCCESS (8.805s)
[403.938549] Subtest plain-flip-fb-recreate: SUCCESS (35.468s)
[405.085574] [093/133] (638s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[405.142249] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[405.245870] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[405.339844] [094/133] (637s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[405.444068] Starting subtest: yf-tiled-64bpp-rotate-270
[405.448473] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[405.538756] [095/133] (637s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[405.640057] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[405.642425] Starting dynamic subtest: pipe-A-eDP-1
[405.736473] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[405.751206] Starting dynamic subtest: pipe-B-eDP-1
[406.933202] Dynamic subtest pipe-B-eDP-1: SKIP (1.193s)
[406.937779] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.298s)
[408.180769] [096/133] (635s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[408.296106] Starting subtest: psr-rgb565-draw-pwrite
[415.314844] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.020s)
[415.437652] [097/133] (627s left) kms_busy (extended-modeset-hang-oldfb)
[415.530909] Starting subtest: extended-modeset-hang-oldfb
[415.533145] Starting dynamic subtest: pipe-A
[427.490621] Dynamic subtest pipe-A: SUCCESS (11.954s)
[427.504474] Starting dynamic subtest: pipe-D
[440.032947] Dynamic subtest pipe-D: SUCCESS (12.537s)
[440.035112] Subtest extended-modeset-hang-oldfb: SUCCESS (24.496s)
[440.888222] [098/133] (602s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[440.950704] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[440.952937] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[441.059760] [099/133] (602s left) gem_exec_fence (invalid-timeline-fence-array)
[441.755451] Starting subtest: invalid-timeline-fence-array
[441.760953] Subtest invalid-timeline-fence-array: SUCCESS (0.010s)
[443.529865] [100/133] (599s left) syncobj_eventfd (invalid-bad-pad)
[443.578921] Starting subtest: invalid-bad-pad
[443.581245] Subtest invalid-bad-pad: SUCCESS (0.000s)
[443.680080] [101/133] (599s left) api_intel_bb (render)
[443.725798] Starting subtest: render
[443.728073] Starting dynamic subtest: render-none-512
[443.833834] Dynamic subtest render-none-512: SUCCESS (0.107s)
[443.846935] Starting dynamic subtest: render-none-1024
[444.501723] Dynamic subtest render-none-1024: SUCCESS (0.667s)
[444.515995] Starting dynamic subtest: render-x-512
[444.599926] Dynamic subtest render-x-512: SUCCESS (0.096s)
[444.612965] Starting dynamic subtest: render-x-1024
[444.954899] Dynamic subtest render-x-1024: SUCCESS (0.353s)
[444.965218] Starting dynamic subtest: render-y-512
[445.048459] Dynamic subtest render-y-512: SUCCESS (0.093s)
[445.060721] Starting dynamic subtest: render-y-1024
[445.399489] Dynamic subtest render-y-1024: SUCCESS (0.349s)
[445.402038] Subtest render: SUCCESS (1.674s)
[445.519059] [102/133] (598s left) gem_softpin (evict-active-interruptible)
[445.588687] Starting subtest: evict-active-interruptible
[445.598085] Subtest evict-active-interruptible: SUCCESS (0.009s)
[445.715288] [103/133] (597s left) kms_big_fb (linear-16bpp-rotate-0)
[445.831149] Starting subtest: linear-16bpp-rotate-0
[447.255019] Subtest linear-16bpp-rotate-0: SUCCESS (1.425s)
[447.404096] [104/133] (596s left) kms_psr (fbc-psr-cursor-blt)
[447.498999] Starting subtest: fbc-psr-cursor-blt
[447.500913] Starting dynamic subtest: eDP-1
[447.504310] Dynamic subtest eDP-1: SKIP (0.000s)
[447.507819] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[447.575286] [105/133] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[447.682169] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[447.685663] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[447.767276] [106/133] (596s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[447.829183] Starting subtest: invalid-bsd1-flag-on-vebox
[447.830781] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[447.929275] [107/133] (595s left) kms_plane_multiple (tiling-y)
[448.028992] Starting subtest: tiling-y
[448.032988] Subtest tiling-y: SKIP (0.000s)
[448.106968] [108/133] (595s left) prime_mmap (test_map_unmap)
[448.175956] Starting subtest: test_map_unmap
[448.177785] Starting dynamic subtest: test_map_unmap-smem
[448.207031] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[448.209155] Subtest test_map_unmap: SUCCESS (0.033s)
[448.312640] [109/133] (595s left) gem_ctx_param (non-root-set)
[448.364171] Starting subtest: non-root-set
[448.381768] Subtest non-root-set: SUCCESS (0.017s)
[448.477422] [110/133] (595s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[448.560119] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[448.561980] Starting dynamic subtest: pipe-A-eDP-1
[454.342940] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.777s)
[454.365663] Starting dynamic subtest: pipe-B-eDP-1
[460.854425] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.511s)
[460.856826] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.291s)
[461.700121] [111/133] (582s left) gem_mmap_gtt (cpuset-medium-copy)
[461.767615] Subtest cpuset-medium-copy: SKIP (0.000s)
[461.833289] [112/133] (582s left) prime_self_import (reimport-vs-gem_close-race)
[461.876675] Starting subtest: reimport-vs-gem_close-race
[466.976822] Subtest reimport-vs-gem_close-race: SUCCESS (5.105s)
[467.055873] [113/133] (577s left) gem_ctx_sseu (mmap-args)
[467.122392] Subtest mmap-args: SKIP (0.000s)
[467.185432] [114/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[467.286676] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[470.814776] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.533s)
[472.002199] [115/133] (572s left) kms_color (legacy-gamma)
[472.095470] Starting subtest: legacy-gamma
[472.097744] Starting dynamic subtest: pipe-A-eDP-1
[472.801292] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[472.812543] Starting dynamic subtest: pipe-B-eDP-1
[474.248128] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.444s)
[474.258495] Starting dynamic subtest: pipe-C-eDP-1
[475.601162] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[475.612254] Starting dynamic subtest: pipe-D-eDP-1
[477.031516] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.432s)
[477.033876] Subtest legacy-gamma: SUCCESS (4.941s)
[477.886259] [116/133] (566s left) syncobj_timeline (single-wait-available-signaled)
[477.952180] Starting subtest: single-wait-available-signaled
[477.954641] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[478.054635] [117/133] (566s left) kms_cursor_edge_walk (64x64-right-edge)
[478.143380] Starting subtest: 64x64-right-edge
[478.145627] Starting dynamic subtest: pipe-A-eDP-1
[481.610936] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[481.622510] Starting dynamic subtest: pipe-D-eDP-1
[484.813270] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.203s)
[484.815599] Subtest 64x64-right-edge: SUCCESS (6.673s)
[485.682322] [118/133] (558s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[485.788708] Starting subtest: fbc-pr-sprite-mmap-cpu
[485.793023] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[485.864034] [119/133] (558s left) kms_cursor_legacy (forked-bo)
[485.991069] Starting subtest: forked-bo
[485.993336] Starting dynamic subtest: pipe-A
[491.466474] Dynamic subtest pipe-A: SUCCESS (5.473s)
[491.488900] Starting dynamic subtest: pipe-B
[496.933172] Dynamic subtest pipe-B: SUCCESS (5.465s)
[496.946124] Starting dynamic subtest: pipe-C
[502.415611] Dynamic subtest pipe-C: SUCCESS (5.480s)
[502.428581] Starting dynamic subtest: pipe-D
[507.904424] Dynamic subtest pipe-D: SUCCESS (5.486s)
[507.917671] Starting dynamic subtest: all-pipes
[513.399732] Dynamic subtest all-pipes: SUCCESS (5.492s)
[513.402450] Subtest forked-bo: SUCCESS (27.409s)
[513.553316] [120/133] (530s left) gen9_exec_parse (shadow-peek)
[513.624467] Subtest shadow-peek: SKIP (0.000s)
[513.714501] [121/133] (530s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[513.820100] Starting subtest: plane-upscale-factor-0-25-with-rotation
[513.822325] Starting dynamic subtest: pipe-A
[514.046687] Dynamic subtest pipe-A: SUCCESS (0.228s)
[514.058279] Starting dynamic subtest: pipe-B
[515.324947] Dynamic subtest pipe-B: SUCCESS (1.278s)
[515.335475] Starting dynamic subtest: pipe-C
[516.626199] Dynamic subtest pipe-C: SUCCESS (1.300s)
[516.643075] Starting dynamic subtest: pipe-D
[517.912917] Dynamic subtest pipe-D: SUCCESS (1.285s)
[517.915535] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.096s)
[519.072442] [122/133] (525s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[519.167929] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[519.172118] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[519.241750] [123/133] (525s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[519.333500] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[519.337513] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[519.428823] [124/133] (525s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[519.535652] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[526.486259] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.953s)
[526.612458] [125/133] (518s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[526.707165] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[526.711417] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[526.779899] [126/133] (517s left) prime_mmap (test_aperture_limit)
[526.829920] Starting subtest: test_aperture_limit
[526.831748] Starting dynamic subtest: test_aperture_limit-smem
[526.838968] Dynamic subtest test_aperture_limit-smem: SKIP (0.009s)
[526.843178] Subtest test_aperture_limit: SKIP (0.009s)
[526.937155] [127/133] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[527.049692] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[533.875828] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.829s)
[534.014775] [128/133] (510s left) kms_hdr (bpc-switch-suspend)
[534.112653] Starting subtest: bpc-switch-suspend
[535.213039] Starting dynamic subtest: pipe-A-eDP-1
[555.214219] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.981s)
[555.216580] Subtest bpc-switch-suspend: SUCCESS (6.082s)
[560.331084] [129/133] (489s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[560.402193] Starting subtest: x-tiled-to-vebox-yf-tiled
[560.406827] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[560.590647] [130/133] (489s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[560.688581] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[560.690971] Starting dynamic subtest: pipe-A
[560.811387] Dynamic subtest pipe-A: SKIP (0.119s)
[560.822396] Starting dynamic subtest: pipe-B
[562.020273] Dynamic subtest pipe-B: SKIP (1.190s)
[562.031115] Starting dynamic subtest: pipe-C
[563.249371] Dynamic subtest pipe-C: SUCCESS (1.212s)
[563.260697] Starting dynamic subtest: pipe-D
[564.463279] Dynamic subtest pipe-D: SUCCESS (1.194s)
[564.465733] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.718s)
[565.664977] [131/133] (484s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[567.603596] Starting subtest: dpms-mode-unset-non-lpsp
[568.771592] Subtest dpms-mode-unset-non-lpsp: SKIP (1.159s)
[569.170865] [132/133] (480s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[569.263623] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[569.267908] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[569.338689] [133/133] (480s left) gem_exec_schedule (u-fairslice)
[569.410725] Starting subtest: u-fairslice
[569.412713] Starting dynamic subtest: rcs0
[571.430625] Dynamic subtest rcs0: SUCCESS (2.010s)
[571.442226] Starting dynamic subtest: bcs0
[573.446934] Dynamic subtest bcs0: SUCCESS (2.006s)
[573.458569] Starting dynamic subtest: vcs0
[575.468614] Dynamic subtest vcs0: SUCCESS (2.011s)
[575.479941] Starting dynamic subtest: vcs1
[577.488915] Dynamic subtest vcs1: SUCCESS (2.012s)
[577.500754] Starting dynamic subtest: vecs0
[579.507438] Dynamic subtest vecs0: SUCCESS (2.013s)
[579.518660] Starting dynamic subtest: ccs0
[581.525783] Dynamic subtest ccs0: SUCCESS (2.014s)
[581.528240] Subtest u-fairslice: SUCCESS (12.071s)
[581.830972] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_fenced_exec_thrash
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: gem_workarounds
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_hdmi_inject
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: i915_pm_rps
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: gem_create
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: sysfs_preempt_timeout
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: fbdev
results: parsing output: 35/ for test: gem_ctx_param
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: kms_prop_blob
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: i915_suspend
results: parsing output: 42/ for test: kms_draw_crc
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_pipe_stress
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_tiled_display
results: parsing output: 54/ for test: gem_pxp
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_ctx_shared
results: parsing output: 57/ for test: gem_caching
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_vrr
results: parsing output: 61/ for test: prime_mmap_kms
results: parsing output: 62/ for test: kms_content_protection
results: parsing output: 63/ for test: api_intel_allocator
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: gem_userptr_blits
results: parsing output: 76/ for test: gem_exec_capture
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: device_reset
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_lease
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: gem_exec_store
results: parsing output: 87/ for test: gem_ppgtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_busy
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: syncobj_eventfd
results: parsing output: 100/ for test: api_intel_bb
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: prime_self_import
results: parsing output: 112/ for test: gem_ctx_sseu
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_color
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gen9_exec_parse
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_flip_scaled_crc
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_pm_rpm
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: gem_exec_schedule
Done.