[44.252635] Initializing watchdogs [44.252739] /dev/watchdog0 [44.260628] [001/144] (960s left) v3d/v3d_perfmon (create-perfmon-invalid-counters) [44.371307] Subtest create-perfmon-invalid-counters: SKIP (0.000s) [44.419092] [002/144] (960s left) gem_exec_whisper (basic-normal-all) [44.493725] Starting subtest: basic-normal-all [46.771387] Subtest basic-normal-all: SUCCESS (2.276s) [46.995961] [003/144] (957s left) gem_exec_params (invalid-batch-start-offset) [47.089687] Starting subtest: invalid-batch-start-offset [47.092829] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [47.218408] [004/144] (957s left) gem_lmem_swapping (random) [57.397050] Starting subtest: random [57.397951] Starting dynamic subtest: lmem0 [58.330465] Dynamic subtest lmem0: SUCCESS (0.930s) [58.331420] Subtest random: SUCCESS (0.931s) [59.321690] [005/144] (945s left) syncobj_timeline (multi-wait-all-available-signaled) [68.066518] Starting subtest: multi-wait-all-available-signaled [68.067303] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [69.026230] [006/144] (935s left) kms_vblank (wait-idle) [71.003276] Starting subtest: wait-idle [71.004203] Starting dynamic subtest: pipe-A-HDMI-A-4 [73.320157] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.316s) [73.328423] Starting dynamic subtest: pipe-D-HDMI-A-4 [75.484726] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.159s) [75.485593] Subtest wait-idle: SUCCESS (4.481s) [75.584538] [007/144] (929s left) kms_psr (psr-sprite-plane-onoff) [77.556531] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [77.577119] [008/144] (927s left) perf_pmu (init-sema) [77.631799] Starting subtest: init-sema [77.632842] Starting dynamic subtest: rcs0 [77.636174] Dynamic subtest rcs0: SUCCESS (0.004s) [77.641455] Starting dynamic subtest: bcs0 [77.642527] Dynamic subtest bcs0: SUCCESS (0.000s) [77.647879] Starting dynamic subtest: vcs0 [77.648903] Dynamic subtest vcs0: SUCCESS (0.000s) [77.654696] Starting dynamic subtest: vcs1 [77.656066] Dynamic subtest vcs1: SUCCESS (0.000s) [77.662185] Starting dynamic subtest: vecs0 [77.663502] Dynamic subtest vecs0: SUCCESS (0.000s) [77.664817] Subtest init-sema: SUCCESS (0.006s) [77.738074] [009/144] (927s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [77.850739] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [77.851871] Starting dynamic subtest: smem [77.953778] Dynamic subtest smem: SUCCESS (0.103s) [77.960109] Starting dynamic subtest: lmem0 [78.894112] Dynamic subtest lmem0: SUCCESS (0.937s) [78.894971] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.041s) [79.127164] [010/144] (925s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [81.098383] Starting subtest: psr-rgb101010-draw-blt [81.100618] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [81.171353] [011/144] (923s left) kms_cursor_crc (cursor-offscreen-128x42) [83.362236] Starting subtest: cursor-offscreen-128x42 [83.368997] Starting dynamic subtest: pipe-A-HDMI-A-4 [85.926675] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.557s) [85.949940] Starting dynamic subtest: pipe-D-HDMI-A-4 [88.307191] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.361s) [88.308134] Subtest cursor-offscreen-128x42: SUCCESS (4.944s) [88.622506] [012/144] (916s left) v3d/v3d_job_submission (array-job-submission) [88.707646] Subtest array-job-submission: SKIP (0.000s) [88.756207] [013/144] (916s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf-tiled-ccs) [90.828559] Starting subtest: pipe-B-crc-sprite-planes-basic-yf-tiled-ccs [90.832944] Subtest pipe-B-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.003s) [90.991840] [014/144] (914s left) kms_ccs (pipe-a-missing-ccs-buffer-yf-tiled-ccs) [93.015878] Starting subtest: pipe-A-missing-ccs-buffer-yf-tiled-ccs [93.017805] Subtest pipe-A-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s) [93.223274] [015/144] (911s left) sw_sync (sync_expired_merge) [93.267582] Starting subtest: sync_expired_merge [94.344403] Subtest sync_expired_merge: SUCCESS (1.074s) [94.390361] [016/144] (910s left) vc4/vc4_perfmon (destroy-valid-perfmon) [94.460648] Subtest destroy-valid-perfmon: SKIP (0.000s) [94.512073] [017/144] (910s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs) [96.602502] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs [96.604482] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s) [96.789387] [018/144] (908s left) vc4/vc4_perfmon (create-perfmon-exceed) [96.859817] Subtest create-perfmon-exceed: SKIP (0.000s) [96.907780] [019/144] (908s left) kms_big_fb (4-tiled-32bpp-rotate-270) [98.883165] Starting subtest: 4-tiled-32bpp-rotate-270 [98.885122] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s) [98.960185] [020/144] (906s left) gem_pwrite (basic-random) [99.066934] Subtest basic-random: SKIP (0.000s) [99.100927] [021/144] (906s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [101.080519] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [101.085559] Starting dynamic subtest: pipe-A-HDMI-A-4 [101.099567] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.013s) [101.108449] Starting dynamic subtest: pipe-B-HDMI-A-4 [101.127465] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.023s) [101.134925] Starting dynamic subtest: pipe-C-HDMI-A-4 [101.154769] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.023s) [101.162674] Starting dynamic subtest: pipe-D-HDMI-A-4 [101.182978] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.023s) [101.184994] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.101s) [101.273127] [022/144] (903s left) prime_vgem (shrink) [101.378524] Starting subtest: shrink [101.385904] Subtest shrink: SUCCESS (0.007s) [101.464361] [023/144] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [103.435592] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [103.437351] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [103.508685] [024/144] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [105.567258] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [105.569253] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [105.644122] [025/144] (899s left) perf (mi-rpc) [105.824088] Starting subtest: mi-rpc [105.826259] Subtest mi-rpc: SKIP (0.000s) [105.854411] [026/144] (899s left) kms_psr2_sf (fbc-plane-move-sf-dmg-area) [105.922290] Subtest fbc-plane-move-sf-dmg-area: SKIP (0.000s) [105.988344] [027/144] (899s left) gem_eio (in-flight-suspend) [106.162251] Starting subtest: in-flight-suspend [147.884828] Subtest in-flight-suspend: SUCCESS (15.576s) [154.880944] [028/144] (881s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [155.010180] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [155.011209] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [155.087875] [029/144] (881s left) gem_ctx_exec (basic-close-race) [155.149532] Starting subtest: basic-close-race [160.699595] Subtest basic-close-race: SUCCESS (5.547s) [160.853831] [030/144] (875s left) i915_hangman (gt-engine-error) [160.934944] Starting subtest: gt-engine-error [160.935850] Starting dynamic subtest: rcs0 [161.627534] Dynamic subtest rcs0: SUCCESS (0.692s) [161.635510] Starting dynamic subtest: bcs0 [162.285651] Dynamic subtest bcs0: SUCCESS (0.658s) [162.293770] Starting dynamic subtest: vcs0 [162.947534] Dynamic subtest vcs0: SUCCESS (0.662s) [162.955295] Starting dynamic subtest: vcs1 [163.604487] Dynamic subtest vcs1: SUCCESS (0.657s) [163.612772] Starting dynamic subtest: vecs0 [164.271678] Dynamic subtest vecs0: SUCCESS (0.667s) [164.272689] Subtest gt-engine-error: SUCCESS (3.337s) [164.382561] [031/144] (872s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [164.440940] Starting subtest: etime-single-wait-for-submit-submitted [164.552130] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s) [164.638665] [032/144] (871s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [166.724563] Starting subtest: pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc [166.808698] Subtest pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.084s) [167.033513] [033/144] (869s left) i915_query (query-topology-garbage-items) [167.102498] Starting subtest: query-topology-garbage-items [167.103435] Subtest query-topology-garbage-items: SUCCESS (0.000s) [167.206076] [034/144] (869s left) syncobj_wait (wait-all-for-submit-snapshot) [167.274962] Starting subtest: wait-all-for-submit-snapshot [167.358763] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [167.463197] [035/144] (869s left) gem_exec_reloc (basic-cpu-read-active) [167.554856] Subtest basic-cpu-read-active: SKIP (0.000s) [167.592659] [036/144] (869s left) gem_exec_fence (keep-in-fence) [167.790280] Starting subtest: keep-in-fence [167.791232] Starting dynamic subtest: rcs0 [167.858222] Dynamic subtest rcs0: SUCCESS (0.071s) [167.867536] Starting dynamic subtest: bcs0 [167.909803] Dynamic subtest bcs0: SUCCESS (0.051s) [167.920351] Starting dynamic subtest: vcs0 [167.963321] Dynamic subtest vcs0: SUCCESS (0.053s) [167.974991] Starting dynamic subtest: vcs1 [168.017421] Dynamic subtest vcs1: SUCCESS (0.053s) [168.051415] Starting dynamic subtest: vecs0 [168.095562] Dynamic subtest vecs0: SUCCESS (0.078s) [168.096958] Subtest keep-in-fence: SUCCESS (0.308s) [168.626774] [037/144] (868s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [171.202571] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [171.284067] [038/144] (865s left) gem_exec_balancer (hog) [171.352208] Starting subtest: hog [171.354012] Subtest hog: SKIP (0.000s) [171.720057] [039/144] (864s left) vgem_basic (second-client) [171.782408] Starting subtest: second-client [171.816523] Subtest second-client: SUCCESS (0.034s) [171.869485] [040/144] (864s left) gem_exec_balancer (sequential) [171.940417] Starting subtest: sequential [175.285900] Subtest sequential: SUCCESS (3.343s) [175.582927] [041/144] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [177.564040] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [177.565646] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [177.637141] [042/144] (859s left) kms_fbcon_fbt (fbc) [177.775212] Starting subtest: fbc [181.151238] Subtest fbc: SUCCESS (3.372s) [181.180074] [043/144] (855s left) kms_feature_discovery (display-3x) [183.146542] Starting subtest: display-3x [183.148581] Subtest display-3x: SKIP (0.000s) [183.218615] [044/144] (853s left) i915_pm_rps (engine-order) [183.374343] Starting subtest: engine-order [191.185642] Subtest engine-order: SUCCESS (7.807s) [191.378668] [045/144] (845s left) kms_invalid_mode (bad-vsync-end) [193.354573] Starting subtest: bad-vsync-end [193.355674] Starting dynamic subtest: pipe-A-HDMI-A-4 [193.383848] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.030s) [193.392122] Starting dynamic subtest: pipe-B-HDMI-A-4 [193.393202] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [193.401544] Starting dynamic subtest: pipe-C-HDMI-A-4 [193.402807] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [193.410858] Starting dynamic subtest: pipe-D-HDMI-A-4 [193.411911] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [193.412949] Subtest bad-vsync-end: SUCCESS (0.038s) [193.490913] [046/144] (843s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [195.659795] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [195.660713] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.000s) [195.774753] [047/144] (841s left) gem_ctx_param (root-set) [195.832787] Starting subtest: root-set [195.834795] Subtest root-set: SUCCESS (0.001s) [195.947995] [048/144] (840s left) kms_lease (lease-again) [197.932145] Starting subtest: lease-again [197.933165] Starting dynamic subtest: pipe-A-HDMI-A-4 [197.936112] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.004s) [197.945943] Starting dynamic subtest: pipe-B-HDMI-A-4 [197.946899] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.003s) [197.955215] Starting dynamic subtest: pipe-C-HDMI-A-4 [197.956182] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.003s) [197.964497] Starting dynamic subtest: pipe-D-HDMI-A-4 [197.965856] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.003s) [197.967251] Subtest lease-again: SUCCESS (0.020s) [198.048254] [049/144] (838s left) kms_plane_lowres (tiling-x) [200.082729] Starting subtest: tiling-x [200.085631] Starting dynamic subtest: pipe-A-HDMI-A-4 [209.231649] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.147s) [209.295091] Starting dynamic subtest: pipe-B-HDMI-A-4 [218.223394] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (8.936s) [218.288502] Starting dynamic subtest: pipe-C-HDMI-A-4 [227.178864] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (8.898s) [227.259943] Starting dynamic subtest: pipe-D-HDMI-A-4 [236.151400] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (8.898s) [236.189021] Subtest tiling-x: SUCCESS (36.106s) [236.316784] [050/144] (800s left) fbdev (unaligned-read) [236.381887] Starting subtest: unaligned-read [236.391497] Subtest unaligned-read: SUCCESS (0.010s) [236.454355] [051/144] (800s left) gem_ctx_isolation (nonpriv-switch) [236.535091] Starting subtest: nonpriv-switch [236.535968] Starting dynamic subtest: rcs0 [237.525996] Dynamic subtest rcs0: SUCCESS (0.990s) [237.536019] Starting dynamic subtest: bcs0 [238.634573] Dynamic subtest bcs0: SUCCESS (1.107s) [238.644827] Starting dynamic subtest: vcs0 [239.727845] Dynamic subtest vcs0: SUCCESS (1.092s) [239.737823] Starting dynamic subtest: vcs1 [240.809204] Dynamic subtest vcs1: SUCCESS (1.080s) [240.819539] Starting dynamic subtest: vecs0 [241.942616] Dynamic subtest vecs0: SUCCESS (1.132s) [241.943549] Subtest nonpriv-switch: SUCCESS (5.408s) [242.222968] [052/144] (794s left) kms_prime (basic-crc-hybrid) [244.197343] Subtest basic-crc-hybrid: SKIP (0.000s) [244.269413] [053/144] (792s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [246.303639] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [246.323841] [054/144] (790s left) kms_big_fb (y-tiled-16bpp-rotate-270) [248.301157] Starting subtest: y-tiled-16bpp-rotate-270 [250.017377] Subtest y-tiled-16bpp-rotate-270: SUCCESS (1.712s) [250.134550] [055/144] (786s left) kms_atomic_transition (plane-toggle-modeset-transition) [252.105446] Starting subtest: plane-toggle-modeset-transition [252.108564] Starting dynamic subtest: pipe-A-HDMI-A-4 [253.578568] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (1.471s) [253.589558] Starting dynamic subtest: pipe-B-HDMI-A-4 [254.823009] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (1.240s) [254.823977] Subtest plane-toggle-modeset-transition: SUCCESS (2.719s) [254.920178] [056/144] (782s left) kms_pm_dc (dc5-dpms-negative) [257.895069] Starting subtest: dc5-dpms-negative [262.311303] Subtest dc5-dpms-negative: SUCCESS (4.414s) [262.565489] [057/144] (774s left) kms_properties (connector-properties-atomic) [264.528379] Starting subtest: connector-properties-atomic [264.694891] Subtest connector-properties-atomic: SUCCESS (0.166s) [264.815057] [058/144] (772s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [266.931410] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [266.934883] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.001s) [267.064381] [059/144] (770s left) perf_pmu (busy-accuracy-50) [267.116750] Starting subtest: busy-accuracy-50 [267.117798] Starting dynamic subtest: rcs0 [268.664049] Dynamic subtest rcs0: SUCCESS (1.546s) [268.672784] Starting dynamic subtest: bcs0 [270.212153] Dynamic subtest bcs0: SUCCESS (1.547s) [270.221014] Starting dynamic subtest: vcs0 [271.759202] Dynamic subtest vcs0: SUCCESS (1.546s) [271.767963] Starting dynamic subtest: vcs1 [273.306156] Dynamic subtest vcs1: SUCCESS (1.546s) [273.314878] Starting dynamic subtest: vecs0 [274.853358] Dynamic subtest vecs0: SUCCESS (1.546s) [274.854356] Subtest busy-accuracy-50: SUCCESS (7.736s) [274.966066] [060/144] (762s left) gem_ctx_persistence (saturated-hostile) [275.036476] Starting subtest: saturated-hostile [275.037353] Starting dynamic subtest: rcs0 [275.169155] Dynamic subtest rcs0: SUCCESS (0.132s) [275.184892] Starting dynamic subtest: bcs0 [275.265810] Dynamic subtest bcs0: SUCCESS (0.094s) [275.284399] Starting dynamic subtest: vcs0 [275.353567] Dynamic subtest vcs0: SUCCESS (0.082s) [275.380025] Starting dynamic subtest: vcs1 [275.468380] Dynamic subtest vcs1: SUCCESS (0.112s) [275.503814] Starting dynamic subtest: vecs0 [275.566863] Dynamic subtest vecs0: SUCCESS (0.094s) [275.572496] Subtest saturated-hostile: SUCCESS (0.532s) [275.708480] [061/144] (761s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [277.697103] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [277.699081] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [277.792163] [062/144] (759s left) core_setmaster_vs_auth [278.081193] [063/144] (759s left) kms_psr (pr-suspend) [280.172863] Subtest pr-suspend: SKIP (0.000s) [280.205646] [064/144] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [282.176703] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [282.178861] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [282.252450] [065/144] (755s left) gem_ctx_shared (q-smoketest-all) [282.402508] Starting subtest: Q-smoketest-all [314.704539] Subtest Q-smoketest-all: SUCCESS (32.294s) [314.985206] [066/144] (722s left) gem_spin_batch (resubmit-all) [315.074886] Starting subtest: resubmit-all [315.075761] Starting dynamic subtest: rcs0 [315.098765] Dynamic subtest rcs0: SUCCESS (0.023s) [315.109791] Starting dynamic subtest: bcs0 [315.110637] Dynamic subtest bcs0: SUCCESS (0.002s) [315.119362] Starting dynamic subtest: vcs0 [315.120142] Dynamic subtest vcs0: SUCCESS (0.003s) [315.128674] Starting dynamic subtest: vcs1 [315.129763] Dynamic subtest vcs1: SUCCESS (0.002s) [315.137967] Starting dynamic subtest: vecs0 [315.139055] Dynamic subtest vecs0: SUCCESS (0.002s) [315.140141] Subtest resubmit-all: SUCCESS (0.038s) [315.363506] [067/144] (721s left) gem_pipe_control_store_loop (reused-buffer) [315.460189] Starting subtest: reused-buffer [317.630755] Subtest reused-buffer: SUCCESS (2.168s) [317.749455] [068/144] (719s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf-tiled-ccs) [319.881918] Starting subtest: pipe-D-crc-primary-rotation-180-yf-tiled-ccs [319.884046] Subtest pipe-D-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [319.994481] [069/144] (717s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [321.967029] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [321.968958] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [322.073962] [070/144] (715s left) gem_exec_reloc (basic-cpu-wc-active) [322.221196] Subtest basic-cpu-wc-active: SKIP (0.000s) [322.270538] [071/144] (715s left) tools_test (sysfs_l3_parity) [322.324965] Starting subtest: sysfs_l3_parity [322.427005] Subtest sysfs_l3_parity: SKIP (0.108s) [322.491084] [072/144] (714s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [324.495754] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [327.395511] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.897s) [327.556633] [073/144] (709s left) kms_getfb (getfb-repeated-different-handles) [327.615925] Starting subtest: getfb-repeated-different-handles [327.616738] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [327.720227] [074/144] (709s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [329.702450] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [329.704363] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [329.809400] [075/144] (707s left) gem_exec_schedule (lateslice) [329.966237] Starting subtest: lateslice [329.967419] Starting dynamic subtest: rcs0 [330.007436] Dynamic subtest rcs0: SUCCESS (0.041s) [330.016545] Starting dynamic subtest: bcs0 [330.029290] Dynamic subtest bcs0: SUCCESS (0.021s) [330.037972] Starting dynamic subtest: vcs0 [330.052515] Dynamic subtest vcs0: SUCCESS (0.022s) [330.061165] Starting dynamic subtest: vcs1 [330.073923] Dynamic subtest vcs1: SUCCESS (0.020s) [330.082982] Starting dynamic subtest: vecs0 [330.095108] Dynamic subtest vecs0: SUCCESS (0.020s) [330.096202] Subtest lateslice: SUCCESS (0.129s) [330.471737] [076/144] (707s left) prime_vgem (basic-gtt) [330.574447] Starting subtest: basic-gtt [330.576366] Subtest basic-gtt: SKIP (0.000s) [330.693445] [077/144] (706s left) kms_cursor_crc (cursor-onscreen-max-size) [332.969511] Starting subtest: cursor-onscreen-max-size [332.972489] Subtest cursor-onscreen-max-size: SKIP (0.000s) [333.104191] [078/144] (704s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [335.100693] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [335.127415] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.025s) [335.198529] [079/144] (702s left) kms_psr (fbc-pr-cursor-mmap-gtt) [337.226174] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [337.286507] [080/144] (700s left) kms_big_fb (x-tiled-64bpp-rotate-90) [339.323434] Starting subtest: x-tiled-64bpp-rotate-90 [339.391534] Subtest x-tiled-64bpp-rotate-90: SKIP (0.066s) [339.508971] [081/144] (698s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [341.519417] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [341.524502] Starting dynamic subtest: pipe-A-HDMI-A-4 [363.709525] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (22.185s) [363.724636] Starting dynamic subtest: pipe-B-HDMI-A-4 [385.663612] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (21.948s) [385.677678] Starting dynamic subtest: pipe-C-HDMI-A-4 [386.052851] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.383s) [386.069252] Starting dynamic subtest: pipe-D-HDMI-A-4 [386.425174] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.366s) [386.426140] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (44.907s) [386.585081] [082/144] (651s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [388.554454] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [388.556290] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [388.834012] [083/144] (648s left) gem_fenced_exec_thrash (too-many-fences) [388.901917] Subtest too-many-fences: SKIP (0.000s) [388.945684] [084/144] (648s left) kms_pipe_crc_basic (bad-source) [390.913236] Starting subtest: bad-source [390.914150] Subtest bad-source: SUCCESS (0.000s) [390.968501] [085/144] (646s left) api_intel_bb (misplaced-blitter) [391.078957] Starting subtest: misplaced-blitter [391.125912] Subtest misplaced-blitter: SUCCESS (0.048s) [391.275226] [086/144] (646s left) kms_psr (psr2-primary-page-flip) [393.275530] Subtest psr2-primary-page-flip: SKIP (0.000s) [393.339789] [087/144] (644s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [395.404995] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [395.407102] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [395.670697] [088/144] (642s left) syncobj_timeline (single-wait-all-available-submitted) [395.761492] Starting subtest: single-wait-all-available-submitted [395.762408] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [395.843350] [089/144] (642s left) kms_chamelium_edid (hdmi-edid-read) [397.856923] Subtest hdmi-edid-read: SKIP (0.000s) [397.915559] [090/144] (640s left) gem_unref_active_buffers [398.219091] [091/144] (639s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [400.212311] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [400.213275] Starting dynamic subtest: pipe-A-valid-mode [400.925965] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.713s) [400.926764] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.715s) [401.051038] [092/144] (637s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [403.029640] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [404.282265] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.251s) [404.464397] [093/144] (633s left) gem_exec_schedule (u-semaphore-resolve) [404.542278] Starting subtest: u-semaphore-resolve [404.604083] Subtest u-semaphore-resolve: SUCCESS (0.062s) [405.011093] [094/144] (633s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [406.972358] Starting subtest: primary-y-tiled-reflect-x-90 [417.510499] Subtest primary-y-tiled-reflect-x-90: SUCCESS (10.537s) [417.711050] [095/144] (620s left) gem_exec_schedule (semaphore-noskip) [417.780064] Starting subtest: semaphore-noskip [418.218435] Subtest semaphore-noskip: SUCCESS (0.436s) [418.580206] [096/144] (619s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [420.560859] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [420.562846] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [420.632595] [097/144] (617s left) kms_cursor_legacy (torture-bo) [422.688523] Starting subtest: torture-bo [422.689674] Starting dynamic subtest: pipe-A [428.318089] Dynamic subtest pipe-A: SUCCESS (5.626s) [428.329696] Starting dynamic subtest: pipe-B [433.782617] Dynamic subtest pipe-B: SUCCESS (5.463s) [433.792376] Starting dynamic subtest: pipe-C [439.257021] Dynamic subtest pipe-C: SUCCESS (5.473s) [439.266212] Starting dynamic subtest: pipe-D [444.729270] Dynamic subtest pipe-D: SUCCESS (5.474s) [444.741204] Starting dynamic subtest: all-pipes [450.204287] Dynamic subtest all-pipes: SUCCESS (5.474s) [450.205247] Subtest torture-bo: SUCCESS (27.516s) [450.276003] [098/144] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [452.292982] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [452.294949] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [452.383739] [099/144] (585s left) api_intel_allocator (fork-simple-stress-signal) [452.534669] Starting subtest: fork-simple-stress-signal [457.964290] Subtest fork-simple-stress-signal: SUCCESS (5.427s) [458.050912] [100/144] (580s left) vgem_basic (bad-flag) [458.170967] Starting subtest: bad-flag [458.171803] Subtest bad-flag: SUCCESS (0.000s) [458.222865] [101/144] (580s left) kms_ccs (pipe-d-bad-pixel-format-yf-tiled-ccs) [460.332015] Starting subtest: pipe-D-bad-pixel-format-yf-tiled-ccs [460.334107] Subtest pipe-D-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [460.457412] [102/144] (577s left) gem_eio (suspend) [460.665027] Starting subtest: suspend [473.277419] Subtest suspend: SUCCESS (12.613s) [480.441825] [103/144] (562s left) drm_mm (drm_mm) [480.495872] Starting subtest: drm_mm [480.721588] Starting dynamic subtest: drm_test_mm_init [480.748784] Dynamic subtest drm_test_mm_init: SUCCESS (0.030s) [480.783461] Starting dynamic subtest: drm_test_mm_debug [480.784633] Dynamic subtest drm_test_mm_debug: SUCCESS (0.002s) [480.797281] Starting dynamic subtest: drm_test_mm_align32 [480.798529] Dynamic subtest drm_test_mm_align32: SUCCESS (0.000s) [480.808287] Starting dynamic subtest: drm_test_mm_align64 [480.809550] Dynamic subtest drm_test_mm_align64: SUCCESS (0.001s) [480.818317] Starting dynamic subtest: drm_test_mm_lowest [480.819419] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.000s) [480.828331] Starting dynamic subtest: drm_test_mm_highest [480.829552] Dynamic subtest drm_test_mm_highest: SUCCESS (0.000s) [480.830848] Subtest drm_mm: SUCCESS (0.280s) [481.018043] [104/144] (562s left) perf_pmu (cpu-hotplug) [481.077813] Starting subtest: cpu-hotplug [481.095545] Subtest cpu-hotplug: SKIP (0.017s) [481.188180] [105/144] (562s left) kms_draw_crc (draw-method-mmap-cpu) [483.155389] Starting subtest: draw-method-mmap-cpu [483.156365] Starting dynamic subtest: xrgb8888-untiled [483.515923] Dynamic subtest xrgb8888-untiled: SUCCESS (0.359s) [483.558077] Starting dynamic subtest: rgb565-untiled [483.848869] Dynamic subtest rgb565-untiled: SUCCESS (0.327s) [483.886342] Starting dynamic subtest: xrgb2101010-untiled [484.182438] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.327s) [484.220725] Starting dynamic subtest: xrgb8888-xtiled [484.382566] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.194s) [484.395114] Starting dynamic subtest: rgb565-xtiled [484.532119] Dynamic subtest rgb565-xtiled: SUCCESS (0.145s) [484.573693] Starting dynamic subtest: xrgb2101010-xtiled [484.715289] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.177s) [484.735064] Starting dynamic subtest: xrgb8888-ytiled [484.882412] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.161s) [484.920672] Starting dynamic subtest: rgb565-ytiled [485.065653] Dynamic subtest rgb565-ytiled: SUCCESS (0.177s) [485.107989] Starting dynamic subtest: xrgb2101010-ytiled [485.247151] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.177s) [485.248233] Subtest draw-method-mmap-cpu: SUCCESS (2.093s) [485.368204] [106/144] (558s left) gem_exec_reloc (basic-gtt-cpu-active) [485.452026] Subtest basic-gtt-cpu-active: SKIP (0.000s) [485.524757] [107/144] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [487.508027] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [487.509879] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [487.612846] [108/144] (555s left) kms_psr (fbc-psr-suspend) [489.664237] Subtest fbc-psr-suspend: SKIP (0.000s) [489.691762] [109/144] (553s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [491.667199] Starting subtest: yf-tiled-16bpp-rotate-180 [491.669419] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [491.760550] [110/144] (551s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [493.861958] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [493.863915] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s) [494.083534] [111/144] (549s left) prime_self_import (basic-llseek-bad) [494.130843] Starting subtest: basic-llseek-bad [494.145837] Subtest basic-llseek-bad: SUCCESS (0.015s) [494.272684] [112/144] (549s left) kms_big_fb (linear-8bpp-rotate-180) [496.268866] Starting subtest: linear-8bpp-rotate-180 [497.951301] Subtest linear-8bpp-rotate-180: SUCCESS (1.678s) [498.034032] [113/144] (545s left) gem_mmap_offset (isolation) [498.093696] Starting subtest: isolation [498.102343] Subtest isolation: SUCCESS (0.007s) [498.226496] [114/144] (545s left) gem_exec_reloc (basic-write-gtt) [498.326080] Subtest basic-write-gtt: SKIP (0.000s) [498.379706] [115/144] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [500.364510] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [500.366654] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [500.461887] [116/144] (543s left) dmabuf_sync_file (import-basic) [500.614574] Starting subtest: import-basic [500.617453] Subtest import-basic: SUCCESS (0.002s) [500.667682] [117/144] (543s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [502.767114] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [502.769162] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s) [502.950359] [118/144] (540s left) syncobj_wait (invalid-single-wait-unsubmitted) [503.018394] Starting subtest: invalid-single-wait-unsubmitted [503.019242] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [503.124588] [119/144] (540s left) gem_userptr_blits (vma-merge) [503.218653] Starting subtest: vma-merge [523.321083] Subtest vma-merge: FAIL (20.084s) [523.402694] [120/144] (520s left) syncobj_wait (invalid-multi-wait-unsubmitted) [523.461573] Starting subtest: invalid-multi-wait-unsubmitted [523.462585] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [523.591459] [121/144] (520s left) i915_suspend (sysfs-reader) [523.676939] Starting subtest: sysfs-reader [546.693050] Subtest sysfs-reader: SUCCESS (10.394s) [551.762904] [122/144] (509s left) kms_cursor_crc (cursor-random-64x21) [553.853588] Starting subtest: cursor-random-64x21 [553.860927] Starting dynamic subtest: pipe-A-HDMI-A-4 [558.409432] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.548s) [558.437690] Starting dynamic subtest: pipe-D-HDMI-A-4 [562.872108] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.443s) [562.872913] Subtest cursor-random-64x21: SUCCESS (9.018s) [563.241853] [123/144] (498s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-mc-ccs) [566.937023] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs [566.938665] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s) [567.130610] [124/144] (494s left) kms_setmode (clone-exclusive-crtc) [567.193716] Starting subtest: clone-exclusive-crtc [567.196295] Subtest clone-exclusive-crtc: SKIP (0.000s) [567.262350] [125/144] (494s left) prime_mmap (test_forked) [567.323917] Starting subtest: test_forked [567.324797] Starting dynamic subtest: test_forked-smem [567.405658] Dynamic subtest test_forked-smem: SUCCESS (0.081s) [567.416634] Starting dynamic subtest: test_forked-lmem0 [567.487011] Dynamic subtest test_forked-lmem0: SUCCESS (0.080s) [567.487954] Subtest test_forked: SUCCESS (0.164s) [567.563679] [126/144] (494s left) kms_pipe_crc_basic (disable-crc-after-crtc) [569.843393] Starting subtest: disable-crc-after-crtc [569.844366] Starting dynamic subtest: pipe-A-HDMI-A-4 [570.437843] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.592s) [570.449791] Starting dynamic subtest: pipe-B-HDMI-A-4 [570.871333] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.431s) [570.886316] Starting dynamic subtest: pipe-C-HDMI-A-4 [571.267171] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.390s) [571.285516] Starting dynamic subtest: pipe-D-HDMI-A-4 [571.709601] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.437s) [571.710584] Subtest disable-crc-after-crtc: SUCCESS (1.867s) [571.825309] [127/144] (489s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [571.900696] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [573.918522] [128/144] (487s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [576.009569] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [578.027667] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.018s) [578.170221] [129/144] (483s left) kms_getfb (getfb-reject-ccs) [578.228088] Starting subtest: getfb-reject-ccs [578.228909] Subtest getfb-reject-ccs: SUCCESS (0.000s) [578.309032] [130/144] (483s left) kms_tiled_display (basic-test-pattern) [581.239205] Subtest basic-test-pattern: SKIP (0.000s) [581.266206] [131/144] (480s left) gen9_exec_parse (cmd-crossing-page) [581.339748] Subtest cmd-crossing-page: SKIP (0.000s) [581.385959] [132/144] (480s left) syncobj_timeline (wait-any-complex) [581.479736] Starting subtest: wait-any-complex [581.542143] Subtest wait-any-complex: SUCCESS (0.062s) [581.638969] [133/144] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [583.635355] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [583.637519] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [583.713577] [134/144] (478s left) kms_frontbuffer_tracking (psr-2p-rte) [585.778108] Starting subtest: psr-2p-rte [585.780068] Subtest psr-2p-rte: SKIP (0.000s) [585.865896] [135/144] (476s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [587.905564] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [587.908716] Starting dynamic subtest: pipe-A-valid-mode [588.751001] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.843s) [588.751868] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.845s) [588.866113] [136/144] (473s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [590.844104] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [590.846552] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [590.944997] [137/144] (471s left) v3d/v3d_submit_csd (bad-multisync-extension) [591.113640] Subtest bad-multisync-extension: SKIP (0.000s) [591.165069] [138/144] (470s left) gem_exec_reloc (basic-cpu-gtt) [591.231997] Subtest basic-cpu-gtt: SKIP (0.000s) [591.300270] [139/144] (470s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [593.424861] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs [593.426850] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s) [593.566969] [140/144] (468s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [595.547217] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [595.549317] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [595.644070] [141/144] (466s left) kms_chamelium_hpd (dp-hpd-after-suspend) [597.736776] Subtest dp-hpd-after-suspend: SKIP (0.000s) [597.794587] [142/144] (464s left) kms_chamelium_audio (dp-audio-edid) [599.804195] Subtest dp-audio-edid: SKIP (0.000s) [599.861507] [143/144] (462s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [599.924325] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [600.023793] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s) [600.143622] [144/144] (462s left) kms_color (ctm-blue-to-red) [602.132742] Starting subtest: ctm-blue-to-red [602.133819] Starting dynamic subtest: pipe-A [602.818977] Dynamic subtest pipe-A: SUCCESS (0.686s) [602.828520] Starting dynamic subtest: pipe-B [603.302401] Dynamic subtest pipe-B: SUCCESS (0.483s) [603.311955] Starting dynamic subtest: pipe-C [603.796389] Dynamic subtest pipe-C: SUCCESS (0.493s) [603.809456] Starting dynamic subtest: pipe-D [604.228240] Dynamic subtest pipe-D: SUCCESS (0.430s) [604.229265] Subtest ctm-blue-to-red: SUCCESS (2.098s) [604.348523] Closing watchdogs Done.