0s autopkgtest [11:22:48]: starting date and time: 2024-03-25 11:22:48+0000 0s autopkgtest [11:22:48]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [11:22:48]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.9fv99r_n/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:curl,src:gnutls28,src:libpsl,src:nettle,src:openssl,src:orthanc-python --apt-upgrade vip-manager --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=curl/8.5.0-2ubuntu8 gnutls28/3.8.3-1.1ubuntu2 libpsl/0.21.2-1.1 nettle/3.9.1-2.2 openssl/3.0.13-0ubuntu2 orthanc-python/4.1+ds-2build3' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos01-arm64-8.secgroup --name adt-noble-arm64-vip-manager-20240325-110722-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://us.ports.ubuntu.com/ubuntu-ports/ 111s autopkgtest [11:24:39]: testbed dpkg architecture: arm64 111s autopkgtest [11:24:39]: testbed apt version: 2.7.12 111s autopkgtest [11:24:39]: @@@@@@@@@@@@@@@@@@@@ test bed setup 112s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 112s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 113s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [7608 B] 113s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3984 kB] 113s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.8 kB] 113s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [713 kB] 113s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 113s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [39.7 kB] 113s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 113s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4352 kB] 113s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 113s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [71.0 kB] 113s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 121s Fetched 9850 kB in 3s (3197 kB/s) 121s Reading package lists... 126s Reading package lists... 126s Building dependency tree... 126s Reading state information... 128s Calculating upgrade... 129s The following packages will be REMOVED: 129s libssl3 129s The following NEW packages will be installed: 129s libssl3t64 129s The following packages have been kept back: 129s curl 129s The following packages will be upgraded: 129s openssl 129s 1 upgraded, 1 newly installed, 1 to remove and 1 not upgraded. 129s Need to get 2777 kB of archives. 129s After this operation, 139 kB of additional disk space will be used. 129s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 openssl arm64 3.0.13-0ubuntu2 [985 kB] 130s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libssl3t64 arm64 3.0.13-0ubuntu2 [1793 kB] 130s Fetched 2777 kB in 1s (3900 kB/s) 131s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75911 files and directories currently installed.) 131s Preparing to unpack .../openssl_3.0.13-0ubuntu2_arm64.deb ... 131s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ... 131s dpkg: libssl3:arm64: dependency problems, but removing anyway as you requested: 131s wget depends on libssl3 (>= 3.0.0). 131s u-boot-tools depends on libssl3 (>= 3.0.0). 131s tnftp depends on libssl3 (>= 3.0.0). 131s tcpdump depends on libssl3 (>= 3.0.0). 131s systemd-resolved depends on libssl3 (>= 3.0.0). 131s systemd depends on libssl3 (>= 3.0.0). 131s sudo depends on libssl3 (>= 3.0.0). 131s sbsigntool depends on libssl3 (>= 3.0.0). 131s rsync depends on libssl3 (>= 3.0.0). 131s python3-cryptography depends on libssl3 (>= 3.0.0). 131s openssh-server depends on libssl3 (>= 3.0.10). 131s openssh-client depends on libssl3 (>= 3.0.10). 131s mtd-utils depends on libssl3 (>= 3.0.0). 131s mokutil depends on libssl3 (>= 3.0.0). 131s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 131s libsystemd-shared:arm64 depends on libssl3 (>= 3.0.0). 131s libssh-4:arm64 depends on libssl3 (>= 3.0.0). 131s libsasl2-modules:arm64 depends on libssl3 (>= 3.0.0). 131s libsasl2-2:arm64 depends on libssl3 (>= 3.0.0). 131s libpython3.12-minimal:arm64 depends on libssl3 (>= 3.0.0). 131s libpython3.11-minimal:arm64 depends on libssl3 (>= 3.0.0). 131s libnvme1 depends on libssl3 (>= 3.0.0). 131s libkrb5-3:arm64 depends on libssl3 (>= 3.0.0). 131s libkmod2:arm64 depends on libssl3 (>= 3.0.0). 131s libfido2-1:arm64 depends on libssl3 (>= 3.0.0). 131s libcurl4:arm64 depends on libssl3 (>= 3.0.0). 131s libcryptsetup12:arm64 depends on libssl3 (>= 3.0.0). 131s kmod depends on libssl3 (>= 3.0.0). 131s dhcpcd-base depends on libssl3 (>= 3.0.0). 131s bind9-libs:arm64 depends on libssl3 (>= 3.0.0). 131s 131s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75911 files and directories currently installed.) 131s Removing libssl3:arm64 (3.0.10-1ubuntu4) ... 131s Selecting previously unselected package libssl3t64:arm64. 131s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75900 files and directories currently installed.) 131s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_arm64.deb ... 131s Unpacking libssl3t64:arm64 (3.0.13-0ubuntu2) ... 131s Setting up libssl3t64:arm64 (3.0.13-0ubuntu2) ... 131s Setting up openssl (3.0.13-0ubuntu2) ... 131s Processing triggers for man-db (2.12.0-3) ... 133s Processing triggers for libc-bin (2.39-0ubuntu6) ... 133s Reading package lists... 134s Building dependency tree... 134s Reading state information... 135s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 137s sh: Attempting to set up Debian/Ubuntu apt sources automatically 137s sh: Distribution appears to be Ubuntu 139s Reading package lists... 139s Building dependency tree... 139s Reading state information... 140s eatmydata is already the newest version (131-1). 140s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 142s dbus is already the newest version (1.14.10-4ubuntu1). 142s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 142s Reading package lists... 143s Building dependency tree... 143s Reading state information... 144s rng-tools-debian is already the newest version (2.4). 144s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 146s The following packages will be REMOVED: 146s cloud-init* python3-configobj* python3-debconf* 147s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 147s After this operation, 3256 kB disk space will be freed. 147s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75913 files and directories currently installed.) 147s Removing cloud-init (24.1.2-0ubuntu1) ... 149s Removing python3-configobj (5.0.8-3) ... 149s Removing python3-debconf (1.5.86) ... 149s Processing triggers for man-db (2.12.0-3) ... 150s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75524 files and directories currently installed.) 150s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 151s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 151s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 151s invoke-rc.d: policy-rc.d denied execution of try-restart. 152s Reading package lists... 152s Building dependency tree... 152s Reading state information... 154s linux-generic is already the newest version (6.8.0-11.11+1). 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 154s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 155s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 155s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 162s Reading package lists... 162s Reading package lists... 162s Building dependency tree... 162s Reading state information... 163s Calculating upgrade... 164s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 167s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 167s autopkgtest [11:25:35]: rebooting testbed after setup commands that affected boot 324s autopkgtest [11:28:12]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 327s autopkgtest [11:28:15]: @@@@@@@@@@@@@@@@@@@@ apt-source vip-manager 329s Get:1 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (dsc) [2473 B] 329s Get:2 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (tar) [69.9 kB] 329s Get:3 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (diff) [9272 B] 329s gpgv: Signature made Tue Oct 24 12:29:18 2023 UTC 329s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 329s gpgv: Can't check signature: No public key 329s dpkg-source: warning: cannot verify inline signature for ./vip-manager_1.0.2-8.dsc: no acceptable signature found 329s autopkgtest [11:28:17]: testing package vip-manager version 1.0.2-8 330s autopkgtest [11:28:18]: build not needed 330s autopkgtest [11:28:18]: test test: preparing testbed 331s Reading package lists... 332s Building dependency tree... 332s Reading state information... 332s Starting pkgProblemResolver with broken count: 0 333s Starting 2 pkgProblemResolver with broken count: 0 333s Done 334s The following additional packages will be installed: 334s etcd-server liblua5.4-0 ncat vip-manager 334s Suggested packages: 334s etcd-client 334s The following NEW packages will be installed: 334s autopkgtest-satdep etcd-server liblua5.4-0 ncat vip-manager 334s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 334s Need to get 10.2 MB/10.2 MB of archives. 334s After this operation, 32.4 MB of additional disk space will be used. 334s Get:1 /tmp/autopkgtest.NzzYiR/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [740 B] 334s Get:2 http://ftpmaster.internal/ubuntu noble/universe arm64 etcd-server arm64 3.4.30-1 [7555 kB] 337s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 liblua5.4-0 arm64 5.4.6-3 [158 kB] 337s Get:4 http://ftpmaster.internal/ubuntu noble/universe arm64 ncat arm64 7.94+git20230807.3be01efb1+dfsg-3 [212 kB] 337s Get:5 http://ftpmaster.internal/ubuntu noble/universe arm64 vip-manager arm64 1.0.2-8 [2303 kB] 338s Fetched 10.2 MB in 3s (3409 kB/s) 338s Selecting previously unselected package etcd-server. 338s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 75469 files and directories currently installed.) 338s Preparing to unpack .../etcd-server_3.4.30-1_arm64.deb ... 338s Unpacking etcd-server (3.4.30-1) ... 339s Selecting previously unselected package liblua5.4-0:arm64. 339s Preparing to unpack .../liblua5.4-0_5.4.6-3_arm64.deb ... 339s Unpacking liblua5.4-0:arm64 (5.4.6-3) ... 339s Selecting previously unselected package ncat. 339s Preparing to unpack .../ncat_7.94+git20230807.3be01efb1+dfsg-3_arm64.deb ... 339s Unpacking ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 339s Selecting previously unselected package vip-manager. 339s Preparing to unpack .../vip-manager_1.0.2-8_arm64.deb ... 339s Unpacking vip-manager (1.0.2-8) ... 339s Selecting previously unselected package autopkgtest-satdep. 339s Preparing to unpack .../1-autopkgtest-satdep.deb ... 339s Unpacking autopkgtest-satdep (0) ... 339s Setting up liblua5.4-0:arm64 (5.4.6-3) ... 339s Setting up etcd-server (3.4.30-1) ... 339s info: Selecting UID from range 100 to 999 ... 339s 339s info: Selecting GID from range 100 to 999 ... 339s info: Adding system user `etcd' (UID 107) ... 339s info: Adding new group `etcd' (GID 108) ... 339s info: Adding new user `etcd' (UID 107) with group `etcd' ... 339s info: Creating home directory `/var/lib/etcd/' ... 340s Created symlink /etc/systemd/system/etcd2.service → /usr/lib/systemd/system/etcd.service. 340s Created symlink /etc/systemd/system/multi-user.target.wants/etcd.service → /usr/lib/systemd/system/etcd.service. 341s Setting up vip-manager (1.0.2-8) ... 342s Created symlink /etc/systemd/system/multi-user.target.wants/vip-manager.service → /usr/lib/systemd/system/vip-manager.service. 343s Setting up ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 343s Setting up autopkgtest-satdep (0) ... 343s Processing triggers for man-db (2.12.0-3) ... 343s Processing triggers for libc-bin (2.39-0ubuntu6) ... 349s (Reading database ... 75726 files and directories currently installed.) 349s Removing autopkgtest-satdep (0) ... 349s autopkgtest [11:28:37]: test test: [----------------------- 351s ○ etcd.service - etcd - highly-available key value store 351s Loaded: loaded (/usr/lib/systemd/system/etcd.service; enabled; preset: enabled) 351s Active: inactive (dead) since Mon 2024-03-25 11:28:39 UTC; 26ms ago 351s Duration: 9.704s 351s Docs: https://etcd.io/docs 351s man:etcd 351s Process: 1206 ExecStart=/usr/bin/etcd $DAEMON_ARGS (code=killed, signal=TERM) 351s Main PID: 1206 (code=killed, signal=TERM) 351s CPU: 120ms 351s 351s Mar 25 11:28:29 autopkgtest systemd[1]: Started etcd.service - etcd - highly-available key value store. 351s Mar 25 11:28:29 autopkgtest etcd[1206]: set the initial cluster version to 3.4 351s Mar 25 11:28:29 autopkgtest etcd[1206]: enabled capabilities for version 3.4 351s Mar 25 11:28:39 autopkgtest etcd[1206]: received terminated signal, shutting down... 351s Mar 25 11:28:39 autopkgtest etcd[1206]: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 351s Mar 25 11:28:39 autopkgtest etcd[1206]: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 351s Mar 25 11:28:39 autopkgtest etcd[1206]: skipped leadership transfer for single voting member cluster 351s Mar 25 11:28:39 autopkgtest systemd[1]: Stopping etcd.service - etcd - highly-available key value store... 351s Mar 25 11:28:39 autopkgtest systemd[1]: etcd.service: Deactivated successfully. 351s Mar 25 11:28:39 autopkgtest systemd[1]: Stopped etcd.service - etcd - highly-available key value store. 351s dpkg-architecture: warning: cannot determine CC system type, falling back to default (native compilation) 351s running etcd on unsupported architecture "arm64" since ETCD_UNSUPPORTED_ARCH is set 351s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 351s 2024-03-25 11:28:39.854264 W | embed: Running http and grpc server on single port. This is not recommended for production. 351s 2024-03-25 11:28:39.854369 I | etcdmain: etcd Version: 3.4.30 351s 2024-03-25 11:28:39.854378 I | etcdmain: Git SHA: Not provided (use ./build instead of go build) 351s 2024-03-25 11:28:39.854385 I | etcdmain: Go Version: go1.22.0 351s 2024-03-25 11:28:39.854392 I | etcdmain: Go OS/Arch: linux/arm64 351s 2024-03-25 11:28:39.854400 I | etcdmain: setting maximum number of CPUs to 1, total number of available CPUs is 1 351s 2024-03-25 11:28:39.854412 W | etcdmain: no data-dir provided, using default data-dir ./default.etcd 351s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 351s 2024-03-25 11:28:39.854474 W | embed: Running http and grpc server on single port. This is not recommended for production. 351s 2024-03-25 11:28:39.855739 I | embed: name = default 351s 2024-03-25 11:28:39.855898 I | embed: data dir = default.etcd 351s 2024-03-25 11:28:39.856024 I | embed: member dir = default.etcd/member 351s 2024-03-25 11:28:39.856141 I | embed: heartbeat = 100ms 351s 2024-03-25 11:28:39.856257 I | embed: election = 1000ms 351s 2024-03-25 11:28:39.856362 I | embed: snapshot count = 100000 351s 2024-03-25 11:28:39.856401 I | embed: advertise client URLs = http://localhost:2379 351s 2024-03-25 11:28:39.863091 I | etcdserver: starting member 8e9e05c52164694d in cluster cdf818194e3a8c32 351s raft2024/03/25 11:28:39 INFO: 8e9e05c52164694d switched to configuration voters=() 351s raft2024/03/25 11:28:39 INFO: 8e9e05c52164694d became follower at term 0 351s raft2024/03/25 11:28:39 INFO: newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0] 351s raft2024/03/25 11:28:39 INFO: 8e9e05c52164694d became follower at term 1 351s raft2024/03/25 11:28:39 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 351s 2024-03-25 11:28:39.868292 W | auth: simple token is not cryptographically signed 351s 2024-03-25 11:28:39.874838 I | etcdserver: starting server... [version: 3.4.30, cluster version: to_be_decided] 351s 2024-03-25 11:28:39.877350 I | etcdserver: 8e9e05c52164694d as single-node; fast-forwarding 9 ticks (election ticks 10) 351s 2024-03-25 11:28:39.877683 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap.db, max: 5, interval: 30s 351s 2024-03-25 11:28:39.877789 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap, max: 5, interval: 30s 351s 2024-03-25 11:28:39.877872 I | pkg/fileutil: started to purge file, dir: default.etcd/member/wal, suffix: wal, max: 5, interval: 30s 351s raft2024/03/25 11:28:39 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 351s 2024-03-25 11:28:39.878855 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32 351s 2024-03-25 11:28:39.881969 I | embed: listening for peers on 127.0.0.1:2380 352s raft2024/03/25 11:28:40 INFO: 8e9e05c52164694d is starting a new election at term 1 352s raft2024/03/25 11:28:40 INFO: 8e9e05c52164694d became candidate at term 2 352s raft2024/03/25 11:28:40 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2 352s raft2024/03/25 11:28:40 INFO: 8e9e05c52164694d became leader at term 2 352s raft2024/03/25 11:28:40 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2 352s 2024-03-25 11:28:40.267990 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32 352s 2024-03-25 11:28:40.268994 I | etcdserver: setting up the initial cluster version to 3.4 352s 2024-03-25 11:28:40.269505 I | embed: ready to serve client requests 352s 2024-03-25 11:28:40.270726 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged! 352s 2024-03-25 11:28:40.271039 N | etcdserver/membership: set the initial cluster version to 3.4 352s 2024-03-25 11:28:40.271146 I | etcdserver/api: enabled capabilities for version 3.4 353s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 353s Ncat: Listening on 0.0.0.0:12345 353s {"errorCode":100,"message":"Key not found","cause":"/service","index":3} 353s 2024/03/25 11:28:41 No dcs-endpoints specified, trying to use localhost with standard ports! 353s dcs-endpoints : [http://127.0.0.1:2379] 353s dcs-type : etcd 353s hostingtype : basic 353s interface : enp1s0 353s interval : 1000 353s ip : 10.0.2.123 353s manager-type : basic 353s netmask : 32 353s retry-after : 250 353s retry-num : 3 353s trigger-key : service/pgcluster/leader 353s trigger-value : autopkgtest 353s verbose : false 353s version : false 353s 2024/03/25 11:28:41 This is the config that will be used: 353s 2024/03/25 11:28:41 IP address 10.0.2.123/32 state is false, desired false 353s 2024/03/25 11:28:41 etcd error: 100: Key not found (/service) [3] 354s 2024/03/25 11:28:42 etcd error: 100: Key not found (/service) [3] 355s 2024/03/25 11:28:43 etcd error: 100: Key not found (/service) [3] 355s { 355s "action": "set", 355s "node": { 355s "key": "/service/pgcluster/leader", 355s "value": "autopkgtest", 355s "modifiedIndex": 4, 355s "createdIndex": 4 355s } 355s } 356s 2024/03/25 11:28:44 IP address 10.0.2.123/32 state is false, desired true 356s 2024/03/25 11:28:44 Configuring address 10.0.2.123/32 on enp1s0 356s 2024/03/25 11:28:44 Sent gratuitous ARP reply 356s 2024/03/25 11:28:44 Sent gratuitous ARP request 356s 2024/03/25 11:28:44 IP address 10.0.2.123/32 state is true, desired true 357s inet 10.0.2.123/32 scope global enp1s0 357s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 358s Ncat: Connection from 10.0.2.123:55612. 358s Ncat: Connected to 10.0.2.123:12345. 358s Ncat: 0 bytes sent, 0 bytes received in 0.20 seconds. 358s { 358s "action": "set", 358s "node": { 358s "key": "/service/pgcluster/leader", 358s "value": "0xGARBAGE", 358s "modifiedIndex": 5, 358s "createdIndex": 5 358s }, 358s "prevNode": { 358s "key": "/service/pgcluster/leader", 358s "value": "autopkgtest", 358s "modifiedIndex": 4, 358s "createdIndex": 4 358s } 358s } 358s 2024/03/25 11:28:46 IP address 10.0.2.123/32 state is true, desired false 358s 2024/03/25 11:28:46 Removing address 10.0.2.123/32 on enp1s0 358s 2024/03/25 11:28:46 IP address 10.0.2.123/32 state is false, desired false 360s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 361s Ncat: TIMEOUT. 361s ### You've reached the end of the script, all "tests" have successfully been passed! ### 361s 2024-03-25 11:28:49.426935 N | pkg/osutil: received terminated signal, shutting down... 361s 2024-03-25 11:28:49.428055 W | embed: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 361s 2024-03-25 11:28:49.428372 W | embed: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 361s 2024-03-25 11:28:49.428402 I | etcdserver: skipped leadership transfer for single voting member cluster 361s autopkgtest [11:28:49]: test test: -----------------------] 362s autopkgtest [11:28:50]: test test: - - - - - - - - - - results - - - - - - - - - - 362s test PASS 363s autopkgtest [11:28:51]: @@@@@@@@@@@@@@@@@@@@ summary 363s test PASS 376s Creating nova instance adt-noble-arm64-vip-manager-20240325-110722-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-arm64-server-20240324.img (UUID 2df78aec-1bf7-4c70-8bf1-31fba04b7d21)...