0s autopkgtest [07:47:13]: starting date and time: 2024-03-24 07:47:13+0000 0s autopkgtest [07:47:13]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [07:47:13]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.q0qap13h/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-2@bos02-ppc64el-17.secgroup --name adt-noble-ppc64el-vip-manager-20240324-074713-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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://ftpmaster.internal/ubuntu/ 99s autopkgtest [07:48:52]: testbed dpkg architecture: ppc64el 99s autopkgtest [07:48:52]: testbed apt version: 2.7.12 99s autopkgtest [07:48:52]: @@@@@@@@@@@@@@@@@@@@ test bed setup 100s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 101s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB] 101s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 101s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [494 kB] 101s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4004 kB] 102s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [698 kB] 102s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 102s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 102s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 102s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [4265 kB] 102s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 102s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [60.8 kB] 102s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 105s Fetched 9715 kB in 3s (3285 kB/s) 105s Reading package lists... 108s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s Calculating upgrade... 109s The following packages will be REMOVED: 109s libssl3 109s The following NEW packages will be installed: 109s libssl3t64 109s The following packages have been kept back: 109s curl 109s The following packages will be upgraded: 109s openssl 109s 1 upgraded, 1 newly installed, 1 to remove and 1 not upgraded. 109s Need to get 3151 kB of archives. 109s After this operation, 73.7 kB of additional disk space will be used. 109s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el openssl ppc64el 3.0.13-0ubuntu2 [1026 kB] 110s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libssl3t64 ppc64el 3.0.13-0ubuntu2 [2125 kB] 110s Fetched 3151 kB in 1s (4423 kB/s) 110s (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 ... 70156 files and directories currently installed.) 110s Preparing to unpack .../openssl_3.0.13-0ubuntu2_ppc64el.deb ... 110s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ... 110s dpkg: libssl3:ppc64el: dependency problems, but removing anyway as you requested: 110s wget depends on libssl3 (>= 3.0.0). 110s tnftp depends on libssl3 (>= 3.0.0). 110s tcpdump depends on libssl3 (>= 3.0.0). 110s systemd-resolved depends on libssl3 (>= 3.0.0). 110s systemd depends on libssl3 (>= 3.0.0). 110s sudo depends on libssl3 (>= 3.0.0). 110s rsync depends on libssl3 (>= 3.0.0). 110s python3-cryptography depends on libssl3 (>= 3.0.0). 110s openssh-server depends on libssl3 (>= 3.0.10). 110s openssh-client depends on libssl3 (>= 3.0.10). 110s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 110s libsystemd-shared:ppc64el depends on libssl3 (>= 3.0.0). 110s libssh-4:ppc64el depends on libssl3 (>= 3.0.0). 110s libsasl2-modules:ppc64el depends on libssl3 (>= 3.0.0). 110s libsasl2-2:ppc64el depends on libssl3 (>= 3.0.0). 110s libpython3.12-minimal:ppc64el depends on libssl3 (>= 3.0.0). 110s libpython3.11-minimal:ppc64el depends on libssl3 (>= 3.0.0). 110s libnvme1 depends on libssl3 (>= 3.0.0). 110s libkrb5-3:ppc64el depends on libssl3 (>= 3.0.0). 110s libkmod2:ppc64el depends on libssl3 (>= 3.0.0). 110s libfido2-1:ppc64el depends on libssl3 (>= 3.0.0). 110s libcurl4:ppc64el depends on libssl3 (>= 3.0.0). 110s libcryptsetup12:ppc64el depends on libssl3 (>= 3.0.0). 110s kmod depends on libssl3 (>= 3.0.0). 110s dhcpcd-base depends on libssl3 (>= 3.0.0). 110s bind9-libs:ppc64el depends on libssl3 (>= 3.0.0). 110s 110s (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 ... 70156 files and directories currently installed.) 110s Removing libssl3:ppc64el (3.0.10-1ubuntu4) ... 110s Selecting previously unselected package libssl3t64:ppc64el. 110s (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 ... 70145 files and directories currently installed.) 110s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_ppc64el.deb ... 110s Unpacking libssl3t64:ppc64el (3.0.13-0ubuntu2) ... 110s Setting up libssl3t64:ppc64el (3.0.13-0ubuntu2) ... 110s Setting up openssl (3.0.13-0ubuntu2) ... 110s Processing triggers for man-db (2.12.0-3) ... 111s Processing triggers for libc-bin (2.39-0ubuntu6) ... 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 113s sh: Attempting to set up Debian/Ubuntu apt sources automatically 113s Reading package lists...sh: Distribution appears to be Ubuntu 113s 113s Building dependency tree... 113s Reading state information... 113s eatmydata is already the newest version (131-1). 113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s dbus is already the newest version (1.14.10-4ubuntu1). 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s rng-tools-debian is already the newest version (2.4). 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 115s The following packages will be REMOVED: 115s cloud-init* python3-configobj* python3-debconf* 115s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 115s After this operation, 3256 kB disk space will be freed. 115s (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 ... 70158 files and directories currently installed.) 115s Removing cloud-init (24.1.2-0ubuntu1) ... 115s Removing python3-configobj (5.0.8-3) ... 115s Removing python3-debconf (1.5.86) ... 115s Processing triggers for man-db (2.12.0-3) ... 116s (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 ... 69769 files and directories currently installed.) 116s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 116s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 116s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 116s invoke-rc.d: policy-rc.d denied execution of try-restart. 116s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s linux-generic is already the newest version (6.8.0-11.11+1). 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 117s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 117s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 120s Reading package lists... 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Calculating upgrade... 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s autopkgtest [07:49:14]: rebooting testbed after setup commands that affected boot 288s autopkgtest [07:52:01]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 291s autopkgtest [07:52:04]: @@@@@@@@@@@@@@@@@@@@ apt-source vip-manager 293s Get:1 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (dsc) [2473 B] 293s Get:2 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (tar) [69.9 kB] 293s Get:3 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (diff) [9272 B] 293s gpgv: Signature made Tue Oct 24 12:29:18 2023 UTC 293s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 293s gpgv: Can't check signature: No public key 293s dpkg-source: warning: cannot verify inline signature for ./vip-manager_1.0.2-8.dsc: no acceptable signature found 293s autopkgtest [07:52:06]: testing package vip-manager version 1.0.2-8 294s autopkgtest [07:52:07]: build not needed 295s autopkgtest [07:52:08]: test test: preparing testbed 300s Reading package lists... 301s Building dependency tree... 301s Reading state information... 301s Starting pkgProblemResolver with broken count: 0 301s Starting 2 pkgProblemResolver with broken count: 0 301s Done 301s The following additional packages will be installed: 301s etcd-server liblua5.4-0 ncat vip-manager 301s Suggested packages: 301s etcd-client 301s The following NEW packages will be installed: 301s autopkgtest-satdep etcd-server liblua5.4-0 ncat vip-manager 301s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 301s Need to get 10.1 MB/10.1 MB of archives. 301s After this operation, 33.6 MB of additional disk space will be used. 301s Get:1 /tmp/autopkgtest.qnZCWV/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [740 B] 301s Get:2 http://ftpmaster.internal/ubuntu noble/universe ppc64el etcd-server ppc64el 3.4.30-1 [7420 kB] 304s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el liblua5.4-0 ppc64el 5.4.6-3 [216 kB] 304s Get:4 http://ftpmaster.internal/ubuntu noble/universe ppc64el ncat ppc64el 7.94+git20230807.3be01efb1+dfsg-3 [231 kB] 304s Get:5 http://ftpmaster.internal/ubuntu noble/universe ppc64el vip-manager ppc64el 1.0.2-8 [2281 kB] 304s Fetched 10.1 MB in 3s (3287 kB/s) 304s Selecting previously unselected package etcd-server. 304s (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 ... 69714 files and directories currently installed.) 304s Preparing to unpack .../etcd-server_3.4.30-1_ppc64el.deb ... 304s Unpacking etcd-server (3.4.30-1) ... 305s Selecting previously unselected package liblua5.4-0:ppc64el. 305s Preparing to unpack .../liblua5.4-0_5.4.6-3_ppc64el.deb ... 305s Unpacking liblua5.4-0:ppc64el (5.4.6-3) ... 305s Selecting previously unselected package ncat. 305s Preparing to unpack .../ncat_7.94+git20230807.3be01efb1+dfsg-3_ppc64el.deb ... 305s Unpacking ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 305s Selecting previously unselected package vip-manager. 305s Preparing to unpack .../vip-manager_1.0.2-8_ppc64el.deb ... 305s Unpacking vip-manager (1.0.2-8) ... 305s Selecting previously unselected package autopkgtest-satdep. 305s Preparing to unpack .../1-autopkgtest-satdep.deb ... 305s Unpacking autopkgtest-satdep (0) ... 305s Setting up liblua5.4-0:ppc64el (5.4.6-3) ... 305s Setting up etcd-server (3.4.30-1) ... 305s info: Selecting UID from range 100 to 999 ... 305s 305s info: Selecting GID from range 100 to 999 ... 305s info: Adding system user `etcd' (UID 107) ... 305s info: Adding new group `etcd' (GID 108) ... 305s info: Adding new user `etcd' (UID 107) with group `etcd' ... 305s info: Creating home directory `/var/lib/etcd/' ... 305s Created symlink /etc/systemd/system/etcd2.service → /usr/lib/systemd/system/etcd.service. 305s Created symlink /etc/systemd/system/multi-user.target.wants/etcd.service → /usr/lib/systemd/system/etcd.service. 306s Setting up vip-manager (1.0.2-8) ... 306s Created symlink /etc/systemd/system/multi-user.target.wants/vip-manager.service → /usr/lib/systemd/system/vip-manager.service. 306s Setting up ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 306s Setting up autopkgtest-satdep (0) ... 306s Processing triggers for man-db (2.12.0-3) ... 307s Processing triggers for libc-bin (2.39-0ubuntu6) ... 309s (Reading database ... 69971 files and directories currently installed.) 309s Removing autopkgtest-satdep (0) ... 310s autopkgtest [07:52:23]: test test: [----------------------- 310s ○ etcd.service - etcd - highly-available key value store 310s Loaded: loaded (/usr/lib/systemd/system/etcd.service; enabled; preset: enabled) 310s Active: inactive (dead) since Sun 2024-03-24 07:52:22 UTC; 10ms ago 310s Duration: 4.399s 310s Docs: https://etcd.io/docs 310s man:etcd 310s Process: 1292 ExecStart=/usr/bin/etcd $DAEMON_ARGS (code=killed, signal=TERM) 310s Main PID: 1292 (code=killed, signal=TERM) 310s CPU: 31ms 310s 310s Mar 24 07:52:18 autopkgtest systemd[1]: Started etcd.service - etcd - highly-available key value store. 310s Mar 24 07:52:18 autopkgtest etcd[1292]: set the initial cluster version to 3.4 310s Mar 24 07:52:18 autopkgtest etcd[1292]: enabled capabilities for version 3.4 310s Mar 24 07:52:22 autopkgtest etcd[1292]: received terminated signal, shutting down... 310s Mar 24 07:52:22 autopkgtest etcd[1292]: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 310s Mar 24 07:52:22 autopkgtest etcd[1292]: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 310s Mar 24 07:52:22 autopkgtest etcd[1292]: skipped leadership transfer for single voting member cluster 310s Mar 24 07:52:22 autopkgtest systemd[1]: Stopping etcd.service - etcd - highly-available key value store... 310s Mar 24 07:52:22 autopkgtest systemd[1]: etcd.service: Deactivated successfully. 310s Mar 24 07:52:22 autopkgtest systemd[1]: Stopped etcd.service - etcd - highly-available key value store. 310s dpkg-architecture: warning: cannot determine CC system type, falling back to default (native compilation) 310s 2024-03-24 07:52:22.865986 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH= 310s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 310s 2024-03-24 07:52:22.866175 W | embed: Running http and grpc server on single port. This is not recommended for production. 310s 2024-03-24 07:52:22.866274 I | etcdmain: etcd Version: 3.4.30 310s 2024-03-24 07:52:22.866307 I | etcdmain: Git SHA: Not provided (use ./build instead of go build) 310s 2024-03-24 07:52:22.866400 I | etcdmain: Go Version: go1.22.0 310s 2024-03-24 07:52:22.866531 I | etcdmain: Go OS/Arch: linux/ppc64le 310s 2024-03-24 07:52:22.866619 I | etcdmain: setting maximum number of CPUs to 1, total number of available CPUs is 1 310s 2024-03-24 07:52:22.866628 W | etcdmain: no data-dir provided, using default data-dir ./default.etcd 310s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 310s 2024-03-24 07:52:22.866685 W | embed: Running http and grpc server on single port. This is not recommended for production. 310s 2024-03-24 07:52:22.867281 I | embed: name = default 310s 2024-03-24 07:52:22.867286 I | embed: data dir = default.etcd 310s 2024-03-24 07:52:22.867290 I | embed: member dir = default.etcd/member 310s 2024-03-24 07:52:22.867293 I | embed: heartbeat = 100ms 310s 2024-03-24 07:52:22.867297 I | embed: election = 1000ms 310s 2024-03-24 07:52:22.867300 I | embed: snapshot count = 100000 310s 2024-03-24 07:52:22.867307 I | embed: advertise client URLs = http://localhost:2379 310s 2024-03-24 07:52:22.870891 I | etcdserver: starting member 8e9e05c52164694d in cluster cdf818194e3a8c32 310s raft2024/03/24 07:52:22 INFO: 8e9e05c52164694d switched to configuration voters=() 310s raft2024/03/24 07:52:22 INFO: 8e9e05c52164694d became follower at term 0 310s raft2024/03/24 07:52:22 INFO: newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0] 310s raft2024/03/24 07:52:22 INFO: 8e9e05c52164694d became follower at term 1 310s raft2024/03/24 07:52:22 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 310s 2024-03-24 07:52:22.875080 W | auth: simple token is not cryptographically signed 310s 2024-03-24 07:52:22.878951 I | etcdserver: starting server... [version: 3.4.30, cluster version: to_be_decided] 310s 2024-03-24 07:52:22.883619 I | etcdserver: 8e9e05c52164694d as single-node; fast-forwarding 9 ticks (election ticks 10) 310s 2024-03-24 07:52:22.883780 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap.db, max: 5, interval: 30s 310s 2024-03-24 07:52:22.883824 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap, max: 5, interval: 30s 310s 2024-03-24 07:52:22.883884 I | pkg/fileutil: started to purge file, dir: default.etcd/member/wal, suffix: wal, max: 5, interval: 30s 310s 2024-03-24 07:52:22.884162 I | embed: listening for peers on 127.0.0.1:2380 310s raft2024/03/24 07:52:22 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 310s 2024-03-24 07:52:22.884441 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32 311s raft2024/03/24 07:52:23 INFO: 8e9e05c52164694d is starting a new election at term 1 311s raft2024/03/24 07:52:23 INFO: 8e9e05c52164694d became candidate at term 2 311s raft2024/03/24 07:52:23 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2 311s raft2024/03/24 07:52:23 INFO: 8e9e05c52164694d became leader at term 2 311s raft2024/03/24 07:52:23 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2 311s 2024-03-24 07:52:23.473181 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32 311s 2024-03-24 07:52:23.473374 I | etcdserver: setting up the initial cluster version to 3.4 311s 2024-03-24 07:52:23.473782 I | embed: ready to serve client requests 311s 2024-03-24 07:52:23.474421 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged! 311s 2024-03-24 07:52:23.474597 N | etcdserver/membership: set the initial cluster version to 3.4 311s 2024-03-24 07:52:23.474711 I | etcdserver/api: enabled capabilities for version 3.4 312s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 312s Ncat: Listening on 0.0.0.0:12345 312s {"errorCode":100,"message":"Key not found","cause":"/service","index":3} 312s 2024/03/24 07:52:24 No dcs-endpoints specified, trying to use localhost with standard ports! 312s 2024/03/24 07:52:24 This is the config that will be used: 312s dcs-endpoints : [http://127.0.0.1:2379] 312s dcs-type : etcd 312s hostingtype : basic 312s interface : enp0s1 312s interval : 1000 312s ip : 10.0.2.123 312s manager-type : basic 312s netmask : 32 312s retry-after : 250 312s retry-num : 3 312s trigger-key : service/pgcluster/leader 312s trigger-value : autopkgtest 312s verbose : false 312s version : false 312s 2024/03/24 07:52:24 IP address 10.0.2.123/32 state is false, desired false 312s 2024/03/24 07:52:24 etcd error: 100: Key not found (/service) [3] 313s 2024/03/24 07:52:25 etcd error: 100: Key not found (/service) [3] 314s 2024/03/24 07:52:26 etcd error: 100: Key not found (/service) [3] 314s { 314s "action": "set", 314s "node": { 314s "key": "/service/pgcluster/leader", 314s "value": "autopkgtest", 314s "modifiedIndex": 4, 314s "createdIndex": 4 314s } 314s } 315s 2024/03/24 07:52:27 IP address 10.0.2.123/32 state is false, desired true 315s 2024/03/24 07:52:27 Configuring address 10.0.2.123/32 on enp0s1 315s 2024/03/24 07:52:27 Sent gratuitous ARP reply 315s 2024/03/24 07:52:27 Sent gratuitous ARP request 315s 2024/03/24 07:52:27 IP address 10.0.2.123/32 state is true, desired true 316s inet 10.0.2.123/32 scope global enp0s1 316s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 317s Ncat: Connection from 10.0.2.123:57186. 317s Ncat: Connected to 10.0.2.123:12345. 317s Ncat: 0 bytes sent, 0 bytes received in 0.11 seconds. 317s { 317s "action": "set", 317s "node": { 317s "key": "/service/pgcluster/leader", 317s "value": "0xGARBAGE", 317s "modifiedIndex": 5, 317s "createdIndex": 5 317s }, 317s "prevNode": { 317s "key": "/service/pgcluster/leader", 317s "value": "autopkgtest", 317s "modifiedIndex": 4, 317s "createdIndex": 4 317s } 317s } 317s 2024/03/24 07:52:30 IP address 10.0.2.123/32 state is true, desired false 317s 2024/03/24 07:52:30 Removing address 10.0.2.123/32 on enp0s1 317s 2024/03/24 07:52:30 IP address 10.0.2.123/32 state is false, desired false 319s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 320s Ncat: TIMEOUT. 320s ### You've reached the end of the script, all "tests" have successfully been passed! ### 320s 2024-03-24 07:52:33.156454 N | pkg/osutil: received terminated signal, shutting down... 320s 2024-03-24 07:52:33.157208 W | embed: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 320s 2024-03-24 07:52:33.157340 W | embed: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 320s 2024-03-24 07:52:33.157352 I | etcdserver: skipped leadership transfer for single voting member cluster 320s autopkgtest [07:52:33]: test test: -----------------------] 320s test PASS 320s autopkgtest [07:52:33]: test test: - - - - - - - - - - results - - - - - - - - - - 321s autopkgtest [07:52:34]: @@@@@@@@@@@@@@@@@@@@ summary 321s test PASS 343s Creating nova instance adt-noble-ppc64el-vip-manager-20240324-074713-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240323.img (UUID ff8abf95-5243-4ea5-b7f5-3bf690534a1d)...