01KJZMRJM5METAT1N5GB8MMFXS: falcon

BasicConfig {
    output_rules: [],
    rust_toolchain: None,
    target: Some(
        "lab-2.0-gimlet",
    ),
    access_repos: [],
    publish: [],
    skip_clone: true,
}

Buildomat Job: 01KJZMS8FMBRAND31AGNRSKNHK

Tags:

Output:

SEQ GLOBAL TIME DETAILS
12026-03-05T19:13:21.413Zjob dependencies complete; ready to run (waiting for 33 m 25 s)
22026-03-05T19:16:35.480Zjob assigned to worker 01KJZPPET6VHJHSH28HV9BNEQB [factory edgar, gimlet/BRM42220060/166] (queued for 3 m 14 s)
32026-03-05T19:16:36.698Zdownloading input: /input/build-interop/work/testbed.tar.gz
42026-03-05T19:16:45.812Zdownloaded input: /input/build-interop/work/testbed.tar.gz
52026-03-05T19:16:45.812Zdownloading input: /input/build-interop/work/dhcp-server
62026-03-05T19:16:48.394Zdownloaded input: /input/build-interop/work/dhcp-server
72026-03-05T19:16:48.419Zdownloading input: /input/build/work/debug/ddmadm
82026-03-05T19:17:10.745Zdownloaded input: /input/build/work/debug/ddmadm
92026-03-05T19:17:10.745Zdownloading input: /input/build/work/debug/ddmd
102026-03-05T19:17:36.604Zdownloaded input: /input/build/work/debug/ddmd
112026-03-05T19:17:36.604Zdownloading input: /input/build/work/debug/mgadm
122026-03-05T19:18:03.766Zdownloaded input: /input/build/work/debug/mgadm
132026-03-05T19:18:03.766Zdownloading input: /input/build/work/debug/mgd
142026-03-05T19:18:32.939Zdownloaded input: /input/build/work/debug/mgd
152026-03-05T19:18:32.964Zdownloading input: /input/build/work/release/ddmadm
162026-03-05T19:18:35.533Zdownloaded input: /input/build/work/release/ddmadm
172026-03-05T19:18:35.533Zdownloading input: /input/build/work/release/ddmd
182026-03-05T19:18:37.838Zdownloaded input: /input/build/work/release/ddmd
192026-03-05T19:18:37.862Zdownloading input: /input/build/work/release/falcon-lab
202026-03-05T19:18:39.489Zdownloaded input: /input/build/work/release/falcon-lab
212026-03-05T19:18:39.489Zdownloading input: /input/build/work/release/mgadm
222026-03-05T19:18:42.032Zdownloaded input: /input/build/work/release/mgadm
232026-03-05T19:18:42.032Zdownloading input: /input/build/work/release/mgd
242026-03-05T19:18:45.107Zdownloaded input: /input/build/work/release/mgd
 
252026-03-05T19:18:45.107Zstarting task 0: "setup"
262026-03-05T19:18:45.133Z++ uname -s
272026-03-05T19:18:45.133Z+ kern=SunOS
282026-03-05T19:18:45.133Z+ build_user=build
292026-03-05T19:18:45.133Z+ build_uid=12345
302026-03-05T19:18:45.133Z+ work_dir=/work
312026-03-05T19:18:45.133Z+ input_dir=/input
322026-03-05T19:18:45.133Z+ [[ 0 == 12345 ]]
332026-03-05T19:18:45.133Z+ case "$kern" in
342026-03-05T19:18:45.133Z+ groupadd -g 12345 build
352026-03-05T19:18:45.158Z+ useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build
362026-03-05T19:18:47.144Z+ zfs create -o mountpoint=/work rpool/work
372026-03-05T19:18:47.325Z++ awk '$2 == "/home" { print $3 }' /etc/mnttab
382026-03-05T19:18:47.356Z+ home_fs=
392026-03-05T19:18:47.356Z+ [[ '' == autofs ]]
402026-03-05T19:18:47.356Z+ mkdir -p /home/build
412026-03-05T19:18:47.356Z+ chown build:build /home/build /work
422026-03-05T19:18:49.342Z+ chmod 0700 /home/build /work
432026-03-05T19:18:49.368Zprocess exited: duration 4235 ms, exit code 0
 
442026-03-05T19:18:49.420Zstarting task 1: "authentication"
452026-03-05T19:18:49.516Zprocess exited: duration 95 ms, exit code 0
 
462026-03-05T19:18:49.570Zstarting task 2: "build"
472026-03-05T19:18:49.596Z+ set -e
482026-03-05T19:18:49.596Z+ banner zpool
492026-03-05T19:18:49.596Z
502026-03-05T19:18:49.597Z ###### ##### #### #### #
512026-03-05T19:18:49.597Z # # # # # # # #
522026-03-05T19:18:49.597Z # # # # # # # #
532026-03-05T19:18:49.597Z # ##### # # # # #
542026-03-05T19:18:49.597Z # # # # # # #
552026-03-05T19:18:49.597Z ###### # #### #### ######
562026-03-05T19:18:49.597Z
572026-03-05T19:18:49.597Z++ pfexec diskinfo -pH
582026-03-05T19:18:49.597Z++ sort -k8 -n -r
592026-03-05T19:18:49.597Z++ head -1
602026-03-05T19:18:49.624Z++ awk '{print $2}'
612026-03-05T19:18:49.650Z+ DISK=c9t0014EE81000BC57Cd0
622026-03-05T19:18:49.650Z+ export DISK
632026-03-05T19:18:49.650Z+ pfexec zpool create -o ashift=12 -f cpool c9t0014EE81000BC57Cd0
642026-03-05T19:18:49.708Z+ pfexec zfs create -o mountpoint=/ci cpool/ci
652026-03-05T19:18:49.735Z++ curl -s http://catacomb.eng.oxide.computer:12346/trim-me
662026-03-05T19:22:09.532Z+ [[ '' =~ true ]]
672026-03-05T19:22:09.532Z+ pfexec chown 12345 /ci
682026-03-05T19:22:09.557Z+ cd /ci
692026-03-05T19:22:09.558Z+ export FALCON_DATASET=cpool/falcon
702026-03-05T19:22:09.558Z+ FALCON_DATASET=cpool/falcon
712026-03-05T19:22:09.558Z+ banner setup
722026-03-05T19:22:09.558Z
732026-03-05T19:22:09.558Z #### ###### ##### # # #####
742026-03-05T19:22:09.558Z # # # # # # #
752026-03-05T19:22:09.558Z #### ##### # # # # #
762026-03-05T19:22:09.558Z # # # # # #####
772026-03-05T19:22:09.558Z # # # # # # #
782026-03-05T19:22:09.559Z #### ###### # #### #
792026-03-05T19:22:09.559Z
802026-03-05T19:22:09.559Z+ cp /input/build-interop/work/dhcp-server .
812026-03-05T19:22:09.886Z+ cp /input/build/work/release/falcon-lab .
822026-03-05T19:22:09.914Z+ cp /input/build/work/release/mgd .
832026-03-05T19:22:09.980Z+ cp /input/build/work/release/ddmd .
842026-03-05T19:22:10.021Z+ chmod +x dhcp-server falcon-lab mgd ddmd
852026-03-05T19:22:10.046Z+ mkdir -p cargo-bay
862026-03-05T19:22:10.046Z+ mv mgd cargo-bay/
872026-03-05T19:22:10.046Z+ mv ddmd cargo-bay/
882026-03-05T19:22:10.046Z+ export EXT_INTERFACE=igb0
892026-03-05T19:22:10.046Z+ EXT_INTERFACE=igb0
902026-03-05T19:22:10.046Z++ bmat address ls -f extra -Ho first
912026-03-05T19:22:10.072Z+ first=10.151.7.164
922026-03-05T19:22:10.072Z++ bmat address ls -f extra -Ho last
932026-03-05T19:22:10.105Z+ last=10.151.7.227
942026-03-05T19:22:10.106Z++ bmat address ls -f extra -Ho gateway
952026-03-05T19:22:10.131Z+ gw=10.151.7.1
962026-03-05T19:22:10.131Z++ ipadm show-addr igb0/dhcp -po ADDR
972026-03-05T19:22:10.131Z++ sed 's#/.*##g'
982026-03-05T19:22:10.131Z+ server=10.151.7.100
992026-03-05T19:22:10.131Z+ pfexec ./dhcp-server 10.151.7.164 10.151.7.227 10.151.7.1 10.151.7.100
1002026-03-05T19:22:10.132Z++ pfexec dladm create-vnic -l igb0 dummy0
1012026-03-05T19:22:10.132Z+ error=
1022026-03-05T19:22:10.132Z+ RUST_LOG=debug
1032026-03-05T19:22:10.132Z+ pfexec ./falcon-lab run trio-unnumbered
1042026-03-05T19:22:10.156ZMar 05 19:22:10.131 DEBG using default route interface igb0
1052026-03-05T19:22:10.156ZMar 05 19:22:10.132 DEBG using default route interface igb0
1062026-03-05T19:22:10.156ZMar 05 19:22:10.132 DEBG using default route interface igb0
1072026-03-05T19:22:10.156ZMar 05 19:22:10.132 INFO launching runner: deployment(mgtriou) persistent(false) custom_propolis_binary(None) dataset(cpool/falcon) falcon_dir(.falcon)
1082026-03-05T19:22:10.156ZMar 05 19:22:10.132 INFO starting preflight for deployment mgtriou
1092026-03-05T19:22:10.156ZMar 05 19:22:10.132 INFO propolis-server binary not found
1102026-03-05T19:22:10.157ZMar 05 19:22:10.132 INFO downloading propolis server rev ff31c527515d65886e599fc07eb41240aeb767c6, writing to .falcon/bin/propolis-server
1112026-03-05T19:22:13.979ZMar 05 19:22:13.968 INFO ovmf fd not found
1122026-03-05T19:22:13.979ZMar 05 19:22:13.968 INFO downloading ovmf
1132026-03-05T19:22:14.358ZMar 05 19:22:14.347 INFO base image for helios-2.9 does not exist, attempting to install
1142026-03-05T19:22:14.358ZMar 05 19:22:14.347 INFO trying to download https://oxide-falcon-assets.s3.us-west-2.amazonaws.com/helios-2.9_0.raw.xz
1152026-03-05T19:22:43.578ZMar 05 19:22:43.567 INFO extracting image to /tmp/helios-2.9_0.raw
1162026-03-05T19:23:16.972ZMar 05 19:23:16.955 INFO creating zvol cpool/falcon/img/helios-2.9 of size 4508880896
1172026-03-05T19:23:17.012ZMar 05 19:23:17.000 INFO copying image data to zvol
1182026-03-05T19:23:27.560ZMar 05 19:23:27.548 INFO creating zfs snapshot cpool/falcon/img/helios-2.9@base
1192026-03-05T19:23:30.913ZMar 05 19:23:30.901 INFO base image for debian-13.2 does not exist, attempting to install
1202026-03-05T19:23:30.914ZMar 05 19:23:30.901 INFO trying to download https://oxide-falcon-assets.s3.us-west-2.amazonaws.com/debian-13.2_0.raw.xz
1212026-03-05T19:23:51.497ZMar 05 19:23:51.484 INFO extracting image to /tmp/debian-13.2_0.raw
1222026-03-05T19:24:12.243ZMar 05 19:24:12.230 INFO creating zvol cpool/falcon/img/debian-13.2 of size 3221229568
1232026-03-05T19:24:12.268ZMar 05 19:24:12.255 INFO copying image data to zvol
1242026-03-05T19:24:20.708ZMar 05 19:24:20.695 INFO creating zfs snapshot cpool/falcon/img/debian-13.2@base
1252026-03-05T19:24:23.615ZMar 05 19:24:23.602 INFO base image for eos-4.35 does not exist, attempting to install
1262026-03-05T19:24:23.615ZMar 05 19:24:23.602 INFO trying to download https://oxide-falcon-assets.s3.us-west-2.amazonaws.com/eos-4.35_0.raw.xz
1272026-03-05T19:25:09.138ZMar 05 19:25:09.124 INFO extracting image to /tmp/eos-4.35_0.raw
1282026-03-05T19:26:32.309ZMar 05 19:26:32.294 INFO creating zvol cpool/falcon/img/eos-4.35 of size 21474840576
1292026-03-05T19:26:32.338ZMar 05 19:26:32.317 INFO copying image data to zvol
1302026-03-05T19:27:21.052ZMar 05 19:27:21.038 INFO creating zfs snapshot cpool/falcon/img/eos-4.35@base
1312026-03-05T19:27:24.374ZMar 05 19:27:24.360 INFO creating links
1322026-03-05T19:27:24.374ZMar 05 19:27:24.360 DEBG destroying link mgtriou_ox_sn_vnic0
1332026-03-05T19:27:24.398ZMar 05 19:27:24.360 DEBG destroying link mgtriou_ox_sn_sim0
1342026-03-05T19:27:24.398ZMar 05 19:27:24.360 INFO creating simnet link 'mgtriou_ox_sn_sim0'
1352026-03-05T19:27:24.398ZMar 05 19:27:24.362 INFO creating vnic link 'mgtriou_ox_sn_vnic0'
1362026-03-05T19:27:24.398ZMar 05 19:27:24.369 DEBG link pair created
1372026-03-05T19:27:24.398ZMar 05 19:27:24.369 DEBG destroying link mgtriou_cr1_vn_vnic0
1382026-03-05T19:27:24.398ZMar 05 19:27:24.369 DEBG destroying link mgtriou_cr1_vn_sim0
1392026-03-05T19:27:24.398ZMar 05 19:27:24.369 INFO creating simnet link 'mgtriou_cr1_vn_sim0'
1402026-03-05T19:27:24.398ZMar 05 19:27:24.371 INFO creating vnic link 'mgtriou_cr1_vn_vnic0'
1412026-03-05T19:27:24.398ZMar 05 19:27:24.378 DEBG link pair created
1422026-03-05T19:27:24.398ZMar 05 19:27:24.378 DEBG destroying link mgtriou_ox_sn_vnic1
1432026-03-05T19:27:24.398ZMar 05 19:27:24.378 DEBG destroying link mgtriou_ox_sn_sim1
1442026-03-05T19:27:24.398ZMar 05 19:27:24.378 INFO creating simnet link 'mgtriou_ox_sn_sim1'
1452026-03-05T19:27:24.398ZMar 05 19:27:24.380 INFO creating vnic link 'mgtriou_ox_sn_vnic1'
1462026-03-05T19:27:24.423ZMar 05 19:27:24.386 DEBG link pair created
1472026-03-05T19:27:24.423ZMar 05 19:27:24.386 DEBG destroying link mgtriou_cr2_vn_vnic0
1482026-03-05T19:27:24.423ZMar 05 19:27:24.386 DEBG destroying link mgtriou_cr2_vn_sim0
1492026-03-05T19:27:24.423ZMar 05 19:27:24.386 INFO creating simnet link 'mgtriou_cr2_vn_sim0'
1502026-03-05T19:27:24.423ZMar 05 19:27:24.388 INFO creating vnic link 'mgtriou_cr2_vn_vnic0'
1512026-03-05T19:27:24.423ZMar 05 19:27:24.395 DEBG link pair created
1522026-03-05T19:27:24.423ZMar 05 19:27:24.395 INFO creating external links
1532026-03-05T19:27:24.423ZMar 05 19:27:24.395 DEBG destroying external link mgtriou_ox_vn_vnic2
1542026-03-05T19:27:24.423ZMar 05 19:27:24.395 INFO creating external link mgtriou_ox_vn_vnic2
1552026-03-05T19:27:24.423ZMar 05 19:27:24.396 DEBG external link mgtriou_ox_vn_vnic2@igb0 created
1562026-03-05T19:27:24.423ZMar 05 19:27:24.396 DEBG destroying external link mgtriou_cr1_vn_vnic1
1572026-03-05T19:27:24.423ZMar 05 19:27:24.396 INFO creating external link mgtriou_cr1_vn_vnic1
1582026-03-05T19:27:24.423ZMar 05 19:27:24.398 DEBG external link mgtriou_cr1_vn_vnic1@igb0 created
1592026-03-05T19:27:24.423ZMar 05 19:27:24.398 DEBG destroying external link mgtriou_cr2_vn_vnic1
1602026-03-05T19:27:24.423ZMar 05 19:27:24.398 INFO creating external link mgtriou_cr2_vn_vnic1
1612026-03-05T19:27:24.423ZMar 05 19:27:24.399 DEBG external link mgtriou_cr2_vn_vnic1@igb0 created
1622026-03-05T19:27:24.423ZMar 05 19:27:24.399 INFO creating nodes
1632026-03-05T19:27:24.424ZMar 05 19:27:24.399 INFO ox: launching node
1642026-03-05T19:27:24.424ZMar 05 19:27:24.402 INFO cr1: launching node
1652026-03-05T19:27:24.424ZMar 05 19:27:24.404 INFO cr2: launching node
1662026-03-05T19:27:24.448ZMar 05 19:27:24.418 INFO launched instance ox with pid 846 on port 53443
1672026-03-05T19:27:24.448ZMar 05 19:27:24.418 INFO ox: instance ensure
1682026-03-05T19:27:24.448ZMar 05 19:27:24.419 INFO launched instance cr1 with pid 847 on port 43950
1692026-03-05T19:27:24.448ZMar 05 19:27:24.419 INFO cr1: instance ensure
1702026-03-05T19:27:24.448ZMar 05 19:27:24.419 INFO launched instance cr2 with pid 848 on port 53555
1712026-03-05T19:27:24.448ZMar 05 19:27:24.419 INFO cr2: instance ensure
1722026-03-05T19:27:26.600ZMar 05 19:27:26.586 INFO cr1: instance run
1732026-03-05T19:27:26.625ZMar 05 19:27:26.587 DEBG [sc] cr1: starting
1742026-03-05T19:27:26.625ZMar 05 19:27:26.587 DEBG [sc] cr1: connecting to [::1]:43950
1752026-03-05T19:27:26.625ZMar 05 19:27:26.588 DEBG [sc] cr1 waiting for prompt
1762026-03-05T19:27:26.725ZMar 05 19:27:26.711 INFO ox: instance run
1772026-03-05T19:27:26.749ZMar 05 19:27:26.711 DEBG [sc] ox: starting
1782026-03-05T19:27:26.749ZMar 05 19:27:26.711 DEBG [sc] ox: connecting to [::1]:53443
1792026-03-05T19:27:26.749ZMar 05 19:27:26.712 DEBG [sc] ox waiting for prompt
1802026-03-05T19:27:26.773ZMar 05 19:27:26.750 INFO cr2: instance run
1812026-03-05T19:27:26.773ZMar 05 19:27:26.751 DEBG [sc] cr2: starting
1822026-03-05T19:27:26.773ZMar 05 19:27:26.751 DEBG [sc] cr2: connecting to [::1]:53555
1832026-03-05T19:27:26.774ZMar 05 19:27:26.752 DEBG [sc] cr2 waiting for prompt
1842026-03-05T19:27:43.713ZMar 05 19:27:43.698 DEBG [sc] cr1: logging in
1852026-03-05T19:27:44.063ZMar 05 19:27:44.048 INFO cr1: mounting /opt/cargo-bay
1862026-03-05T19:27:44.063ZMar 05 19:27:44.048 DEBG [sc] cr1: executing command `mkdir -p /opt/cargo-bay; cd /opt/cargo-bay; p9kp pull`
1872026-03-05T19:27:44.088ZMar 05 19:27:44.071 DEBG [sc] cr1: executing command `cd`
1882026-03-05T19:27:44.112ZMar 05 19:27:44.081 INFO cr1: finished mounting /opt/cargo-bay
1892026-03-05T19:27:44.112ZMar 05 19:27:44.081 DEBG [sc] cr1: executing command `hostname cr1`
1902026-03-05T19:27:44.112ZMar 05 19:27:44.092 DEBG [sc] cr1: executing command `echo 'cr1' > /etc/nodename`
1912026-03-05T19:27:44.137ZMar 05 19:27:44.104 DEBG [sc] cr1: executing command `echo '::1 cr1.local cr1' >> /etc/hosts`
1922026-03-05T19:27:44.137ZMar 05 19:27:44.115 DEBG [sc] cr1: executing command `echo '127.0.0.1 cr1.local cr1' >> /etc/hosts`
1932026-03-05T19:27:44.162ZMar 05 19:27:44.125 INFO cr1: logging out
1942026-03-05T19:27:46.205ZMar 05 19:27:46.189 INFO cr1: logged out
1952026-03-05T19:27:47.342ZMar 05 19:27:47.328 DEBG [sc] ox: logging in
1962026-03-05T19:27:47.510ZMar 05 19:27:47.496 INFO ox: mounting /opt/cargo-bay
1972026-03-05T19:27:47.510ZMar 05 19:27:47.496 DEBG [sc] ox: executing command `mkdir -p /opt/cargo-bay; cd /opt/cargo-bay; p9kp pull`
1982026-03-05T19:27:48.329ZMar 05 19:27:48.315 DEBG [sc] cr2: logging in
1992026-03-05T19:27:48.547ZMar 05 19:27:48.533 DEBG [sc] ox: executing command `cd`
2002026-03-05T19:27:48.572ZMar 05 19:27:48.544 INFO ox: finished mounting /opt/cargo-bay
2012026-03-05T19:27:48.572ZMar 05 19:27:48.544 DEBG [sc] ox: executing command `hostname ox`
2022026-03-05T19:27:48.572ZMar 05 19:27:48.556 DEBG [sc] ox: executing command `echo 'ox' > /etc/nodename`
2032026-03-05T19:27:48.597ZMar 05 19:27:48.567 DEBG [sc] ox: executing command `echo '::1 ox.local ox' >> /etc/hosts`
2042026-03-05T19:27:48.597ZMar 05 19:27:48.578 DEBG [sc] ox: executing command `echo '127.0.0.1 ox.local ox' >> /etc/hosts`
2052026-03-05T19:27:48.621ZMar 05 19:27:48.589 INFO ox: logging out
2062026-03-05T19:27:48.692ZMar 05 19:27:48.677 INFO ox: logged out
2072026-03-05T19:27:48.739ZMar 05 19:27:48.724 INFO cr2: mounting /opt/cargo-bay
2082026-03-05T19:27:48.739ZMar 05 19:27:48.724 DEBG [sc] cr2: executing command `mkdir -p /opt/cargo-bay; cd /opt/cargo-bay; p9kp pull`
2092026-03-05T19:27:48.763ZMar 05 19:27:48.746 DEBG [sc] cr2: executing command `cd`
2102026-03-05T19:27:48.788ZMar 05 19:27:48.758 INFO cr2: finished mounting /opt/cargo-bay
2112026-03-05T19:27:48.788ZMar 05 19:27:48.758 DEBG [sc] cr2: executing command `hostname cr2`
2122026-03-05T19:27:48.788ZMar 05 19:27:48.769 DEBG [sc] cr2: executing command `echo 'cr2' > /etc/nodename`
2132026-03-05T19:27:48.816ZMar 05 19:27:48.780 DEBG [sc] cr2: executing command `echo '::1 cr2.local cr2' >> /etc/hosts`
2142026-03-05T19:27:48.816ZMar 05 19:27:48.791 DEBG [sc] cr2: executing command `echo '127.0.0.1 cr2.local cr2' >> /etc/hosts`
2152026-03-05T19:27:48.870ZMar 05 19:27:48.801 INFO cr2: logging out
2162026-03-05T19:27:51.745ZMar 05 19:27:51.730 INFO cr2: logged out
2172026-03-05T19:27:51.770ZMar 05 19:27:51.730 DEBG [sc] ox: starting
2182026-03-05T19:27:51.770ZMar 05 19:27:51.730 DEBG [sc] ox: connecting to [::1]:53443
2192026-03-05T19:27:51.770ZMar 05 19:27:51.731 DEBG [sc] ox waiting for prompt
2202026-03-05T19:27:51.771ZMar 05 19:27:51.743 DEBG [sc] ox: logging in
2212026-03-05T19:27:51.834ZMar 05 19:27:51.819 DEBG [sc] ox: executing command `ipadm create-addr -T dhcp vioif1/dhcp`
2222026-03-05T19:27:57.881ZMar 05 19:27:57.867 DEBG [sc] ox: starting
2232026-03-05T19:27:57.881ZMar 05 19:27:57.867 DEBG [sc] ox: connecting to [::1]:53443
2242026-03-05T19:27:57.906ZMar 05 19:27:57.867 DEBG [sc] ox waiting for prompt
2252026-03-05T19:27:57.906ZMar 05 19:27:57.878 DEBG [sc] ox: logging in
2262026-03-05T19:27:57.981ZMar 05 19:27:57.966 DEBG [sc] ox: executing command `echo 'nameserver 1.1.1.1' > /etc/resolv.conf`
2272026-03-05T19:27:58.068ZMar 05 19:27:58.054 DEBG [sc] ox: starting
2282026-03-05T19:27:58.069ZMar 05 19:27:58.054 DEBG [sc] ox: connecting to [::1]:53443
2292026-03-05T19:27:58.093ZMar 05 19:27:58.054 DEBG [sc] ox waiting for prompt
2302026-03-05T19:27:58.093ZMar 05 19:27:58.064 DEBG [sc] ox: logging in
2312026-03-05T19:27:58.170ZMar 05 19:27:58.152 DEBG [sc] ox: executing command `ipadm show-addr vioif1/dhcp -p -o addr`
2322026-03-05T19:27:58.234ZMar 05 19:27:58.219 INFO cr1: installing frr
2332026-03-05T19:27:58.234ZMar 05 19:27:58.219 INFO waiting for ceos to initialize
2342026-03-05T19:27:58.234ZMar 05 19:27:58.219 INFO ox: setting up npuvm
2352026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr2: starting
2362026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr2: connecting to [::1]:53555
2372026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr1: starting
2382026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr1: connecting to [::1]:43950
2392026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] ox: starting
2402026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] ox: connecting to [::1]:53443
2412026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr1 waiting for prompt
2422026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] cr2 waiting for prompt
2432026-03-05T19:27:58.259ZMar 05 19:27:58.220 DEBG [sc] ox waiting for prompt
2442026-03-05T19:27:58.259ZMar 05 19:27:58.231 DEBG [sc] ox: logging in
2452026-03-05T19:27:58.259ZMar 05 19:27:58.231 DEBG [sc] cr1: logging in
2462026-03-05T19:27:58.259ZMar 05 19:27:58.232 DEBG [sc] cr2: logging in
2472026-03-05T19:27:58.322ZMar 05 19:27:58.307 DEBG [sc] ox: executing command `curl --retry 5 -OL https://buildomat.eng.oxide.computer/public/file/oxidecomputer//softnpu/image/fd2c726815cdb03c2687e1bf2912a9184905557b/npuvm`
2482026-03-05T19:27:58.389ZMar 05 19:27:58.375 DEBG [sc] cr2: executing command `docker inspect ceos --format '{{.State.Status}}'`
2492026-03-05T19:27:58.602ZMar 05 19:27:58.588 DEBG [sc] cr1: executing command `apt-get -y update && apt-get -y install frr`
2502026-03-05T19:28:00.646ZMar 05 19:28:00.632 INFO cr2: executing eos script show version
2512026-03-05T19:28:00.646ZMar 05 19:28:00.632 DEBG [sc] cr2: starting
2522026-03-05T19:28:00.646ZMar 05 19:28:00.632 DEBG [sc] cr2: connecting to [::1]:53555
2532026-03-05T19:28:00.670ZMar 05 19:28:00.632 DEBG [sc] cr2 waiting for prompt
2542026-03-05T19:28:00.670ZMar 05 19:28:00.642 DEBG [sc] cr2: logging in
2552026-03-05T19:28:00.844ZMar 05 19:28:00.786 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show version'`
2562026-03-05T19:28:03.798ZMar 05 19:28:03.784 DEBG [sc] ox: starting
2572026-03-05T19:28:03.799ZMar 05 19:28:03.784 DEBG [sc] ox: connecting to [::1]:53443
2582026-03-05T19:28:03.824ZMar 05 19:28:03.784 DEBG [sc] ox waiting for prompt
2592026-03-05T19:28:03.824ZMar 05 19:28:03.795 DEBG [sc] ox: logging in
2602026-03-05T19:28:03.902ZMar 05 19:28:03.885 DEBG [sc] ox: executing command `chmod +x npuvm`
2612026-03-05T19:28:03.956ZMar 05 19:28:03.940 DEBG [sc] ox: starting
2622026-03-05T19:28:03.956ZMar 05 19:28:03.940 DEBG [sc] ox: connecting to [::1]:53443
2632026-03-05T19:28:03.982ZMar 05 19:28:03.940 DEBG [sc] ox waiting for prompt
2642026-03-05T19:28:03.982ZMar 05 19:28:03.951 DEBG [sc] ox: logging in
2652026-03-05T19:28:04.044ZMar 05 19:28:04.028 DEBG [sc] ox: executing command `./npuvm install --front-ports 2 --rear-ports 0 --pkt-source vioif0 `
2662026-03-05T19:28:08.541ZMar 05 19:28:08.527 DEBG [sc] cr2: starting
2672026-03-05T19:28:08.541ZMar 05 19:28:08.527 DEBG [sc] cr2: connecting to [::1]:53555
2682026-03-05T19:28:08.566ZMar 05 19:28:08.528 DEBG [sc] cr2 waiting for prompt
2692026-03-05T19:28:08.566ZMar 05 19:28:08.538 DEBG [sc] cr2: logging in
2702026-03-05T19:28:08.684ZMar 05 19:28:08.670 DEBG [sc] cr2: executing command `docker inspect ceos --format '{{.State.Status}}'`
2712026-03-05T19:28:10.801ZMar 05 19:28:10.787 INFO cr2: executing eos script show version
2722026-03-05T19:28:10.825ZMar 05 19:28:10.787 DEBG [sc] cr2: starting
2732026-03-05T19:28:10.825ZMar 05 19:28:10.787 DEBG [sc] cr2: connecting to [::1]:53555
2742026-03-05T19:28:10.825ZMar 05 19:28:10.788 DEBG [sc] cr2 waiting for prompt
2752026-03-05T19:28:10.825ZMar 05 19:28:10.798 DEBG [sc] cr2: logging in
2762026-03-05T19:28:10.967ZMar 05 19:28:10.953 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show version'`
2772026-03-05T19:28:13.299ZMar 05 19:28:13.284 DEBG [sc] cr2: starting
2782026-03-05T19:28:13.299ZMar 05 19:28:13.284 DEBG [sc] cr2: connecting to [::1]:53555
2792026-03-05T19:28:13.323ZMar 05 19:28:13.285 DEBG [sc] cr2 waiting for prompt
2802026-03-05T19:28:13.323ZMar 05 19:28:13.295 DEBG [sc] cr2: logging in
2812026-03-05T19:28:13.442ZMar 05 19:28:13.427 DEBG [sc] cr2: executing command `docker inspect ceos --format '{{.State.Status}}'`
2822026-03-05T19:28:15.578ZMar 05 19:28:15.564 INFO cr2: executing eos script show version
2832026-03-05T19:28:15.578ZMar 05 19:28:15.564 DEBG [sc] cr2: starting
2842026-03-05T19:28:15.578ZMar 05 19:28:15.564 DEBG [sc] cr2: connecting to [::1]:53555
2852026-03-05T19:28:15.618ZMar 05 19:28:15.564 DEBG [sc] cr2 waiting for prompt
2862026-03-05T19:28:15.618ZMar 05 19:28:15.574 DEBG [sc] cr2: logging in
2872026-03-05T19:28:15.731ZMar 05 19:28:15.717 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show version'`
2882026-03-05T19:28:18.141ZMar 05 19:28:18.127 DEBG [sc] cr2: starting
2892026-03-05T19:28:18.141ZMar 05 19:28:18.128 DEBG [sc] cr2: connecting to [::1]:53555
2902026-03-05T19:28:18.167ZMar 05 19:28:18.128 DEBG [sc] cr2 waiting for prompt
2912026-03-05T19:28:18.167ZMar 05 19:28:18.138 DEBG [sc] cr2: logging in
2922026-03-05T19:28:18.284ZMar 05 19:28:18.270 DEBG [sc] cr2: executing command `docker inspect ceos --format '{{.State.Status}}'`
2932026-03-05T19:28:20.402ZMar 05 19:28:20.388 INFO cr2: executing eos script show version
2942026-03-05T19:28:20.402ZMar 05 19:28:20.388 DEBG [sc] cr2: starting
2952026-03-05T19:28:20.402ZMar 05 19:28:20.388 DEBG [sc] cr2: connecting to [::1]:53555
2962026-03-05T19:28:20.426ZMar 05 19:28:20.388 DEBG [sc] cr2 waiting for prompt
2972026-03-05T19:28:20.426ZMar 05 19:28:20.399 DEBG [sc] cr2: logging in
2982026-03-05T19:28:20.535ZMar 05 19:28:20.521 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show version'`
2992026-03-05T19:28:22.838ZMar 05 19:28:22.823 INFO cr2: executing eos script
3002026-03-05T19:28:22.838Z enable
3012026-03-05T19:28:22.838Z configure
3022026-03-05T19:28:22.838Z ipv6 unicast-routing
3032026-03-05T19:28:22.838Z ip routing ipv6 interfaces
3042026-03-05T19:28:22.838Z ip routing
3052026-03-05T19:28:22.838Z ip route 1.2.3.0/24 null0
3062026-03-05T19:28:22.838Z ipv6 route fd99::/64 null0
3072026-03-05T19:28:22.838Z interface et1
3082026-03-05T19:28:22.838Z no switchport
3092026-03-05T19:28:22.838Z ipv6 enable
3102026-03-05T19:28:22.838Z
3112026-03-05T19:28:22.838Z router bgp 45
3122026-03-05T19:28:22.838Z router-id 1.2.3.1
3132026-03-05T19:28:22.838Z no bgp default ipv4-unicast
3142026-03-05T19:28:22.838Z timers bgp 2 6
3152026-03-05T19:28:22.838Z neighbor ebgp peer group
3162026-03-05T19:28:22.838Z neighbor ebgp remote-as 33
3172026-03-05T19:28:22.838Z neighbor interface Et1 peer-group ebgp
3182026-03-05T19:28:22.838Z address-family ipv4
3192026-03-05T19:28:22.838Z neighbor ebgp activate
3202026-03-05T19:28:22.838Z neighbor ebgp next-hop address-family ipv6 originate
3212026-03-05T19:28:22.838Z network 1.2.3.0/24
3222026-03-05T19:28:22.838Z exit
3232026-03-05T19:28:22.838Z address-family ipv6
3242026-03-05T19:28:22.839Z neighbor ebgp activate
3252026-03-05T19:28:22.839Z neighbor ebgp next-hop address-family ipv6 originate
3262026-03-05T19:28:22.839Z network fd99::/64
3272026-03-05T19:28:22.839Z exit
3282026-03-05T19:28:22.839Z exit
3292026-03-05T19:28:22.839Z
3302026-03-05T19:28:22.839ZMar 05 19:28:22.823 DEBG [sc] cr2: starting
3312026-03-05T19:28:22.863ZMar 05 19:28:22.823 DEBG [sc] cr2: connecting to [::1]:53555
3322026-03-05T19:28:22.863ZMar 05 19:28:22.824 DEBG [sc] cr2 waiting for prompt
3332026-03-05T19:28:22.863ZMar 05 19:28:22.835 DEBG [sc] cr2: logging in
3342026-03-05T19:28:22.982ZMar 05 19:28:22.967 DEBG [sc] cr2: executing command `docker exec ceos Cli -c '
3352026-03-05T19:28:22.982Z enable
3362026-03-05T19:28:22.982Z configure
3372026-03-05T19:28:22.982Z ipv6 unicast-routing
3382026-03-05T19:28:22.982Z ip routing ipv6 interfaces
3392026-03-05T19:28:22.982Z ip routing
3402026-03-05T19:28:22.982Z ip route 1.2.3.0/24 null0
3412026-03-05T19:28:22.983Z ipv6 route fd99::/64 null0
3422026-03-05T19:28:22.983Z interface et1
3432026-03-05T19:28:22.983Z no switchport
3442026-03-05T19:28:22.983Z ipv6 enable
3452026-03-05T19:28:22.983Z
3462026-03-05T19:28:22.983Z router bgp 45
3472026-03-05T19:28:22.983Z router-id 1.2.3.1
3482026-03-05T19:28:22.983Z no bgp default ipv4-unicast
3492026-03-05T19:28:22.983Z timers bgp 2 6
3502026-03-05T19:28:22.983Z neighbor ebgp peer group
3512026-03-05T19:28:22.983Z neighbor ebgp remote-as 33
3522026-03-05T19:28:22.983Z neighbor interface Et1 peer-group ebgp
3532026-03-05T19:28:22.983Z address-family ipv4
3542026-03-05T19:28:22.983Z neighbor ebgp activate
3552026-03-05T19:28:22.983Z neighbor ebgp next-hop address-family ipv6 originate
3562026-03-05T19:28:22.983Z network 1.2.3.0/24
3572026-03-05T19:28:22.983Z exit
3582026-03-05T19:28:22.983Z address-family ipv6
3592026-03-05T19:28:22.984Z neighbor ebgp activate
3602026-03-05T19:28:22.984Z neighbor ebgp next-hop address-family ipv6 originate
3612026-03-05T19:28:22.984Z network fd99::/64
3622026-03-05T19:28:22.984Z exit
3632026-03-05T19:28:22.984Z exit
3642026-03-05T19:28:22.984Z '`
3652026-03-05T19:28:36.181ZMar 05 19:28:36.166 INFO cr1: enabling frr daemon bgpd
3662026-03-05T19:28:36.181ZMar 05 19:28:36.166 DEBG [sc] cr1: starting
3672026-03-05T19:28:36.181ZMar 05 19:28:36.166 DEBG [sc] cr1: connecting to [::1]:43950
3682026-03-05T19:28:36.207ZMar 05 19:28:36.166 DEBG [sc] cr1 waiting for prompt
3692026-03-05T19:28:36.208ZMar 05 19:28:36.176 DEBG [sc] cr1: logging in
3702026-03-05T19:28:36.325ZMar 05 19:28:36.310 DEBG [sc] cr1: executing command `sed -i 's/bgpd=no/bgpd=yes/g' /etc/frr/daemons`
3712026-03-05T19:28:38.400ZMar 05 19:28:38.385 DEBG [sc] cr1: starting
3722026-03-05T19:28:38.400ZMar 05 19:28:38.385 DEBG [sc] cr1: connecting to [::1]:43950
3732026-03-05T19:28:38.424ZMar 05 19:28:38.386 DEBG [sc] cr1 waiting for prompt
3742026-03-05T19:28:38.424ZMar 05 19:28:38.396 DEBG [sc] cr1: logging in
3752026-03-05T19:28:38.543ZMar 05 19:28:38.528 DEBG [sc] cr1: executing command `systemctl restart frr`
3762026-03-05T19:28:46.152ZMar 05 19:28:46.137 INFO cr1: executing frr script
3772026-03-05T19:28:46.152Z configure
3782026-03-05T19:28:46.153Z ip forwarding
3792026-03-05T19:28:46.153Z ipv6 forwarding
3802026-03-05T19:28:46.153Z ip route 1.2.3.0/24 null0
3812026-03-05T19:28:46.153Z ipv6 route fd99::/64 null0
3822026-03-05T19:28:46.153Z route-map PERMIT-ALL permit 10
3832026-03-05T19:28:46.153Z router bgp 44
3842026-03-05T19:28:46.153Z timers bgp 2 6
3852026-03-05T19:28:46.153Z neighbor enp0s8 interface remote-as external
3862026-03-05T19:28:46.153Z neighbor enp0s8 timers connect 1
3872026-03-05T19:28:46.153Z address-family ipv4 unicast
3882026-03-05T19:28:46.153Z network 1.2.3.0/24
3892026-03-05T19:28:46.153Z neighbor enp0s8 activate
3902026-03-05T19:28:46.153Z neighbor enp0s8 route-map PERMIT-ALL out
3912026-03-05T19:28:46.153Z neighbor enp0s8 route-map PERMIT-ALL in
3922026-03-05T19:28:46.153Z exit-address-family
3932026-03-05T19:28:46.153Z address-family ipv6 unicast
3942026-03-05T19:28:46.153Z network fd99::/64
3952026-03-05T19:28:46.153Z neighbor enp0s8 activate
3962026-03-05T19:28:46.153Z neighbor enp0s8 route-map PERMIT-ALL out
3972026-03-05T19:28:46.153Z neighbor enp0s8 route-map PERMIT-ALL in
3982026-03-05T19:28:46.153Z exit-address-family
3992026-03-05T19:28:46.153Z exit
4002026-03-05T19:28:46.153Z
4012026-03-05T19:28:46.153ZMar 05 19:28:46.137 DEBG [sc] cr1: starting
4022026-03-05T19:28:46.153ZMar 05 19:28:46.137 DEBG [sc] cr1: connecting to [::1]:43950
4032026-03-05T19:28:46.178ZMar 05 19:28:46.138 DEBG [sc] cr1 waiting for prompt
4042026-03-05T19:28:46.179ZMar 05 19:28:46.149 DEBG [sc] cr1: logging in
4052026-03-05T19:28:46.298ZMar 05 19:28:46.282 DEBG [sc] cr1: executing command `vtysh -c '' -c ' configure' -c ' ip forwarding' -c ' ipv6 forwarding' -c ' ip route 1.2.3.0/24 null0' -c ' ipv6 route fd99::/64 null0' -c ' route-map PERMIT-ALL permit 10' -c ' router bgp 44' -c ' timers bgp 2 6' -c ' neighbor enp0s8 interface remote-as external' -c ' neighbor enp0s8 timers connect 1 ' -c ' address-family ipv4 unicast' -c ' network 1.2.3.0/24' -c ' neighbor enp0s8 activate' -c ' neighbor enp0s8 route-map PERMIT-ALL out' -c ' neighbor enp0s8 route-map PERMIT-ALL in' -c ' exit-address-family' -c ' address-family ipv6 unicast' -c ' network fd99::/64' -c ' neighbor enp0s8 activate' -c ' neighbor enp0s8 route-map PERMIT-ALL out' -c ' neighbor enp0s8 route-map PERMIT-ALL in' -c ' exit-address-family' -c ' exit' -c ' '`
4062026-03-05T19:29:36.918ZMar 05 19:29:36.902 DEBG [sc] ox: starting
4072026-03-05T19:29:36.918ZMar 05 19:29:36.902 DEBG [sc] ox: connecting to [::1]:53443
4082026-03-05T19:29:36.942ZMar 05 19:29:36.902 DEBG [sc] ox waiting for prompt
4092026-03-05T19:29:36.942ZMar 05 19:29:36.913 DEBG [sc] ox: logging in
4102026-03-05T19:29:37.007ZMar 05 19:29:36.991 DEBG [sc] ox: executing command `/root/scadm propolis load-program /root/libsidecar_lite.so`
4112026-03-05T19:29:37.290ZMar 05 19:29:37.275 DEBG [sc] ox: starting
4122026-03-05T19:29:37.290ZMar 05 19:29:37.275 DEBG [sc] ox: connecting to [::1]:53443
4132026-03-05T19:29:37.314ZMar 05 19:29:37.276 DEBG [sc] ox waiting for prompt
4142026-03-05T19:29:37.314ZMar 05 19:29:37.287 DEBG [sc] ox: logging in
4152026-03-05T19:29:37.381ZMar 05 19:29:37.366 DEBG [sc] ox: executing command `dladm show-link tfportqsfp0_0 -p -o link`
4162026-03-05T19:29:38.407ZMar 05 19:29:38.390 DEBG [sc] ox: starting
4172026-03-05T19:29:38.407ZMar 05 19:29:38.390 DEBG [sc] ox: connecting to [::1]:53443
4182026-03-05T19:29:38.432ZMar 05 19:29:38.391 DEBG [sc] ox waiting for prompt
4192026-03-05T19:29:38.433ZMar 05 19:29:38.391 DEBG [sc] ox: logging in
4202026-03-05T19:29:38.484ZMar 05 19:29:38.468 DEBG [sc] ox: executing command `dladm show-link tfportqsfp0_0 -p -o link`
4212026-03-05T19:29:38.540ZMar 05 19:29:38.524 DEBG [sc] ox: starting
4222026-03-05T19:29:38.541ZMar 05 19:29:38.524 DEBG [sc] ox: connecting to [::1]:53443
4232026-03-05T19:29:38.567ZMar 05 19:29:38.525 DEBG [sc] ox waiting for prompt
4242026-03-05T19:29:38.567ZMar 05 19:29:38.535 DEBG [sc] ox: logging in
4252026-03-05T19:29:38.638ZMar 05 19:29:38.612 DEBG [sc] ox: executing command `ipadm create-addr -T addrconf tfportqsfp0_0/ll`
4262026-03-05T19:29:38.683ZMar 05 19:29:38.668 DEBG [sc] ox: starting
4272026-03-05T19:29:38.683ZMar 05 19:29:38.668 DEBG [sc] ox: connecting to [::1]:53443
4282026-03-05T19:29:38.707ZMar 05 19:29:38.668 DEBG [sc] ox waiting for prompt
4292026-03-05T19:29:38.707ZMar 05 19:29:38.678 DEBG [sc] ox: logging in
4302026-03-05T19:29:38.771ZMar 05 19:29:38.757 DEBG [sc] ox: executing command `ipadm show-addr tfportqsfp0_0/ll -p -o addr`
4312026-03-05T19:29:38.826ZMar 05 19:29:38.811 DEBG [sc] ox: starting
4322026-03-05T19:29:38.826ZMar 05 19:29:38.811 DEBG [sc] ox: connecting to [::1]:53443
4332026-03-05T19:29:38.850ZMar 05 19:29:38.812 DEBG [sc] ox waiting for prompt
4342026-03-05T19:29:38.850ZMar 05 19:29:38.822 DEBG [sc] ox: logging in
4352026-03-05T19:29:38.915ZMar 05 19:29:38.900 DEBG [sc] ox: executing command `dladm show-link tfportqsfp1_0 -p -o link`
4362026-03-05T19:29:38.969ZMar 05 19:29:38.955 DEBG [sc] ox: starting
4372026-03-05T19:29:38.970ZMar 05 19:29:38.955 DEBG [sc] ox: connecting to [::1]:53443
4382026-03-05T19:29:38.994ZMar 05 19:29:38.955 DEBG [sc] ox waiting for prompt
4392026-03-05T19:29:38.994ZMar 05 19:29:38.965 DEBG [sc] ox: logging in
4402026-03-05T19:29:39.058ZMar 05 19:29:39.043 DEBG [sc] ox: executing command `ipadm create-addr -T addrconf tfportqsfp1_0/ll`
4412026-03-05T19:29:39.114ZMar 05 19:29:39.099 DEBG [sc] ox: starting
4422026-03-05T19:29:39.114ZMar 05 19:29:39.099 DEBG [sc] ox: connecting to [::1]:53443
4432026-03-05T19:29:39.138ZMar 05 19:29:39.100 DEBG [sc] ox waiting for prompt
4442026-03-05T19:29:39.138ZMar 05 19:29:39.109 DEBG [sc] ox: logging in
4452026-03-05T19:29:39.201ZMar 05 19:29:39.186 DEBG [sc] ox: executing command `ipadm show-addr tfportqsfp1_0/ll -p -o addr`
4462026-03-05T19:29:39.257ZMar 05 19:29:39.242 DEBG [sc] ox: starting
4472026-03-05T19:29:39.257ZMar 05 19:29:39.242 DEBG [sc] ox: connecting to [::1]:53443
4482026-03-05T19:29:39.281ZMar 05 19:29:39.243 DEBG [sc] ox waiting for prompt
4492026-03-05T19:29:39.282ZMar 05 19:29:39.253 DEBG [sc] ox: logging in
4502026-03-05T19:29:39.345ZMar 05 19:29:39.330 DEBG [sc] ox: executing command `chmod +x /opt/cargo-bay/mgd && /opt/cargo-bay/mgd run &> /tmp/mgd.log &`
4512026-03-05T19:29:39.407ZMar 05 19:29:39.386 DEBG [sc] ox: starting
4522026-03-05T19:29:39.407ZMar 05 19:29:39.386 DEBG [sc] ox: connecting to [::1]:53443
4532026-03-05T19:29:39.431ZMar 05 19:29:39.386 DEBG [sc] ox waiting for prompt
4542026-03-05T19:29:39.431ZMar 05 19:29:39.397 DEBG [sc] ox: logging in
4552026-03-05T19:29:39.489ZMar 05 19:29:39.474 DEBG [sc] ox: executing command `chmod +x /opt/cargo-bay/ddmd && /opt/cargo-bay/ddmd &> /tmp/ddm.log &`
4562026-03-05T19:29:39.558ZMar 05 19:29:39.543 INFO adding BGP router to mgd
4572026-03-05T19:29:41.578ZMar 05 19:29:41.563 INFO cr1: executing frr script show ip bgp json
4582026-03-05T19:29:41.578ZMar 05 19:29:41.563 DEBG [sc] cr1: starting
4592026-03-05T19:29:41.578ZMar 05 19:29:41.563 DEBG [sc] cr1: connecting to [::1]:43950
4602026-03-05T19:29:41.602ZMar 05 19:29:41.563 DEBG [sc] cr1 waiting for prompt
4612026-03-05T19:29:41.602ZMar 05 19:29:41.575 DEBG [sc] cr1: logging in
4622026-03-05T19:29:41.894ZMar 05 19:29:41.879 DEBG [sc] cr1: executing command `vtysh -c 'show ip bgp json'`
4632026-03-05T19:29:44.023ZMar 05 19:29:44.008 INFO cr1: executing frr script show bgp json
4642026-03-05T19:29:44.023ZMar 05 19:29:44.008 DEBG [sc] cr1: starting
4652026-03-05T19:29:44.023ZMar 05 19:29:44.008 DEBG [sc] cr1: connecting to [::1]:43950
4662026-03-05T19:29:44.047ZMar 05 19:29:44.009 DEBG [sc] cr1 waiting for prompt
4672026-03-05T19:29:44.047ZMar 05 19:29:44.019 DEBG [sc] cr1: logging in
4682026-03-05T19:29:44.167ZMar 05 19:29:44.152 DEBG [sc] cr1: executing command `vtysh -c 'show bgp json'`
4692026-03-05T19:29:46.286ZMar 05 19:29:46.271 INFO cr2: executing eos script show ip bgp | json
4702026-03-05T19:29:46.286ZMar 05 19:29:46.272 DEBG [sc] cr2: starting
4712026-03-05T19:29:46.286ZMar 05 19:29:46.272 DEBG [sc] cr2: connecting to [::1]:53555
4722026-03-05T19:29:46.310ZMar 05 19:29:46.272 DEBG [sc] cr2 waiting for prompt
4732026-03-05T19:29:46.311ZMar 05 19:29:46.283 DEBG [sc] cr2: logging in
4742026-03-05T19:29:46.652ZMar 05 19:29:46.638 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show ip bgp | json'`
4752026-03-05T19:29:49.052ZMar 05 19:29:49.036 INFO cr2: executing eos script show ipv6 bgp | json
4762026-03-05T19:29:49.052ZMar 05 19:29:49.036 DEBG [sc] cr2: starting
4772026-03-05T19:29:49.052ZMar 05 19:29:49.036 DEBG [sc] cr2: connecting to [::1]:53555
4782026-03-05T19:29:49.076ZMar 05 19:29:49.037 DEBG [sc] cr2 waiting for prompt
4792026-03-05T19:29:49.076ZMar 05 19:29:49.046 DEBG [sc] cr2: logging in
4802026-03-05T19:29:49.183ZMar 05 19:29:49.168 DEBG [sc] cr2: executing command `docker exec ceos Cli -c 'show ipv6 bgp | json'`
4812026-03-05T19:29:51.584ZMar 05 19:29:51.569 INFO trio bgp unnumbered test passed 🎉
4822026-03-05T19:29:51.585ZMar 05 19:29:51.569 INFO destroying runner for deployment mgtriou
4832026-03-05T19:29:51.585ZMar 05 19:29:51.569 INFO destroying deployment mgtriou
4842026-03-05T19:29:51.585ZMar 05 19:29:51.569 INFO destroying nodes
4852026-03-05T19:29:51.715ZMar 05 19:29:51.688 INFO destroying links
4862026-03-05T19:29:51.715ZMar 05 19:29:51.688 INFO destroying link mgtriou_ox_sn_vnic0
4872026-03-05T19:29:51.715ZMar 05 19:29:51.691 INFO destroying link mgtriou_ox_sn_sim0
4882026-03-05T19:29:51.715ZMar 05 19:29:51.692 INFO destroying link mgtriou_cr1_vn_vnic0
4892026-03-05T19:29:52.710ZMar 05 19:29:52.695 INFO destroying link mgtriou_cr1_vn_sim0
4902026-03-05T19:29:52.734ZMar 05 19:29:52.696 INFO destroying link mgtriou_ox_sn_vnic1
4912026-03-05T19:29:52.734ZMar 05 19:29:52.697 INFO destroying link mgtriou_ox_sn_sim1
4922026-03-05T19:29:52.734ZMar 05 19:29:52.699 INFO destroying link mgtriou_cr2_vn_vnic0
4932026-03-05T19:29:52.734ZMar 05 19:29:52.701 INFO destroying link mgtriou_cr2_vn_sim0
4942026-03-05T19:29:52.734ZMar 05 19:29:52.702 INFO destroying external links
4952026-03-05T19:29:52.734ZMar 05 19:29:52.702 INFO destroying external link mgtriou_ox_vn_vnic2
4962026-03-05T19:29:52.734ZMar 05 19:29:52.703 INFO destroying external link mgtriou_cr1_vn_vnic1
4972026-03-05T19:29:52.734ZMar 05 19:29:52.705 INFO destroying external link mgtriou_cr2_vn_vnic1
4982026-03-05T19:29:52.734ZMar 05 19:29:52.706 INFO destroying images
4992026-03-05T19:29:53.215ZMar 05 19:29:53.200 INFO destroying workspace at .falcon
5002026-03-05T19:29:53.241Zprocess exited: duration 663632 ms, exit code 0
 
5012026-03-05T19:29:53.291Zfound 0 output files