0s autopkgtest [07:27:56]: starting date and time: 2024-03-24 07:27:56+0000 0s autopkgtest [07:27:56]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [07:27:56]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.lzrfg1xg/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-s390x-7.secgroup --name adt-noble-s390x-vip-manager-20240324-072756-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-s390x-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/ 133s autopkgtest [07:30:09]: testbed dpkg architecture: s390x 133s autopkgtest [07:30:09]: testbed apt version: 2.7.12 133s autopkgtest [07:30:09]: @@@@@@@@@@@@@@@@@@@@ test bed setup 134s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 134s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [56.9 kB] 134s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 134s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [4004 kB] 135s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [494 kB] 135s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main s390x Packages [690 kB] 135s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main s390x c-n-f Metadata [3032 B] 135s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x Packages [1372 B] 135s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted s390x c-n-f Metadata [116 B] 135s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x Packages [4161 kB] 135s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe s390x c-n-f Metadata [7292 B] 135s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x Packages [46.8 kB] 135s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse s390x c-n-f Metadata [116 B] 138s Fetched 9588 kB in 3s (3229 kB/s) 138s Reading package lists... 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 141s Calculating upgrade... 141s The following packages will be REMOVED: 141s libssl3 141s The following NEW packages will be installed: 141s libssl3t64 141s The following packages have been kept back: 141s curl 141s The following packages will be upgraded: 141s openssl 141s 1 upgraded, 1 newly installed, 1 to remove and 1 not upgraded. 141s Need to get 2685 kB of archives. 141s After this operation, 239 kB of additional disk space will be used. 141s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main s390x openssl s390x 3.0.13-0ubuntu2 [1010 kB] 142s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main s390x libssl3t64 s390x 3.0.13-0ubuntu2 [1675 kB] 142s Fetched 2685 kB in 1s (3908 kB/s) 143s (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 ... 51777 files and directories currently installed.) 143s Preparing to unpack .../openssl_3.0.13-0ubuntu2_s390x.deb ... 143s Unpacking openssl (3.0.13-0ubuntu2) over (3.0.10-1ubuntu4) ... 143s dpkg: libssl3:s390x: dependency problems, but removing anyway as you requested: 143s wpasupplicant depends on libssl3 (>= 3.0.0). 143s wget depends on libssl3 (>= 3.0.0). 143s tnftp depends on libssl3 (>= 3.0.0). 143s tcpdump depends on libssl3 (>= 3.0.0). 143s systemd-resolved depends on libssl3 (>= 3.0.0). 143s systemd depends on libssl3 (>= 3.0.0). 143s sudo depends on libssl3 (>= 3.0.0). 143s s390-tools depends on libssl3 (>= 3.0.0). 143s rsync depends on libssl3 (>= 3.0.0). 143s python3-cryptography depends on libssl3 (>= 3.0.0). 143s openssh-server depends on libssl3 (>= 3.0.10). 143s openssh-client depends on libssl3 (>= 3.0.10). 143s linux-headers-6.8.0-11-generic depends on libssl3 (>= 3.0.0). 143s libtss2-esys-3.0.2-0:s390x depends on libssl3 (>= 3.0.0). 143s libsystemd-shared:s390x depends on libssl3 (>= 3.0.0). 143s libssh-4:s390x depends on libssl3 (>= 3.0.0). 143s libsasl2-modules:s390x depends on libssl3 (>= 3.0.0). 143s libsasl2-2:s390x depends on libssl3 (>= 3.0.0). 143s libpython3.12-minimal:s390x depends on libssl3 (>= 3.0.0). 143s libnvme1 depends on libssl3 (>= 3.0.0). 143s libkrb5-3:s390x depends on libssl3 (>= 3.0.0). 143s libkmod2:s390x depends on libssl3 (>= 3.0.0). 143s libfido2-1:s390x depends on libssl3 (>= 3.0.0). 143s libcurl4:s390x depends on libssl3 (>= 3.0.0). 143s libcryptsetup12:s390x depends on libssl3 (>= 3.0.0). 143s kmod depends on libssl3 (>= 3.0.0). 143s dhcpcd-base depends on libssl3 (>= 3.0.0). 143s bind9-libs:s390x depends on libssl3 (>= 3.0.0). 143s 143s (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 ... 51777 files and directories currently installed.) 143s Removing libssl3:s390x (3.0.10-1ubuntu4) ... 143s Selecting previously unselected package libssl3t64:s390x. 143s (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 ... 51766 files and directories currently installed.) 143s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu2_s390x.deb ... 143s Unpacking libssl3t64:s390x (3.0.13-0ubuntu2) ... 143s Setting up libssl3t64:s390x (3.0.13-0ubuntu2) ... 143s Setting up openssl (3.0.13-0ubuntu2) ... 143s Processing triggers for man-db (2.12.0-3) ... 143s Processing triggers for libc-bin (2.39-0ubuntu6) ... 144s Reading package lists... 144s Building dependency tree... 144s Reading state information... 144s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 145s Unknown architecture, assuming PC-style ttyS0 145s sh: Attempting to set up Debian/Ubuntu apt sources automatically 145s sh: Distribution appears to be Ubuntu 146s Reading package lists... 146s Building dependency tree... 146s Reading state information... 146s eatmydata is already the newest version (131-1). 146s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 146s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s dbus is already the newest version (1.14.10-4ubuntu1). 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s rng-tools-debian is already the newest version (2.4). 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 147s Reading package lists... 148s Building dependency tree... 148s Reading state information... 148s The following packages will be REMOVED: 148s cloud-init* python3-configobj* python3-debconf* 148s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 148s After this operation, 3256 kB disk space will be freed. 148s (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 ... 51779 files and directories currently installed.) 148s 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 ... 51390 files and directories currently installed.) 150s Purging configuration files for cloud-init (24.1.2-0ubuntu1) ... 150s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 150s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 150s invoke-rc.d: policy-rc.d denied execution of try-restart. 151s Reading package lists... 151s Building dependency tree... 151s Reading state information... 151s linux-generic is already the newest version (6.8.0-11.11+1). 151s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 152s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 152s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 152s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 154s Reading package lists... 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 154s Calculating upgrade... 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 155s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 155s autopkgtest [07:30:31]: rebooting testbed after setup commands that affected boot 295s autopkgtest [07:32:51]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Tue Feb 13 23:45:46 UTC 2024 298s autopkgtest [07:32:54]: @@@@@@@@@@@@@@@@@@@@ apt-source vip-manager 300s Get:1 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (dsc) [2473 B] 300s Get:2 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (tar) [69.9 kB] 300s Get:3 http://ftpmaster.internal/ubuntu noble/universe vip-manager 1.0.2-8 (diff) [9272 B] 300s gpgv: Signature made Tue Oct 24 12:29:18 2023 UTC 300s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 300s gpgv: Can't check signature: No public key 300s dpkg-source: warning: cannot verify inline signature for ./vip-manager_1.0.2-8.dsc: no acceptable signature found 300s autopkgtest [07:32:56]: testing package vip-manager version 1.0.2-8 300s autopkgtest [07:32:56]: build not needed 301s autopkgtest [07:32:57]: test test: preparing testbed 303s Reading package lists... 303s Building dependency tree... 303s Reading state information... 304s Starting pkgProblemResolver with broken count: 0 304s Starting 2 pkgProblemResolver with broken count: 0 304s Done 304s The following additional packages will be installed: 304s etcd-server liblua5.4-0 ncat vip-manager 304s Suggested packages: 304s etcd-client 304s The following NEW packages will be installed: 304s autopkgtest-satdep etcd-server liblua5.4-0 ncat vip-manager 304s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 304s Need to get 10.6 MB/10.6 MB of archives. 304s After this operation, 35.2 MB of additional disk space will be used. 304s Get:1 /tmp/autopkgtest.PJQHju/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [736 B] 304s Get:2 http://ftpmaster.internal/ubuntu noble/universe s390x etcd-server s390x 3.4.30-1 [7779 kB] 305s Get:3 http://ftpmaster.internal/ubuntu noble/main s390x liblua5.4-0 s390x 5.4.6-3 [179 kB] 305s Get:4 http://ftpmaster.internal/ubuntu noble/universe s390x ncat s390x 7.94+git20230807.3be01efb1+dfsg-3 [215 kB] 305s Get:5 http://ftpmaster.internal/ubuntu noble/universe s390x vip-manager s390x 1.0.2-8 [2410 kB] 305s Fetched 10.6 MB in 1s (8047 kB/s) 305s Selecting previously unselected package etcd-server. 305s (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 ... 51333 files and directories currently installed.) 305s Preparing to unpack .../etcd-server_3.4.30-1_s390x.deb ... 305s Unpacking etcd-server (3.4.30-1) ... 306s Selecting previously unselected package liblua5.4-0:s390x. 306s Preparing to unpack .../liblua5.4-0_5.4.6-3_s390x.deb ... 306s Unpacking liblua5.4-0:s390x (5.4.6-3) ... 306s Selecting previously unselected package ncat. 306s Preparing to unpack .../ncat_7.94+git20230807.3be01efb1+dfsg-3_s390x.deb ... 306s Unpacking ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 306s Selecting previously unselected package vip-manager. 306s Preparing to unpack .../vip-manager_1.0.2-8_s390x.deb ... 306s Unpacking vip-manager (1.0.2-8) ... 306s Selecting previously unselected package autopkgtest-satdep. 306s Preparing to unpack .../1-autopkgtest-satdep.deb ... 306s Unpacking autopkgtest-satdep (0) ... 306s Setting up liblua5.4-0:s390x (5.4.6-3) ... 306s Setting up etcd-server (3.4.30-1) ... 306s info: Selecting UID from range 100 to 999 ... 306s 306s info: Selecting GID from range 100 to 999 ... 306s info: Adding system user `etcd' (UID 113) ... 306s info: Adding new group `etcd' (GID 123) ... 306s info: Adding new user `etcd' (UID 113) with group `etcd' ... 306s info: Creating home directory `/var/lib/etcd/' ... 306s Created symlink /etc/systemd/system/etcd2.service → /usr/lib/systemd/system/etcd.service. 306s Created symlink /etc/systemd/system/multi-user.target.wants/etcd.service → /usr/lib/systemd/system/etcd.service. 307s Setting up vip-manager (1.0.2-8) ... 307s Created symlink /etc/systemd/system/multi-user.target.wants/vip-manager.service → /usr/lib/systemd/system/vip-manager.service. 308s Setting up ncat (7.94+git20230807.3be01efb1+dfsg-3) ... 308s Setting up autopkgtest-satdep (0) ... 308s Processing triggers for man-db (2.12.0-3) ... 308s Processing triggers for libc-bin (2.39-0ubuntu6) ... 311s (Reading database ... 51590 files and directories currently installed.) 311s Removing autopkgtest-satdep (0) ... 312s autopkgtest [07:33:08]: test test: [----------------------- 312s ○ etcd.service - etcd - highly-available key value store 312s Loaded: loaded (/usr/lib/systemd/system/etcd.service; enabled; preset: enabled) 312s Active: inactive (dead) since Sun 2024-03-24 07:33:07 UTC; 10ms ago 312s Duration: 5.133s 312s Docs: https://etcd.io/docs 312s man:etcd 312s Process: 1270 ExecStart=/usr/bin/etcd $DAEMON_ARGS (code=killed, signal=TERM) 312s Main PID: 1270 (code=killed, signal=TERM) 312s CPU: 46ms 312s 312s Mar 24 07:33:02 autopkgtest systemd[1]: Started etcd.service - etcd - highly-available key value store. 312s Mar 24 07:33:02 autopkgtest etcd[1270]: set the initial cluster version to 3.4 312s Mar 24 07:33:02 autopkgtest etcd[1270]: enabled capabilities for version 3.4 312s Mar 24 07:33:07 autopkgtest etcd[1270]: received terminated signal, shutting down... 312s Mar 24 07:33:07 autopkgtest systemd[1]: Stopping etcd.service - etcd - highly-available key value store... 312s Mar 24 07:33:07 autopkgtest etcd[1270]: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 312s Mar 24 07:33:07 autopkgtest etcd[1270]: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 312s Mar 24 07:33:07 autopkgtest etcd[1270]: skipped leadership transfer for single voting member cluster 312s Mar 24 07:33:07 autopkgtest systemd[1]: etcd.service: Deactivated successfully. 312s Mar 24 07:33:07 autopkgtest systemd[1]: Stopped etcd.service - etcd - highly-available key value store. 312s dpkg-architecture: warning: cannot determine CC system type, falling back to default (native compilation) 312s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 312s 2024-03-24 07:33:07.288361 W | embed: Running http and grpc server on single port. This is not recommended for production. 312s 2024-03-24 07:33:07.288455 I | etcdmain: etcd Version: 3.4.30 312s 2024-03-24 07:33:07.288489 I | etcdmain: Git SHA: Not provided (use ./build instead of go build) 312s 2024-03-24 07:33:07.288531 I | etcdmain: Go Version: go1.22.0 312s 2024-03-24 07:33:07.288565 I | etcdmain: Go OS/Arch: linux/s390x 312s 2024-03-24 07:33:07.288570 I | etcdmain: setting maximum number of CPUs to 1, total number of available CPUs is 1 312s 2024-03-24 07:33:07.288577 W | etcdmain: no data-dir provided, using default data-dir ./default.etcd 312s [WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead 312s running etcd on unsupported architecture "s390x" since ETCD_UNSUPPORTED_ARCH is set 312s 2024-03-24 07:33:07.288666 W | embed: Running http and grpc server on single port. This is not recommended for production. 312s 2024-03-24 07:33:07.289232 I | embed: name = default 312s 2024-03-24 07:33:07.289261 I | embed: data dir = default.etcd 312s 2024-03-24 07:33:07.289270 I | embed: member dir = default.etcd/member 312s 2024-03-24 07:33:07.289273 I | embed: heartbeat = 100ms 312s 2024-03-24 07:33:07.289275 I | embed: election = 1000ms 312s 2024-03-24 07:33:07.289278 I | embed: snapshot count = 100000 312s 2024-03-24 07:33:07.289306 I | embed: advertise client URLs = http://localhost:2379 312s 2024-03-24 07:33:07.294113 I | etcdserver: starting member 8e9e05c52164694d in cluster cdf818194e3a8c32 312s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d switched to configuration voters=() 312s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d became follower at term 0 312s raft2024/03/24 07:33:07 INFO: newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0] 312s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d became follower at term 1 312s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 312s 2024-03-24 07:33:07.297678 W | auth: simple token is not cryptographically signed 312s 2024-03-24 07:33:07.299256 I | etcdserver: starting server... [version: 3.4.30, cluster version: to_be_decided] 312s 2024-03-24 07:33:07.301719 I | etcdserver: 8e9e05c52164694d as single-node; fast-forwarding 9 ticks (election ticks 10) 312s 2024-03-24 07:33:07.301819 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap.db, max: 5, interval: 30s 312s 2024-03-24 07:33:07.301825 I | pkg/fileutil: started to purge file, dir: default.etcd/member/snap, suffix: snap, max: 5, interval: 30s 312s 2024-03-24 07:33:07.301852 I | pkg/fileutil: started to purge file, dir: default.etcd/member/wal, suffix: wal, max: 5, interval: 30s 312s 2024-03-24 07:33:07.302051 I | embed: listening for peers on 127.0.0.1:2380 312s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437) 312s 2024-03-24 07:33:07.302938 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32 313s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d is starting a new election at term 1 313s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d became candidate at term 2 313s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2 313s raft2024/03/24 07:33:07 INFO: 8e9e05c52164694d became leader at term 2 313s raft2024/03/24 07:33:07 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2 313s 2024-03-24 07:33:07.796131 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32 313s 2024-03-24 07:33:07.796447 I | etcdserver: setting up the initial cluster version to 3.4 313s 2024-03-24 07:33:07.796646 I | embed: ready to serve client requests 313s 2024-03-24 07:33:07.799039 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged! 313s 2024-03-24 07:33:07.800708 N | etcdserver/membership: set the initial cluster version to 3.4 313s 2024-03-24 07:33:07.800883 I | etcdserver/api: enabled capabilities for version 3.4 314s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 314s Ncat: Listening on 0.0.0.0:12345 314s {"errorCode":100,"message":"Key not found","cause":"/service","index":3} 314s 2024/03/24 07:33:09 No dcs-endpoints specified, trying to use localhost with standard ports! 314s 2024/03/24 07:33:09 This is the config that will be used: 314s dcs-endpoints : [http://127.0.0.1:2379] 314s dcs-type : etcd 314s hostingtype : basic 314s interface : enc0 314s interval : 1000 314s ip : 10.0.2.123 314s manager-type : basic 314s netmask : 32 314s retry-after : 250 314s retry-num : 3 314s trigger-key : service/pgcluster/leader 314s trigger-value : autopkgtest 314s verbose : false 314s version : false 314s 2024/03/24 07:33:09 IP address 10.0.2.123/32 state is false, desired false 314s 2024/03/24 07:33:09 etcd error: 100: Key not found (/service) [3] 315s 2024/03/24 07:33:10 etcd error: 100: Key not found (/service) [3] 316s 2024/03/24 07:33:11 etcd error: 100: Key not found (/service) [3] 316s { 316s "action": "set", 316s "node": { 316s "key": "/service/pgcluster/leader", 316s "value": "autopkgtest", 316s "modifiedIndex": 4, 316s "createdIndex": 4 316s } 316s } 317s 2024/03/24 07:33:12 IP address 10.0.2.123/32 state is false, desired true 317s 2024/03/24 07:33:12 Configuring address 10.0.2.123/32 on enc0 317s 2024/03/24 07:33:12 Sent gratuitous ARP reply 317s 2024/03/24 07:33:12 Sent gratuitous ARP request 317s 2024/03/24 07:33:12 IP address 10.0.2.123/32 state is true, desired true 318s inet 10.0.2.123/32 scope global enc0 318s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 318s Ncat: Ncat: Connected to 10.0.2.123:12345. 318s Ncat: 0 bytes sent, 0 bytes received in 0.08 seconds. 318s Connection from 10.0.2.123:55384. 318s { 318s "action": "set", 318s "node": { 318s "key": "/service/pgcluster/leader", 318s "value": "0xGARBAGE", 318s "modifiedIndex": 5, 318s "createdIndex": 5 318s }, 318s "prevNode": { 318s "key": "/service/pgcluster/leader", 318s "value": "autopkgtest", 318s "modifiedIndex": 4, 318s "createdIndex": 4 318s } 318s } 319s 2024/03/24 07:33:14 IP address 10.0.2.123/32 state is true, desired false 319s 2024/03/24 07:33:14 Removing address 10.0.2.123/32 on enc0 319s 2024/03/24 07:33:14 IP address 10.0.2.123/32 state is false, desired false 320s Ncat: Version 7.94SVN ( https://nmap.org/ncat ) 323s Ncat: ### You've reached the end of the script, all "tests" have successfully been passed! ### 323s TIMEOUT. 323s 2024-03-24 07:33:18.065830 N | pkg/osutil: received terminated signal, shutting down... 323s 2024-03-24 07:33:18.066054 W | embed: stopping insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 323s 2024-03-24 07:33:18.067111 W | embed: stopped insecure grpc server due to error: accept tcp 127.0.0.1:2379: use of closed network connection 323s 2024-03-24 07:33:18.069686 I | etcdserver: skipped leadership transfer for single voting member cluster 323s autopkgtest [07:33:18]: test test: -----------------------] 323s autopkgtest [07:33:19]: test test: - - - - - - - - - - results - - - - - - - - - - 323s test PASS 324s autopkgtest [07:33:20]: @@@@@@@@@@@@@@@@@@@@ summary 324s test PASS 338s Creating nova instance adt-noble-s390x-vip-manager-20240324-072756-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-s390x-server-20240324.img (UUID e72c9cf8-77d4-4e3d-be82-5e850d5031de)...