[16.918861] Initializing watchdogs [16.918916] /dev/watchdog0 [16.922820] [001/144] (960s left) v3d/v3d_perfmon (create-perfmon-invalid-counters) [16.984961] Subtest create-perfmon-invalid-counters: SKIP (0.000s) [17.012234] [002/144] (960s left) gem_exec_whisper (basic-normal-all) [17.084976] Starting subtest: basic-normal-all [18.950869] Subtest basic-normal-all: SUCCESS (1.865s) [19.108338] [003/144] (958s left) gem_exec_params (invalid-batch-start-offset) [19.173487] Starting subtest: invalid-batch-start-offset [19.176016] Subtest invalid-batch-start-offset: SUCCESS (0.002s) [19.255385] [004/144] (958s left) gem_lmem_swapping (random) [19.306939] Subtest random: SKIP (0.000s) [19.323116] [005/144] (958s left) syncobj_timeline (multi-wait-all-available-signaled) [19.365871] Starting subtest: multi-wait-all-available-signaled [19.366762] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [19.421853] [006/144] (958s left) kms_vblank (wait-idle) [19.520198] Starting subtest: wait-idle [19.520958] Starting dynamic subtest: pipe-A-HDMI-A-1 [20.676371] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.155s) [20.682662] Starting dynamic subtest: pipe-D-HDMI-A-1 [21.821424] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.141s) [21.822212] Subtest wait-idle: SUCCESS (2.301s) [21.920958] [007/144] (955s left) kms_psr (psr-sprite-plane-onoff) [22.011598] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [22.030334] [008/144] (955s left) perf_pmu (init-sema) [22.069702] Starting subtest: init-sema [22.070570] Starting dynamic subtest: rcs0 [22.071398] Dynamic subtest rcs0: SUCCESS (0.001s) [22.076009] Starting dynamic subtest: bcs0 [22.076785] Dynamic subtest bcs0: SUCCESS (0.000s) [22.080196] Starting dynamic subtest: vcs0 [22.081023] Dynamic subtest vcs0: SUCCESS (0.000s) [22.084568] Starting dynamic subtest: vcs1 [22.085398] Dynamic subtest vcs1: SUCCESS (0.000s) [22.088730] Starting dynamic subtest: vecs0 [22.089534] Dynamic subtest vecs0: SUCCESS (0.000s) [22.090367] Subtest init-sema: SUCCESS (0.003s) [22.131704] [009/144] (955s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [22.182335] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [22.183258] Starting dynamic subtest: smem [22.257355] Dynamic subtest smem: SUCCESS (0.075s) [22.258199] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.075s) [22.410941] [010/144] (955s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [22.515864] Starting subtest: psr-rgb101010-draw-blt [22.517330] Subtest psr-rgb101010-draw-blt: SKIP (0.000s) [22.578496] [011/144] (954s left) kms_cursor_crc (cursor-offscreen-128x42) [22.684175] Starting subtest: cursor-offscreen-128x42 [22.689421] Starting dynamic subtest: pipe-A-HDMI-A-1 [23.984177] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.295s) [24.008753] Starting dynamic subtest: pipe-D-HDMI-A-1 [25.209128] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.203s) [25.209968] Subtest cursor-offscreen-128x42: SUCCESS (2.524s) [25.310222] [012/144] (952s left) v3d/v3d_job_submission (array-job-submission) [25.364551] Subtest array-job-submission: SKIP (0.000s) [25.393014] [013/144] (952s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf-tiled-ccs) [25.576539] Starting subtest: pipe-B-crc-sprite-planes-basic-yf-tiled-ccs [25.579607] Subtest pipe-B-crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.002s) [25.698336] [014/144] (951s left) kms_ccs (pipe-a-missing-ccs-buffer-yf-tiled-ccs) [25.856860] Starting subtest: pipe-A-missing-ccs-buffer-yf-tiled-ccs [25.858446] Subtest pipe-A-missing-ccs-buffer-yf-tiled-ccs: SKIP (0.000s) [26.009971] [015/144] (951s left) sw_sync (sync_expired_merge) [26.042542] Starting subtest: sync_expired_merge [27.125256] Subtest sync_expired_merge: SUCCESS (1.074s) [27.144383] [016/144] (950s left) vc4/vc4_perfmon (destroy-valid-perfmon) [27.198783] Subtest destroy-valid-perfmon: SKIP (0.000s) [27.231349] [017/144] (950s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-mtl-mc-ccs) [27.406245] Starting subtest: pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs [27.407886] Subtest pipe-B-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s) [27.545620] [018/144] (950s left) vc4/vc4_perfmon (create-perfmon-exceed) [27.593154] Subtest create-perfmon-exceed: SKIP (0.000s) [27.621547] [019/144] (950s left) kms_big_fb (4-tiled-32bpp-rotate-270) [27.719320] Starting subtest: 4-tiled-32bpp-rotate-270 [27.721125] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s) [27.764326] [020/144] (949s left) gem_pwrite (basic-random) [27.815932] Starting subtest: basic-random [33.501037] Subtest basic-random: SUCCESS (5.651s) [33.524921] [021/144] (944s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [33.664146] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [33.674788] Starting dynamic subtest: pipe-A-HDMI-A-1 [33.688943] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.013s) [33.703928] Starting dynamic subtest: pipe-B-HDMI-A-1 [33.730599] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.030s) [33.744779] Starting dynamic subtest: pipe-C-HDMI-A-1 [33.771651] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.029s) [33.786496] Starting dynamic subtest: pipe-D-HDMI-A-1 [33.812334] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.029s) [33.814038] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.148s) [33.881282] [022/144] (943s left) prime_vgem (shrink) [33.977834] Starting subtest: shrink [33.985639] Subtest shrink: SUCCESS (0.007s) [34.046390] [023/144] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [34.149543] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [34.151198] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [34.212145] [024/144] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [34.320818] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [34.322196] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [34.375185] [025/144] (943s left) perf (mi-rpc) [34.472878] Starting subtest: mi-rpc [34.474236] Subtest mi-rpc: SKIP (0.000s) [34.486116] [026/144] (943s left) kms_psr2_sf (fbc-plane-move-sf-dmg-area) [34.533734] Subtest fbc-plane-move-sf-dmg-area: SKIP (0.000s) [34.571637] [027/144] (943s left) gem_eio (in-flight-suspend) [34.642571] Starting subtest: in-flight-suspend [71.030319] Subtest in-flight-suspend: SUCCESS (7.348s) [77.111318] [028/144] (935s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [77.171280] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [77.172182] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [77.217589] [029/144] (935s left) gem_ctx_exec (basic-close-race) [77.267009] Starting subtest: basic-close-race [82.798910] Subtest basic-close-race: SUCCESS (5.530s) [82.874337] [030/144] (929s left) i915_hangman (gt-engine-error) [82.933426] Starting subtest: gt-engine-error [82.934492] Starting dynamic subtest: rcs0 [82.996485] Dynamic subtest rcs0: SUCCESS (0.062s) [83.007410] Starting dynamic subtest: bcs0 [83.054401] Dynamic subtest bcs0: SUCCESS (0.058s) [83.065296] Starting dynamic subtest: vcs0 [83.118467] Dynamic subtest vcs0: SUCCESS (0.064s) [83.130329] Starting dynamic subtest: vcs1 [83.187527] Dynamic subtest vcs1: SUCCESS (0.069s) [83.199585] Starting dynamic subtest: vecs0 [83.256489] Dynamic subtest vecs0: SUCCESS (0.069s) [83.258073] Subtest gt-engine-error: SUCCESS (0.323s) [83.298098] [031/144] (929s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [83.354068] Starting subtest: etime-single-wait-for-submit-submitted [83.455153] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s) [83.506420] [032/144] (929s left) kms_ccs (pipe-c-bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [83.720219] Starting subtest: pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc [83.786149] Subtest pipe-C-bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.066s) [83.961406] [033/144] (928s left) i915_query (query-topology-garbage-items) [84.004178] Starting subtest: query-topology-garbage-items [84.005101] Subtest query-topology-garbage-items: SUCCESS (0.000s) [84.059793] [034/144] (928s left) syncobj_wait (wait-all-for-submit-snapshot) [84.127509] Starting subtest: wait-all-for-submit-snapshot [84.210049] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [84.253466] [035/144] (928s left) gem_exec_reloc (basic-cpu-read-active) [84.312141] Starting subtest: basic-cpu-read-active [84.429350] Subtest basic-cpu-read-active: SUCCESS (0.117s) [84.520530] [036/144] (928s left) gem_exec_fence (keep-in-fence) [84.698274] Starting subtest: keep-in-fence [84.699800] Starting dynamic subtest: rcs0 [84.725027] Dynamic subtest rcs0: SUCCESS (0.027s) [84.734779] Starting dynamic subtest: bcs0 [84.749933] Dynamic subtest bcs0: SUCCESS (0.025s) [84.761143] Starting dynamic subtest: vcs0 [84.775889] Dynamic subtest vcs0: SUCCESS (0.026s) [84.786623] Starting dynamic subtest: vcs1 [84.810001] Dynamic subtest vcs1: SUCCESS (0.034s) [84.821642] Starting dynamic subtest: vecs0 [84.834197] Dynamic subtest vecs0: SUCCESS (0.024s) [84.835781] Subtest keep-in-fence: SUCCESS (0.136s) [85.263431] [037/144] (927s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [87.849005] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s) [87.882551] [038/144] (925s left) gem_exec_balancer (hog) [87.936069] Starting subtest: hog [88.821731] Subtest hog: SUCCESS (0.885s) [89.085726] [039/144] (923s left) vgem_basic (second-client) [89.133094] Starting subtest: second-client [89.150604] Subtest second-client: SUCCESS (0.017s) [89.183462] [040/144] (923s left) gem_exec_balancer (sequential) [89.242219] Starting subtest: sequential [92.206503] Subtest sequential: SUCCESS (2.964s) [92.469456] [041/144] (920s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [92.576436] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [92.578148] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [92.636559] [042/144] (920s left) kms_fbcon_fbt (fbc) [92.698404] Starting subtest: fbc [96.052668] Subtest fbc: SUCCESS (3.353s) [96.081004] [043/144] (916s left) kms_feature_discovery (display-3x) [96.188105] Starting subtest: display-3x [96.189812] Subtest display-3x: SKIP (0.000s) [96.223375] [044/144] (916s left) i915_pm_rps (engine-order) [96.276765] Starting subtest: engine-order [98.529914] Subtest engine-order: SUCCESS (2.251s) [98.609615] [045/144] (914s left) kms_invalid_mode (bad-vsync-end) [98.705216] Starting subtest: bad-vsync-end [98.706088] Starting dynamic subtest: pipe-A-HDMI-A-1 [98.752838] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.047s) [98.757889] Starting dynamic subtest: pipe-B-HDMI-A-1 [98.758756] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [98.763757] Starting dynamic subtest: pipe-C-HDMI-A-1 [98.764551] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [98.769309] Starting dynamic subtest: pipe-D-HDMI-A-1 [98.770183] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [98.771085] Subtest bad-vsync-end: SUCCESS (0.056s) [98.855418] [046/144] (914s left) kms_ccs (pipe-d-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [99.088547] Starting subtest: pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [99.089507] Subtest pipe-D-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.000s) [99.167245] [047/144] (913s left) gem_ctx_param (root-set) [99.217259] Starting subtest: root-set [99.218683] Subtest root-set: SUCCESS (0.001s) [99.276863] [048/144] (913s left) kms_lease (lease-again) [99.379538] Starting subtest: lease-again [99.381664] Starting dynamic subtest: pipe-A-HDMI-A-1 [99.382426] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s) [99.387693] Starting dynamic subtest: pipe-B-HDMI-A-1 [99.388400] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [99.393297] Starting dynamic subtest: pipe-C-HDMI-A-1 [99.394021] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [99.398936] Starting dynamic subtest: pipe-D-HDMI-A-1 [99.399653] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.002s) [99.400354] Subtest lease-again: SUCCESS (0.012s) [99.456602] [049/144] (913s left) kms_plane_lowres (tiling-x) [99.556295] Starting subtest: tiling-x [99.557237] Starting dynamic subtest: pipe-A-HDMI-A-1 [106.504962] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.947s) [106.586087] Starting dynamic subtest: pipe-B-HDMI-A-1 [113.318547] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.737s) [113.387277] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.057847] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.674s) [120.127683] Starting dynamic subtest: pipe-D-HDMI-A-1 [126.821112] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (6.699s) [126.900725] Subtest tiling-x: SUCCESS (27.337s) [127.006677] [050/144] (886s left) fbdev (unaligned-read) [127.058775] Starting subtest: unaligned-read [127.063468] Subtest unaligned-read: SUCCESS (0.005s) [127.096057] [051/144] (886s left) gem_ctx_isolation (nonpriv-switch) [127.157578] Starting subtest: nonpriv-switch [127.158808] Starting dynamic subtest: rcs0 [127.351702] Dynamic subtest rcs0: SUCCESS (0.192s) [127.356978] Starting dynamic subtest: bcs0 [127.563691] Dynamic subtest bcs0: SUCCESS (0.212s) [127.569076] Starting dynamic subtest: vcs0 [127.777989] Dynamic subtest vcs0: SUCCESS (0.214s) [127.783251] Starting dynamic subtest: vcs1 [127.988815] Dynamic subtest vcs1: SUCCESS (0.210s) [127.994032] Starting dynamic subtest: vecs0 [128.200968] Dynamic subtest vecs0: SUCCESS (0.212s) [128.201787] Subtest nonpriv-switch: SUCCESS (1.044s) [128.363890] [052/144] (884s left) kms_prime (basic-crc-hybrid) [129.073590] Subtest basic-crc-hybrid: SKIP (0.000s) [129.114522] [053/144] (884s left) kms_psr (fbc-psr2-cursor-mmap-cpu) [129.207405] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s) [129.225034] [054/144] (883s left) kms_big_fb (y-tiled-16bpp-rotate-270) [129.327038] Starting subtest: y-tiled-16bpp-rotate-270 [130.250511] Subtest y-tiled-16bpp-rotate-270: SUCCESS (0.923s) [130.345248] [055/144] (882s left) kms_atomic_transition (plane-toggle-modeset-transition) [130.437146] Starting subtest: plane-toggle-modeset-transition [130.438016] Starting dynamic subtest: pipe-A-HDMI-A-1 [132.146475] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.708s) [132.153286] Starting dynamic subtest: pipe-B-HDMI-A-1 [133.770187] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.621s) [133.770995] Subtest plane-toggle-modeset-transition: SUCCESS (3.335s) [133.868982] [056/144] (879s left) kms_pm_dc (dc5-dpms-negative) [134.972389] Starting subtest: dc5-dpms-negative [139.194622] Subtest dc5-dpms-negative: SUCCESS (4.221s) [139.244281] [057/144] (873s left) kms_properties (connector-properties-atomic) [139.340245] Starting subtest: connector-properties-atomic [139.465526] Subtest connector-properties-atomic: SUCCESS (0.124s) [139.546232] [058/144] (873s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [139.757983] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [139.758917] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.001s) [139.860538] [059/144] (873s left) perf_pmu (busy-accuracy-50) [139.895859] Starting subtest: busy-accuracy-50 [139.896763] Starting dynamic subtest: rcs0 [141.419636] Dynamic subtest rcs0: SUCCESS (1.523s) [141.427289] Starting dynamic subtest: bcs0 [142.943349] Dynamic subtest bcs0: SUCCESS (1.523s) [142.949662] Starting dynamic subtest: vcs0 [144.466212] Dynamic subtest vcs0: SUCCESS (1.522s) [144.473901] Starting dynamic subtest: vcs1 [145.990604] Dynamic subtest vcs1: SUCCESS (1.524s) [145.998335] Starting dynamic subtest: vecs0 [147.515079] Dynamic subtest vecs0: SUCCESS (1.524s) [147.516108] Subtest busy-accuracy-50: SUCCESS (7.619s) [147.567131] [060/144] (865s left) gem_ctx_persistence (saturated-hostile) [147.623001] Starting subtest: saturated-hostile [147.623788] Starting dynamic subtest: rcs0 [147.754227] Dynamic subtest rcs0: SUCCESS (0.130s) [147.769943] Starting dynamic subtest: bcs0 [147.874324] Dynamic subtest bcs0: SUCCESS (0.118s) [147.888376] Starting dynamic subtest: vcs0 [147.988278] Dynamic subtest vcs0: SUCCESS (0.112s) [148.004568] Starting dynamic subtest: vcs1 [148.108155] Dynamic subtest vcs1: SUCCESS (0.118s) [148.124054] Starting dynamic subtest: vecs0 [148.221178] Dynamic subtest vecs0: SUCCESS (0.111s) [148.222558] Subtest saturated-hostile: SUCCESS (0.598s) [148.307536] [061/144] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [148.418317] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [148.419886] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [148.476775] [062/144] (864s left) core_setmaster_vs_auth [148.603068] [063/144] (864s left) kms_psr (pr-suspend) [148.702427] Subtest pr-suspend: SKIP (0.000s) [148.722799] [064/144] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [148.811589] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [148.813170] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [148.878798] [065/144] (864s left) gem_ctx_shared (q-smoketest-all) [148.941952] Starting subtest: Q-smoketest-all [181.201844] Subtest Q-smoketest-all: SUCCESS (32.254s) [181.360948] [066/144] (831s left) gem_spin_batch (resubmit-all) [181.428464] Starting subtest: resubmit-all [181.429209] Starting dynamic subtest: rcs0 [181.431838] Dynamic subtest rcs0: SUCCESS (0.003s) [181.437703] Starting dynamic subtest: bcs0 [181.438473] Dynamic subtest bcs0: SUCCESS (0.001s) [181.444088] Starting dynamic subtest: vcs0 [181.444802] Dynamic subtest vcs0: SUCCESS (0.001s) [181.449838] Starting dynamic subtest: vcs1 [181.450556] Dynamic subtest vcs1: SUCCESS (0.001s) [181.455466] Starting dynamic subtest: vecs0 [181.456159] Dynamic subtest vecs0: SUCCESS (0.002s) [181.456842] Subtest resubmit-all: SUCCESS (0.012s) [181.602186] [067/144] (831s left) gem_pipe_control_store_loop (reused-buffer) [181.662777] Starting subtest: reused-buffer [183.816095] Subtest reused-buffer: SUCCESS (2.153s) [183.883899] [068/144] (829s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf-tiled-ccs) [184.128855] Starting subtest: pipe-D-crc-primary-rotation-180-yf-tiled-ccs [184.130483] Subtest pipe-D-crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [184.220965] [069/144] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [184.315903] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [184.317320] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [184.378106] [070/144] (829s left) gem_exec_reloc (basic-cpu-wc-active) [184.433391] Starting subtest: basic-cpu-wc-active [184.550942] Subtest basic-cpu-wc-active: SUCCESS (0.117s) [184.645933] [071/144] (828s left) tools_test (sysfs_l3_parity) [184.692501] Starting subtest: sysfs_l3_parity [184.750604] Subtest sysfs_l3_parity: SKIP (0.063s) [184.790310] [072/144] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [184.885546] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [186.224955] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.340s) [186.327443] [073/144] (827s left) kms_getfb (getfb-repeated-different-handles) [186.385262] Starting subtest: getfb-repeated-different-handles [186.386257] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [186.457904] [074/144] (827s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu) [186.563699] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu [186.565226] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [186.628575] [075/144] (826s left) gem_exec_schedule (lateslice) [186.683177] Starting subtest: lateslice [186.684148] Starting dynamic subtest: rcs0 [186.702475] Dynamic subtest rcs0: SUCCESS (0.019s) [186.708447] Starting dynamic subtest: bcs0 [186.718534] Dynamic subtest bcs0: SUCCESS (0.015s) [186.724437] Starting dynamic subtest: vcs0 [186.732706] Dynamic subtest vcs0: SUCCESS (0.013s) [186.738526] Starting dynamic subtest: vcs1 [186.746318] Dynamic subtest vcs1: SUCCESS (0.013s) [186.752213] Starting dynamic subtest: vecs0 [186.760320] Dynamic subtest vecs0: SUCCESS (0.013s) [186.761448] Subtest lateslice: SUCCESS (0.078s) [187.042494] [076/144] (826s left) prime_vgem (basic-gtt) [187.111398] Starting subtest: basic-gtt [187.124496] Subtest basic-gtt: SUCCESS (0.014s) [187.187125] [077/144] (826s left) kms_cursor_crc (cursor-onscreen-max-size) [187.301141] Starting subtest: cursor-onscreen-max-size [187.303542] Subtest cursor-onscreen-max-size: SKIP (0.000s) [187.339951] [078/144] (826s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [187.439327] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [187.451836] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.012s) [187.488046] [079/144] (826s left) kms_psr (fbc-pr-cursor-mmap-gtt) [187.585308] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [187.606216] [080/144] (825s left) kms_big_fb (x-tiled-64bpp-rotate-90) [187.715539] Starting subtest: x-tiled-64bpp-rotate-90 [187.751187] Subtest x-tiled-64bpp-rotate-90: SKIP (0.035s) [187.828221] [081/144] (825s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [187.916231] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [187.928189] Starting dynamic subtest: pipe-A-HDMI-A-1 [195.459755] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.532s) [195.476385] Starting dynamic subtest: pipe-B-HDMI-A-1 [202.955480] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.483s) [202.971172] Starting dynamic subtest: pipe-C-HDMI-A-1 [203.155690] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.189s) [203.176213] Starting dynamic subtest: pipe-D-HDMI-A-1 [203.364728] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.193s) [203.365893] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (15.449s) [203.504628] [082/144] (810s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [203.596081] Starting subtest: pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [203.597751] Subtest pipe-A-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [203.814069] [083/144] (809s left) gem_fenced_exec_thrash (too-many-fences) [203.861660] Starting subtest: too-many-fences [206.014591] Subtest too-many-fences: SUCCESS (2.152s) [206.102212] [084/144] (807s left) kms_pipe_crc_basic (bad-source) [206.209224] Starting subtest: bad-source [206.210028] Subtest bad-source: SUCCESS (0.000s) [206.248624] [085/144] (807s left) api_intel_bb (misplaced-blitter) [206.292732] Starting subtest: misplaced-blitter [206.298708] Subtest misplaced-blitter: SUCCESS (0.006s) [206.374950] [086/144] (807s left) kms_psr (psr2-primary-page-flip) [206.480722] Subtest psr2-primary-page-flip: SKIP (0.000s) [206.499778] [087/144] (807s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [206.635334] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc [206.636739] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [206.804456] [088/144] (806s left) syncobj_timeline (single-wait-all-available-submitted) [206.846412] Starting subtest: single-wait-all-available-submitted [206.847142] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [206.908138] [089/144] (806s left) kms_chamelium_edid (hdmi-edid-read) [207.057084] Subtest hdmi-edid-read: SKIP (0.000s) [207.114286] [090/144] (806s left) gem_unref_active_buffers [207.259834] [091/144] (806s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [207.361132] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [207.361893] Starting dynamic subtest: pipe-A-valid-mode [208.033422] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.671s) [208.034129] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.673s) [208.136386] [092/144] (805s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [208.235194] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [208.889994] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.654s) [208.988137] [093/144] (804s left) gem_exec_schedule (u-semaphore-resolve) [209.050382] Starting subtest: u-semaphore-resolve [209.065347] Subtest u-semaphore-resolve: SUCCESS (0.015s) [209.348487] [094/144] (804s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [209.440066] Starting subtest: primary-y-tiled-reflect-x-90 [214.526330] Subtest primary-y-tiled-reflect-x-90: SUCCESS (5.087s) [214.687200] [095/144] (799s left) gem_exec_schedule (semaphore-noskip) [214.751140] Starting subtest: semaphore-noskip [215.055616] Subtest semaphore-noskip: SUCCESS (0.303s) [215.323476] [096/144] (798s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [215.448371] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [216.358349] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SUCCESS (0.914s) [216.448060] [097/144] (797s left) kms_cursor_legacy (torture-bo) [216.548226] Starting subtest: torture-bo [216.549034] Starting dynamic subtest: pipe-A [222.003815] Dynamic subtest pipe-A: SUCCESS (5.454s) [222.009971] Starting dynamic subtest: pipe-B [227.474554] Dynamic subtest pipe-B: SUCCESS (5.470s) [227.481322] Starting dynamic subtest: pipe-C [233.024506] Dynamic subtest pipe-C: SUCCESS (5.549s) [233.030027] Starting dynamic subtest: pipe-D [238.532440] Dynamic subtest pipe-D: SUCCESS (5.508s) [238.538559] Starting dynamic subtest: all-pipes [243.996404] Dynamic subtest all-pipes: SUCCESS (5.463s) [243.997279] Subtest torture-bo: SUCCESS (27.447s) [244.043895] [098/144] (769s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [244.173298] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [244.174901] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [244.217201] [099/144] (769s left) api_intel_allocator (fork-simple-stress-signal) [244.265816] Starting subtest: fork-simple-stress-signal [249.673813] Subtest fork-simple-stress-signal: SUCCESS (5.409s) [249.731269] [100/144] (764s left) vgem_basic (bad-flag) [249.803227] Starting subtest: bad-flag [249.804028] Subtest bad-flag: SUCCESS (0.000s) [249.837351] [101/144] (764s left) kms_ccs (pipe-d-bad-pixel-format-yf-tiled-ccs) [250.067554] Starting subtest: pipe-D-bad-pixel-format-yf-tiled-ccs [250.069500] Subtest pipe-D-bad-pixel-format-yf-tiled-ccs: SKIP (0.000s) [250.164413] [102/144] (763s left) gem_eio (suspend) [250.217050] Starting subtest: suspend [260.808829] Subtest suspend: SUCCESS (10.591s) [264.914892] [103/144] (753s left) drm_mm (drm_mm) [264.954171] Starting subtest: drm_mm [265.078614] Starting dynamic subtest: drm_test_mm_init [265.096271] Dynamic subtest drm_test_mm_init: SUCCESS (0.016s) [265.103233] Starting dynamic subtest: drm_test_mm_debug [265.103964] Dynamic subtest drm_test_mm_debug: SUCCESS (0.001s) [265.109804] Starting dynamic subtest: drm_test_mm_align32 [265.110517] Dynamic subtest drm_test_mm_align32: SUCCESS (0.000s) [265.115913] Starting dynamic subtest: drm_test_mm_align64 [265.116625] Dynamic subtest drm_test_mm_align64: SUCCESS (0.000s) [265.121730] Starting dynamic subtest: drm_test_mm_lowest [265.122484] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.000s) [265.127971] Starting dynamic subtest: drm_test_mm_highest [265.128740] Dynamic subtest drm_test_mm_highest: SUCCESS (0.000s) [265.129495] Subtest drm_mm: SUCCESS (0.146s) [265.273701] [104/144] (752s left) perf_pmu (cpu-hotplug) [265.312416] Starting subtest: cpu-hotplug [265.314166] Subtest cpu-hotplug: SKIP (0.001s) [265.378393] [105/144] (752s left) kms_draw_crc (draw-method-mmap-cpu) [265.477746] Starting subtest: draw-method-mmap-cpu [265.478610] Starting dynamic subtest: xrgb8888-untiled [265.632268] Dynamic subtest xrgb8888-untiled: SUCCESS (0.153s) [265.645218] Starting dynamic subtest: rgb565-untiled [265.790645] Dynamic subtest rgb565-untiled: SUCCESS (0.157s) [265.805810] Starting dynamic subtest: xrgb2101010-untiled [265.932127] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.140s) [265.949452] Starting dynamic subtest: xrgb8888-xtiled [266.023907] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.090s) [266.039376] Starting dynamic subtest: rgb565-xtiled [266.115698] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s) [266.128802] Starting dynamic subtest: xrgb2101010-xtiled [266.198692] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s) [266.214349] Starting dynamic subtest: xrgb8888-ytiled [266.290832] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s) [266.305227] Starting dynamic subtest: rgb565-ytiled [266.382186] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [266.394422] Starting dynamic subtest: xrgb2101010-ytiled [266.457263] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.073s) [266.458666] Subtest draw-method-mmap-cpu: SUCCESS (0.980s) [266.539111] [106/144] (751s left) gem_exec_reloc (basic-gtt-cpu-active) [266.595508] Starting subtest: basic-gtt-cpu-active [266.713739] Subtest basic-gtt-cpu-active: SUCCESS (0.117s) [266.803615] [107/144] (751s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [266.896834] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [266.898421] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [266.948739] [108/144] (751s left) kms_psr (fbc-psr-suspend) [267.046446] Subtest fbc-psr-suspend: SKIP (0.000s) [267.065683] [109/144] (750s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [267.169673] Starting subtest: yf-tiled-16bpp-rotate-180 [267.171165] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [267.233431] [110/144] (750s left) kms_ccs (pipe-a-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [267.388242] Starting subtest: pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [267.389988] Subtest pipe-A-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.001s) [267.564948] [111/144] (750s left) prime_self_import (basic-llseek-bad) [267.596352] Starting subtest: basic-llseek-bad [267.609894] Subtest basic-llseek-bad: SUCCESS (0.012s) [267.668174] [112/144] (750s left) kms_big_fb (linear-8bpp-rotate-180) [267.776391] Starting subtest: linear-8bpp-rotate-180 [269.102401] Subtest linear-8bpp-rotate-180: SUCCESS (1.326s) [269.222818] [113/144] (748s left) gem_mmap_offset (isolation) [269.269634] Starting subtest: isolation [269.277491] Subtest isolation: SUCCESS (0.005s) [269.353357] [114/144] (748s left) gem_exec_reloc (basic-write-gtt) [269.410375] Starting subtest: basic-write-gtt [269.414969] Subtest basic-write-gtt: SUCCESS (0.004s) [269.498995] [115/144] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [269.599278] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [269.600869] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [269.652199] [116/144] (748s left) dmabuf_sync_file (import-basic) [269.693790] Starting subtest: import-basic [269.694613] Subtest import-basic: SUCCESS (0.001s) [269.723658] [117/144] (748s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [269.915740] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [269.917460] Subtest pipe-C-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s) [270.030252] [118/144] (748s left) syncobj_wait (invalid-single-wait-unsubmitted) [270.082778] Starting subtest: invalid-single-wait-unsubmitted [270.083705] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [270.157494] [119/144] (748s left) gem_userptr_blits (vma-merge) [270.234226] Starting subtest: vma-merge [290.301118] Subtest vma-merge: FAIL (20.055s) [290.326474] [120/144] (727s left) syncobj_wait (invalid-multi-wait-unsubmitted) [290.377456] Starting subtest: invalid-multi-wait-unsubmitted [290.378335] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [290.441894] [121/144] (727s left) i915_suspend (sysfs-reader) [290.499557] Starting subtest: sysfs-reader [308.994038] Subtest sysfs-reader: SUCCESS (3.094s) [314.018870] [122/144] (724s left) kms_cursor_crc (cursor-random-64x21) [314.122302] Starting subtest: cursor-random-64x21 [314.127406] Starting dynamic subtest: pipe-A-HDMI-A-1 [316.025409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.897s) [316.051224] Starting dynamic subtest: pipe-D-HDMI-A-1 [317.914865] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.869s) [317.915642] Subtest cursor-random-64x21: SUCCESS (3.792s) [318.004275] [123/144] (720s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-dg2-mc-ccs) [318.179734] Starting subtest: pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs [318.181312] Subtest pipe-B-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s) [318.321737] [124/144] (720s left) kms_setmode (clone-exclusive-crtc) [318.368563] Starting subtest: clone-exclusive-crtc [318.370959] Subtest clone-exclusive-crtc: SKIP (0.000s) [318.426641] [125/144] (720s left) prime_mmap (test_forked) [318.468333] Starting subtest: test_forked [318.469128] Starting dynamic subtest: test_forked-smem [318.481557] Dynamic subtest test_forked-smem: SUCCESS (0.014s) [318.482295] Subtest test_forked: SUCCESS (0.014s) [318.549689] [126/144] (720s left) kms_pipe_crc_basic (disable-crc-after-crtc) [318.645724] Starting subtest: disable-crc-after-crtc [318.646551] Starting dynamic subtest: pipe-A-HDMI-A-1 [318.964621] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.318s) [318.971809] Starting dynamic subtest: pipe-B-HDMI-A-1 [319.251248] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.284s) [319.258321] Starting dynamic subtest: pipe-C-HDMI-A-1 [319.543119] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.290s) [319.550724] Starting dynamic subtest: pipe-D-HDMI-A-1 [319.831972] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.287s) [319.832820] Subtest disable-crc-after-crtc: SUCCESS (1.187s) [319.922312] [127/144] (718s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [319.969963] Starting subtest: addfb25-framebuffer-vs-set-tiling [319.970771] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [320.056365] [128/144] (718s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu) [320.170315] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu [321.094319] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (0.929s) [321.192855] [129/144] (717s left) kms_getfb (getfb-reject-ccs) [321.265255] Starting subtest: getfb-reject-ccs [321.266590] Subtest getfb-reject-ccs: SUCCESS (0.000s) [321.345172] [130/144] (717s left) kms_tiled_display (basic-test-pattern) [321.482127] Subtest basic-test-pattern: SKIP (0.000s) [321.516626] [131/144] (717s left) gen9_exec_parse (cmd-crossing-page) [321.584447] Subtest cmd-crossing-page: SKIP (0.000s) [321.609069] [132/144] (717s left) syncobj_timeline (wait-any-complex) [321.669484] Starting subtest: wait-any-complex [321.723418] Subtest wait-any-complex: SUCCESS (0.062s) [321.776025] [133/144] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [321.883699] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [321.886298] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [321.939467] [134/144] (716s left) kms_frontbuffer_tracking (psr-2p-rte) [322.053610] Starting subtest: psr-2p-rte [322.055206] Subtest psr-2p-rte: SKIP (0.000s) [322.091476] [135/144] (716s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [322.190152] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [322.191049] Starting dynamic subtest: pipe-A-valid-mode [323.090990] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.900s) [323.099721] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.901s) [323.196171] [136/144] (715s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [323.300955] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [323.302409] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [323.375169] [137/144] (715s left) v3d/v3d_submit_csd (bad-multisync-extension) [323.442453] Subtest bad-multisync-extension: SKIP (0.000s) [323.469154] [138/144] (715s left) gem_exec_reloc (basic-cpu-gtt) [323.523505] Starting subtest: basic-cpu-gtt [323.535057] Subtest basic-cpu-gtt: SUCCESS (0.005s) [323.611888] [139/144] (715s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [323.818827] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs [323.820551] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s) [323.930300] [140/144] (715s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [324.037794] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [324.039479] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [324.089350] [141/144] (714s left) kms_chamelium_hpd (dp-hpd-after-suspend) [324.265303] Subtest dp-hpd-after-suspend: SKIP (0.000s) [324.321908] [142/144] (714s left) kms_chamelium_audio (dp-audio-edid) [324.496923] Subtest dp-audio-edid: SKIP (0.000s) [324.545254] [143/144] (714s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal [324.599517] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled [324.704129] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s) [324.766748] [144/144] (714s left) kms_color (ctm-blue-to-red) [324.868966] Starting subtest: ctm-blue-to-red [324.869753] Starting dynamic subtest: pipe-A [325.151710] Dynamic subtest pipe-A: SUCCESS (0.283s) [325.158212] Starting dynamic subtest: pipe-B [325.415630] Dynamic subtest pipe-B: SUCCESS (0.263s) [325.422078] Starting dynamic subtest: pipe-C [325.682518] Dynamic subtest pipe-C: SUCCESS (0.266s) [325.688979] Starting dynamic subtest: pipe-D [325.950248] Dynamic subtest pipe-D: SUCCESS (0.266s) [325.951078] Subtest ctm-blue-to-red: SUCCESS (1.081s) [326.031111] Closing watchdogs Done.