[108.272659] Initializing watchdogs
[108.272723]   /dev/watchdog0
[108.291028] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[108.300742] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[108.304311] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[108.306811] [001/130] (960s left) api_intel_bb (misplaced-blitter)
[108.452977] Starting subtest: misplaced-blitter
[108.482705] Subtest misplaced-blitter: SUCCESS (0.030s)
[108.601813] [002/130] (960s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[108.812703] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[108.856775] [003/130] (960s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[109.061561] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[109.063320] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[109.182341] [004/130] (959s left) prime_mmap (test_reprime)
[109.255317] Starting subtest: test_reprime
[109.256259] Starting dynamic subtest: test_reprime-smem
[109.306581] Dynamic subtest test_reprime-smem: SUCCESS (0.051s)
[109.313494] Starting dynamic subtest: test_reprime-lmem0
[109.518964] Dynamic subtest test_reprime-lmem0: SUCCESS (0.202s)
[109.520200] Subtest test_reprime: SUCCESS (0.253s)
[109.616717] [005/130] (959s left) kms_plane_alpha_blend (alpha-opaque-fb)
[109.816167] Starting subtest: alpha-opaque-fb
[110.053368] Starting dynamic subtest: pipe-A-DP-3
[110.566136] Dynamic subtest pipe-A-DP-3: SUCCESS (0.512s)
[110.574896] Starting dynamic subtest: pipe-D-DP-3
[111.148483] Dynamic subtest pipe-D-DP-3: SUCCESS (0.581s)
[111.149358] Subtest alpha-opaque-fb: SUCCESS (1.332s)
[111.420094] [006/130] (957s left) kms_flip (2x-flip-vs-modeset)
[111.621962] Starting subtest: 2x-flip-vs-modeset
[111.636347] Subtest 2x-flip-vs-modeset: SKIP (0.014s)
[111.731957] [007/130] (957s left) drm_fdinfo (virtual-busy-idle-all)
[111.799460] Starting subtest: virtual-busy-idle-all
[111.801731] Subtest virtual-busy-idle-all: SKIP (0.000s)
[111.905550] [008/130] (957s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[112.104527] Starting subtest: basic-busy-flip-before-cursor-legacy
[112.106315] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[112.197427] [009/130] (957s left) gem_exec_fence (syncobj-unused-fence)
[112.773180] Starting subtest: syncobj-unused-fence
[112.798652] Subtest syncobj-unused-fence: SUCCESS (0.025s)
[113.228510] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[113.230522] [010/130] (956s left) perf (invalid-oa-format-id)
[113.565154] Starting subtest: invalid-oa-format-id
[113.582687] Subtest invalid-oa-format-id: SUCCESS (0.017s)
[113.635816] [011/130] (955s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[113.845171] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[113.846177] Starting dynamic subtest: pipe-A-DP-3
[113.849634] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[113.857167] Starting dynamic subtest: pipe-B-DP-3
[113.860639] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[113.867988] Starting dynamic subtest: pipe-C-DP-3
[113.871407] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[113.878671] Starting dynamic subtest: pipe-D-DP-3
[113.882149] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[113.883919] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[114.293173] [012/130] (955s left) dmabuf_sync_file (export-multiwait)
[114.358299] Starting subtest: export-multiwait
[114.359225] Subtest export-multiwait: SUCCESS (0.000s)
[114.449383] [013/130] (954s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[114.659191] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[114.660059] Starting dynamic subtest: pipe-A
[116.258270] Dynamic subtest pipe-A: SUCCESS (1.598s)
[116.278211] Starting dynamic subtest: pipe-B
[117.976863] Dynamic subtest pipe-B: SUCCESS (1.718s)
[117.994079] Starting dynamic subtest: pipe-C
[118.295588] Dynamic subtest pipe-C: SUCCESS (0.318s)
[118.310431] Starting dynamic subtest: pipe-D
[118.615093] Dynamic subtest pipe-D: SUCCESS (0.319s)
[118.616448] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (3.955s)
[118.951395] [014/130] (950s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[119.168954] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[120.217670] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.049s)
[120.405298] [015/130] (949s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[120.616745] Starting subtest: yf-tiled-32bpp-rotate-270
[120.618470] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[120.766217] [016/130] (948s left) kms_feature_discovery (display-3x)
[120.971233] Starting subtest: display-3x
[120.973161] Subtest display-3x: SKIP (0.000s)
[121.069405] [017/130] (948s left) gem_userptr_blits (create-destroy-unsync)
[121.157926] Subtest create-destroy-unsync: SKIP (0.000s)
[121.349415] [018/130] (948s left) kms_frontbuffer_tracking (psr-1p-rte)
[121.575588] Starting subtest: psr-1p-rte
[121.577282] Subtest psr-1p-rte: SKIP (0.000s)
[121.767714] [019/130] (948s left) kms_dsc (dsc-fractional-bpp)
[121.974333] Starting subtest: dsc-fractional-bpp
[121.979551] Subtest dsc-fractional-bpp: SKIP (0.001s)
[122.065552] [020/130] (947s left) gem_fence_thrash (bo-write-verify-y)
[122.115224] Starting subtest: bo-write-verify-y
[122.143895] Subtest bo-write-verify-y: SKIP (0.028s)
[122.242622] [021/130] (947s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[122.456427] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[122.458154] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[122.586345] [022/130] (947s left) gem_userptr_blits (unsync-unmap-cycles)
[122.674915] Subtest unsync-unmap-cycles: SKIP (0.000s)
[122.870788] [023/130] (947s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[123.092231] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[123.093182] Starting dynamic subtest: pipe-A-DP-3
[123.101986] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[123.109991] Starting dynamic subtest: pipe-B-DP-3
[123.118926] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[123.126669] Starting dynamic subtest: pipe-C-DP-3
[123.135285] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[123.142901] Starting dynamic subtest: pipe-D-DP-3
[123.153354] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[123.155356] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s)
[123.539327] [024/130] (946s left) gem_lmem_swapping (random-engines)
[126.472673] Starting subtest: random-engines
[126.476514] Starting dynamic subtest: lmem0
[127.249473] Dynamic subtest lmem0: SUCCESS (0.777s)
[127.250651] Subtest random-engines: SUCCESS (0.777s)
[128.481360] [FACT gem_lmem_swapping (random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[128.482406] [FACT gem_lmem_swapping (random-engines)] deleted: kernel.kmod_is_loaded.i915: true
[128.484113] [025/130] (941s left) perf (enable-disable)
[130.220720] Starting subtest: enable-disable
[130.221537] Starting dynamic subtest: 0-rcs0
[132.491518] Dynamic subtest 0-rcs0: SUCCESS (2.270s)
[132.492439] Subtest enable-disable: SUCCESS (2.271s)
[132.533670] [FACT perf (enable-disable)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[132.537531] [FACT perf (enable-disable)] new: kernel.kmod_is_loaded.i915: true
[132.540275] [026/130] (937s left) gem_tiled_wc
[132.696709] [027/130] (937s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[132.774623] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[132.882257] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[133.022079] [028/130] (937s left) gem_ctx_isolation (dirty-create)
[133.112510] Starting subtest: dirty-create
[133.113469] Starting dynamic subtest: rcs0
[133.676587] Dynamic subtest rcs0: SUCCESS (0.564s)
[133.685294] Starting dynamic subtest: bcs0
[134.297960] Dynamic subtest bcs0: SUCCESS (0.621s)
[134.306053] Starting dynamic subtest: vcs0
[134.927331] Dynamic subtest vcs0: SUCCESS (0.629s)
[134.935434] Starting dynamic subtest: vcs1
[135.551067] Dynamic subtest vcs1: SUCCESS (0.617s)
[135.559388] Starting dynamic subtest: vecs0
[136.168704] Dynamic subtest vecs0: SUCCESS (0.624s)
[136.176984] Starting dynamic subtest: vecs1
[136.795785] Dynamic subtest vecs1: SUCCESS (0.627s)
[136.803924] Starting dynamic subtest: ccs0
[137.425333] Dynamic subtest ccs0: SUCCESS (0.629s)
[137.426410] Subtest dirty-create: SUCCESS (4.313s)
[137.697497] [029/130] (932s left) kms_vblank (query-forked-busy)
[137.911245] Starting subtest: query-forked-busy
[137.913254] Starting dynamic subtest: pipe-A-DP-3
[140.462358] Dynamic subtest pipe-A-DP-3: SUCCESS (2.546s)
[140.499484] Starting dynamic subtest: pipe-D-DP-3
[142.981585] Dynamic subtest pipe-D-DP-3: SUCCESS (2.510s)
[142.983222] Subtest query-forked-busy: SUCCESS (5.070s)
[143.284516] [030/130] (927s left) syncobj_timeline (single-wait-all-signaled)
[143.369783] Starting subtest: single-wait-all-signaled
[143.370758] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[143.528396] [031/130] (927s left) kms_color (legacy-gamma-reset)
[143.736221] Starting subtest: legacy-gamma-reset
[143.737171] Starting dynamic subtest: pipe-A-DP-3
[143.969548] Dynamic subtest pipe-A-DP-3: SUCCESS (0.233s)
[143.979222] Starting dynamic subtest: pipe-B-DP-3
[143.989549] Dynamic subtest pipe-B-DP-3: SUCCESS (0.020s)
[143.997609] Starting dynamic subtest: pipe-C-DP-3
[144.007808] Dynamic subtest pipe-C-DP-3: SUCCESS (0.018s)
[144.015977] Starting dynamic subtest: pipe-D-DP-3
[144.027445] Dynamic subtest pipe-D-DP-3: SUCCESS (0.018s)
[144.028299] Subtest legacy-gamma-reset: SUCCESS (0.290s)
[144.244737] [032/130] (926s left) kms_busy (extended-pageflip-hang-oldfb)
[144.460244] Starting subtest: extended-pageflip-hang-oldfb
[144.462243] Starting dynamic subtest: pipe-A
[144.700531] Dynamic subtest pipe-A: SUCCESS (0.237s)
[144.724287] Starting dynamic subtest: pipe-D
[144.954913] Dynamic subtest pipe-D: SUCCESS (0.247s)
[144.955982] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.496s)
[145.245659] [033/130] (925s left) kms_vrr (flip-basic-fastset)
[145.454442] Starting subtest: flip-basic-fastset
[145.457127] Subtest flip-basic-fastset: SKIP (0.000s)
[145.562732] [034/130] (925s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[145.642171] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[145.715540] [035/130] (925s left) kms_addfb_basic (unused-pitches)
[145.794187] Starting subtest: unused-pitches
[145.795157] Subtest unused-pitches: SUCCESS (0.000s)
[146.059816] [036/130] (924s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[146.349356] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[146.497611] [037/130] (924s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[146.715266] Starting subtest: 2x-absolute-wf_vblank-interruptible
[146.730589] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.014s)
[146.826558] [038/130] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[147.036903] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[147.038566] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[147.190698] [039/130] (923s left) kms_content_protection (lic-type-0)
[147.460356] Starting subtest: lic-type-0
[147.495050] Starting dynamic subtest: pipe-A-DP-3
[270.448559] Dynamic subtest pipe-A-DP-3: FAIL (122.781s)
[270.449599] Subtest lic-type-0: FAIL (122.910s)
[270.637573] [040/130] (800s left) kms_psr (psr2-sprite-blt)
[270.845176] Subtest psr2-sprite-blt: SKIP (0.000s)
[270.897480] [041/130] (800s left) gem_exec_flush (basic-batch-kernel-default-uc)
[270.988444] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[271.089150] [042/130] (800s left) kms_selftest (drm_format_helper)
[271.141303] Starting subtest: drm_format_helper
[271.165450] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[271.295520] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.131s)
[271.304337] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[271.394759] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.097s)
[271.429994] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[271.524274] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.128s)
[271.560442] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[271.634048] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.106s)
[271.670695] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[271.745406] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.107s)
[271.776887] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[271.855402] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.107s)
[271.888802] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[271.972391] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.115s)
[272.006584] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[272.089182] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.115s)
[272.123869] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[272.175507] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.084s)
[272.208605] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[272.269084] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.090s)
[272.302188] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[272.372252] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.102s)
[272.407055] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[272.488193] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.113s)
[272.523315] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[272.615342] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.125s)
[272.650500] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[272.730307] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.111s)
[272.761440] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[272.816961] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.084s)
[272.849193] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[272.936656] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.118s)
[272.967371] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[273.042790] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.104s)
[273.062558] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[273.162683] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.118s)
[273.163826] Subtest drm_format_helper: SUCCESS (2.021s)
[273.407993] [043/130] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[273.621888] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[273.623581] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[273.733571] [044/130] (797s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[274.080512] Starting subtest: cursor-rapid-movement-128x128
[274.084971] Starting dynamic subtest: pipe-A-DP-3
[274.518246] Dynamic subtest pipe-A-DP-3: SUCCESS (0.433s)
[274.561173] Starting dynamic subtest: pipe-D-DP-3
[274.927537] Dynamic subtest pipe-D-DP-3: SUCCESS (0.374s)
[274.928525] Subtest cursor-rapid-movement-128x128: SUCCESS (0.847s)
[275.375853] [045/130] (796s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[275.587475] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[275.588406] Starting dynamic subtest: pipe-A-valid-mode
[277.430834] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.840s)
[277.432768] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (1.842s)
[277.691420] [046/130] (793s left) gem_spin_batch (legacy-resubmit)
[277.784281] Starting subtest: legacy-resubmit
[277.785287] Starting dynamic subtest: default
[277.809657] Dynamic subtest default: SUCCESS (0.025s)
[277.818741] Starting dynamic subtest: render
[277.819605] Dynamic subtest render: SUCCESS (0.001s)
[277.828840] Starting dynamic subtest: bsd
[277.830085] Dynamic subtest bsd: SUCCESS (0.002s)
[277.838853] Starting dynamic subtest: bsd1
[277.840169] Dynamic subtest bsd1: SUCCESS (0.001s)
[277.848978] Starting dynamic subtest: bsd2
[277.850146] Dynamic subtest bsd2: SUCCESS (0.002s)
[277.858446] Starting dynamic subtest: blt
[277.859479] Dynamic subtest blt: SUCCESS (0.002s)
[277.867839] Starting dynamic subtest: vebox
[277.869062] Dynamic subtest vebox: SUCCESS (0.002s)
[277.870339] Subtest legacy-resubmit: SUCCESS (0.040s)
[278.113948] [047/130] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[278.332999] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[278.334735] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[278.502696] [048/130] (793s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[278.719820] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[278.767938] [049/130] (793s left) syncobj_basic (bad-fd-to-handle)
[278.851334] Starting subtest: bad-fd-to-handle
[278.852244] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[278.999944] [050/130] (792s left) gem_ctx_shared (q-smoketest)
[279.095765] Starting subtest: Q-smoketest
[279.096673] Starting dynamic subtest: rcs0
[284.556526] Dynamic subtest rcs0: SUCCESS (5.455s)
[284.565130] Starting dynamic subtest: bcs0
[289.984540] Dynamic subtest bcs0: SUCCESS (5.427s)
[289.993955] Starting dynamic subtest: vcs0
[295.409878] Dynamic subtest vcs0: SUCCESS (5.424s)
[295.419270] Starting dynamic subtest: vcs1
[300.840333] Dynamic subtest vcs1: SUCCESS (5.430s)
[300.849180] Starting dynamic subtest: vecs0
[306.262924] Dynamic subtest vecs0: SUCCESS (5.421s)
[306.272129] Starting dynamic subtest: vecs1
[311.681182] Dynamic subtest vecs1: SUCCESS (5.418s)
[311.690066] Starting dynamic subtest: ccs0
[317.103265] Dynamic subtest ccs0: SUCCESS (5.421s)
[317.104134] Subtest Q-smoketest: SUCCESS (38.001s)
[317.424848] [051/130] (754s left) gem_eio (wait-10ms)
[317.753265] Starting subtest: wait-10ms
[318.379509] Subtest wait-10ms: SUCCESS (0.626s)
[318.628407] [052/130] (753s left) gem_mmap_wc (fault-concurrent)
[318.710439] Subtest fault-concurrent: SKIP (0.000s)
[318.809040] [053/130] (753s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[319.022431] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[319.026950] Starting dynamic subtest: A-DP3
[319.968039] Dynamic subtest A-DP3: SUCCESS (0.941s)
[319.979241] Starting dynamic subtest: B-DP3
[320.677276] Dynamic subtest B-DP3: SUCCESS (0.708s)
[320.686445] Starting dynamic subtest: C-DP3
[321.390602] Dynamic subtest C-DP3: SUCCESS (0.712s)
[321.400072] Starting dynamic subtest: D-DP3
[322.100786] Dynamic subtest D-DP3: SUCCESS (0.709s)
[322.102936] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (3.079s)
[322.394015] [054/130] (749s left) gem_exec_schedule (preempt-queue-contexts-chain)
[322.489522] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[322.815940] [055/130] (749s left) kms_addfb_basic (addfb25-4-tiled)
[323.035126] Starting subtest: addfb25-4-tiled
[323.036064] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[323.163478] [056/130] (749s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[323.380558] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[323.395580] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s)
[323.502342] [057/130] (748s left) gem_ccs (ctrl-surf-copy-new-ctx)
[323.595166] Starting subtest: ctrl-surf-copy-new-ctx
[323.596146] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[323.646323] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (0.050s)
[323.655633] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[323.872121] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.221s)
[323.881501] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[323.894445] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[323.905849] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[324.115558] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s)
[324.124723] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[324.141937] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[324.151215] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[324.363207] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.220s)
[324.372548] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[324.389431] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (0.025s)
[324.400285] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[324.608248] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (0.217s)
[324.609218] Subtest ctrl-surf-copy-new-ctx: SUCCESS (1.013s)
[324.778502] [058/130] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[324.987902] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[324.989593] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[325.109991] [059/130] (747s left) kms_rmfb (rmfb-ioctl)
[325.317457] Starting subtest: rmfb-ioctl
[325.319662] Starting dynamic subtest: pipe-A-DP-3
[325.463706] Dynamic subtest pipe-A-DP-3: SUCCESS (0.145s)
[325.481040] Starting dynamic subtest: pipe-B-DP-3
[325.733538] Dynamic subtest pipe-B-DP-3: SUCCESS (0.268s)
[325.746368] Starting dynamic subtest: pipe-C-DP-3
[326.005214] Dynamic subtest pipe-C-DP-3: SUCCESS (0.270s)
[326.015682] Starting dynamic subtest: pipe-D-DP-3
[326.259330] Dynamic subtest pipe-D-DP-3: SUCCESS (0.252s)
[326.260287] Subtest rmfb-ioctl: SUCCESS (0.942s)
[326.581719] [060/130] (746s left) kms_async_flips (async-flip-suspend-resume)
[326.791637] Starting subtest: async-flip-suspend-resume
[327.025700] Starting dynamic subtest: pipe-A-DP-3
[347.634969] Dynamic subtest pipe-A-DP-3: SUCCESS (5.120s)
[347.858234] Starting dynamic subtest: pipe-B-DP-3
[349.950414] Dynamic subtest pipe-B-DP-3: SUCCESS (2.104s)
[350.162411] Starting dynamic subtest: pipe-C-DP-3
[352.259229] Dynamic subtest pipe-C-DP-3: SUCCESS (2.108s)
[352.432992] Starting dynamic subtest: pipe-D-DP-3
[354.526265] Dynamic subtest pipe-D-DP-3: SUCCESS (2.103s)
[354.527141] Subtest async-flip-suspend-resume: SUCCESS (12.247s)
[354.947892] [061/130] (733s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[355.170773] Starting subtest: x-tiled-16bpp-rotate-0
[356.776291] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.605s)
[356.946120] [062/130] (731s left) kms_lease (atomic-implicit-crtc)
[357.159704] Starting subtest: atomic-implicit-crtc
[357.162142] Starting dynamic subtest: pipe-A-DP-3
[357.166682] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[357.178552] Starting dynamic subtest: pipe-B-DP-3
[357.182842] Dynamic subtest pipe-B-DP-3: SUCCESS (0.009s)
[357.194224] Starting dynamic subtest: pipe-C-DP-3
[357.198574] Dynamic subtest pipe-C-DP-3: SUCCESS (0.009s)
[357.210437] Starting dynamic subtest: pipe-D-DP-3
[357.215551] Dynamic subtest pipe-D-DP-3: SUCCESS (0.009s)
[357.216433] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[357.350593] [063/130] (730s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[357.433414] Starting subtest: etime-multi-wait-all-submitted-signaled
[357.536423] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[357.678168] [064/130] (730s left) api_intel_allocator (simple-allocator)
[357.757584] Starting subtest: simple-allocator
[357.758501] Starting dynamic subtest: basic
[357.783388] Dynamic subtest basic: SUCCESS (0.025s)
[357.795103] Starting dynamic subtest: parallel-one
[357.981308] Dynamic subtest parallel-one: SUCCESS (0.184s)
[357.992904] Starting dynamic subtest: print
[357.993831] Dynamic subtest print: SUCCESS (0.000s)
[358.005132] Starting dynamic subtest: reuse
[358.006245] Dynamic subtest reuse: SUCCESS (0.000s)
[358.016969] Starting dynamic subtest: reserve
[358.018143] Dynamic subtest reserve: SUCCESS (0.000s)
[358.029101] Starting dynamic subtest: fork-reopen-allocator
[358.030417] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[358.032104] Subtest simple-allocator: SUCCESS (0.231s)
[358.141242] [065/130] (730s left) i915_hangman (gt-engine-error)
[358.233505] Starting subtest: gt-engine-error
[358.234427] Starting dynamic subtest: rcs0
[359.088843] Dynamic subtest rcs0: SUCCESS (0.855s)
[359.109373] Starting dynamic subtest: bcs0
[359.889536] Dynamic subtest bcs0: SUCCESS (0.799s)
[359.901012] Starting dynamic subtest: vcs0
[360.634561] Dynamic subtest vcs0: SUCCESS (0.744s)
[360.646449] Starting dynamic subtest: vcs1
[361.433452] Dynamic subtest vcs1: SUCCESS (0.798s)
[361.446599] Starting dynamic subtest: vecs0
[362.181590] Dynamic subtest vecs0: SUCCESS (0.747s)
[362.193390] Starting dynamic subtest: vecs1
[362.909276] Dynamic subtest vecs1: SUCCESS (0.727s)
[362.921098] Starting dynamic subtest: ccs0
[363.757132] Dynamic subtest ccs0: SUCCESS (0.847s)
[363.758395] Subtest gt-engine-error: SUCCESS (5.524s)
[363.909131] [066/130] (724s left) gem_exec_whisper (basic-contexts-forked-all)
[364.002905] Starting subtest: basic-contexts-forked-all
[386.321645] Subtest basic-contexts-forked-all: SUCCESS (22.316s)
[386.570166] [067/130] (701s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[386.780761] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[386.782601] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[387.065766] [068/130] (701s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[389.524504] Starting subtest: modeset-non-lpsp-stress-no-wait
[393.109348] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.584s)
[393.390990] [069/130] (695s left) kms_plane (plane-panning-bottom-right)
[393.600721] Starting subtest: plane-panning-bottom-right
[393.603100] Starting dynamic subtest: pipe-A
[394.353385] Dynamic subtest pipe-A: SUCCESS (0.750s)
[394.372748] Starting dynamic subtest: pipe-B
[395.009169] Dynamic subtest pipe-B: SUCCESS (0.653s)
[395.010258] Subtest plane-panning-bottom-right: SUCCESS (1.408s)
[395.278268] [070/130] (693s left) gem_exec_params (rs-invalid)
[395.368365] Starting subtest: rs-invalid
[395.370829] Subtest rs-invalid: SUCCESS (0.002s)
[395.550441] [071/130] (693s left) gem_userptr_blits (invalid-null-pointer)
[395.640441] Starting subtest: invalid-null-pointer
[395.641324] Subtest invalid-null-pointer: SUCCESS (0.001s)
[395.855760] [072/130] (693s left) gem_render_linear_blits (basic)
[395.945969] Starting subtest: basic
[396.018320] Subtest basic: SUCCESS (0.072s)
[396.110130] [073/130] (692s left) kms_psr (fbc-psr-cursor-plane-move)
[396.318358] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[396.375757] [074/130] (692s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[396.591683] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[396.606650] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s)
[396.701593] [075/130] (692s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[396.923516] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[397.516691] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.592s)
[397.771240] [076/130] (691s left) perf_pmu (semaphore-busy)
[397.843708] Starting subtest: semaphore-busy
[397.844612] Starting dynamic subtest: rcs0
[399.521383] Dynamic subtest rcs0: SUCCESS (1.674s)
[399.536701] Starting dynamic subtest: bcs0
[401.150600] Dynamic subtest bcs0: SUCCESS (1.624s)
[401.167842] Starting dynamic subtest: vcs0
[402.784915] Dynamic subtest vcs0: SUCCESS (1.630s)
[402.806058] Starting dynamic subtest: vcs1
[404.424487] Dynamic subtest vcs1: SUCCESS (1.635s)
[404.439878] Starting dynamic subtest: vecs0
[406.060311] Dynamic subtest vecs0: SUCCESS (1.631s)
[406.075449] Starting dynamic subtest: vecs1
[407.699430] Dynamic subtest vecs1: SUCCESS (1.635s)
[407.714341] Starting dynamic subtest: ccs0
[409.335298] Dynamic subtest ccs0: SUCCESS (1.631s)
[409.336987] Subtest semaphore-busy: SUCCESS (11.491s)
[409.503313] [077/130] (679s left) syncobj_timeline (wait-all-delayed-signal)
[409.584792] Starting subtest: wait-all-delayed-signal
[409.687909] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[409.789595] [078/130] (679s left) perf (invalid-open-flags)
[409.987641] Starting subtest: invalid-open-flags
[409.988602] Subtest invalid-open-flags: SUCCESS (0.000s)
[410.047023] [079/130] (679s left) kms_psr (fbc-pr-dpms)
[410.255522] Subtest fbc-pr-dpms: SKIP (0.000s)
[410.310911] [080/130] (679s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[410.519809] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[410.522135] Starting dynamic subtest: pipe-A-valid-mode
[410.592581] Dynamic subtest pipe-A-valid-mode: SKIP (0.070s)
[410.594394] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.071s)
[410.811909] [081/130] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[411.024090] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[411.025866] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[411.182377] [082/130] (678s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[411.392120] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[411.394128] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[411.547261] [083/130] (678s left) gem_wait (write-wait)
[411.640652] Starting subtest: write-wait
[411.641589] Starting dynamic subtest: all-engines
[412.768536] Dynamic subtest all-engines: SUCCESS (1.127s)
[412.784442] Starting dynamic subtest: rcs0
[413.832572] Dynamic subtest rcs0: SUCCESS (1.063s)
[413.849518] Starting dynamic subtest: bcs0
[414.893738] Dynamic subtest bcs0: SUCCESS (1.060s)
[414.911425] Starting dynamic subtest: vcs0
[415.955058] Dynamic subtest vcs0: SUCCESS (1.059s)
[415.974755] Starting dynamic subtest: vcs1
[417.018026] Dynamic subtest vcs1: SUCCESS (1.058s)
[417.037714] Starting dynamic subtest: vecs0
[418.082767] Dynamic subtest vecs0: SUCCESS (1.060s)
[418.127614] Starting dynamic subtest: vecs1
[419.156059] Dynamic subtest vecs1: SUCCESS (1.068s)
[419.205160] Starting dynamic subtest: ccs0
[420.228057] Dynamic subtest ccs0: SUCCESS (1.067s)
[420.234466] Subtest write-wait: SUCCESS (8.588s)
[420.500467] [084/130] (669s left) kms_pm_rpm (pm-tiling)
[422.534007] Starting subtest: pm-tiling
[422.536586] Subtest pm-tiling: SKIP (0.000s)
[422.920662] [085/130] (666s left) gem_mmap_gtt (basic-write)
[423.004504] Subtest basic-write: SKIP (0.000s)
[423.085580] [086/130] (666s left) gem_ctx_param (root-set)
[423.163907] Starting subtest: root-set
[423.166350] Subtest root-set: SUCCESS (0.001s)
[423.343220] [087/130] (666s left) gem_ctx_create (basic)
[423.433653] Starting subtest: basic
[423.434784] Subtest basic: SUCCESS (0.000s)
[423.677208] [088/130] (666s left) prime_vgem (basic-read)
[423.771335] Starting subtest: basic-read
[423.777530] Subtest basic-read: SKIP (0.005s)
[423.952355] [089/130] (666s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[424.173712] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[424.175469] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[424.312063] [090/130] (665s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[424.525702] Starting subtest: cursorA-vs-flipA-toggle
[435.441079] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.916s)
[435.711936] [091/130] (654s left) i915_pm_rps (waitboost)
[435.803759] Starting subtest: waitboost
[438.384153] Subtest waitboost: SUCCESS (2.580s)
[438.522800] [092/130] (651s left) kms_psr (pr-no-drrs)
[438.734158] Subtest pr-no-drrs: SKIP (0.000s)
[438.797338] [093/130] (651s left) perf (create-destroy-userspace-config)
[438.988974] Starting subtest: create-destroy-userspace-config
[439.017831] Subtest create-destroy-userspace-config: SUCCESS (0.028s)
[439.083567] [094/130] (651s left) kms_cursor_crc (cursor-random-128x42)
[439.445681] Starting subtest: cursor-random-128x42
[439.450507] Starting dynamic subtest: pipe-A-DP-3
[443.803951] Dynamic subtest pipe-A-DP-3: SUCCESS (4.352s)
[443.855682] Starting dynamic subtest: pipe-D-DP-3
[448.171476] Dynamic subtest pipe-D-DP-3: SUCCESS (4.327s)
[448.172499] Subtest cursor-random-128x42: SUCCESS (8.725s)
[448.577847] [095/130] (641s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[448.794310] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[448.796155] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[448.920557] [096/130] (641s left) kms_hdr (static-toggle-dpms)
[449.133718] Starting subtest: static-toggle-dpms
[452.461560] Starting dynamic subtest: pipe-A-DP-3
[453.766226] Dynamic subtest pipe-A-DP-3: SUCCESS (1.304s)
[453.767600] Subtest static-toggle-dpms: SUCCESS (4.634s)
[454.115254] [097/130] (636s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[454.331214] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[454.332931] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[454.462566] [098/130] (636s left) gem_pxp (reject-modify-context-protection-off-1)
[457.065756] Starting subtest: reject-modify-context-protection-off-1
[457.067813] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[457.165988] [099/130] (633s left) gem_ctx_persistence (smoketest)
[457.258814] Starting subtest: smoketest
[495.957581] Subtest smoketest: SUCCESS (38.699s)
[496.106160] [100/130] (594s left) perf_pmu (busy-no-semaphores)
[496.179529] Starting subtest: busy-no-semaphores
[496.180550] Starting dynamic subtest: rcs0
[496.767004] Dynamic subtest rcs0: SUCCESS (0.586s)
[496.783425] Starting dynamic subtest: bcs0
[497.317959] Dynamic subtest bcs0: SUCCESS (0.546s)
[497.339019] Starting dynamic subtest: vcs0
[497.868203] Dynamic subtest vcs0: SUCCESS (0.546s)
[497.884420] Starting dynamic subtest: vcs1
[498.419215] Dynamic subtest vcs1: SUCCESS (0.546s)
[498.440170] Starting dynamic subtest: vecs0
[498.971160] Dynamic subtest vecs0: SUCCESS (0.547s)
[498.987315] Starting dynamic subtest: vecs1
[499.522603] Dynamic subtest vecs1: SUCCESS (0.547s)
[499.543838] Starting dynamic subtest: ccs0
[500.074532] Dynamic subtest ccs0: SUCCESS (0.547s)
[500.076590] Subtest busy-no-semaphores: SUCCESS (3.896s)
[500.246016] [101/130] (590s left) prime_vgem (fence-write-hang)
[500.354774] Subtest fence-write-hang: SKIP (0.000s)
[500.504764] [102/130] (590s left) i915_hangman (detector)
[500.601436] Starting subtest: detector
[500.602362] Starting dynamic subtest: rcs0
[510.750524] Dynamic subtest rcs0: SUCCESS (10.149s)
[510.764594] Starting dynamic subtest: bcs0
[520.698495] Dynamic subtest bcs0: SUCCESS (9.947s)
[520.714419] Starting dynamic subtest: vcs0
[530.700960] Dynamic subtest vcs0: SUCCESS (10.001s)
[530.714321] Starting dynamic subtest: vcs1
[540.764847] Dynamic subtest vcs1: SUCCESS (10.062s)
[540.781034] Starting dynamic subtest: vecs0
[550.727214] Dynamic subtest vecs0: SUCCESS (9.962s)
[550.741948] Starting dynamic subtest: vecs1
[560.751056] Dynamic subtest vecs1: SUCCESS (10.022s)
[560.784471] Starting dynamic subtest: ccs0
[570.682559] Dynamic subtest ccs0: SUCCESS (9.930s)
[570.683498] Subtest detector: SUCCESS (70.082s)
[570.832907] [103/130] (520s left) core_getstats
[571.086713] [104/130] (519s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[571.303745] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[571.304664] Starting dynamic subtest: pipe-A
[571.410582] Dynamic subtest pipe-A: SUCCESS (0.106s)
[571.431974] Starting dynamic subtest: pipe-B
[571.629645] Dynamic subtest pipe-B: SUCCESS (0.218s)
[571.643335] Starting dynamic subtest: pipe-C
[571.833643] Dynamic subtest pipe-C: SUCCESS (0.203s)
[571.857580] Starting dynamic subtest: pipe-D
[572.053761] Dynamic subtest pipe-D: SUCCESS (0.218s)
[572.054778] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.751s)
[572.377292] [105/130] (518s left) kms_atomic_transition (modeset-transition-fencing)
[572.588920] Starting subtest: modeset-transition-fencing
[572.589796] Starting dynamic subtest: 1x-outputs
[575.228289] Dynamic subtest 1x-outputs: SUCCESS (2.637s)
[575.282758] Subtest modeset-transition-fencing: SUCCESS (2.693s)
[575.537890] [106/130] (515s left) kms_flip (flip-vs-absolute-wf_vblank)
[575.746311] Starting subtest: flip-vs-absolute-wf_vblank
[575.750635] Starting dynamic subtest: A-DP3
[583.890050] Dynamic subtest A-DP3: SUCCESS (8.139s)
[583.906708] Starting dynamic subtest: B-DP3
[591.935133] Dynamic subtest B-DP3: SUCCESS (8.043s)
[591.950960] Starting dynamic subtest: C-DP3
[599.973007] Dynamic subtest C-DP3: SUCCESS (8.036s)
[599.988304] Starting dynamic subtest: D-DP3
[608.009006] Dynamic subtest D-DP3: SUCCESS (8.034s)
[608.011360] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.263s)
[608.324427] [107/130] (483s left) gem_ctx_persistence (heartbeat-stop)
[608.413005] Starting subtest: heartbeat-stop
[608.415242] Subtest heartbeat-stop: SKIP (0.000s)
[608.571397] [108/130] (482s left) gem_tiled_blits (normal)
[608.653617] Subtest normal: SKIP (0.000s)
[608.778789] [109/130] (482s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[608.989260] Starting subtest: fbcpsr-suspend
[608.991105] Subtest fbcpsr-suspend: SKIP (0.000s)
[609.145211] [110/130] (482s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[609.369471] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[609.371309] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[609.498565] [111/130] (482s left) kms_psr (psr2-sprite-plane-onoff)
[609.706374] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[609.775998] [112/130] (481s left) gem_exec_params (invalid-ring)
[609.861778] Starting subtest: invalid-ring
[609.862706] Subtest invalid-ring: SUCCESS (0.000s)
[610.015392] [113/130] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[610.226185] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[610.227962] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[610.426513] [114/130] (481s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[610.707181] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[610.864545] [115/130] (481s left) sw_sync (sync_random_merge)
[610.914922] Starting subtest: sync_random_merge
[610.972696] Subtest sync_random_merge: SUCCESS (0.058s)
[611.054305] [116/130] (480s left) gem_exec_balancer (fairslice)
[611.145878] Starting subtest: fairslice
[616.491355] Subtest fairslice: SUCCESS (5.345s)
[616.913206] [117/130] (475s left) gem_exec_schedule (u-fairslice)
[617.012495] Starting subtest: u-fairslice
[617.013431] Starting dynamic subtest: rcs0
[619.054584] Dynamic subtest rcs0: SUCCESS (2.040s)
[619.068253] Starting dynamic subtest: bcs0
[621.070714] Dynamic subtest bcs0: SUCCESS (2.016s)
[621.083864] Starting dynamic subtest: vcs0
[623.089623] Dynamic subtest vcs0: SUCCESS (2.018s)
[623.102802] Starting dynamic subtest: vcs1
[625.107119] Dynamic subtest vcs1: SUCCESS (2.015s)
[625.120529] Starting dynamic subtest: vecs0
[627.124762] Dynamic subtest vecs0: SUCCESS (2.018s)
[627.138234] Starting dynamic subtest: vecs1
[629.142411] Dynamic subtest vecs1: SUCCESS (2.016s)
[629.155768] Starting dynamic subtest: ccs0
[631.160576] Dynamic subtest ccs0: SUCCESS (2.018s)
[631.161466] Subtest u-fairslice: SUCCESS (14.147s)
[631.587358] [118/130] (460s left) gem_mmap_wc (write-prefaulted)
[631.666681] Subtest write-prefaulted: SKIP (0.000s)
[631.733351] [119/130] (460s left) sriov_basic (bind-unbind-vf)
[631.816610] Subtest bind-unbind-vf: SKIP (0.000s)
[631.901969] [120/130] (460s left) gem_softpin (allocator-basic)
[631.986936] Starting subtest: allocator-basic
[632.168100] Subtest allocator-basic: SUCCESS (0.181s)
[632.341129] [121/130] (459s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[632.544721] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[632.547033] Starting dynamic subtest: pipe-A-DP-3
[632.556614] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[632.569660] Starting dynamic subtest: pipe-B-DP-3
[632.579015] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[632.591495] Starting dynamic subtest: pipe-C-DP-3
[632.602359] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[632.615057] Starting dynamic subtest: pipe-D-DP-3
[632.626582] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[632.628729] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[632.999575] [122/130] (459s left) syncobj_timeline (invalid-signal-illegal-handle)
[633.081146] Starting subtest: invalid-signal-illegal-handle
[633.082106] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[633.235121] [123/130] (459s left) gem_render_copy (linear-to-vebox-yf-tiled)
[633.323680] Starting subtest: linear-to-vebox-yf-tiled
[633.325642] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[633.575319] [124/130] (458s left) gem_mmap_gtt (big-copy)
[633.658775] Subtest big-copy: SKIP (0.000s)
[633.723664] [125/130] (458s left) gem_exec_reloc (basic-write-gtt)
[633.811091] Subtest basic-write-gtt: SKIP (0.000s)
[633.890291] [126/130] (458s left) gem_exec_fence (basic-wait)
[634.130695] Starting subtest: basic-wait
[634.132015] Starting dynamic subtest: rcs0
[634.266439] Dynamic subtest rcs0: SUCCESS (0.134s)
[634.285357] Starting dynamic subtest: bcs0
[634.319827] Dynamic subtest bcs0: SUCCESS (0.050s)
[634.342996] Starting dynamic subtest: vcs0
[634.372982] Dynamic subtest vcs0: SUCCESS (0.052s)
[634.406021] Starting dynamic subtest: vcs1
[634.426152] Dynamic subtest vcs1: SUCCESS (0.051s)
[634.452748] Starting dynamic subtest: vecs0
[634.479835] Dynamic subtest vecs0: SUCCESS (0.052s)
[634.498124] Starting dynamic subtest: vecs1
[634.533029] Dynamic subtest vecs1: SUCCESS (0.052s)
[634.551021] Starting dynamic subtest: ccs0
[634.581891] Dynamic subtest ccs0: SUCCESS (0.047s)
[634.583005] Subtest basic-wait: SUCCESS (0.452s)
[635.265157] [127/130] (457s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[635.474802] Starting subtest: compare-crc-sanitycheck-nv12
[635.477303] Starting dynamic subtest: pipe-A-DP-3
[636.202792] Dynamic subtest pipe-A-DP-3: SUCCESS (0.725s)
[636.218035] Starting dynamic subtest: pipe-B-DP-3
[636.927184] Dynamic subtest pipe-B-DP-3: SUCCESS (0.722s)
[636.941127] Starting dynamic subtest: pipe-C-DP-3
[637.605507] Dynamic subtest pipe-C-DP-3: SUCCESS (0.676s)
[637.619484] Starting dynamic subtest: pipe-D-DP-3
[638.213527] Dynamic subtest pipe-D-DP-3: SUCCESS (0.606s)
[638.214453] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.738s)
[638.472810] [128/130] (454s left) kms_cursor_edge_walk (64x64-right-edge)
[638.679698] Starting subtest: 64x64-right-edge
[638.682051] Starting dynamic subtest: pipe-A-DP-3
[642.122848] Dynamic subtest pipe-A-DP-3: SUCCESS (3.442s)
[642.137213] Starting dynamic subtest: pipe-D-DP-3
[645.446419] Dynamic subtest pipe-D-DP-3: SUCCESS (3.321s)
[645.447464] Subtest 64x64-right-edge: SUCCESS (6.766s)
[645.719214] [129/130] (447s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[645.927234] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[645.929057] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[646.056369] [130/130] (446s left) syncobj_wait (single-wait-signaled)
[646.138609] Starting subtest: single-wait-signaled
[646.139616] Subtest single-wait-signaled: SUCCESS (0.000s)
[646.272984] Closing watchdogs
Done.