[39.701828] Initializing watchdogs
[39.701871]   /dev/watchdog0
[39.708367] [001/142] (960s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[39.801419] Starting subtest: pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[39.806265] Subtest pipe-A-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s)
[41.003547] [002/142] (959s left) kms_cursor_edge_walk (128x128-top-edge)
[41.062120] Starting subtest: 128x128-top-edge
[41.064586] Starting dynamic subtest: pipe-A-eDP-1
[44.595684] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.532s)
[44.605183] Starting dynamic subtest: pipe-D-eDP-1
[47.821393] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.225s)
[47.823841] Subtest 128x128-top-edge: SUCCESS (6.760s)
[48.732484] [003/142] (951s left) v3d/v3d_wait_bo (unused-bo-0ns)
[48.820658] Subtest unused-bo-0ns: SKIP (0.000s)
[48.863896] [004/142] (951s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[48.927796] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[51.722854] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.800s)
[51.837788] [005/142] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[51.904950] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[51.909602] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[51.987433] [006/142] (948s left) gem_lmem_swapping (verify)
[52.048252] Subtest verify: SKIP (0.000s)
[52.083480] [007/142] (948s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render)
[52.153261] Starting subtest: psr-1p-offscren-pri-indfb-draw-render
[56.809288] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.660s)
[56.930123] [008/142] (943s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[57.020728] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[59.620280] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.606s)
[59.745223] [009/142] (940s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[59.825817] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[59.829492] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[59.900694] [010/142] (940s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[60.007407] Starting subtest: 4-tiled-32bpp-rotate-0
[61.365094] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.358s)
[61.486816] [011/142] (938s left) gem_pxp (verify-pxp-stale-buf-execution)
[64.051042] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[64.104425] [012/142] (936s left) gem_tiled_pread_basic
[64.190175] [013/142] (936s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[64.240749] Starting subtest: framebuffer-vs-set-tiling
[64.245376] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[64.331276] [014/142] (936s left) sw_sync (sync_busy)
[64.375913] Starting subtest: sync_busy
[64.378045] Subtest sync_busy: SUCCESS (0.001s)
[64.412837] [015/142] (936s left) prime_vgem (basic-blt)
[64.491434] Starting subtest: basic-blt
[64.547374] Subtest basic-blt: FAIL (0.019s)
[64.603618] [016/142] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[64.669214] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[64.673083] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[64.743360] [017/142] (935s left) i915_pm_rpm (universal-planes)
[66.591566] Starting subtest: universal-planes
[66.594433] Starting dynamic subtest: plane-31
[94.392486] Dynamic subtest plane-31: SUCCESS (27.800s)
[94.403848] Starting dynamic subtest: plane-40
[122.481897] Dynamic subtest plane-40: SUCCESS (28.088s)
[122.492591] Starting dynamic subtest: plane-49
[146.717334] Dynamic subtest plane-49: SUCCESS (24.236s)
[146.728461] Starting dynamic subtest: plane-58
[174.838516] Dynamic subtest plane-58: SUCCESS (28.119s)
[174.848933] Starting dynamic subtest: plane-67
[202.933454] Dynamic subtest plane-67: SUCCESS (28.095s)
[202.945987] Starting dynamic subtest: plane-76
[227.256720] Dynamic subtest plane-76: SUCCESS (24.322s)
[227.259707] Subtest universal-planes: SUCCESS (160.664s)
[228.036196] [018/142] (772s left) gem_ctx_param (invalid-set-no-zeromap)
[228.095050] Starting subtest: invalid-set-no-zeromap
[228.097486] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[228.155538] [019/142] (772s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[228.225438] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[229.359984] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.136s)
[229.473898] [020/142] (771s left) gem_eio (in-flight-contexts-1us)
[229.637836] Starting subtest: in-flight-contexts-1us
[243.720062] Subtest in-flight-contexts-1us: SUCCESS (14.082s)
[245.502509] [021/142] (755s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[245.612438] Starting subtest: cursor-rapid-movement-128x42
[245.614773] Starting dynamic subtest: pipe-A-eDP-1
[246.204852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[246.244339] Starting dynamic subtest: pipe-D-eDP-1
[247.516059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.282s)
[247.518497] Subtest cursor-rapid-movement-128x42: SUCCESS (1.904s)
[248.395773] [022/142] (752s left) gem_exec_flush (basic-batch-kernel-default-wb)
[248.459403] Starting subtest: basic-batch-kernel-default-wb
[257.883826] Subtest basic-batch-kernel-default-wb: SUCCESS (9.424s)
[258.067974] [023/142] (742s left) kms_color (invalid-ctm-matrix-sizes)
[258.138048] Starting subtest: invalid-ctm-matrix-sizes
[258.140341] Starting dynamic subtest: pipe-A
[258.142648] Dynamic subtest pipe-A: SUCCESS (0.003s)
[258.148776] Starting dynamic subtest: pipe-B
[258.150694] Dynamic subtest pipe-B: SUCCESS (0.003s)
[258.155621] Starting dynamic subtest: pipe-C
[258.157847] Dynamic subtest pipe-C: SUCCESS (0.005s)
[258.162638] Starting dynamic subtest: pipe-D
[258.164850] Dynamic subtest pipe-D: SUCCESS (0.005s)
[258.167115] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.016s)
[258.202882] [024/142] (742s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[258.271277] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[258.273652] Starting dynamic subtest: pipe-A-eDP-1
[259.993995] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.723s)
[260.001122] Starting dynamic subtest: pipe-B-eDP-1
[262.763044] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[262.773800] Starting dynamic subtest: pipe-C-eDP-1
[264.048498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s)
[264.056908] Starting dynamic subtest: pipe-D-eDP-1
[265.339411] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.289s)
[265.341900] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (7.070s)
[266.604273] [025/142] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[266.679742] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[271.370532] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.697s)
[271.514297] [026/142] (729s left) gem_fenced_exec_thrash (2-spare-fences)
[271.573532] Subtest 2-spare-fences: SKIP (0.000s)
[271.597309] [027/142] (729s left) syncobj_wait (wait-all-snapshot)
[271.645083] Starting subtest: wait-all-snapshot
[271.728913] Subtest wait-all-snapshot: SUCCESS (0.083s)
[271.795960] [028/142] (729s left) gen7_exec_parse (basic-rejected)
[271.854897] Subtest basic-rejected: SKIP (0.000s)
[271.871165] [029/142] (728s left) gem_exec_params (larger-than-life-batch)
[271.911433] Starting subtest: larger-than-life-batch
[273.467764] Subtest larger-than-life-batch: SUCCESS (1.557s)
[274.515854] [030/142] (726s left) gem_softpin (zero)
[274.637253] Starting subtest: zero
[274.641713] Subtest zero: SUCCESS (0.006s)
[274.737781] [031/142] (726s left) kms_vblank (pipe-a-ts-continuation-idle)
[274.811557] Starting subtest: pipe-A-ts-continuation-idle
[275.233473] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.423s)
[276.140688] [032/142] (724s left) gem_mmap (bad-object)
[276.213072] Subtest bad-object: SKIP (0.000s)
[276.235103] [033/142] (724s left) gem_mmap_gtt (zero-extend)
[276.304480] Subtest zero-extend: SKIP (0.000s)
[276.333421] [034/142] (724s left) gem_ctx_persistence (heartbeat-stop)
[276.388702] Starting subtest: heartbeat-stop
[276.393092] Subtest heartbeat-stop: SKIP (0.000s)
[276.445378] [035/142] (724s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[276.508764] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[276.513198] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[276.592252] [036/142] (724s left) kms_chamelium_edid (hdmi-mode-timings)
[276.944856] Subtest hdmi-mode-timings: SKIP (0.000s)
[277.833491] [037/142] (723s left) kms_atomic_interruptible (legacy-setmode)
[277.929195] Starting subtest: legacy-setmode
[277.931604] Starting dynamic subtest: eDP-1-pipe-A
[284.822238] Dynamic subtest eDP-1-pipe-A: SUCCESS (6.891s)
[284.824657] Subtest legacy-setmode: SUCCESS (6.893s)
[285.742973] [038/142] (715s left) kms_vblank (pipe-d-ts-continuation-modeset)
[285.820697] Starting subtest: pipe-D-ts-continuation-modeset
[288.536194] Subtest pipe-D-ts-continuation-modeset: SUCCESS (2.718s)
[289.450727] [039/142] (711s left) kms_flip (2x-busy-flip)
[289.504033] Starting subtest: 2x-busy-flip
[289.522602] Subtest 2x-busy-flip: SKIP (0.017s)
[289.584343] [040/142] (711s left) kms_invalid_mode (bad-vtotal)
[289.668259] Starting subtest: bad-vtotal
[289.670679] Starting dynamic subtest: eDP-1-pipe-A
[289.954732] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.284s)
[289.967473] Starting dynamic subtest: eDP-1-pipe-B
[289.969813] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[289.982197] Starting dynamic subtest: eDP-1-pipe-C
[289.984183] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[289.996914] Starting dynamic subtest: eDP-1-pipe-D
[289.999875] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[290.002792] Subtest bad-vtotal: SUCCESS (0.298s)
[290.861590] [041/142] (710s left) kms_big_fb (linear-64bpp-rotate-180)
[290.941864] Starting subtest: linear-64bpp-rotate-180
[292.734781] Subtest linear-64bpp-rotate-180: SUCCESS (1.794s)
[292.935591] [042/142] (708s left) drm_fdinfo (most-busy-check-all)
[292.998062] Starting subtest: most-busy-check-all
[293.000583] Starting dynamic subtest: rcs0
[293.005602] Dynamic subtest rcs0: SKIP (0.003s)
[293.018859] Starting dynamic subtest: bcs0
[293.023407] Dynamic subtest bcs0: SKIP (0.001s)
[293.033598] Starting dynamic subtest: vcs0
[293.038091] Dynamic subtest vcs0: SKIP (0.001s)
[293.046607] Starting dynamic subtest: vcs1
[293.050942] Dynamic subtest vcs1: SKIP (0.001s)
[293.058685] Starting dynamic subtest: vecs0
[293.062966] Dynamic subtest vecs0: SKIP (0.001s)
[293.070419] Starting dynamic subtest: ccs0
[293.074652] Dynamic subtest ccs0: SKIP (0.001s)
[293.079016] Subtest most-busy-check-all: SKIP (0.012s)
[293.096471] [043/142] (708s left) kms_flip (2x-plain-flip)
[293.188680] Starting subtest: 2x-plain-flip
[293.206043] Subtest 2x-plain-flip: SKIP (0.020s)
[293.274371] [044/142] (707s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-d)
[293.346300] Starting subtest: universal-plane-pageflip-windowed-pipe-D
[295.105134] Subtest universal-plane-pageflip-windowed-pipe-D: SUCCESS (1.760s)
[296.044718] [045/142] (705s left) vgem_basic (busy-fence)
[296.093864] Starting subtest: busy-fence
[296.096217] Subtest busy-fence: SUCCESS (0.001s)
[296.143154] [046/142] (705s left) kms_vblank (pipe-a-wait-forked)
[296.208637] Starting subtest: pipe-A-wait-forked
[298.022582] Subtest pipe-A-wait-forked: SUCCESS (1.814s)
[298.925616] [047/142] (702s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[299.002060] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[301.729356] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.733s)
[301.846836] [048/142] (699s left) sw_sync (alloc_fence_invalid_timeline)
[301.887690] Starting subtest: alloc_fence_invalid_timeline
[301.889954] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[301.926672] [049/142] (699s left) kms_flip (2x-flip-vs-suspend-interruptible)
[301.989324] Starting subtest: 2x-flip-vs-suspend-interruptible
[302.013125] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.021s)
[302.075584] [050/142] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[302.139780] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[302.143232] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[302.227954] [051/142] (699s left) prime_self_import (basic-with_one_bo)
[302.269536] Starting subtest: basic-with_one_bo
[302.274027] Subtest basic-with_one_bo: SUCCESS (0.002s)
[302.307267] [052/142] (699s left) syncobj_timeline (multi-wait-submitted-signaled)
[302.350621] Starting subtest: multi-wait-submitted-signaled
[302.352354] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[302.401089] [053/142] (699s left) i915_pm_rpm (modeset-lpsp-stress-no-wait)
[304.603432] Starting subtest: modeset-lpsp-stress-no-wait
[316.276947] Subtest modeset-lpsp-stress-no-wait: SUCCESS (11.672s)
[316.365743] [054/142] (685s left) kms_cursor_crc (cursor-onscreen-128x42)
[316.528330] Starting subtest: cursor-onscreen-128x42
[316.530622] Starting dynamic subtest: pipe-A-eDP-1
[318.671192] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.142s)
[318.708068] Starting dynamic subtest: pipe-D-eDP-1
[321.554509] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.857s)
[321.557395] Subtest cursor-onscreen-128x42: SUCCESS (5.026s)
[322.446394] [055/142] (679s left) gem_ctx_exec (basic)
[322.525042] Starting subtest: basic
[322.527419] Subtest basic: SUCCESS (0.003s)
[322.622058] [056/142] (678s left) gem_exec_fair (basic-pace)
[322.680389] Subtest basic-pace: SKIP (0.000s)
[322.706399] [057/142] (678s left) syncobj_timeline (invalid-signal-illegal-handle)
[322.739276] Starting subtest: invalid-signal-illegal-handle
[322.741708] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[322.800314] [058/142] (678s left) prime_self_import (basic-llseek-bad)
[322.851031] Starting subtest: basic-llseek-bad
[322.855853] Subtest basic-llseek-bad: SUCCESS (0.003s)
[322.936347] [059/142] (678s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_mc_ccs)
[323.335254] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs
[323.341313] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[324.204652] [060/142] (677s left) i915_pm_rpm (debugfs-read)
[325.716482] Starting subtest: debugfs-read
[445.951298] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[446.940357] Closing watchdogs
[446.943394] Initializing watchdogs
[446.943468]   /dev/watchdog0
[446.952878] [061/142] (554s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[447.003287] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[447.007273] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[447.072637] [062/142] (554s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs)
[447.506924] Starting subtest: pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs
[449.142402] Subtest pipe-D-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.635s)
[450.335731] [063/142] (551s left) kms_ccs (pipe-b-bad-aux-stride-y_tiled_ccs)
[450.744855] Starting subtest: pipe-B-bad-aux-stride-y_tiled_ccs
[450.750017] Subtest pipe-B-bad-aux-stride-y_tiled_ccs: SKIP (0.000s)
[451.614730] [064/142] (550s left) kms_frontbuffer_tracking (fbc-stridechange)
[451.702066] Starting subtest: fbc-stridechange
[453.964135] Subtest fbc-stridechange: SUCCESS (2.268s)
[454.090303] [065/142] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[454.157832] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[459.377242] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (5.223s)
[459.489451] [066/142] (542s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[459.567530] Starting subtest: 4-tiled-16bpp-rotate-180
[460.822996] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.257s)
[460.931188] [067/142] (540s left) gem_ctx_create (basic-files)
[461.003532] Starting subtest: basic-files
[463.016975] Subtest basic-files: SUCCESS (2.011s)
[464.460793] [068/142] (537s left) kms_flip (absolute-wf_vblank-interruptible)
[464.526427] Starting subtest: absolute-wf_vblank-interruptible
[464.528867] Starting dynamic subtest: A-eDP1
[473.309046] Dynamic subtest A-eDP1: SUCCESS (8.781s)
[473.323055] Starting dynamic subtest: B-eDP1
[482.074591] Dynamic subtest B-eDP1: SUCCESS (8.765s)
[482.087091] Starting dynamic subtest: C-eDP1
[490.832805] Dynamic subtest C-eDP1: SUCCESS (8.755s)
[490.846965] Starting dynamic subtest: D-eDP1
[499.601099] Dynamic subtest D-eDP1: SUCCESS (8.767s)
[499.607723] Subtest absolute-wf_vblank-interruptible: SUCCESS (35.083s)
[500.847235] [069/142] (500s left) kms_vblank (pipe-b-query-forked-busy)
[500.915685] Starting subtest: pipe-B-query-forked-busy
[503.946995] Subtest pipe-B-query-forked-busy: SUCCESS (3.028s)
[504.865040] [070/142] (496s left) api_intel_bb (offset-control)
[504.922323] Starting subtest: offset-control
[504.930190] Subtest offset-control: SUCCESS (0.010s)
[505.034809] [071/142] (496s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[505.096728] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[505.099211] Starting dynamic subtest: pipe-A-default-mode
[505.388394] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[505.393189] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[506.284278] [072/142] (495s left) gem_exec_schedule (semaphore-codependency)
[506.356816] Starting subtest: semaphore-codependency
[506.359110] Subtest semaphore-codependency: SUCCESS (0.005s)
[506.670554] [073/142] (495s left) kms_vblank (pipe-c-wait-idle)
[506.721836] Starting subtest: pipe-C-wait-idle
[509.648853] Subtest pipe-C-wait-idle: SUCCESS (2.930s)
[510.572446] [074/142] (491s left) gem_exec_reloc (basic-wc-active)
[510.642530] Subtest basic-wc-active: SKIP (0.000s)
[510.703804] [075/142] (491s left) gem_mmap_gtt (hang)
[510.744408] Subtest hang: SKIP (0.000s)
[510.771058] [076/142] (491s left) sysfs_preempt_timeout (idempotent)
[510.821380] Starting subtest: idempotent
[510.823727] Starting dynamic subtest: vecs0
[510.826068] Dynamic subtest vecs0: SUCCESS (0.000s)
[510.831994] Starting dynamic subtest: ccs0
[510.834314] Dynamic subtest ccs0: SUCCESS (0.000s)
[510.839561] Starting dynamic subtest: vcs0
[510.841803] Dynamic subtest vcs0: SUCCESS (0.000s)
[510.847255] Starting dynamic subtest: bcs0
[510.849128] Dynamic subtest bcs0: SUCCESS (0.000s)
[510.854298] Starting dynamic subtest: rcs0
[510.856247] Dynamic subtest rcs0: SUCCESS (0.000s)
[510.861228] Starting dynamic subtest: vcs1
[510.863106] Dynamic subtest vcs1: SUCCESS (0.000s)
[510.864981] Subtest idempotent: SUCCESS (0.004s)
[510.877848] [077/142] (491s left) syncobj_timeline (invalid-multi-wait-all-available-unsubmitted-signaled)
[510.914027] Starting subtest: invalid-multi-wait-all-available-unsubmitted-signaled
[510.916622] Subtest invalid-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.001s)
[510.972477] [078/142] (491s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[511.351619] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[511.356445] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[512.238725] [079/142] (489s left) gem_exec_gttfill (engines)
[512.310775] Starting subtest: engines
[512.313307] Starting dynamic subtest: rcs0
[534.719298] Dynamic subtest rcs0: SUCCESS (22.407s)
[534.734887] Starting dynamic subtest: bcs0
[557.136406] Dynamic subtest bcs0: SUCCESS (22.414s)
[557.152734] Starting dynamic subtest: vcs0
[579.465902] Dynamic subtest vcs0: SUCCESS (22.329s)
[579.479179] Starting dynamic subtest: vcs1
[601.821255] Dynamic subtest vcs1: SUCCESS (22.353s)
[601.835163] Starting dynamic subtest: vecs0
[624.218198] Dynamic subtest vecs0: SUCCESS (22.396s)
[624.233448] Starting dynamic subtest: ccs0
[646.592603] Dynamic subtest ccs0: SUCCESS (22.374s)
[646.595191] Subtest engines: SUCCESS (134.283s)
[646.772305] [080/142] (355s left) kms_vblank (pipe-c-ts-continuation-idle-hang)
[646.894053] Starting subtest: pipe-C-ts-continuation-idle-hang
[662.284959] Subtest pipe-C-ts-continuation-idle-hang: SUCCESS (15.393s)
[663.200925] [081/142] (338s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[663.264953] Starting subtest: psr-2p-primscrn-spr-indfb-move
[663.269037] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[663.336682] [082/142] (338s left) perf (missing-sample-flags)
[663.496287] Starting subtest: missing-sample-flags
[663.498613] Subtest missing-sample-flags: SUCCESS (0.002s)
[663.522887] [083/142] (338s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc)
[663.604934] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc
[668.203798] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (4.603s)
[668.334210] [084/142] (333s left) gem_exec_whisper (basic-normal-all)
[668.396694] Starting subtest: basic-normal-all
[671.088112] Subtest basic-normal-all: SUCCESS (2.692s)
[671.264097] [085/142] (330s left) kms_frontbuffer_tracking (psr-slowdraw)
[671.361853] Starting subtest: psr-slowdraw
[694.386186] Subtest psr-slowdraw: SUCCESS (23.027s)
[694.485608] [086/142] (307s left) perf (invalid-oa-metric-set-id)
[694.556507] Starting subtest: invalid-oa-metric-set-id
[694.568633] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[694.606725] [087/142] (307s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[694.692179] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[694.694612] Starting dynamic subtest: pipe-A-default-mode
[694.981738] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[694.986822] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[695.917667] [088/142] (306s left) gem_exec_reloc (basic-write-gtt-active)
[695.979551] Subtest basic-write-gtt-active: SKIP (0.000s)
[696.043266] [089/142] (306s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[696.398182] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[697.444177] Subtest pipe-A-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.046s)
[698.618565] [090/142] (303s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[698.669297] Starting subtest: primary-x-tiled-reflect-x-0
[706.209650] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.543s)
[707.501268] [091/142] (294s left) drm_read (short-buffer-block)
[707.626920] Starting subtest: short-buffer-block
[707.629445] Subtest short-buffer-block: SUCCESS (0.000s)
[707.725969] [092/142] (294s left) gem_exec_reloc (basic-wc-gtt)
[707.785715] Subtest basic-wc-gtt: SKIP (0.000s)
[707.845890] [093/142] (294s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_mtl_rc_ccs)
[708.275161] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs
[709.322608] Subtest pipe-C-crc-primary-rotation-180-4_tiled_mtl_rc_ccs: SUCCESS (1.046s)
[710.497738] [094/142] (291s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_ccs)
[710.852772] Starting subtest: pipe-B-bad-pixel-format-y_tiled_ccs
[710.857934] Subtest pipe-B-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[711.729585] [095/142] (290s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[711.808310] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[712.873020] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.067s)
[713.006770] [096/142] (289s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[713.082400] Starting subtest: 2x-flip-vs-modeset-vs-hang
[713.104529] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.024s)
[713.186079] [097/142] (289s left) vc4/vc4_perfmon (get-values-invalid-pointer)
[713.273587] Subtest get-values-invalid-pointer: SKIP (0.000s)
[713.317195] [098/142] (289s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[713.388047] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[713.391939] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[713.484426] [099/142] (289s left) kms_vblank (pipe-c-ts-continuation-suspend)
[713.556049] Starting subtest: pipe-C-ts-continuation-suspend
[731.302864] Subtest pipe-C-ts-continuation-suspend: SUCCESS (2.751s)
[732.228393] [100/142] (285s left) i915_suspend (sysfs-reader)
[732.268763] Starting subtest: sysfs-reader
[750.125534] Subtest sysfs-reader: SUCCESS (3.220s)
[750.161578] [101/142] (282s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[750.232987] Starting subtest: cursorB-vs-flipB-varying-size
[750.237319] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[750.325554] [102/142] (281s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_mtl_rc_ccs)
[750.700393] Starting subtest: pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs
[751.723837] Subtest pipe-C-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.021s)
[752.891490] [103/142] (279s left) kms_setmode (basic)
[752.957236] Starting subtest: basic
[753.296357] Starting dynamic subtest: pipe-A-eDP-1
[755.425780] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.126s)
[755.778331] Starting dynamic subtest: pipe-B-eDP-1
[757.937467] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.165s)
[758.259663] Subtest basic: SUCCESS (5.301s)
[759.139980] [104/142] (273s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[759.199022] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[764.450953] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.256s)
[764.577591] [105/142] (267s left) sw_sync (timeline_closed)
[764.619202] Starting subtest: timeline_closed
[764.621719] Subtest timeline_closed: SUCCESS (0.000s)
[764.656953] [106/142] (267s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[765.034949] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs
[765.039695] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[765.916338] [107/142] (266s left) gem_vm_create (isolation)
[765.981465] Starting subtest: isolation
[765.989279] Subtest isolation: SUCCESS (0.008s)
[766.086721] [108/142] (266s left) gem_mmap_wc (bad-object)
[766.128250] Subtest bad-object: SKIP (0.000s)
[766.155261] [109/142] (266s left) gem_compute (compute-square)
[766.214766] Starting subtest: compute-square
[766.219403] Subtest compute-square: SKIP (0.000s)
[766.276569] [110/142] (266s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_mc_ccs)
[766.673165] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs
[766.678219] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[767.519926] [111/142] (265s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[767.871191] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[768.713667] [112/142] (263s left) kms_plane_cursor (viewport)
[768.792307] Starting subtest: viewport
[768.797191] Starting dynamic subtest: pipe-A-eDP-1-size-64
[771.775929] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.982s)
[771.837440] Starting dynamic subtest: pipe-A-eDP-1-size-128
[774.866223] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (3.041s)
[774.930630] Starting dynamic subtest: pipe-A-eDP-1-size-256
[777.909198] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.996s)
[778.275669] Starting dynamic subtest: pipe-B-eDP-1-size-64
[782.102579] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.843s)
[782.165606] Starting dynamic subtest: pipe-B-eDP-1-size-128
[785.191176] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (3.040s)
[785.255586] Starting dynamic subtest: pipe-B-eDP-1-size-256
[788.269122] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (3.029s)
[788.640837] Starting dynamic subtest: pipe-C-eDP-1-size-64
[791.947295] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.325s)
[791.980939] Starting dynamic subtest: pipe-C-eDP-1-size-128
[794.513403] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.538s)
[794.552740] Starting dynamic subtest: pipe-C-eDP-1-size-256
[797.089020] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.548s)
[797.426819] Starting dynamic subtest: pipe-D-eDP-1-size-64
[800.726763] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.314s)
[800.763514] Starting dynamic subtest: pipe-D-eDP-1-size-128
[803.216022] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.459s)
[803.253959] Starting dynamic subtest: pipe-D-eDP-1-size-256
[805.748858] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.504s)
[806.079428] Subtest viewport: SUCCESS (37.283s)
[807.027241] [113/142] (225s left) perf_pmu (busy)
[807.092965] Starting subtest: busy
[807.095440] Starting dynamic subtest: rcs0
[807.670485] Dynamic subtest rcs0: SUCCESS (0.577s)
[807.688061] Starting dynamic subtest: bcs0
[808.228381] Dynamic subtest bcs0: SUCCESS (0.556s)
[808.245947] Starting dynamic subtest: vcs0
[810.053571] Dynamic subtest vcs0: SUCCESS (1.824s)
[810.070596] Starting dynamic subtest: vcs1
[812.039559] Dynamic subtest vcs1: SUCCESS (1.983s)
[812.058397] Starting dynamic subtest: vecs0
[814.023206] Dynamic subtest vecs0: SUCCESS (1.982s)
[814.040358] Starting dynamic subtest: ccs0
[814.581545] Dynamic subtest ccs0: SUCCESS (0.558s)
[814.584399] Subtest busy: SUCCESS (7.490s)
[814.658983] [114/142] (217s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_mtl_rc_ccs)
[815.058328] Starting subtest: pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs
[816.055666] Subtest pipe-D-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (0.995s)
[817.266738] [115/142] (215s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[817.338475] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[817.342198] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[817.422024] [116/142] (215s left) api_intel_bb (object-reloc-keep-cache)
[817.478713] Starting subtest: object-reloc-keep-cache
[817.483092] Subtest object-reloc-keep-cache: SKIP (0.001s)
[817.561720] [117/142] (215s left) kms_vblank (pipe-b-ts-continuation-dpms-suspend)
[817.646966] Starting subtest: pipe-B-ts-continuation-dpms-suspend
[835.543663] Subtest pipe-B-ts-continuation-dpms-suspend: SUCCESS (3.067s)
[836.443862] [118/142] (211s left) perf_pmu (init-sema)
[836.498197] Starting subtest: init-sema
[836.502853] Starting dynamic subtest: rcs0
[836.505412] Dynamic subtest rcs0: SUCCESS (0.001s)
[836.512844] Starting dynamic subtest: bcs0
[836.515094] Dynamic subtest bcs0: SUCCESS (0.000s)
[836.521279] Starting dynamic subtest: vcs0
[836.523313] Dynamic subtest vcs0: SUCCESS (0.000s)
[836.529397] Starting dynamic subtest: vcs1
[836.531214] Dynamic subtest vcs1: SUCCESS (0.000s)
[836.537141] Starting dynamic subtest: vecs0
[836.538910] Dynamic subtest vecs0: SUCCESS (0.000s)
[836.544633] Starting dynamic subtest: ccs0
[836.546440] Dynamic subtest ccs0: SUCCESS (0.000s)
[836.548268] Subtest init-sema: SUCCESS (0.005s)
[836.564214] [119/142] (211s left) gem_render_copy (yf-tiled-to-vebox-linear)
[836.631078] Starting subtest: yf-tiled-to-vebox-linear
[836.636562] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[836.808933] [120/142] (210s left) gem_exec_store (cachelines)
[836.886759] Starting subtest: cachelines
[836.889314] Starting dynamic subtest: rcs0
[836.954619] Dynamic subtest rcs0: SUCCESS (0.067s)
[836.972040] Starting dynamic subtest: bcs0
[837.015198] Dynamic subtest bcs0: SUCCESS (0.059s)
[837.031976] Starting dynamic subtest: vcs0
[838.901768] Dynamic subtest vcs0: SUCCESS (1.884s)
[838.920869] Starting dynamic subtest: vcs1
[840.885727] Dynamic subtest vcs1: SUCCESS (1.982s)
[840.903982] Starting dynamic subtest: vecs0
[842.869950] Dynamic subtest vecs0: SUCCESS (1.982s)
[842.887537] Starting dynamic subtest: ccs0
[842.921571] Dynamic subtest ccs0: SUCCESS (0.052s)
[842.924456] Subtest cachelines: SUCCESS (6.035s)
[843.101110] [121/142] (204s left) gem_exec_balancer (full-late-pulse)
[843.173126] Starting subtest: full-late-pulse
[847.521351] Subtest full-late-pulse: SUCCESS (4.349s)
[847.789750] [122/142] (199s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[847.885628] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[847.887670] Starting dynamic subtest: pipe-A-eDP-1
[848.361767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[848.375925] Starting dynamic subtest: pipe-B-eDP-1
[849.963012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.599s)
[849.979494] Starting dynamic subtest: pipe-C-eDP-1
[851.541912] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.577s)
[851.561582] Starting dynamic subtest: pipe-D-eDP-1
[853.053404] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s)
[853.055872] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (5.169s)
[854.303817] [123/142] (193s left) api_intel_allocator (execbuf-with-allocator)
[854.364009] Starting subtest: execbuf-with-allocator
[854.366394] Subtest execbuf-with-allocator: SUCCESS (0.002s)
[854.456432] [124/142] (193s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[854.522808] Starting subtest: multi-wait-for-submit-available-signaled
[854.525216] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[854.580177] [125/142] (193s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_mc_ccs)
[854.987378] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs
[854.992837] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[855.818434] [126/142] (191s left) gem_bad_reloc (negative-reloc)
[855.865232] Subtest negative-reloc: SKIP (0.000s)
[855.929970] [127/142] (191s left) kms_psr (psr2_sprite_render)
[855.991297] Starting subtest: psr2_sprite_render
[857.781795] Subtest psr2_sprite_render: SUCCESS (1.787s)
[858.719554] [128/142] (189s left) kms_invalid_mode (bad-htotal)
[858.795698] Starting subtest: bad-htotal
[858.798195] Starting dynamic subtest: eDP-1-pipe-A
[859.078407] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.285s)
[859.096434] Starting dynamic subtest: eDP-1-pipe-B
[859.098754] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.001s)
[859.110919] Starting dynamic subtest: eDP-1-pipe-C
[859.112853] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.001s)
[859.122460] Starting dynamic subtest: eDP-1-pipe-D
[859.124738] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.001s)
[859.127068] Subtest bad-htotal: SUCCESS (0.298s)
[859.978299] [129/142] (187s left) kms_draw_crc (draw-method-mmap-wc)
[860.070472] Starting subtest: draw-method-mmap-wc
[860.072841] Starting dynamic subtest: xrgb8888-untiled
[860.315511] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[860.330042] Starting dynamic subtest: rgb565-untiled
[860.570818] Dynamic subtest rgb565-untiled: SUCCESS (0.254s)
[860.584483] Starting dynamic subtest: xrgb2101010-untiled
[860.793742] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[860.801809] Starting dynamic subtest: xrgb8888-xtiled
[860.926643] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[860.944801] Starting dynamic subtest: rgb565-xtiled
[861.070518] Dynamic subtest rgb565-xtiled: SUCCESS (0.143s)
[861.086943] Starting dynamic subtest: xrgb2101010-xtiled
[861.194332] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[861.209349] Starting dynamic subtest: xrgb8888-4tiled
[861.318439] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[861.333597] Starting dynamic subtest: rgb565-4tiled
[861.448463] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[861.465863] Starting dynamic subtest: xrgb2101010-4tiled
[861.604855] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[861.606884] Subtest draw-method-mmap-wc: SUCCESS (1.535s)
[861.693535] [130/142] (186s left) i915_hangman (hangcheck-unterminated)
[861.759646] Starting subtest: hangcheck-unterminated
[872.886366] Subtest hangcheck-unterminated: SUCCESS (11.126s)
[872.995339] [131/142] (174s left) kms_prop_blob (blob-multiple)
[873.040964] Starting subtest: blob-multiple
[873.042977] Subtest blob-multiple: SUCCESS (0.001s)
[873.106621] [132/142] (174s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[873.148695] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[873.150961] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[873.195412] [133/142] (174s left) kms_ccs (pipe-d-bad-pixel-format-4_tiled_dg2_rc_ccs_cc)
[873.607338] Starting subtest: pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc
[873.611929] Subtest pipe-D-bad-pixel-format-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[874.463024] [134/142] (173s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[874.564366] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[874.615051] [135/142] (173s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[874.707824] Starting subtest: nonblocking-crc-frame-sequence
[874.710145] Starting dynamic subtest: pipe-A-eDP-1
[875.511414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[875.526706] Starting dynamic subtest: pipe-B-eDP-1
[877.079311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s)
[877.093958] Starting dynamic subtest: pipe-C-eDP-1
[878.536651] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.453s)
[878.554280] Starting dynamic subtest: pipe-D-eDP-1
[880.039911] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.501s)
[880.042462] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.332s)
[880.979898] [136/142] (167s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[886.195771] Starting subtest: overlay-plane-update-continuous-sf
[886.198288] Starting dynamic subtest: pipe-A-eDP-1
[888.012497] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[888.030457] Starting dynamic subtest: pipe-B-eDP-1
[889.833086] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.815s)
[889.835583] Subtest overlay-plane-update-continuous-sf: SUCCESS (3.638s)
[890.721992] [137/142] (157s left) v3d/v3d_submit_cl (multiple-job-submission)
[890.820118] Subtest multiple-job-submission: SKIP (0.000s)
[890.872304] [138/142] (157s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[890.963058] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[890.967425] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[891.056862] [139/142] (157s left) gem_exec_fair (basic-deadline)
[891.129892] Subtest basic-deadline: SKIP (0.000s)
[891.180893] [140/142] (156s left) gem_ctx_sseu (invalid-args)
[891.238189] Subtest invalid-args: SKIP (0.000s)
[891.262216] [141/142] (156s left) kms_chamelium_color (ctm-max)
[891.338608] Subtest ctm-max: SKIP (0.000s)
[891.356584] [142/142] (156s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[891.391640] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[891.394044] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[891.450985] Closing watchdogs
Done.