[19.373773] Initializing watchdogs
[19.373831]   /dev/watchdog0
[19.378621] [001/142] (960s left) kms_color (legacy-gamma-reset)
[19.481846] Starting subtest: legacy-gamma-reset
[19.482560] Starting dynamic subtest: pipe-A
[19.688944] Dynamic subtest pipe-A: SUCCESS (0.207s)
[19.692879] Starting dynamic subtest: pipe-B
[20.825612] Dynamic subtest pipe-B: SUCCESS (1.137s)
[20.828766] Starting dynamic subtest: pipe-C
[21.964755] Dynamic subtest pipe-C: SUCCESS (1.130s)
[21.968030] Starting dynamic subtest: pipe-D
[23.089021] Dynamic subtest pipe-D: SUCCESS (1.133s)
[23.089846] Subtest legacy-gamma-reset: SUCCESS (3.608s)
[23.166884] [002/142] (956s left) fbdev (eof)
[23.226035] Starting subtest: eof
[23.226856] Subtest eof: SUCCESS (0.000s)
[23.255589] [003/142] (956s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[23.326766] Subtest bad-multisync-out-sync: SKIP (0.000s)
[23.355278] [004/142] (956s left) dmabuf_sync_file (export-multiwait)
[23.434940] Starting subtest: export-multiwait
[23.435742] Subtest export-multiwait: SUCCESS (0.001s)
[23.463960] [005/142] (956s left) kms_big_fb (y-tiled-addfb-size-overflow)
[23.570012] Starting subtest: y-tiled-addfb-size-overflow
[23.570855] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s)
[23.630998] [006/142] (956s left) gem_pwrite (basic-self)
[23.688650] Starting subtest: basic-self
[23.727365] Subtest basic-self: SUCCESS (0.039s)
[23.770845] [007/142] (956s left) prime_vgem (busy)
[23.822643] Starting subtest: busy
[23.823404] Starting dynamic subtest: rcs0
[23.846979] Dynamic subtest rcs0: SUCCESS (0.024s)
[23.850627] Starting dynamic subtest: bcs0
[23.858372] Dynamic subtest bcs0: SUCCESS (0.011s)
[23.861719] Starting dynamic subtest: vcs0
[23.873209] Dynamic subtest vcs0: SUCCESS (0.015s)
[23.876341] Starting dynamic subtest: vcs1
[23.886236] Dynamic subtest vcs1: SUCCESS (0.013s)
[23.889587] Starting dynamic subtest: vecs0
[23.902141] Dynamic subtest vecs0: SUCCESS (0.016s)
[23.902997] Subtest busy: SUCCESS (0.079s)
[23.979454] [008/142] (955s left) gem_mmap_wc (invalid-flags)
[24.025892] Starting subtest: invalid-flags
[24.026640] Subtest invalid-flags: SUCCESS (0.000s)
[24.071069] [009/142] (955s left) i915_hangman (error-state-basic)
[24.124279] Starting subtest: error-state-basic
[24.128493] Subtest error-state-basic: SUCCESS (0.005s)
[24.193451] [010/142] (955s left) kms_vrr (flipline)
[24.292201] Starting subtest: flipline
[24.293656] Subtest flipline: SKIP (0.000s)
[24.329963] [011/142] (955s left) perf_pmu (busy-start)
[24.381237] Starting subtest: busy-start
[24.382030] Starting dynamic subtest: rcs0
[26.923953] Dynamic subtest rcs0: SUCCESS (2.518s)
[26.930973] Starting dynamic subtest: bcs0
[29.416445] Dynamic subtest bcs0: SUCCESS (2.516s)
[29.423247] Starting dynamic subtest: vcs0
[31.957662] Dynamic subtest vcs0: SUCCESS (2.515s)
[31.964606] Starting dynamic subtest: vcs1
[34.472480] Dynamic subtest vcs1: SUCCESS (2.515s)
[34.479187] Starting dynamic subtest: vecs0
[36.961921] Dynamic subtest vecs0: SUCCESS (2.515s)
[36.963262] Subtest busy-start: SUCCESS (12.579s)
[37.006037] [012/142] (943s left) kms_universal_plane (universal-plane-pipe-b-functional)
[37.113997] Starting subtest: universal-plane-pipe-B-functional
[38.302047] Subtest universal-plane-pipe-B-functional: SUCCESS (1.189s)
[38.372528] [013/142] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[38.475863] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[38.477407] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[38.523050] [014/142] (941s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[38.626026] Starting subtest: x-tiled-8bpp-rotate-270
[38.680444] Subtest x-tiled-8bpp-rotate-270: SKIP (0.054s)
[38.749021] [015/142] (941s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[38.849949] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[38.850839] Starting dynamic subtest: pipe-A-valid-mode
[39.616317] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.765s)
[39.617093] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (0.766s)
[39.721533] [016/142] (940s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_gen12_mc_ccs)
[39.868280] Starting subtest: pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs
[39.869829] Subtest pipe-A-bad-rotation-90-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[40.172349] [017/142] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[40.271879] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[40.273327] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[40.331316] [018/142] (939s left) gem_exec_nop (basic-parallel)
[40.387600] Starting subtest: basic-parallel
[43.687762] Subtest basic-parallel: SUCCESS (3.301s)
[43.873939] [019/142] (936s left) syncobj_wait (single-wait-all-submitted)
[43.936291] Starting subtest: single-wait-all-submitted
[44.039290] Subtest single-wait-all-submitted: SUCCESS (0.103s)
[44.081306] [020/142] (936s left) kms_cursor_crc (cursor-offscreen-32x32)
[44.189373] Starting subtest: cursor-offscreen-32x32
[44.231268] Subtest cursor-offscreen-32x32: SKIP (0.040s)
[44.289796] [021/142] (935s left) kms_atomic_transition (plane-all-transition-fencing)
[44.386384] Starting subtest: plane-all-transition-fencing
[44.387971] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.309902] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.922s)
[46.365468] Starting dynamic subtest: pipe-B-HDMI-A-1
[48.362379] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.001s)
[48.412529] Subtest plane-all-transition-fencing: SUCCESS (4.025s)
[48.509211] [022/142] (931s left) kms_plane_scaling (invalid-num-scalers)
[48.611762] Starting subtest: invalid-num-scalers
[48.612536] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[48.629587] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.017s)
[48.634765] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[48.663834] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.032s)
[48.668958] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[48.697309] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.032s)
[48.702519] Starting dynamic subtest: pipe-D-HDMI-A-1-invalid-num-scalers
[48.732341] Dynamic subtest pipe-D-HDMI-A-1-invalid-num-scalers: SUCCESS (0.032s)
[48.733122] Subtest invalid-num-scalers: SUCCESS (0.121s)
[48.784109] [023/142] (931s left) i915_hangman (gt-engine-hang)
[48.837689] Starting subtest: gt-engine-hang
[48.838378] Starting dynamic subtest: rcs0
[49.406193] Dynamic subtest rcs0: SUCCESS (0.569s)
[49.411114] Starting dynamic subtest: bcs0
[49.952108] Dynamic subtest bcs0: SUCCESS (0.545s)
[49.958081] Starting dynamic subtest: vcs0
[50.515063] Dynamic subtest vcs0: SUCCESS (0.562s)
[50.520743] Starting dynamic subtest: vcs1
[51.074148] Dynamic subtest vcs1: SUCCESS (0.558s)
[51.078497] Starting dynamic subtest: vecs0
[51.627099] Dynamic subtest vecs0: SUCCESS (0.552s)
[51.627827] Subtest gt-engine-hang: SUCCESS (2.790s)
[51.667991] [024/142] (928s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[51.771257] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[51.772657] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[51.826213] [025/142] (928s left) gem_mmap_wc (bad-size)
[51.874881] Starting subtest: bad-size
[51.875597] Subtest bad-size: SUCCESS (0.000s)
[51.934339] [026/142] (928s left) kms_dsc (dsc-with-formats)
[52.032530] Starting subtest: dsc-with-formats
[52.034063] Subtest dsc-with-formats: SKIP (0.001s)
[52.068091] [027/142] (928s left) gem_lmem_swapping (parallel-random-engines)
[52.120127] Subtest parallel-random-engines: SKIP (0.000s)
[52.136496] [028/142] (928s left) kms_flip (flip-vs-rmfb-interruptible)
[52.220787] Starting subtest: flip-vs-rmfb-interruptible
[52.224301] Starting dynamic subtest: A-HDMI-A1
[59.923921] Dynamic subtest A-HDMI-A1: SUCCESS (7.699s)
[59.928584] Starting dynamic subtest: B-HDMI-A1
[67.545372] Dynamic subtest B-HDMI-A1: SUCCESS (7.620s)
[67.550330] Starting dynamic subtest: C-HDMI-A1
[75.172464] Dynamic subtest C-HDMI-A1: SUCCESS (7.626s)
[75.177804] Starting dynamic subtest: D-HDMI-A1
[82.789890] Dynamic subtest D-HDMI-A1: SUCCESS (7.616s)
[82.792499] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.572s)
[82.920412] [029/142] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[83.019963] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[84.065763] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.047s)
[84.161805] [030/142] (896s left) vgem_basic (bad-fence)
[84.223891] Starting subtest: bad-fence
[84.224639] Subtest bad-fence: SUCCESS (0.000s)
[84.252777] [031/142] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[84.340849] Starting subtest: basic-flip-vs-wf_vblank
[84.343921] Starting dynamic subtest: A-HDMI-A1
[85.158237] Dynamic subtest A-HDMI-A1: SUCCESS (0.814s)
[85.165950] Starting dynamic subtest: B-HDMI-A1
[85.951702] Dynamic subtest B-HDMI-A1: SUCCESS (0.790s)
[85.956788] Starting dynamic subtest: C-HDMI-A1
[86.747220] Dynamic subtest C-HDMI-A1: SUCCESS (0.793s)
[86.751310] Starting dynamic subtest: D-HDMI-A1
[87.537368] Dynamic subtest D-HDMI-A1: SUCCESS (0.788s)
[87.538241] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.195s)
[87.645459] [032/142] (892s left) gem_readwrite (read-write)
[87.693841] Starting subtest: read-write
[87.696771] Subtest read-write: SUCCESS (0.000s)
[87.753421] [033/142] (892s left) kms_ccs (pipe-a-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[87.913475] Starting subtest: pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[87.914976] Subtest pipe-A-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[88.205367] [034/142] (892s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[88.305895] Starting subtest: fbc-modesetfrombusy
[89.174943] Subtest fbc-modesetfrombusy: SUCCESS (0.871s)
[89.238577] [035/142] (891s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[89.341010] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[89.342397] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[89.397369] [036/142] (890s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[89.498478] Starting subtest: 4-tiled-32bpp-rotate-270
[89.500094] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[89.555962] [037/142] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[89.654589] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[89.656011] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[89.705416] [038/142] (890s left) gem_exec_reloc (basic-wc-cpu)
[89.755898] Starting subtest: basic-wc-cpu
[89.760903] Subtest basic-wc-cpu: SUCCESS (0.005s)
[89.846848] [039/142] (890s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[89.945815] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[89.947183] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[89.996868] [040/142] (890s left) kms_vblank (pipe-d-query-forked)
[90.093195] Starting subtest: pipe-D-query-forked
[91.410922] Subtest pipe-D-query-forked: SUCCESS (1.318s)
[91.497884] [041/142] (888s left) gem_ctx_persistence (legacy-engines-mixed-process)
[91.551280] Starting subtest: legacy-engines-mixed-process
[91.552055] Starting dynamic subtest: render
[91.880258] Dynamic subtest render: SUCCESS (0.332s)
[91.885495] Starting dynamic subtest: bsd1
[92.180210] Dynamic subtest bsd1: SUCCESS (0.299s)
[92.184750] Starting dynamic subtest: bsd2
[94.212145] Dynamic subtest bsd2: SUCCESS (2.022s)
[94.219756] Starting dynamic subtest: blt
[94.568393] Dynamic subtest blt: SUCCESS (0.364s)
[94.572804] Starting dynamic subtest: vebox
[94.907433] Dynamic subtest vebox: SUCCESS (0.338s)
[94.908398] Subtest legacy-engines-mixed-process: SUCCESS (3.360s)
[94.947405] [042/142] (885s left) gem_exec_fence (syncobj-timeline-wait)
[95.407741] Starting subtest: syncobj-timeline-wait
[95.427501] Subtest syncobj-timeline-wait: SUCCESS (0.028s)
[95.582134] [043/142] (884s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[95.638116] Starting subtest: invalid-single-wait-all-unsubmitted
[95.638999] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[95.679956] [044/142] (884s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[95.836427] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[95.895571] [045/142] (884s left) gem_ctx_shared (q-promotion)
[95.949054] Starting subtest: Q-promotion
[95.949835] Starting dynamic subtest: rcs0
[95.994165] Dynamic subtest rcs0: SUCCESS (0.045s)
[96.000201] Starting dynamic subtest: bcs0
[96.041146] Dynamic subtest bcs0: SUCCESS (0.046s)
[96.047300] Starting dynamic subtest: vcs0
[96.083216] Dynamic subtest vcs0: SUCCESS (0.041s)
[96.088383] Starting dynamic subtest: vcs1
[96.125934] Dynamic subtest vcs1: SUCCESS (0.042s)
[96.132242] Starting dynamic subtest: vecs0
[96.167363] Dynamic subtest vecs0: SUCCESS (0.041s)
[96.168155] Subtest Q-promotion: SUCCESS (0.219s)
[96.329834] [046/142] (884s left) i915_pm_rpm (universal-planes)
[97.861472] Starting subtest: universal-planes
[97.862808] Starting dynamic subtest: plane-31
[108.995628] Dynamic subtest plane-31: FAIL (11.122s)
[109.204074] Starting dynamic subtest: plane-40
[120.396308] Dynamic subtest plane-40: FAIL (11.183s)
[120.461410] Starting dynamic subtest: plane-49
[131.550705] Dynamic subtest plane-49: FAIL (11.083s)
[131.563516] Starting dynamic subtest: plane-58
[142.650391] Dynamic subtest plane-58: FAIL (11.062s)
[142.791825] Starting dynamic subtest: plane-67
[154.068071] Dynamic subtest plane-67: FAIL (11.268s)
[154.094428] Starting dynamic subtest: plane-76
[167.299360] Dynamic subtest plane-76: FAIL (13.176s)
[167.409061] Starting dynamic subtest: plane-85
[178.623739] Dynamic subtest plane-85: FAIL (11.206s)
[178.920794] Starting dynamic subtest: plane-94
[189.928226] Dynamic subtest plane-94: FAIL (10.999s)
[189.928923] Subtest universal-planes: FAIL (92.054s)
[190.134221] [047/142] (790s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[190.365302] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[190.366700] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[190.592875] [048/142] (789s left) i915_pm_rpm (cursor)
[192.121545] Starting subtest: cursor
[203.218718] Subtest cursor: FAIL (11.087s)
[203.362241] [049/142] (777s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-blt)
[203.469052] Starting subtest: psr-1p-offscren-pri-indfb-draw-blt
[203.470468] Subtest psr-1p-offscren-pri-indfb-draw-blt: SKIP (0.000s)
[203.526378] [050/142] (776s left) v3d/v3d_create_bo (create-bo-0)
[203.596865] Subtest create-bo-0: SKIP (0.000s)
[203.626880] [051/142] (776s left) kms_ccs (pipe-c-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[203.933512] Starting subtest: pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[203.934976] Subtest pipe-C-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[204.089722] [052/142] (776s left) vc4/vc4_label_bo (set-bad-handle)
[204.160318] Subtest set-bad-handle: SKIP (0.000s)
[204.189984] [053/142] (776s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[204.285864] Starting subtest: 2x-cursor-vs-flip-legacy
[204.288825] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.003s)
[204.322950] [054/142] (776s left) prime_vgem (basic-gtt)
[204.379696] Starting subtest: basic-gtt
[204.389074] Subtest basic-gtt: SUCCESS (0.009s)
[204.449716] [055/142] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[204.552408] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[204.553960] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[204.599951] [056/142] (775s left) perf_pmu (init-sema)
[204.651323] Starting subtest: init-sema
[204.652248] Starting dynamic subtest: rcs0
[204.653052] Dynamic subtest rcs0: SUCCESS (0.001s)
[204.658399] Starting dynamic subtest: bcs0
[204.659168] Dynamic subtest bcs0: SUCCESS (0.000s)
[204.663386] Starting dynamic subtest: vcs0
[204.664239] Dynamic subtest vcs0: SUCCESS (0.001s)
[204.668297] Starting dynamic subtest: vcs1
[204.669072] Dynamic subtest vcs1: SUCCESS (0.000s)
[204.673110] Starting dynamic subtest: vecs0
[204.673860] Dynamic subtest vecs0: SUCCESS (0.000s)
[204.674624] Subtest init-sema: SUCCESS (0.004s)
[204.689526] [057/142] (775s left) kms_vblank (pipe-c-query-busy-hang)
[204.785767] Starting subtest: pipe-C-query-busy-hang
[219.109449] Subtest pipe-C-query-busy-hang: SUCCESS (14.324s)
[219.228414] [058/142] (761s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[219.331195] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[219.332583] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[219.382676] [059/142] (761s left) kms_cursor_crc (cursor-random-512x170)
[219.484199] Starting subtest: cursor-random-512x170
[219.486644] Subtest cursor-random-512x170: SKIP (0.001s)
[219.528156] [060/142] (761s left) gem_eio (wait-10ms)
[219.581849] Starting subtest: wait-10ms
[219.738586] Subtest wait-10ms: SUCCESS (0.155s)
[219.830277] [061/142] (760s left) gem_mmap_gtt (basic-small-bo-tiledx)
[219.881832] Starting subtest: basic-small-bo-tiledX
[220.397534] Subtest basic-small-bo-tiledX: SUCCESS (0.516s)
[220.480936] [062/142] (760s left) gem_madvise (dontneed-after-mmap)
[220.570311] Starting subtest: dontneed-after-mmap
[220.574619] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[220.634725] [063/142] (760s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[220.699301] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[220.700101] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[220.737481] [064/142] (759s left) kms_ccs (pipe-c-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[221.025769] Starting subtest: pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[221.027825] Subtest pipe-C-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[221.199078] [065/142] (759s left) gem_softpin (evict-prime-sanity-check)
[221.248272] Starting subtest: evict-prime-sanity-check
[221.249128] Starting dynamic subtest: rcs0
[222.352511] Dynamic subtest rcs0: SUCCESS (1.104s)
[222.363887] Starting dynamic subtest: bcs0
[223.476808] Dynamic subtest bcs0: SUCCESS (1.123s)
[223.492209] Starting dynamic subtest: vcs0
[224.589878] Dynamic subtest vcs0: SUCCESS (1.111s)
[224.603857] Starting dynamic subtest: vcs1
[225.695607] Dynamic subtest vcs1: SUCCESS (1.104s)
[225.705346] Starting dynamic subtest: vecs0
[226.814995] Dynamic subtest vecs0: SUCCESS (1.118s)
[226.828397] Starting dynamic subtest: all
[227.931730] Dynamic subtest all: SUCCESS (1.115s)
[227.934424] Subtest evict-prime-sanity-check: SUCCESS (6.684s)
[227.984624] [066/142] (752s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs)
[228.354485] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs
[228.356089] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[228.461862] [067/142] (752s left) kms_cursor_edge_walk (128x128-top-bottom)
[228.558211] Starting subtest: 128x128-top-bottom
[228.558979] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.335757] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.776s)
[230.343534] Starting dynamic subtest: pipe-D-HDMI-A-1
[231.985638] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.649s)
[231.987063] Subtest 128x128-top-bottom: SUCCESS (3.429s)
[232.063356] [068/142] (748s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[232.167908] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[233.214395] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.049s)
[233.296345] [069/142] (747s left) kms_psr2_sf (cursor-plane-move-continuous-sf)
[233.346126] Subtest cursor-plane-move-continuous-sf: SKIP (0.000s)
[233.361518] [070/142] (747s left) gem_exec_schedule (out-order)
[233.419694] Starting subtest: out-order
[233.420493] Starting dynamic subtest: rcs0
[233.471379] Dynamic subtest rcs0: SUCCESS (0.051s)
[233.481212] Starting dynamic subtest: bcs0
[233.529777] Dynamic subtest bcs0: SUCCESS (0.057s)
[233.539570] Starting dynamic subtest: vcs0
[233.587846] Dynamic subtest vcs0: SUCCESS (0.057s)
[233.597715] Starting dynamic subtest: vcs1
[233.646664] Dynamic subtest vcs1: SUCCESS (0.056s)
[233.657498] Starting dynamic subtest: vecs0
[233.703411] Dynamic subtest vecs0: SUCCESS (0.055s)
[233.704721] Subtest out-order: SUCCESS (0.284s)
[233.980237] [071/142] (746s left) gem_exec_whisper (basic-forked)
[234.042446] Starting subtest: basic-forked
[237.375910] Subtest basic-forked: SUCCESS (3.333s)
[237.546688] [072/142] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[237.658991] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[237.660508] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[237.720168] [073/142] (743s left) kms_psr (cursor_render)
[237.769121] Subtest cursor_render: SKIP (0.000s)
[237.787628] [074/142] (743s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[237.838152] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[237.838961] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[237.879512] [075/142] (742s left) gem_exec_fair (basic-none-rrul)
[237.935832] Starting subtest: basic-none-rrul
[237.936658] Starting dynamic subtest: rcs0
[242.790250] Dynamic subtest rcs0: FAIL (4.831s)
[242.791145] Subtest basic-none-rrul: FAIL (4.832s)
[242.922617] [076/142] (737s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[243.033796] Starting subtest: y-tiled-16bpp-rotate-90
[243.915956] Subtest y-tiled-16bpp-rotate-90: SUCCESS (0.882s)
[244.023676] [077/142] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[244.126819] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[245.341215] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.217s)
[245.434135] [078/142] (735s left) kms_plane_scaling (planes-upscale-factor-0-25)
[245.532114] Starting subtest: planes-upscale-factor-0-25
[245.533921] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.590184] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.057s)
[245.596184] Starting dynamic subtest: pipe-B-HDMI-A-1
[245.699437] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.107s)
[245.707247] Starting dynamic subtest: pipe-C-HDMI-A-1
[245.815322] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.114s)
[245.821496] Starting dynamic subtest: pipe-D-HDMI-A-1
[245.924379] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.107s)
[245.925188] Subtest planes-upscale-factor-0-25: SUCCESS (0.393s)
[246.045298] [079/142] (734s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[246.145053] Starting subtest: primary-yf-tiled-reflect-x-270
[246.198035] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.052s)
[246.237752] [080/142] (734s left) kms_vblank (pipe-b-ts-continuation-suspend)
[246.335087] Starting subtest: pipe-B-ts-continuation-suspend
[263.082609] Subtest pipe-B-ts-continuation-suspend: SUCCESS (1.434s)
[267.181314] [081/142] (733s left) kms_rotation_crc (multiplane-rotation)
[267.280626] Starting subtest: multiplane-rotation
[276.668815] Subtest multiplane-rotation: SUCCESS (9.388s)
[276.740763] [082/142] (723s left) gem_mmap (basic-small-bo)
[276.791082] Starting subtest: basic-small-bo
[276.902816] Subtest basic-small-bo: SUCCESS (0.113s)
[276.957043] [083/142] (723s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[277.110909] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[277.112344] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[277.163340] [084/142] (723s left) api_intel_allocator (standalone)
[277.212480] Starting subtest: standalone
[277.228581] Subtest standalone: SUCCESS (0.017s)
[277.298594] [085/142] (723s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[277.406041] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[277.407460] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[277.466391] [086/142] (722s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[277.513318] Starting subtest: addfb25-x-tiled-mismatch-legacy
[277.514058] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[277.624898] [087/142] (722s left) i915_pm_rpm (modeset-pc8-residency-stress)
[279.208469] Starting subtest: modeset-pc8-residency-stress
[279.211125] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[279.353978] [088/142] (720s left) gem_mmap_gtt (big-copy-odd)
[279.405303] Starting subtest: big-copy-odd
[286.318523] Subtest big-copy-odd: SUCCESS (6.914s)
[286.379373] [089/142] (713s left) dmabuf_sync_file (import-multiple-read-only)
[286.462721] Starting subtest: import-multiple-read-only
[286.470713] Subtest import-multiple-read-only: SUCCESS (0.009s)
[286.508026] [090/142] (713s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[286.865378] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[286.866931] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[286.988683] [091/142] (713s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[287.265530] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[287.266336] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[287.481104] [092/142] (712s left) gem_softpin (zero)
[287.531901] Starting subtest: zero
[287.534466] Subtest zero: SUCCESS (0.003s)
[287.605813] [093/142] (712s left) gem_softpin (noreloc-interruptible)
[287.658110] Starting subtest: noreloc-interruptible
[293.078336] Subtest noreloc-interruptible: SUCCESS (5.419s)
[293.153351] [094/142] (707s left) kms_psr (psr2_cursor_mmap_cpu)
[293.211313] Subtest psr2_cursor_mmap_cpu: SKIP (0.000s)
[293.232156] [095/142] (707s left) kms_legacy_colorkey (invalid-plane)
[293.326861] Starting subtest: invalid-plane
[293.327630] Starting dynamic subtest: zero-id
[293.328372] Dynamic subtest zero-id: SUCCESS (0.000s)
[293.334476] Starting dynamic subtest: outrange-id
[293.335236] Dynamic subtest outrange-id: SUCCESS (0.000s)
[293.335960] Subtest invalid-plane: SUCCESS (0.001s)
[293.364543] [096/142] (707s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_gen12_rc_ccs)
[293.545960] Starting subtest: pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs
[293.546775] Subtest pipe-A-bad-aux-stride-y_tiled_gen12_rc_ccs: SUCCESS (0.001s)
[293.840874] [097/142] (706s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[294.084011] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[294.086915] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[294.294909] [098/142] (706s left) gem_ccs (block-multicopy-inplace)
[294.344929] Starting subtest: block-multicopy-inplace
[294.346545] Subtest block-multicopy-inplace: SKIP (0.000s)
[294.386528] [099/142] (706s left) kms_hdr (bpc-switch-suspend)
[294.484104] Starting subtest: bpc-switch-suspend
[294.485656] Subtest bpc-switch-suspend: SKIP (0.000s)
[294.519974] [100/142] (705s left) gem_exec_schedule (u-fairslice-all)
[294.575680] Starting subtest: u-fairslice-all
[296.610642] Subtest u-fairslice-all: SUCCESS (2.035s)
[296.888083] [101/142] (703s left) syncobj_timeline (reset-signaled)
[296.943891] Starting subtest: reset-signaled
[296.944675] Subtest reset-signaled: SUCCESS (0.000s)
[296.987798] [102/142] (703s left) gem_exec_schedule (implicit-read-write)
[297.051315] Starting subtest: implicit-read-write
[297.052051] Starting dynamic subtest: rcs0
[297.103046] Dynamic subtest rcs0: SUCCESS (0.052s)
[297.117279] Starting dynamic subtest: bcs0
[297.164031] Dynamic subtest bcs0: SUCCESS (0.059s)
[297.175325] Starting dynamic subtest: vcs0
[297.221826] Dynamic subtest vcs0: SUCCESS (0.056s)
[297.232959] Starting dynamic subtest: vcs1
[297.278614] Dynamic subtest vcs1: SUCCESS (0.055s)
[297.290298] Starting dynamic subtest: vecs0
[297.336851] Dynamic subtest vecs0: SUCCESS (0.057s)
[297.337939] Subtest implicit-read-write: SUCCESS (0.287s)
[297.619163] [103/142] (702s left) vgem_basic (sysfs)
[297.680773] Starting subtest: sysfs
[297.681525] Subtest sysfs: SUCCESS (0.000s)
[297.711611] [104/142] (702s left) kms_properties (get_properties-sanity-atomic)
[297.812957] Starting subtest: get_properties-sanity-atomic
[297.817734] Subtest get_properties-sanity-atomic: SUCCESS (0.005s)
[297.855124] [105/142] (702s left) gem_exec_balancer (persistence)
[298.116392] Starting subtest: persistence
[298.951681] Subtest persistence: SUCCESS (0.835s)
[298.986118] [106/142] (701s left) kms_vblank (pipe-b-wait-idle)
[299.085492] Starting subtest: pipe-B-wait-idle
[300.339659] Subtest pipe-B-wait-idle: SUCCESS (1.255s)
[300.448596] [107/142] (700s left) gen3_render_tiledy_blits
[300.516354] [108/142] (700s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[300.570442] Starting subtest: yf-tiled-ccs-to-x-tiled
[300.571338] Starting dynamic subtest: smem
[300.671409] Dynamic subtest smem: SUCCESS (0.100s)
[300.672279] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.101s)
[300.826532] [109/142] (699s left) gen7_exec_parse (batch-without-end)
[300.877805] Subtest batch-without-end: SKIP (0.000s)
[300.899151] [110/142] (699s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[301.005002] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[301.333438] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.329s)
[301.439048] [111/142] (699s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[301.495221] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[301.600929] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[301.650951] [112/142] (699s left) kms_ccs (pipe-b-bad-rotation-90-4_tiled_mtl_rc_ccs_cc)
[301.850777] Starting subtest: pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc
[301.852167] Subtest pipe-B-bad-rotation-90-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[302.106015] [113/142] (698s left) kms_plane_multiple (tiling-x)
[302.200780] Starting subtest: tiling-x
[302.202591] Starting dynamic subtest: pipe-A-HDMI-A-1
[302.711542] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.510s)
[302.718396] Starting dynamic subtest: pipe-B-HDMI-A-1
[303.221783] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.508s)
[303.228347] Starting dynamic subtest: pipe-C-HDMI-A-1
[303.752058] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.529s)
[303.758818] Starting dynamic subtest: pipe-D-HDMI-A-1
[304.263291] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.510s)
[304.264035] Subtest tiling-x: SUCCESS (2.063s)
[304.353643] [114/142] (696s left) gem_exec_balancer (bonded-chain)
[304.411239] Starting subtest: bonded-chain
[311.233323] Subtest bonded-chain: SUCCESS (6.822s)
[311.469092] [115/142] (689s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[311.572304] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[311.575455] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s)
[311.611051] [116/142] (689s left) perf (missing-sample-flags)
[311.700978] Starting subtest: missing-sample-flags
[311.701708] Subtest missing-sample-flags: SUCCESS (0.000s)
[311.716558] [117/142] (689s left) kms_frontbuffer_tracking (fbc-tiling-y)
[311.815476] Starting subtest: fbc-tiling-y
[312.946976] Subtest fbc-tiling-y: SUCCESS (1.133s)
[313.047293] [118/142] (687s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[313.149970] Starting subtest: cursor-vs-flip-atomic-transitions
[341.531148] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (28.381s)
[341.632826] [119/142] (659s left) prime_mmap_coherency (read)
[341.687648] Starting subtest: read
[347.067864] Subtest read: SUCCESS (5.378s)
[347.146466] [120/142] (653s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[347.218848] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[347.249302] [121/142] (653s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[347.304814] Starting subtest: multi-wait-all-for-submit-available-signaled
[347.305543] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[347.340477] [122/142] (653s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[347.437111] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[347.437873] Starting dynamic subtest: pipe-A-valid-mode
[347.484605] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s)
[347.486103] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.048s)
[347.559317] [123/142] (653s left) kms_atomic_interruptible (legacy-cursor)
[347.658512] Starting subtest: legacy-cursor
[347.661000] Starting dynamic subtest: HDMI-A-1-pipe-A
[353.882626] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.221s)
[353.883368] Subtest legacy-cursor: SUCCESS (6.224s)
[353.989025] [124/142] (646s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[354.302543] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[355.092974] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.790s)
[355.267418] [125/142] (645s left) kms_ccs (pipe-a-random-ccs-data-4_tiled_mtl_rc_ccs_cc)
[355.433231] Starting subtest: pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc
[355.435604] Subtest pipe-A-random-ccs-data-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[355.720608] [126/142] (645s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[356.071720] Starting subtest: pipe-D-bad-pixel-format-y_tiled_ccs
[356.073256] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[356.212116] [127/142] (644s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[356.311879] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[356.313610] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[356.378711] [128/142] (644s left) gem_ctx_engines (execute-oneforall)
[356.443454] Starting subtest: execute-oneforall
[356.633893] Subtest execute-oneforall: SUCCESS (0.190s)
[356.776502] [129/142] (644s left) gem_exec_reloc (basic-wc-gtt-active)
[356.827159] Starting subtest: basic-wc-gtt-active
[356.939399] Subtest basic-wc-gtt-active: SUCCESS (0.111s)
[357.026784] [130/142] (643s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc)
[357.192200] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc
[357.193108] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[357.478495] [131/142] (643s left) gem_ctx_param (basic)
[357.530516] Starting subtest: basic
[357.531377] Subtest basic: SUCCESS (0.000s)
[357.570846] [132/142] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[357.686784] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[357.688326] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[357.745141] [133/142] (643s left) prime_mmap (test_refcounting)
[357.801573] Starting subtest: test_refcounting
[357.802333] Starting dynamic subtest: test_refcounting-smem
[357.803081] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s)
[357.803856] Subtest test_refcounting: SUCCESS (0.002s)
[357.859733] [134/142] (643s left) kms_flip (plain-flip-ts-check-interruptible)
[357.943957] Starting subtest: plain-flip-ts-check-interruptible
[357.947564] Starting dynamic subtest: A-HDMI-A1
[365.757842] Dynamic subtest A-HDMI-A1: SUCCESS (7.810s)
[365.765740] Starting dynamic subtest: B-HDMI-A1
[373.525631] Dynamic subtest B-HDMI-A1: SUCCESS (7.767s)
[373.531367] Starting dynamic subtest: C-HDMI-A1
[381.289450] Dynamic subtest C-HDMI-A1: SUCCESS (7.763s)
[381.296863] Starting dynamic subtest: D-HDMI-A1
[389.049087] Dynamic subtest D-HDMI-A1: SUCCESS (7.758s)
[389.051877] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.108s)
[389.188768] [135/142] (611s left) gem_media_vme
[389.255637] [136/142] (611s left) prime_self_import (basic-with_two_bos)
[389.302993] Starting subtest: basic-with_two_bos
[389.305499] Subtest basic-with_two_bos: SUCCESS (0.002s)
[389.362659] [137/142] (611s left) syncobj_basic (bad-destroy-pad)
[389.414221] Starting subtest: bad-destroy-pad
[389.414941] Subtest bad-destroy-pad: SUCCESS (0.000s)
[389.454588] [138/142] (611s left) tools_test (sysfs_l3_parity)
[389.512059] Starting subtest: sysfs_l3_parity
[389.574334] Subtest sysfs_l3_parity: SKIP (0.067s)
[389.616028] [139/142] (611s left) syncobj_basic (bad-flags-fd-to-handle)
[389.668267] Starting subtest: bad-flags-fd-to-handle
[389.668984] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[389.709026] [140/142] (611s left) v3d/v3d_job_submission (multiple-singlesync-to-multisync)
[389.773919] Subtest multiple-singlesync-to-multisync: SKIP (0.000s)
[389.803904] [141/142] (611s left) kms_color (ctm-0-75)
[389.908743] Starting subtest: ctm-0-75
[389.909605] Starting dynamic subtest: pipe-A
[390.913393] Dynamic subtest pipe-A: SUCCESS (1.003s)
[390.928304] Starting dynamic subtest: pipe-B
[391.883619] Dynamic subtest pipe-B: SUCCESS (0.970s)
[391.890131] Starting dynamic subtest: pipe-C
[392.791586] Dynamic subtest pipe-C: SUCCESS (0.908s)
[392.797566] Starting dynamic subtest: pipe-D
[393.690121] Dynamic subtest pipe-D: SUCCESS (0.898s)
[393.690848] Subtest ctm-0-75: SUCCESS (3.782s)
[393.782572] [142/142] (607s left) kms_chamelium_color (ctm-0-75)
[393.886276] Subtest ctm-0-75: SKIP (0.000s)
[393.906656] Closing watchdogs
Done.