0s autopkgtest [18:24:16]: starting date and time: 2024-03-19 18:24:16+0000
  0s autopkgtest [18:24:16]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps
  0s autopkgtest [18:24:16]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.uv8dsdfu/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:dqlite,src:libuv1 --apt-upgrade golang-github-canonical-go-dqlite --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=dqlite/1.16.0-5build1 libuv1/1.48.0-1.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-arm64-13.secgroup --name adt-noble-arm64-golang-github-canonical-go-dqlite-20240319-182416-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-arm64-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://us.ports.ubuntu.com/ubuntu-ports/
217s autopkgtest [18:27:53]: testbed dpkg architecture: arm64
217s autopkgtest [18:27:53]: testbed apt version: 2.7.12
217s autopkgtest [18:27:53]: @@@@@@@@@@@@@@@@@@@@ test bed setup
218s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB]
219s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B]
219s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3740 kB]
219s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [52.7 kB]
219s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [493 kB]
219s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [657 kB]
219s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B]
219s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.6 kB]
219s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B]
219s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4148 kB]
220s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B]
220s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [56.7 kB]
220s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B]
224s Fetched 9315 kB in 3s (3466 kB/s)
225s Reading package lists...
229s Reading package lists...
229s Building dependency tree...
229s Reading state information...
230s Calculating upgrade...
230s The following packages will be upgraded:
230s   ubuntu-minimal ubuntu-standard
231s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
231s Need to get 21.5 kB of archives.
231s After this operation, 0 B of additional disk space will be used.
231s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-minimal arm64 1.536build1 [10.7 kB]
231s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 ubuntu-standard arm64 1.536build1 [10.7 kB]
234s Fetched 21.5 kB in 0s (93.9 kB/s)
234s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease
234s (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 ... 75850 files and directories currently installed.)
234s Preparing to unpack .../ubuntu-minimal_1.536build1_arm64.deb ...
234s Unpacking ubuntu-minimal (1.536build1) over (1.536) ...
234s Preparing to unpack .../ubuntu-standard_1.536build1_arm64.deb ...
234s Unpacking ubuntu-standard (1.536build1) over (1.536) ...
234s Setting up ubuntu-minimal (1.536build1) ...
234s Setting up ubuntu-standard (1.536build1) ...
234s Reading package lists...
234s Building dependency tree...
234s Reading state information...
234s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
234s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease
234s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease
234s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease
237s Reading package lists...
237s Reading package lists...
237s Building dependency tree...
237s Reading state information...
238s Calculating upgrade...
239s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
239s Reading package lists...
239s Building dependency tree...
239s Reading state information...
240s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
243s autopkgtest [18:28:19]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024
243s autopkgtest [18:28:19]: @@@@@@@@@@@@@@@@@@@@ apt-source golang-github-canonical-go-dqlite
246s Get:1 http://ftpmaster.internal/ubuntu noble/universe golang-github-canonical-go-dqlite 1.21.0-1 (dsc) [2778 B]
247s Get:2 http://ftpmaster.internal/ubuntu noble/universe golang-github-canonical-go-dqlite 1.21.0-1 (tar) [110 kB]
247s Get:3 http://ftpmaster.internal/ubuntu noble/universe golang-github-canonical-go-dqlite 1.21.0-1 (diff) [4388 B]
247s gpgv: Signature made Mon Oct 30 22:11:23 2023 UTC
247s gpgv:                using RSA key D41A7AD07DF6C5FCA7489F1C29EEE2D6ECF442F9
247s gpgv:                issuer "gibmat@debian.org"
247s gpgv: Can't check signature: No public key
247s dpkg-source: warning: cannot verify inline signature for ./golang-github-canonical-go-dqlite_1.21.0-1.dsc: no acceptable signature found
247s autopkgtest [18:28:23]: testing package golang-github-canonical-go-dqlite version 1.21.0-1
247s autopkgtest [18:28:23]: build not needed
249s autopkgtest [18:28:25]: test dh-golang-autopkgtest: preparing testbed
254s Reading package lists...
254s Building dependency tree...
254s Reading state information...
255s Starting pkgProblemResolver with broken count: 0
255s Starting 2 pkgProblemResolver with broken count: 0
255s Done
256s The following additional packages will be installed:
256s   autoconf automake autopoint autotools-dev build-essential cpp cpp-13
256s   cpp-13-aarch64-linux-gnu cpp-aarch64-linux-gnu debhelper debugedit
256s   dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13
256s   g++-13-aarch64-linux-gnu g++-aarch64-linux-gnu gcc gcc-13
256s   gcc-13-aarch64-linux-gnu gcc-aarch64-linux-gnu gettext go-dqlite
256s   golang-1.22-go golang-1.22-src golang-any golang-github-burntsushi-toml-dev
256s   golang-github-canonical-go-dqlite-dev
256s   golang-github-cpuguy83-go-md2man-v2-dev golang-github-davecgh-go-spew-dev
256s   golang-github-fsnotify-fsnotify-dev golang-github-ghodss-yaml-dev
256s   golang-github-google-renameio-dev golang-github-hashicorp-hcl-dev
256s   golang-github-kr-fs-dev golang-github-magiconair-properties-dev
256s   golang-github-mattn-go-runewidth-dev golang-github-mattn-go-sqlite3-dev
256s   golang-github-mitchellh-mapstructure-dev golang-github-pelletier-go-toml-dev
256s   golang-github-pelletier-go-toml.v2-dev golang-github-peterh-liner-dev
256s   golang-github-pkg-errors-dev golang-github-pkg-sftp-dev
256s   golang-github-pmezard-go-difflib-dev golang-github-rican7-retry-dev
256s   golang-github-rivo-uniseg-dev golang-github-russross-blackfriday-v2-dev
256s   golang-github-shurcool-sanitized-anchor-name-dev
256s   golang-github-spf13-afero-dev golang-github-spf13-cast-dev
256s   golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev
256s   golang-github-spf13-pflag-dev golang-github-spf13-viper-dev
256s   golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev
256s   golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev
256s   golang-golang-x-sync-dev golang-golang-x-sys-dev golang-golang-x-term-dev
256s   golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev
256s   golang-gopkg-yaml.v3-dev golang-src intltool-debian libarchive-zip-perl
256s   libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev
256s   libdebhelper-perl libdqlite-dev libdqlite0 libdw1
256s   libfile-stripnondeterminism-perl libgcc-13-dev libgomp1 libhwasan0 libisl23
256s   libitm1 liblsan0 libmpc3 libnsl-dev libraft-dev libraft0 libsqlite3-dev
256s   libstdc++-13-dev libsub-override-perl libtirpc-dev libtool libtsan2
256s   libubsan1 libuv1t64 linux-libc-dev m4 po-debconf rpcsvc-proto
256s Suggested packages:
256s   autoconf-archive gnu-standards autoconf-doc cpp-doc gcc-13-locales
256s   cpp-13-doc dh-make gcc-13-doc gcc-multilib manpages-dev flex bison gdb
256s   gcc-doc gdb-aarch64-linux-gnu gettext-doc libasprintf-dev libgettextpo-dev
256s   bzr | brz git mercurial subversion glibc-doc sqlite3-doc libstdc++-13-doc
256s   libtool-doc gfortran | fortran95-compiler gcj-jdk m4-doc libmail-box-perl
256s Recommended packages:
256s   pkg-config manpages manpages-dev libc-devtools libarchive-cpio-perl
256s   libltdl-dev libmail-sendmail-perl
256s The following packages will be REMOVED:
256s   libuv1
256s The following NEW packages will be installed:
256s   autoconf automake autopkgtest-satdep autopoint autotools-dev build-essential
256s   cpp cpp-13 cpp-13-aarch64-linux-gnu cpp-aarch64-linux-gnu debhelper
256s   debugedit dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13
256s   g++-13-aarch64-linux-gnu g++-aarch64-linux-gnu gcc gcc-13
256s   gcc-13-aarch64-linux-gnu gcc-aarch64-linux-gnu gettext go-dqlite
256s   golang-1.22-go golang-1.22-src golang-any golang-github-burntsushi-toml-dev
256s   golang-github-canonical-go-dqlite-dev
256s   golang-github-cpuguy83-go-md2man-v2-dev golang-github-davecgh-go-spew-dev
256s   golang-github-fsnotify-fsnotify-dev golang-github-ghodss-yaml-dev
256s   golang-github-google-renameio-dev golang-github-hashicorp-hcl-dev
256s   golang-github-kr-fs-dev golang-github-magiconair-properties-dev
256s   golang-github-mattn-go-runewidth-dev golang-github-mattn-go-sqlite3-dev
256s   golang-github-mitchellh-mapstructure-dev golang-github-pelletier-go-toml-dev
256s   golang-github-pelletier-go-toml.v2-dev golang-github-peterh-liner-dev
256s   golang-github-pkg-errors-dev golang-github-pkg-sftp-dev
256s   golang-github-pmezard-go-difflib-dev golang-github-rican7-retry-dev
256s   golang-github-rivo-uniseg-dev golang-github-russross-blackfriday-v2-dev
256s   golang-github-shurcool-sanitized-anchor-name-dev
256s   golang-github-spf13-afero-dev golang-github-spf13-cast-dev
256s   golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev
256s   golang-github-spf13-pflag-dev golang-github-spf13-viper-dev
256s   golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev
256s   golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev
256s   golang-golang-x-sync-dev golang-golang-x-sys-dev golang-golang-x-term-dev
256s   golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev
256s   golang-gopkg-yaml.v3-dev golang-src intltool-debian libarchive-zip-perl
256s   libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev
256s   libdebhelper-perl libdqlite-dev libdqlite0 libdw1
256s   libfile-stripnondeterminism-perl libgcc-13-dev libgomp1 libhwasan0 libisl23
256s   libitm1 liblsan0 libmpc3 libnsl-dev libraft-dev libraft0 libsqlite3-dev
256s   libstdc++-13-dev libsub-override-perl libtirpc-dev libtool libtsan2
256s   libubsan1 libuv1t64 linux-libc-dev m4 po-debconf rpcsvc-proto
257s 0 upgraded, 106 newly installed, 1 to remove and 0 not upgraded.
257s Need to get 124 MB/124 MB of archives.
257s After this operation, 555 MB of additional disk space will be used.
257s Get:1 /tmp/autopkgtest.0BC2ra/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [904 B]
257s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 libuv1t64 arm64 1.48.0-1.1 [95.3 kB]
257s Get:3 http://ftpmaster.internal/ubuntu noble/main arm64 m4 arm64 1.4.19-4 [240 kB]
257s Get:4 http://ftpmaster.internal/ubuntu noble/main arm64 autoconf all 2.71-3 [339 kB]
257s Get:5 http://ftpmaster.internal/ubuntu noble/main arm64 autotools-dev all 20220109.1 [44.9 kB]
257s Get:6 http://ftpmaster.internal/ubuntu noble/main arm64 automake all 1:1.16.5-1.3ubuntu1 [558 kB]
257s Get:7 http://ftpmaster.internal/ubuntu noble/main arm64 autopoint all 0.21-14ubuntu1 [422 kB]
257s Get:8 http://ftpmaster.internal/ubuntu noble/main arm64 libc-dev-bin arm64 2.39-0ubuntu2 [19.7 kB]
257s Get:9 http://ftpmaster.internal/ubuntu noble/main arm64 linux-libc-dev arm64 6.8.0-11.11 [1569 kB]
257s Get:10 http://ftpmaster.internal/ubuntu noble/main arm64 libcrypt-dev arm64 1:4.4.36-4 [136 kB]
257s Get:11 http://ftpmaster.internal/ubuntu noble/main arm64 libtirpc-dev arm64 1.3.4+ds-1build1 [232 kB]
257s Get:12 http://ftpmaster.internal/ubuntu noble/main arm64 libnsl-dev arm64 1.3.0-3 [71.9 kB]
257s Get:13 http://ftpmaster.internal/ubuntu noble/main arm64 rpcsvc-proto arm64 1.4.2-0ubuntu6 [65.4 kB]
257s Get:14 http://ftpmaster.internal/ubuntu noble/main arm64 libc6-dev arm64 2.39-0ubuntu2 [1596 kB]
257s Get:15 http://ftpmaster.internal/ubuntu noble/main arm64 libisl23 arm64 0.26-3 [713 kB]
258s Get:16 http://ftpmaster.internal/ubuntu noble/main arm64 libmpc3 arm64 1.3.1-1 [55.3 kB]
258s Get:17 http://ftpmaster.internal/ubuntu noble/main arm64 cpp-13-aarch64-linux-gnu arm64 13.2.0-17ubuntu2 [10.3 MB]
258s Get:18 http://ftpmaster.internal/ubuntu noble/main arm64 cpp-13 arm64 13.2.0-17ubuntu2 [1028 B]
258s Get:19 http://ftpmaster.internal/ubuntu noble/main arm64 cpp-aarch64-linux-gnu arm64 4:13.2.0-7ubuntu1 [5316 B]
258s Get:20 http://ftpmaster.internal/ubuntu noble/main arm64 cpp arm64 4:13.2.0-7ubuntu1 [22.4 kB]
258s Get:21 http://ftpmaster.internal/ubuntu noble/main arm64 libcc1-0 arm64 14-20240303-1ubuntu1 [44.7 kB]
258s Get:22 http://ftpmaster.internal/ubuntu noble/main arm64 libgomp1 arm64 14-20240303-1ubuntu1 [144 kB]
258s Get:23 http://ftpmaster.internal/ubuntu noble/main arm64 libitm1 arm64 14-20240303-1ubuntu1 [27.7 kB]
258s Get:24 http://ftpmaster.internal/ubuntu noble/main arm64 libatomic1 arm64 14-20240303-1ubuntu1 [11.4 kB]
258s Get:25 http://ftpmaster.internal/ubuntu noble/main arm64 libasan8 arm64 14-20240303-1ubuntu1 [2919 kB]
258s Get:26 http://ftpmaster.internal/ubuntu noble/main arm64 liblsan0 arm64 14-20240303-1ubuntu1 [1282 kB]
258s Get:27 http://ftpmaster.internal/ubuntu noble/main arm64 libtsan2 arm64 14-20240303-1ubuntu1 [2687 kB]
259s Get:28 http://ftpmaster.internal/ubuntu noble/main arm64 libubsan1 arm64 14-20240303-1ubuntu1 [1151 kB]
259s Get:29 http://ftpmaster.internal/ubuntu noble/main arm64 libhwasan0 arm64 14-20240303-1ubuntu1 [1597 kB]
259s Get:30 http://ftpmaster.internal/ubuntu noble/main arm64 libgcc-13-dev arm64 13.2.0-17ubuntu2 [2464 kB]
259s Get:31 http://ftpmaster.internal/ubuntu noble/main arm64 gcc-13-aarch64-linux-gnu arm64 13.2.0-17ubuntu2 [20.1 MB]
259s Get:32 http://ftpmaster.internal/ubuntu noble/main arm64 gcc-13 arm64 13.2.0-17ubuntu2 [467 kB]
259s Get:33 http://ftpmaster.internal/ubuntu noble/main arm64 gcc-aarch64-linux-gnu arm64 4:13.2.0-7ubuntu1 [1198 B]
259s Get:34 http://ftpmaster.internal/ubuntu noble/main arm64 gcc arm64 4:13.2.0-7ubuntu1 [5018 B]
259s Get:35 http://ftpmaster.internal/ubuntu noble/main arm64 libstdc++-13-dev arm64 13.2.0-17ubuntu2 [2322 kB]
259s Get:36 http://ftpmaster.internal/ubuntu noble/main arm64 g++-13-aarch64-linux-gnu arm64 13.2.0-17ubuntu2 [11.7 MB]
260s Get:37 http://ftpmaster.internal/ubuntu noble/main arm64 g++-13 arm64 13.2.0-17ubuntu2 [14.4 kB]
260s Get:38 http://ftpmaster.internal/ubuntu noble/main arm64 g++-aarch64-linux-gnu arm64 4:13.2.0-7ubuntu1 [962 B]
260s Get:39 http://ftpmaster.internal/ubuntu noble/main arm64 g++ arm64 4:13.2.0-7ubuntu1 [1082 B]
260s Get:40 http://ftpmaster.internal/ubuntu noble/main arm64 build-essential arm64 12.10ubuntu1 [4932 B]
260s Get:41 http://ftpmaster.internal/ubuntu noble/main arm64 libdebhelper-perl all 13.14.1ubuntu1 [89.5 kB]
260s Get:42 http://ftpmaster.internal/ubuntu noble/main arm64 libtool all 2.4.7-7 [166 kB]
260s Get:43 http://ftpmaster.internal/ubuntu noble/main arm64 dh-autoreconf all 20 [16.1 kB]
260s Get:44 http://ftpmaster.internal/ubuntu noble/main arm64 libarchive-zip-perl all 1.68-1 [90.2 kB]
260s Get:45 http://ftpmaster.internal/ubuntu noble/main arm64 libsub-override-perl all 0.10-1 [10.0 kB]
260s Get:46 http://ftpmaster.internal/ubuntu noble/main arm64 libfile-stripnondeterminism-perl all 1.13.1-1 [18.1 kB]
260s Get:47 http://ftpmaster.internal/ubuntu noble/main arm64 dh-strip-nondeterminism all 1.13.1-1 [5362 B]
260s Get:48 http://ftpmaster.internal/ubuntu noble/main arm64 libdw1 arm64 0.190-1 [254 kB]
260s Get:49 http://ftpmaster.internal/ubuntu noble/main arm64 debugedit arm64 1:5.0-5 [45.9 kB]
260s Get:50 http://ftpmaster.internal/ubuntu noble/main arm64 dwz arm64 0.15-1 [110 kB]
260s Get:51 http://ftpmaster.internal/ubuntu noble/main arm64 gettext arm64 0.21-14ubuntu1 [846 kB]
260s Get:52 http://ftpmaster.internal/ubuntu noble/main arm64 intltool-debian all 0.35.0+20060710.6 [23.2 kB]
260s Get:53 http://ftpmaster.internal/ubuntu noble/main arm64 po-debconf all 1.0.21+nmu1 [233 kB]
260s Get:54 http://ftpmaster.internal/ubuntu noble/main arm64 debhelper all 13.14.1ubuntu1 [869 kB]
260s Get:55 http://ftpmaster.internal/ubuntu noble/universe arm64 libraft0 arm64 0.22.0-1 [91.1 kB]
260s Get:56 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 libdqlite0 arm64 1.16.0-5build1 [77.8 kB]
260s Get:57 http://ftpmaster.internal/ubuntu noble/universe arm64 go-dqlite arm64 1.21.0-1 [3911 kB]
260s Get:58 http://ftpmaster.internal/ubuntu noble/main arm64 golang-1.22-src all 1.22.1-1 [19.7 MB]
261s Get:59 http://ftpmaster.internal/ubuntu noble/main arm64 golang-1.22-go arm64 1.22.1-1 [23.6 MB]
261s Get:60 http://ftpmaster.internal/ubuntu noble/main arm64 golang-src all 2:1.22~2 [4992 B]
261s Get:61 http://ftpmaster.internal/ubuntu noble/main arm64 golang-go arm64 2:1.22~2 [43.9 kB]
261s Get:62 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-any arm64 2:1.22~2 [2840 B]
261s Get:63 http://ftpmaster.internal/ubuntu noble/main arm64 libsqlite3-dev arm64 3.45.1-1 [916 kB]
261s Get:64 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 libdqlite-dev arm64 1.16.0-5build1 [116 kB]
261s Get:65 http://ftpmaster.internal/ubuntu noble/universe arm64 libraft-dev arm64 0.22.0-1 [153 kB]
261s Get:66 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-gopkg-yaml.v2-dev all 2.4.0-4 [62.6 kB]
261s Get:67 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-ghodss-yaml-dev all 1.0.0+git20220118.d8423dc-2 [16.6 kB]
261s Get:68 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-google-renameio-dev all 2.0.0-2 [10.3 kB]
261s Get:69 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-mattn-go-sqlite3-dev arm64 1.14.19~ds1-1 [85.5 kB]
261s Get:70 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-rivo-uniseg-dev all 0.4.4-1 [256 kB]
261s Get:71 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-mattn-go-runewidth-dev all 0.0.15-2 [17.2 kB]
261s Get:72 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-peterh-liner-dev all 1.2.2-1 [21.3 kB]
261s Get:73 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-pkg-errors-dev all 0.9.1-3 [13.2 kB]
261s Get:74 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-rican7-retry-dev all 0.3.1-2 [7740 B]
261s Get:75 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-pmezard-go-difflib-dev all 1.0.0-3 [12.4 kB]
261s Get:76 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-shurcool-sanitized-anchor-name-dev all 1.0.0-3 [3590 B]
261s Get:77 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-russross-blackfriday-v2-dev all 2.1.0-1 [79.6 kB]
261s Get:78 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-cpuguy83-go-md2man-v2-dev all 2.0.3+ds1-1 [10.4 kB]
261s Get:79 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-pflag-dev all 1.0.6~git20210604-d5e0c0615ace-1 [43.6 kB]
261s Get:80 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-golang-x-sys-dev all 0.17.0-1 [424 kB]
261s Get:81 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-fsnotify-fsnotify-dev all 1.7.0-1 [39.1 kB]
261s Get:82 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-davecgh-go-spew-dev all 1.1.1-3 [31.1 kB]
261s Get:83 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-hashicorp-hcl-dev all 1.0.0-1.1 [58.9 kB]
261s Get:84 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-magiconair-properties-dev all 1.8.7-1 [27.3 kB]
261s Get:85 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-mitchellh-mapstructure-dev all 1.5.0+git20231216.8508981-1 [28.3 kB]
261s Get:86 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-burntsushi-toml-dev all 1.3.2-2 [115 kB]
261s Get:87 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-pelletier-go-toml-dev all 1.9.5-1build1 [79.6 kB]
261s Get:88 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-pelletier-go-toml.v2-dev all 2.1.1-1 [876 kB]
261s Get:89 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-kr-fs-dev all 0.1.0-2 [6344 B]
261s Get:90 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-golang-x-term-dev all 0.17.0-1 [14.7 kB]
261s Get:91 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-golang-x-text-dev all 0.14.0-1 [4646 kB]
262s Get:92 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-golang-x-crypto-dev all 1:0.19.0-1 [1712 kB]
262s Get:93 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-pkg-sftp-dev all 1.13.6-1 [104 kB]
262s Get:94 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-afero-dev all 1.11.0-1 [59.6 kB]
262s Get:95 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-cast-dev all 1.6.0-1 [14.3 kB]
262s Get:96 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-stretchr-objx-dev all 0.5.0-1 [26.5 kB]
262s Get:97 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-gopkg-yaml.v3-dev all 3.0.1-3 [76.1 kB]
262s Get:98 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-stretchr-testify-dev all 1.8.4-1 [72.8 kB]
262s Get:99 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-jwalterweatherman-dev all 1.1.0+really1.1.0-2 [6828 B]
262s Get:100 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-subosito-gotenv-dev all 1.3.0-1 [8808 B]
262s Get:101 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-gopkg-ini.v1-dev all 1.67.0-1 [40.8 kB]
262s Get:102 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-viper-dev all 1.12.0-1 [71.0 kB]
262s Get:103 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-spf13-cobra-dev all 1.8.0-1 [74.5 kB]
262s Get:104 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-golang-x-sync-dev all 0.6.0-1 [18.9 kB]
262s Get:105 http://ftpmaster.internal/ubuntu noble/universe arm64 golang-github-canonical-go-dqlite-dev all 1.21.0-1 [86.3 kB]
262s Get:106 http://ftpmaster.internal/ubuntu noble/main arm64 dh-golang all 1.62 [25.2 kB]
263s Fetched 124 MB in 6s (21.7 MB/s)
263s dpkg: libuv1:arm64: dependency problems, but removing anyway as you requested:
263s  bind9-libs:arm64 depends on libuv1 (>= 1.40.0).
263s 
263s (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 ... 75850 files and directories currently installed.)
263s Removing libuv1:arm64 (1.48.0-1) ...
263s Selecting previously unselected package libuv1t64:arm64.
263s (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 ... 75845 files and directories currently installed.)
263s Preparing to unpack .../000-libuv1t64_1.48.0-1.1_arm64.deb ...
263s Unpacking libuv1t64:arm64 (1.48.0-1.1) ...
263s Selecting previously unselected package m4.
263s Preparing to unpack .../001-m4_1.4.19-4_arm64.deb ...
263s Unpacking m4 (1.4.19-4) ...
263s Selecting previously unselected package autoconf.
263s Preparing to unpack .../002-autoconf_2.71-3_all.deb ...
263s Unpacking autoconf (2.71-3) ...
264s Selecting previously unselected package autotools-dev.
264s Preparing to unpack .../003-autotools-dev_20220109.1_all.deb ...
264s Unpacking autotools-dev (20220109.1) ...
264s Selecting previously unselected package automake.
264s Preparing to unpack .../004-automake_1%3a1.16.5-1.3ubuntu1_all.deb ...
264s Unpacking automake (1:1.16.5-1.3ubuntu1) ...
264s Selecting previously unselected package autopoint.
264s Preparing to unpack .../005-autopoint_0.21-14ubuntu1_all.deb ...
264s Unpacking autopoint (0.21-14ubuntu1) ...
264s Selecting previously unselected package libc-dev-bin.
264s Preparing to unpack .../006-libc-dev-bin_2.39-0ubuntu2_arm64.deb ...
264s Unpacking libc-dev-bin (2.39-0ubuntu2) ...
264s Selecting previously unselected package linux-libc-dev:arm64.
264s Preparing to unpack .../007-linux-libc-dev_6.8.0-11.11_arm64.deb ...
264s Unpacking linux-libc-dev:arm64 (6.8.0-11.11) ...
264s Selecting previously unselected package libcrypt-dev:arm64.
264s Preparing to unpack .../008-libcrypt-dev_1%3a4.4.36-4_arm64.deb ...
264s Unpacking libcrypt-dev:arm64 (1:4.4.36-4) ...
264s Selecting previously unselected package libtirpc-dev:arm64.
264s Preparing to unpack .../009-libtirpc-dev_1.3.4+ds-1build1_arm64.deb ...
264s Unpacking libtirpc-dev:arm64 (1.3.4+ds-1build1) ...
264s Selecting previously unselected package libnsl-dev:arm64.
264s Preparing to unpack .../010-libnsl-dev_1.3.0-3_arm64.deb ...
264s Unpacking libnsl-dev:arm64 (1.3.0-3) ...
264s Selecting previously unselected package rpcsvc-proto.
264s Preparing to unpack .../011-rpcsvc-proto_1.4.2-0ubuntu6_arm64.deb ...
264s Unpacking rpcsvc-proto (1.4.2-0ubuntu6) ...
264s Selecting previously unselected package libc6-dev:arm64.
264s Preparing to unpack .../012-libc6-dev_2.39-0ubuntu2_arm64.deb ...
264s Unpacking libc6-dev:arm64 (2.39-0ubuntu2) ...
265s Selecting previously unselected package libisl23:arm64.
265s Preparing to unpack .../013-libisl23_0.26-3_arm64.deb ...
265s Unpacking libisl23:arm64 (0.26-3) ...
265s Selecting previously unselected package libmpc3:arm64.
265s Preparing to unpack .../014-libmpc3_1.3.1-1_arm64.deb ...
265s Unpacking libmpc3:arm64 (1.3.1-1) ...
265s Selecting previously unselected package cpp-13-aarch64-linux-gnu.
265s Preparing to unpack .../015-cpp-13-aarch64-linux-gnu_13.2.0-17ubuntu2_arm64.deb ...
265s Unpacking cpp-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
265s Selecting previously unselected package cpp-13.
265s Preparing to unpack .../016-cpp-13_13.2.0-17ubuntu2_arm64.deb ...
265s Unpacking cpp-13 (13.2.0-17ubuntu2) ...
265s Selecting previously unselected package cpp-aarch64-linux-gnu.
265s Preparing to unpack .../017-cpp-aarch64-linux-gnu_4%3a13.2.0-7ubuntu1_arm64.deb ...
265s Unpacking cpp-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
265s Selecting previously unselected package cpp.
265s Preparing to unpack .../018-cpp_4%3a13.2.0-7ubuntu1_arm64.deb ...
265s Unpacking cpp (4:13.2.0-7ubuntu1) ...
265s Selecting previously unselected package libcc1-0:arm64.
265s Preparing to unpack .../019-libcc1-0_14-20240303-1ubuntu1_arm64.deb ...
265s Unpacking libcc1-0:arm64 (14-20240303-1ubuntu1) ...
265s Selecting previously unselected package libgomp1:arm64.
265s Preparing to unpack .../020-libgomp1_14-20240303-1ubuntu1_arm64.deb ...
265s Unpacking libgomp1:arm64 (14-20240303-1ubuntu1) ...
265s Selecting previously unselected package libitm1:arm64.
265s Preparing to unpack .../021-libitm1_14-20240303-1ubuntu1_arm64.deb ...
265s Unpacking libitm1:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libatomic1:arm64.
266s Preparing to unpack .../022-libatomic1_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking libatomic1:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libasan8:arm64.
266s Preparing to unpack .../023-libasan8_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking libasan8:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package liblsan0:arm64.
266s Preparing to unpack .../024-liblsan0_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking liblsan0:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libtsan2:arm64.
266s Preparing to unpack .../025-libtsan2_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking libtsan2:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libubsan1:arm64.
266s Preparing to unpack .../026-libubsan1_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking libubsan1:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libhwasan0:arm64.
266s Preparing to unpack .../027-libhwasan0_14-20240303-1ubuntu1_arm64.deb ...
266s Unpacking libhwasan0:arm64 (14-20240303-1ubuntu1) ...
266s Selecting previously unselected package libgcc-13-dev:arm64.
266s Preparing to unpack .../028-libgcc-13-dev_13.2.0-17ubuntu2_arm64.deb ...
266s Unpacking libgcc-13-dev:arm64 (13.2.0-17ubuntu2) ...
266s Selecting previously unselected package gcc-13-aarch64-linux-gnu.
266s Preparing to unpack .../029-gcc-13-aarch64-linux-gnu_13.2.0-17ubuntu2_arm64.deb ...
266s Unpacking gcc-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
267s Selecting previously unselected package gcc-13.
267s Preparing to unpack .../030-gcc-13_13.2.0-17ubuntu2_arm64.deb ...
267s Unpacking gcc-13 (13.2.0-17ubuntu2) ...
267s Selecting previously unselected package gcc-aarch64-linux-gnu.
267s Preparing to unpack .../031-gcc-aarch64-linux-gnu_4%3a13.2.0-7ubuntu1_arm64.deb ...
267s Unpacking gcc-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
267s Selecting previously unselected package gcc.
267s Preparing to unpack .../032-gcc_4%3a13.2.0-7ubuntu1_arm64.deb ...
267s Unpacking gcc (4:13.2.0-7ubuntu1) ...
267s Selecting previously unselected package libstdc++-13-dev:arm64.
267s Preparing to unpack .../033-libstdc++-13-dev_13.2.0-17ubuntu2_arm64.deb ...
267s Unpacking libstdc++-13-dev:arm64 (13.2.0-17ubuntu2) ...
268s Selecting previously unselected package g++-13-aarch64-linux-gnu.
268s Preparing to unpack .../034-g++-13-aarch64-linux-gnu_13.2.0-17ubuntu2_arm64.deb ...
268s Unpacking g++-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
268s Selecting previously unselected package g++-13.
268s Preparing to unpack .../035-g++-13_13.2.0-17ubuntu2_arm64.deb ...
268s Unpacking g++-13 (13.2.0-17ubuntu2) ...
268s Selecting previously unselected package g++-aarch64-linux-gnu.
268s Preparing to unpack .../036-g++-aarch64-linux-gnu_4%3a13.2.0-7ubuntu1_arm64.deb ...
268s Unpacking g++-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
268s Selecting previously unselected package g++.
268s Preparing to unpack .../037-g++_4%3a13.2.0-7ubuntu1_arm64.deb ...
268s Unpacking g++ (4:13.2.0-7ubuntu1) ...
268s Selecting previously unselected package build-essential.
268s Preparing to unpack .../038-build-essential_12.10ubuntu1_arm64.deb ...
268s Unpacking build-essential (12.10ubuntu1) ...
268s Selecting previously unselected package libdebhelper-perl.
268s Preparing to unpack .../039-libdebhelper-perl_13.14.1ubuntu1_all.deb ...
268s Unpacking libdebhelper-perl (13.14.1ubuntu1) ...
268s Selecting previously unselected package libtool.
268s Preparing to unpack .../040-libtool_2.4.7-7_all.deb ...
268s Unpacking libtool (2.4.7-7) ...
268s Selecting previously unselected package dh-autoreconf.
268s Preparing to unpack .../041-dh-autoreconf_20_all.deb ...
268s Unpacking dh-autoreconf (20) ...
269s Selecting previously unselected package libarchive-zip-perl.
269s Preparing to unpack .../042-libarchive-zip-perl_1.68-1_all.deb ...
269s Unpacking libarchive-zip-perl (1.68-1) ...
269s Selecting previously unselected package libsub-override-perl.
269s Preparing to unpack .../043-libsub-override-perl_0.10-1_all.deb ...
269s Unpacking libsub-override-perl (0.10-1) ...
269s Selecting previously unselected package libfile-stripnondeterminism-perl.
269s Preparing to unpack .../044-libfile-stripnondeterminism-perl_1.13.1-1_all.deb ...
269s Unpacking libfile-stripnondeterminism-perl (1.13.1-1) ...
269s Selecting previously unselected package dh-strip-nondeterminism.
269s Preparing to unpack .../045-dh-strip-nondeterminism_1.13.1-1_all.deb ...
269s Unpacking dh-strip-nondeterminism (1.13.1-1) ...
269s Selecting previously unselected package libdw1:arm64.
269s Preparing to unpack .../046-libdw1_0.190-1_arm64.deb ...
269s Unpacking libdw1:arm64 (0.190-1) ...
269s Selecting previously unselected package debugedit.
269s Preparing to unpack .../047-debugedit_1%3a5.0-5_arm64.deb ...
269s Unpacking debugedit (1:5.0-5) ...
269s Selecting previously unselected package dwz.
269s Preparing to unpack .../048-dwz_0.15-1_arm64.deb ...
269s Unpacking dwz (0.15-1) ...
269s Selecting previously unselected package gettext.
269s Preparing to unpack .../049-gettext_0.21-14ubuntu1_arm64.deb ...
269s Unpacking gettext (0.21-14ubuntu1) ...
269s Selecting previously unselected package intltool-debian.
269s Preparing to unpack .../050-intltool-debian_0.35.0+20060710.6_all.deb ...
269s Unpacking intltool-debian (0.35.0+20060710.6) ...
269s Selecting previously unselected package po-debconf.
269s Preparing to unpack .../051-po-debconf_1.0.21+nmu1_all.deb ...
269s Unpacking po-debconf (1.0.21+nmu1) ...
269s Selecting previously unselected package debhelper.
269s Preparing to unpack .../052-debhelper_13.14.1ubuntu1_all.deb ...
269s Unpacking debhelper (13.14.1ubuntu1) ...
269s Selecting previously unselected package libraft0:arm64.
269s Preparing to unpack .../053-libraft0_0.22.0-1_arm64.deb ...
269s Unpacking libraft0:arm64 (0.22.0-1) ...
269s Selecting previously unselected package libdqlite0:arm64.
269s Preparing to unpack .../054-libdqlite0_1.16.0-5build1_arm64.deb ...
269s Unpacking libdqlite0:arm64 (1.16.0-5build1) ...
269s Selecting previously unselected package go-dqlite.
269s Preparing to unpack .../055-go-dqlite_1.21.0-1_arm64.deb ...
269s Unpacking go-dqlite (1.21.0-1) ...
270s Selecting previously unselected package golang-1.22-src.
270s Preparing to unpack .../056-golang-1.22-src_1.22.1-1_all.deb ...
270s Unpacking golang-1.22-src (1.22.1-1) ...
274s Selecting previously unselected package golang-1.22-go.
274s Preparing to unpack .../057-golang-1.22-go_1.22.1-1_arm64.deb ...
274s Unpacking golang-1.22-go (1.22.1-1) ...
275s Selecting previously unselected package golang-src.
275s Preparing to unpack .../058-golang-src_2%3a1.22~2_all.deb ...
275s Unpacking golang-src (2:1.22~2) ...
275s Selecting previously unselected package golang-go:arm64.
275s Preparing to unpack .../059-golang-go_2%3a1.22~2_arm64.deb ...
275s Unpacking golang-go:arm64 (2:1.22~2) ...
276s Selecting previously unselected package golang-any:arm64.
276s Preparing to unpack .../060-golang-any_2%3a1.22~2_arm64.deb ...
276s Unpacking golang-any:arm64 (2:1.22~2) ...
276s Selecting previously unselected package libsqlite3-dev:arm64.
276s Preparing to unpack .../061-libsqlite3-dev_3.45.1-1_arm64.deb ...
276s Unpacking libsqlite3-dev:arm64 (3.45.1-1) ...
276s Selecting previously unselected package libdqlite-dev:arm64.
276s Preparing to unpack .../062-libdqlite-dev_1.16.0-5build1_arm64.deb ...
276s Unpacking libdqlite-dev:arm64 (1.16.0-5build1) ...
276s Selecting previously unselected package libraft-dev:arm64.
276s Preparing to unpack .../063-libraft-dev_0.22.0-1_arm64.deb ...
276s Unpacking libraft-dev:arm64 (0.22.0-1) ...
276s Selecting previously unselected package golang-gopkg-yaml.v2-dev.
276s Preparing to unpack .../064-golang-gopkg-yaml.v2-dev_2.4.0-4_all.deb ...
276s Unpacking golang-gopkg-yaml.v2-dev (2.4.0-4) ...
276s Selecting previously unselected package golang-github-ghodss-yaml-dev.
276s Preparing to unpack .../065-golang-github-ghodss-yaml-dev_1.0.0+git20220118.d8423dc-2_all.deb ...
276s Unpacking golang-github-ghodss-yaml-dev (1.0.0+git20220118.d8423dc-2) ...
276s Selecting previously unselected package golang-github-google-renameio-dev.
276s Preparing to unpack .../066-golang-github-google-renameio-dev_2.0.0-2_all.deb ...
276s Unpacking golang-github-google-renameio-dev (2.0.0-2) ...
276s Selecting previously unselected package golang-github-mattn-go-sqlite3-dev:arm64.
276s Preparing to unpack .../067-golang-github-mattn-go-sqlite3-dev_1.14.19~ds1-1_arm64.deb ...
276s Unpacking golang-github-mattn-go-sqlite3-dev:arm64 (1.14.19~ds1-1) ...
276s Selecting previously unselected package golang-github-rivo-uniseg-dev.
276s Preparing to unpack .../068-golang-github-rivo-uniseg-dev_0.4.4-1_all.deb ...
276s Unpacking golang-github-rivo-uniseg-dev (0.4.4-1) ...
276s Selecting previously unselected package golang-github-mattn-go-runewidth-dev.
276s Preparing to unpack .../069-golang-github-mattn-go-runewidth-dev_0.0.15-2_all.deb ...
276s Unpacking golang-github-mattn-go-runewidth-dev (0.0.15-2) ...
276s Selecting previously unselected package golang-github-peterh-liner-dev.
276s Preparing to unpack .../070-golang-github-peterh-liner-dev_1.2.2-1_all.deb ...
276s Unpacking golang-github-peterh-liner-dev (1.2.2-1) ...
276s Selecting previously unselected package golang-github-pkg-errors-dev.
276s Preparing to unpack .../071-golang-github-pkg-errors-dev_0.9.1-3_all.deb ...
276s Unpacking golang-github-pkg-errors-dev (0.9.1-3) ...
276s Selecting previously unselected package golang-github-rican7-retry-dev.
276s Preparing to unpack .../072-golang-github-rican7-retry-dev_0.3.1-2_all.deb ...
276s Unpacking golang-github-rican7-retry-dev (0.3.1-2) ...
276s Selecting previously unselected package golang-github-pmezard-go-difflib-dev.
276s Preparing to unpack .../073-golang-github-pmezard-go-difflib-dev_1.0.0-3_all.deb ...
276s Unpacking golang-github-pmezard-go-difflib-dev (1.0.0-3) ...
276s Selecting previously unselected package golang-github-shurcool-sanitized-anchor-name-dev.
276s Preparing to unpack .../074-golang-github-shurcool-sanitized-anchor-name-dev_1.0.0-3_all.deb ...
276s Unpacking golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-3) ...
276s Selecting previously unselected package golang-github-russross-blackfriday-v2-dev.
276s Preparing to unpack .../075-golang-github-russross-blackfriday-v2-dev_2.1.0-1_all.deb ...
276s Unpacking golang-github-russross-blackfriday-v2-dev (2.1.0-1) ...
276s Selecting previously unselected package golang-github-cpuguy83-go-md2man-v2-dev.
277s Preparing to unpack .../076-golang-github-cpuguy83-go-md2man-v2-dev_2.0.3+ds1-1_all.deb ...
277s Unpacking golang-github-cpuguy83-go-md2man-v2-dev (2.0.3+ds1-1) ...
277s Selecting previously unselected package golang-github-spf13-pflag-dev.
277s Preparing to unpack .../077-golang-github-spf13-pflag-dev_1.0.6~git20210604-d5e0c0615ace-1_all.deb ...
277s Unpacking golang-github-spf13-pflag-dev (1.0.6~git20210604-d5e0c0615ace-1) ...
277s Selecting previously unselected package golang-golang-x-sys-dev.
277s Preparing to unpack .../078-golang-golang-x-sys-dev_0.17.0-1_all.deb ...
277s Unpacking golang-golang-x-sys-dev (0.17.0-1) ...
277s Selecting previously unselected package golang-github-fsnotify-fsnotify-dev.
277s Preparing to unpack .../079-golang-github-fsnotify-fsnotify-dev_1.7.0-1_all.deb ...
277s Unpacking golang-github-fsnotify-fsnotify-dev (1.7.0-1) ...
277s Selecting previously unselected package golang-github-davecgh-go-spew-dev.
277s Preparing to unpack .../080-golang-github-davecgh-go-spew-dev_1.1.1-3_all.deb ...
277s Unpacking golang-github-davecgh-go-spew-dev (1.1.1-3) ...
277s Selecting previously unselected package golang-github-hashicorp-hcl-dev.
277s Preparing to unpack .../081-golang-github-hashicorp-hcl-dev_1.0.0-1.1_all.deb ...
277s Unpacking golang-github-hashicorp-hcl-dev (1.0.0-1.1) ...
277s Selecting previously unselected package golang-github-magiconair-properties-dev.
277s Preparing to unpack .../082-golang-github-magiconair-properties-dev_1.8.7-1_all.deb ...
277s Unpacking golang-github-magiconair-properties-dev (1.8.7-1) ...
277s Selecting previously unselected package golang-github-mitchellh-mapstructure-dev.
277s Preparing to unpack .../083-golang-github-mitchellh-mapstructure-dev_1.5.0+git20231216.8508981-1_all.deb ...
277s Unpacking golang-github-mitchellh-mapstructure-dev (1.5.0+git20231216.8508981-1) ...
277s Selecting previously unselected package golang-github-burntsushi-toml-dev.
277s Preparing to unpack .../084-golang-github-burntsushi-toml-dev_1.3.2-2_all.deb ...
277s Unpacking golang-github-burntsushi-toml-dev (1.3.2-2) ...
278s Selecting previously unselected package golang-github-pelletier-go-toml-dev.
278s Preparing to unpack .../085-golang-github-pelletier-go-toml-dev_1.9.5-1build1_all.deb ...
278s Unpacking golang-github-pelletier-go-toml-dev (1.9.5-1build1) ...
278s Selecting previously unselected package golang-github-pelletier-go-toml.v2-dev.
278s Preparing to unpack .../086-golang-github-pelletier-go-toml.v2-dev_2.1.1-1_all.deb ...
278s Unpacking golang-github-pelletier-go-toml.v2-dev (2.1.1-1) ...
278s Selecting previously unselected package golang-github-kr-fs-dev.
278s Preparing to unpack .../087-golang-github-kr-fs-dev_0.1.0-2_all.deb ...
278s Unpacking golang-github-kr-fs-dev (0.1.0-2) ...
278s Selecting previously unselected package golang-golang-x-term-dev.
278s Preparing to unpack .../088-golang-golang-x-term-dev_0.17.0-1_all.deb ...
278s Unpacking golang-golang-x-term-dev (0.17.0-1) ...
278s Selecting previously unselected package golang-golang-x-text-dev.
278s Preparing to unpack .../089-golang-golang-x-text-dev_0.14.0-1_all.deb ...
278s Unpacking golang-golang-x-text-dev (0.14.0-1) ...
278s Selecting previously unselected package golang-golang-x-crypto-dev.
278s Preparing to unpack .../090-golang-golang-x-crypto-dev_1%3a0.19.0-1_all.deb ...
278s Unpacking golang-golang-x-crypto-dev (1:0.19.0-1) ...
279s Selecting previously unselected package golang-github-pkg-sftp-dev.
279s Preparing to unpack .../091-golang-github-pkg-sftp-dev_1.13.6-1_all.deb ...
279s Unpacking golang-github-pkg-sftp-dev (1.13.6-1) ...
279s Selecting previously unselected package golang-github-spf13-afero-dev.
279s Preparing to unpack .../092-golang-github-spf13-afero-dev_1.11.0-1_all.deb ...
279s Unpacking golang-github-spf13-afero-dev (1.11.0-1) ...
279s Selecting previously unselected package golang-github-spf13-cast-dev.
279s Preparing to unpack .../093-golang-github-spf13-cast-dev_1.6.0-1_all.deb ...
279s Unpacking golang-github-spf13-cast-dev (1.6.0-1) ...
279s Selecting previously unselected package golang-github-stretchr-objx-dev.
279s Preparing to unpack .../094-golang-github-stretchr-objx-dev_0.5.0-1_all.deb ...
279s Unpacking golang-github-stretchr-objx-dev (0.5.0-1) ...
279s Selecting previously unselected package golang-gopkg-yaml.v3-dev.
279s Preparing to unpack .../095-golang-gopkg-yaml.v3-dev_3.0.1-3_all.deb ...
279s Unpacking golang-gopkg-yaml.v3-dev (3.0.1-3) ...
279s Selecting previously unselected package golang-github-stretchr-testify-dev.
279s Preparing to unpack .../096-golang-github-stretchr-testify-dev_1.8.4-1_all.deb ...
279s Unpacking golang-github-stretchr-testify-dev (1.8.4-1) ...
279s Selecting previously unselected package golang-github-spf13-jwalterweatherman-dev.
279s Preparing to unpack .../097-golang-github-spf13-jwalterweatherman-dev_1.1.0+really1.1.0-2_all.deb ...
279s Unpacking golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-2) ...
279s Selecting previously unselected package golang-github-subosito-gotenv-dev.
279s Preparing to unpack .../098-golang-github-subosito-gotenv-dev_1.3.0-1_all.deb ...
279s Unpacking golang-github-subosito-gotenv-dev (1.3.0-1) ...
279s Selecting previously unselected package golang-gopkg-ini.v1-dev.
279s Preparing to unpack .../099-golang-gopkg-ini.v1-dev_1.67.0-1_all.deb ...
279s Unpacking golang-gopkg-ini.v1-dev (1.67.0-1) ...
279s Selecting previously unselected package golang-github-spf13-viper-dev.
279s Preparing to unpack .../100-golang-github-spf13-viper-dev_1.12.0-1_all.deb ...
279s Unpacking golang-github-spf13-viper-dev (1.12.0-1) ...
279s Selecting previously unselected package golang-github-spf13-cobra-dev.
279s Preparing to unpack .../101-golang-github-spf13-cobra-dev_1.8.0-1_all.deb ...
279s Unpacking golang-github-spf13-cobra-dev (1.8.0-1) ...
279s Selecting previously unselected package golang-golang-x-sync-dev.
279s Preparing to unpack .../102-golang-golang-x-sync-dev_0.6.0-1_all.deb ...
279s Unpacking golang-golang-x-sync-dev (0.6.0-1) ...
279s Selecting previously unselected package golang-github-canonical-go-dqlite-dev.
279s Preparing to unpack .../103-golang-github-canonical-go-dqlite-dev_1.21.0-1_all.deb ...
279s Unpacking golang-github-canonical-go-dqlite-dev (1.21.0-1) ...
280s Selecting previously unselected package dh-golang.
280s Preparing to unpack .../104-dh-golang_1.62_all.deb ...
280s Unpacking dh-golang (1.62) ...
280s Selecting previously unselected package autopkgtest-satdep.
280s Preparing to unpack .../105-1-autopkgtest-satdep.deb ...
280s Unpacking autopkgtest-satdep (0) ...
280s Setting up golang-github-pelletier-go-toml.v2-dev (2.1.1-1) ...
280s Setting up golang-gopkg-yaml.v2-dev (2.4.0-4) ...
280s Setting up libdw1:arm64 (0.190-1) ...
280s Setting up golang-github-mitchellh-mapstructure-dev (1.5.0+git20231216.8508981-1) ...
280s Setting up golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-3) ...
280s Setting up golang-github-stretchr-objx-dev (0.5.0-1) ...
280s Setting up golang-github-pkg-errors-dev (0.9.1-3) ...
280s Setting up libarchive-zip-perl (1.68-1) ...
280s Setting up golang-gopkg-yaml.v3-dev (3.0.1-3) ...
280s Setting up libdebhelper-perl (13.14.1ubuntu1) ...
280s Setting up golang-github-burntsushi-toml-dev (1.3.2-2) ...
280s Setting up golang-golang-x-sys-dev (0.17.0-1) ...
280s Setting up golang-github-kr-fs-dev (0.1.0-2) ...
280s Setting up libuv1t64:arm64 (1.48.0-1.1) ...
280s Setting up golang-github-subosito-gotenv-dev (1.3.0-1) ...
280s Setting up linux-libc-dev:arm64 (6.8.0-11.11) ...
280s Setting up golang-github-pmezard-go-difflib-dev (1.0.0-3) ...
280s Setting up m4 (1.4.19-4) ...
280s Setting up golang-golang-x-term-dev (0.17.0-1) ...
280s Setting up libgomp1:arm64 (14-20240303-1ubuntu1) ...
280s Setting up golang-github-google-renameio-dev (2.0.0-2) ...
280s Setting up golang-github-spf13-pflag-dev (1.0.6~git20210604-d5e0c0615ace-1) ...
280s Setting up golang-github-davecgh-go-spew-dev (1.1.1-3) ...
280s Setting up autotools-dev (20220109.1) ...
280s Setting up libtirpc-dev:arm64 (1.3.4+ds-1build1) ...
280s Setting up rpcsvc-proto (1.4.2-0ubuntu6) ...
280s Setting up libraft0:arm64 (0.22.0-1) ...
280s Setting up golang-github-stretchr-testify-dev (1.8.4-1) ...
280s Setting up golang-1.22-src (1.22.1-1) ...
280s Setting up libraft-dev:arm64 (0.22.0-1) ...
280s Setting up golang-gopkg-ini.v1-dev (1.67.0-1) ...
280s Setting up libmpc3:arm64 (1.3.1-1) ...
280s Setting up libatomic1:arm64 (14-20240303-1ubuntu1) ...
280s Setting up golang-golang-x-sync-dev (0.6.0-1) ...
280s Setting up autopoint (0.21-14ubuntu1) ...
280s Setting up golang-github-magiconair-properties-dev (1.8.7-1) ...
280s Setting up golang-github-hashicorp-hcl-dev (1.0.0-1.1) ...
280s Setting up golang-github-rican7-retry-dev (0.3.1-2) ...
280s Setting up autoconf (2.71-3) ...
280s Setting up golang-github-rivo-uniseg-dev (0.4.4-1) ...
280s Setting up libubsan1:arm64 (14-20240303-1ubuntu1) ...
280s Setting up dwz (0.15-1) ...
280s Setting up libnsl-dev:arm64 (1.3.0-3) ...
280s Setting up golang-golang-x-text-dev (0.14.0-1) ...
280s Setting up libhwasan0:arm64 (14-20240303-1ubuntu1) ...
280s Setting up libcrypt-dev:arm64 (1:4.4.36-4) ...
280s Setting up libasan8:arm64 (14-20240303-1ubuntu1) ...
280s Setting up golang-github-spf13-cast-dev (1.6.0-1) ...
280s Setting up golang-github-fsnotify-fsnotify-dev (1.7.0-1) ...
280s Setting up debugedit (1:5.0-5) ...
280s Setting up libsub-override-perl (0.10-1) ...
280s Setting up golang-golang-x-crypto-dev (1:0.19.0-1) ...
280s Setting up golang-github-pelletier-go-toml-dev (1.9.5-1build1) ...
280s Setting up golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-2) ...
280s Setting up libtsan2:arm64 (14-20240303-1ubuntu1) ...
280s Setting up libdqlite0:arm64 (1.16.0-5build1) ...
280s Setting up libisl23:arm64 (0.26-3) ...
280s Setting up golang-github-ghodss-yaml-dev (1.0.0+git20220118.d8423dc-2) ...
280s Setting up libc-dev-bin (2.39-0ubuntu2) ...
280s Setting up golang-src (2:1.22~2) ...
280s Setting up libcc1-0:arm64 (14-20240303-1ubuntu1) ...
280s Setting up liblsan0:arm64 (14-20240303-1ubuntu1) ...
280s Setting up libitm1:arm64 (14-20240303-1ubuntu1) ...
280s Setting up automake (1:1.16.5-1.3ubuntu1) ...
280s update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode
280s Setting up libfile-stripnondeterminism-perl (1.13.1-1) ...
280s Setting up golang-github-mattn-go-runewidth-dev (0.0.15-2) ...
280s Setting up gettext (0.21-14ubuntu1) ...
280s Setting up golang-github-russross-blackfriday-v2-dev (2.1.0-1) ...
280s Setting up cpp-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
280s Setting up golang-github-pkg-sftp-dev (1.13.6-1) ...
280s Setting up golang-1.22-go (1.22.1-1) ...
280s Setting up intltool-debian (0.35.0+20060710.6) ...
280s Setting up golang-github-peterh-liner-dev (1.2.2-1) ...
280s Setting up go-dqlite (1.21.0-1) ...
280s Setting up cpp-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
280s Setting up dh-strip-nondeterminism (1.13.1-1) ...
280s Setting up libgcc-13-dev:arm64 (13.2.0-17ubuntu2) ...
280s Setting up libc6-dev:arm64 (2.39-0ubuntu2) ...
280s Setting up golang-github-spf13-afero-dev (1.11.0-1) ...
280s Setting up libstdc++-13-dev:arm64 (13.2.0-17ubuntu2) ...
280s Setting up golang-github-cpuguy83-go-md2man-v2-dev (2.0.3+ds1-1) ...
280s Setting up cpp-13 (13.2.0-17ubuntu2) ...
280s Setting up golang-go:arm64 (2:1.22~2) ...
280s Setting up po-debconf (1.0.21+nmu1) ...
280s Setting up gcc-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
280s Setting up golang-any:arm64 (2:1.22~2) ...
280s Setting up libsqlite3-dev:arm64 (3.45.1-1) ...
280s Setting up gcc-13 (13.2.0-17ubuntu2) ...
280s Setting up golang-github-spf13-viper-dev (1.12.0-1) ...
280s Setting up cpp (4:13.2.0-7ubuntu1) ...
280s Setting up g++-13-aarch64-linux-gnu (13.2.0-17ubuntu2) ...
280s Setting up gcc-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
280s Setting up libdqlite-dev:arm64 (1.16.0-5build1) ...
280s Setting up g++-13 (13.2.0-17ubuntu2) ...
280s Setting up libtool (2.4.7-7) ...
280s Setting up gcc (4:13.2.0-7ubuntu1) ...
280s Setting up dh-autoreconf (20) ...
280s Setting up golang-github-mattn-go-sqlite3-dev:arm64 (1.14.19~ds1-1) ...
280s Setting up golang-github-spf13-cobra-dev (1.8.0-1) ...
280s Setting up g++-aarch64-linux-gnu (4:13.2.0-7ubuntu1) ...
280s Setting up debhelper (13.14.1ubuntu1) ...
280s Setting up golang-github-canonical-go-dqlite-dev (1.21.0-1) ...
280s Setting up g++ (4:13.2.0-7ubuntu1) ...
280s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode
280s Setting up build-essential (12.10ubuntu1) ...
280s Setting up dh-golang (1.62) ...
280s Setting up autopkgtest-satdep (0) ...
280s Processing triggers for man-db (2.12.0-3) ...
281s Processing triggers for install-info (7.1-3) ...
282s Processing triggers for libc-bin (2.39-0ubuntu2) ...
289s (Reading database ... 97825 files and directories currently installed.)
289s Removing autopkgtest-satdep (0) ...
290s autopkgtest [18:29:06]: test dh-golang-autopkgtest: /usr/bin/dh_golang_autopkgtest
290s autopkgtest [18:29:06]: test dh-golang-autopkgtest: [-----------------------
290s [info] Testing github.com/canonical/go-dqlite...
290s [info] Source code installed by binary package, overriding dh_auto_configure...
290s dh build --builddirectory=_build --buildsystem=golang --with=golang
291s    dh_update_autotools_config -O--builddirectory=_build -O--buildsystem=golang
291s    dh_autoreconf -O--builddirectory=_build -O--buildsystem=golang
291s    debian/rules override_dh_auto_configure
291s make[1]: Entering directory '/tmp/autopkgtest.0BC2ra/autopkgtest_tmp'
291s mkdir -p "_build"
291s # remove existing symlinks, since "cp -a" won't convert them
291s find "_build" -type l -exec rm "{}" \;
291s cp -a /usr/share/gocode/src "_build"
292s make[1]: Leaving directory '/tmp/autopkgtest.0BC2ra/autopkgtest_tmp'
292s    dh_auto_build -O--builddirectory=_build -O--buildsystem=golang
292s 	cd _build && go install -trimpath -v -p 1 github.com/canonical/go-dqlite github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/benchmark github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite/cmd/dqlite github.com/canonical/go-dqlite/cmd/dqlite-benchmark github.com/canonical/go-dqlite/cmd/dqlite-demo github.com/canonical/go-dqlite/driver github.com/canonical/go-dqlite/internal/bindings github.com/canonical/go-dqlite/internal/protocol github.com/canonical/go-dqlite/internal/shell github.com/canonical/go-dqlite/logging github.com/canonical/go-dqlite/tracing
293s internal/goarch
293s internal/abi
293s internal/unsafeheader
293s internal/cpu
293s internal/bytealg
293s internal/chacha8rand
294s internal/coverage/rtcov
294s internal/godebugs
294s internal/goexperiment
294s internal/goos
294s runtime/internal/atomic
294s runtime/internal/math
294s runtime/internal/sys
294s runtime/internal/syscall
294s runtime
304s internal/reflectlite
304s errors
304s internal/race
304s sync/atomic
304s sync
304s internal/itoa
304s internal/oserror
304s syscall
305s time
306s context
307s math/bits
307s math
307s unicode/utf8
307s strconv
308s unicode
308s reflect
310s cmp
310s slices
310s sort
311s internal/fmtsort
311s io
311s internal/syscall/unix
311s internal/poll
311s internal/safefilepath
311s internal/syscall/execenv
311s internal/testlog
311s path
311s io/fs
312s os
312s fmt
313s bytes
313s container/list
313s hash
314s crypto
314s crypto/internal/alias
314s crypto/subtle
314s encoding/binary
314s crypto/cipher
314s crypto/internal/boring/sig
314s crypto/internal/boring
314s crypto/aes
314s crypto/des
314s crypto/internal/edwards25519/field
315s crypto/internal/nistec/fiat
316s embed
316s crypto/internal/nistec
316s crypto/internal/randutil
316s crypto/ecdh
316s internal/bisect
317s internal/godebug
317s math/rand
317s strings
317s math/big
319s crypto/elliptic
319s crypto/internal/bigmod
319s crypto/internal/boring/bbig
319s crypto/sha512
319s unicode/utf16
319s encoding/asn1
320s vendor/golang.org/x/crypto/cryptobyte/asn1
320s vendor/golang.org/x/crypto/cryptobyte
320s crypto/ecdsa
320s crypto/internal/edwards25519
321s crypto/rand
321s crypto/ed25519
321s crypto/hmac
321s crypto/md5
321s crypto/rc4
321s crypto/rsa
321s crypto/sha1
321s crypto/sha256
321s crypto/dsa
321s encoding/hex
322s crypto/x509/pkix
322s encoding/base64
322s encoding/pem
322s vendor/golang.org/x/net/dns/dnsmessage
322s internal/nettrace
322s internal/singleflight
322s internal/intern
322s net/netip
323s runtime/cgo
325s net
330s net/url
330s path/filepath
331s crypto/x509
332s vendor/golang.org/x/crypto/internal/alias
332s vendor/golang.org/x/crypto/chacha20
332s vendor/golang.org/x/crypto/internal/poly1305
332s vendor/golang.org/x/crypto/chacha20poly1305
332s vendor/golang.org/x/crypto/hkdf
332s crypto/tls
336s database/sql/driver
336s database/sql
337s github.com/Rican7/retry/backoff
337s github.com/Rican7/retry/jitter
337s github.com/Rican7/retry/strategy
337s github.com/Rican7/retry
337s encoding
337s flag
337s bufio
337s internal/sysinfo
337s runtime/debug
338s runtime/trace
338s testing
339s github.com/canonical/go-dqlite/logging
339s github.com/pkg/errors
339s github.com/canonical/go-dqlite/internal/protocol
339s io/ioutil
339s github.com/google/renameio
339s github.com/mattn/go-sqlite3
349s regexp/syntax
349s regexp
349s gopkg.in/yaml.v2
351s github.com/canonical/go-dqlite/client
351s github.com/canonical/go-dqlite/internal/bindings
354s github.com/canonical/go-dqlite
354s github.com/canonical/go-dqlite/tracing
354s github.com/canonical/go-dqlite/driver
354s golang.org/x/sync/semaphore
354s golang.org/x/sys/unix
356s log/internal
356s log
356s github.com/canonical/go-dqlite/app
357s github.com/canonical/go-dqlite/benchmark
357s encoding/json
358s github.com/canonical/go-dqlite/internal/shell
358s container/ring
358s github.com/rivo/uniseg
359s github.com/mattn/go-runewidth
359s os/signal
359s github.com/peterh/liner
360s encoding/csv
360s github.com/spf13/pflag
361s text/template/parse
362s text/template
363s github.com/spf13/cobra
363s github.com/canonical/go-dqlite/cmd/dqlite
366s github.com/canonical/go-dqlite/cmd/dqlite-benchmark
368s compress/flate
368s hash/crc32
368s compress/gzip
368s vendor/golang.org/x/text/transform
368s vendor/golang.org/x/text/unicode/bidi
369s vendor/golang.org/x/text/secure/bidirule
369s vendor/golang.org/x/text/unicode/norm
370s vendor/golang.org/x/net/idna
370s net/textproto
370s vendor/golang.org/x/net/http/httpguts
370s vendor/golang.org/x/net/http/httpproxy
370s vendor/golang.org/x/net/http2/hpack
371s mime
371s mime/quotedprintable
371s mime/multipart
371s net/http/httptrace
371s net/http/internal
371s net/http/internal/ascii
371s net/http
378s github.com/canonical/go-dqlite/cmd/dqlite-demo
380s    create-stamp debian/debhelper-build-stamp
381s dh_auto_test -O--builddirectory=_build -O--buildsystem=golang
381s 	cd _build && go test -vet=off -v -p 1 github.com/canonical/go-dqlite github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/benchmark github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite/cmd/dqlite github.com/canonical/go-dqlite/cmd/dqlite-benchmark github.com/canonical/go-dqlite/cmd/dqlite-demo github.com/canonical/go-dqlite/driver github.com/canonical/go-dqlite/internal/bindings github.com/canonical/go-dqlite/internal/protocol github.com/canonical/go-dqlite/internal/shell github.com/canonical/go-dqlite/logging github.com/canonical/go-dqlite/tracing
445s ?   	github.com/canonical/go-dqlite	[no test files]
470s === RUN   TestNew_PristineDefault
470s --- PASS: TestNew_PristineDefault (0.03s)
470s === RUN   TestNew_PristineJoiner
470s     app_test.go:1202: 18:32:03.353 - 2: DEBUG: new connection from 127.0.0.1:58876
470s     app_test.go:1202: 18:32:03.359 - 2: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.362 - 2: DEBUG: new connection from 127.0.0.1:58890
470s     app_test.go:1202: 18:32:03.372 - 2: DEBUG: new connection from 127.0.0.1:58898
470s     app_test.go:1202: 18:32:03.376 - 3: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.381 - 2: DEBUG: new connection from 127.0.0.1:58906
470s     app_test.go:1202: 18:32:03.385 - 3: DEBUG: new connection from 127.0.0.1:55416
470s     app_test.go:1202: 18:32:03.390 - 2: DEBUG: new connection from 127.0.0.1:58912
470s     app_test.go:1202: 18:32:03.394 - 2: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s --- PASS: TestNew_PristineJoiner (0.11s)
470s === RUN   TestNew_JoinerRestart
470s     app_test.go:1202: 18:32:03.468 - 4: DEBUG: new connection from 127.0.0.1:43342
470s     app_test.go:1202: 18:32:03.472 - 4: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.475 - 4: DEBUG: new connection from 127.0.0.1:43348
470s     app_test.go:1202: 18:32:03.513 - 4: DEBUG: new connection from 127.0.0.1:43356
470s     app_test.go:1202: 18:32:03.516 - 5: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.520 - 4: DEBUG: new connection from 127.0.0.1:43362
470s     app_test.go:1202: 18:32:03.525 - 5: DEBUG: new connection from 127.0.0.1:60110
470s     app_test.go:1202: 18:32:03.562 - 4: DEBUG: new connection from 127.0.0.1:43374
470s     app_test.go:1202: 18:32:03.567 - 6: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.570 - 4: DEBUG: new connection from 127.0.0.1:43386
470s     app_test.go:1202: 18:32:03.575 - 6: DEBUG: new connection from 127.0.0.1:60122
470s --- PASS: TestNew_JoinerRestart (0.18s)
470s === RUN   TestNew_SecondJoiner
470s     app_test.go:1202: 18:32:03.639 - 7: DEBUG: new connection from 127.0.0.1:43390
470s     app_test.go:1202: 18:32:03.644 - 7: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.649 - 7: DEBUG: new connection from 127.0.0.1:43402
470s     app_test.go:1202: 18:32:03.681 - 7: DEBUG: new connection from 127.0.0.1:43418
470s     app_test.go:1202: 18:32:03.686 - 8: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.691 - 7: DEBUG: new connection from 127.0.0.1:43424
470s     app_test.go:1202: 18:32:03.696 - 8: DEBUG: new connection from 127.0.0.1:60136
470s     app_test.go:1202: 18:32:03.729 - 7: DEBUG: new connection from 127.0.0.1:43428
470s     app_test.go:1202: 18:32:03.732 - 9: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.737 - 7: DEBUG: new connection from 127.0.0.1:43436
470s     app_test.go:1202: 18:32:03.741 - 8: DEBUG: new connection from 127.0.0.1:60140
470s     app_test.go:1202: 18:32:03.746 - 9: DEBUG: new connection from 127.0.0.1:57636
470s     app_test.go:1202: 18:32:03.750 - 9: DEBUG: new connection from 127.0.0.1:57640
470s     app_test.go:1202: 18:32:03.756 - 7: DEBUG: new connection from 127.0.0.1:43452
470s     app_test.go:1202: 18:32:03.772 - 8: DEBUG: new connection from 127.0.0.1:60150
470s     app_test.go:1202: 18:32:03.779 - 7: DEBUG: new connection from 127.0.0.1:43464
470s     app_test.go:1202: 18:32:03.786 - 7: DEBUG: new connection from 127.0.0.1:43474
470s     app_test.go:1202: 18:32:03.790 - 7: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s --- PASS: TestNew_SecondJoiner (0.25s)
470s === RUN   TestNew_ThirdJoiner
470s     app_test.go:1202: 18:32:03.891 - 10: DEBUG: new connection from 127.0.0.1:43488
470s     app_test.go:1202: 18:32:03.895 - 10: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.898 - 10: DEBUG: new connection from 127.0.0.1:43502
470s     app_test.go:1202: 18:32:03.933 - 10: DEBUG: new connection from 127.0.0.1:43508
470s     app_test.go:1202: 18:32:03.937 - 11: DEBUG: attempt 1: server 127.0.0.1:9001: connected
470s     app_test.go:1202: 18:32:03.942 - 10: DEBUG: new connection from 127.0.0.1:43524
470s     app_test.go:1202: 18:32:03.946 - 11: DEBUG: new connection from 127.0.0.1:60156
471s     app_test.go:1202: 18:32:03.981 - 10: DEBUG: new connection from 127.0.0.1:43532
471s     app_test.go:1202: 18:32:03.986 - 12: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.989 - 10: DEBUG: new connection from 127.0.0.1:43536
471s     app_test.go:1202: 18:32:03.995 - 11: DEBUG: new connection from 127.0.0.1:60158
471s     app_test.go:1202: 18:32:03.000 - 12: DEBUG: new connection from 127.0.0.1:57648
471s     app_test.go:1202: 18:32:03.005 - 12: DEBUG: new connection from 127.0.0.1:57658
471s     app_test.go:1202: 18:32:03.012 - 10: DEBUG: new connection from 127.0.0.1:43552
471s     app_test.go:1202: 18:32:03.019 - 11: DEBUG: new connection from 127.0.0.1:60172
471s     app_test.go:1202: 18:32:03.028 - 10: DEBUG: new connection from 127.0.0.1:43554
471s     app_test.go:1202: 18:32:03.061 - 10: DEBUG: new connection from 127.0.0.1:43556
471s     app_test.go:1202: 18:32:03.065 - 13: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.069 - 10: DEBUG: new connection from 127.0.0.1:43562
471s     app_test.go:1202: 18:32:03.073 - 11: DEBUG: new connection from 127.0.0.1:60176
471s     app_test.go:1202: 18:32:03.078 - 12: DEBUG: new connection from 127.0.0.1:57670
471s     app_test.go:1202: 18:32:03.081 - 13: DEBUG: new connection from 127.0.0.1:35412
471s     app_test.go:1202: 18:32:03.088 - 13: DEBUG: new connection from 127.0.0.1:35426
471s     app_test.go:1202: 18:32:03.093 - 10: DEBUG: new connection from 127.0.0.1:43572
471s     app_test.go:1202: 18:32:03.097 - 10: DEBUG: new connection from 127.0.0.1:43578
471s     app_test.go:1202: 18:32:03.102 - 10: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s --- PASS: TestNew_ThirdJoiner (0.36s)
471s === RUN   TestNew_FourthJoiner
471s     app_test.go:1202: 18:32:03.248 - 14: DEBUG: new connection from 127.0.0.1:43586
471s     app_test.go:1202: 18:32:03.252 - 14: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.255 - 14: DEBUG: new connection from 127.0.0.1:43596
471s     app_test.go:1202: 18:32:03.293 - 14: DEBUG: new connection from 127.0.0.1:43610
471s     app_test.go:1202: 18:32:03.299 - 15: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.304 - 14: DEBUG: new connection from 127.0.0.1:43614
471s     app_test.go:1202: 18:32:03.308 - 15: DEBUG: new connection from 127.0.0.1:60184
471s     app_test.go:1202: 18:32:03.345 - 14: DEBUG: new connection from 127.0.0.1:43616
471s     app_test.go:1202: 18:32:03.348 - 16: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.352 - 14: DEBUG: new connection from 127.0.0.1:43620
471s     app_test.go:1202: 18:32:03.356 - 15: DEBUG: new connection from 127.0.0.1:60194
471s     app_test.go:1202: 18:32:03.360 - 16: DEBUG: new connection from 127.0.0.1:57678
471s     app_test.go:1202: 18:32:03.364 - 16: DEBUG: new connection from 127.0.0.1:57688
471s     app_test.go:1202: 18:32:03.370 - 14: DEBUG: new connection from 127.0.0.1:43634
471s     app_test.go:1202: 18:32:03.377 - 15: DEBUG: new connection from 127.0.0.1:60204
471s     app_test.go:1202: 18:32:03.382 - 14: DEBUG: new connection from 127.0.0.1:43638
471s     app_test.go:1202: 18:32:03.421 - 14: DEBUG: new connection from 127.0.0.1:43646
471s     app_test.go:1202: 18:32:03.425 - 17: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.430 - 14: DEBUG: new connection from 127.0.0.1:43660
471s     app_test.go:1202: 18:32:03.434 - 15: DEBUG: new connection from 127.0.0.1:60208
471s     app_test.go:1202: 18:32:03.438 - 16: DEBUG: new connection from 127.0.0.1:57696
471s     app_test.go:1202: 18:32:03.442 - 17: DEBUG: new connection from 127.0.0.1:35436
471s     app_test.go:1202: 18:32:03.447 - 17: DEBUG: new connection from 127.0.0.1:35442
471s     app_test.go:1202: 18:32:03.457 - 14: DEBUG: new connection from 127.0.0.1:43668
471s     app_test.go:1202: 18:32:03.489 - 14: DEBUG: new connection from 127.0.0.1:43678
471s     app_test.go:1202: 18:32:03.493 - 18: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.499 - 14: DEBUG: new connection from 127.0.0.1:43688
471s     app_test.go:1202: 18:32:03.503 - 15: DEBUG: new connection from 127.0.0.1:60210
471s     app_test.go:1202: 18:32:03.506 - 16: DEBUG: new connection from 127.0.0.1:57702
471s     app_test.go:1202: 18:32:03.510 - 17: DEBUG: new connection from 127.0.0.1:35458
471s     app_test.go:1202: 18:32:03.514 - 18: DEBUG: new connection from 127.0.0.1:34894
471s     app_test.go:1202: 18:32:03.519 - 18: DEBUG: new connection from 127.0.0.1:34904
471s     app_test.go:1202: 18:32:03.525 - 14: DEBUG: new connection from 127.0.0.1:43690
471s     app_test.go:1202: 18:32:03.526 - 14: DEBUG: new connection from 127.0.0.1:43702
471s     app_test.go:1202: 18:32:03.533 - 14: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s --- PASS: TestNew_FourthJoiner (0.43s)
471s === RUN   TestNew_FifthJoiner
471s     app_test.go:1202: 18:32:03.680 - 19: DEBUG: new connection from 127.0.0.1:43712
471s     app_test.go:1202: 18:32:03.684 - 19: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.687 - 19: DEBUG: new connection from 127.0.0.1:43714
471s     app_test.go:1202: 18:32:03.724 - 19: DEBUG: new connection from 127.0.0.1:43720
471s     app_test.go:1202: 18:32:03.728 - 20: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.732 - 19: DEBUG: new connection from 127.0.0.1:43736
471s     app_test.go:1202: 18:32:03.737 - 20: DEBUG: new connection from 127.0.0.1:60218
471s     app_test.go:1202: 18:32:03.781 - 19: DEBUG: new connection from 127.0.0.1:43750
471s     app_test.go:1202: 18:32:03.785 - 21: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.792 - 19: DEBUG: new connection from 127.0.0.1:43766
471s     app_test.go:1202: 18:32:03.797 - 20: DEBUG: new connection from 127.0.0.1:60234
471s     app_test.go:1202: 18:32:03.800 - 21: DEBUG: new connection from 127.0.0.1:57714
471s     app_test.go:1202: 18:32:03.805 - 21: DEBUG: new connection from 127.0.0.1:57722
471s     app_test.go:1202: 18:32:03.811 - 19: DEBUG: new connection from 127.0.0.1:43768
471s     app_test.go:1202: 18:32:03.819 - 20: DEBUG: new connection from 127.0.0.1:60242
471s     app_test.go:1202: 18:32:03.825 - 19: DEBUG: new connection from 127.0.0.1:43770
471s     app_test.go:1202: 18:32:03.861 - 19: DEBUG: new connection from 127.0.0.1:43772
471s     app_test.go:1202: 18:32:03.864 - 22: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.869 - 19: DEBUG: new connection from 127.0.0.1:43776
471s     app_test.go:1202: 18:32:03.873 - 20: DEBUG: new connection from 127.0.0.1:60258
471s     app_test.go:1202: 18:32:03.877 - 21: DEBUG: new connection from 127.0.0.1:57732
471s     app_test.go:1202: 18:32:03.881 - 22: DEBUG: new connection from 127.0.0.1:35468
471s     app_test.go:1202: 18:32:03.886 - 22: DEBUG: new connection from 127.0.0.1:35470
471s     app_test.go:1202: 18:32:03.895 - 19: DEBUG: new connection from 127.0.0.1:43782
471s     app_test.go:1202: 18:32:03.929 - 19: DEBUG: new connection from 127.0.0.1:43784
471s     app_test.go:1202: 18:32:03.933 - 23: DEBUG: attempt 1: server 127.0.0.1:9001: connected
471s     app_test.go:1202: 18:32:03.940 - 19: DEBUG: new connection from 127.0.0.1:43792
471s     app_test.go:1202: 18:32:03.944 - 20: DEBUG: new connection from 127.0.0.1:60272
471s     app_test.go:1202: 18:32:03.948 - 21: DEBUG: new connection from 127.0.0.1:57738
471s     app_test.go:1202: 18:32:03.951 - 22: DEBUG: new connection from 127.0.0.1:35484
471s     app_test.go:1202: 18:32:03.955 - 23: DEBUG: new connection from 127.0.0.1:34906
472s     app_test.go:1202: 18:32:03.963 - 23: DEBUG: new connection from 127.0.0.1:34916
472s     app_test.go:1202: 18:32:03.974 - 19: DEBUG: new connection from 127.0.0.1:43798
472s     app_test.go:1202: 18:32:03.997 - 19: DEBUG: new connection from 127.0.0.1:43800
472s     app_test.go:1202: 18:32:03.000 - 24: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.006 - 19: DEBUG: new connection from 127.0.0.1:43816
472s     app_test.go:1202: 18:32:03.010 - 20: DEBUG: new connection from 127.0.0.1:60280
472s     app_test.go:1202: 18:32:03.014 - 21: DEBUG: new connection from 127.0.0.1:57740
472s     app_test.go:1202: 18:32:03.018 - 22: DEBUG: new connection from 127.0.0.1:35494
472s     app_test.go:1202: 18:32:03.022 - 23: DEBUG: new connection from 127.0.0.1:34930
472s     app_test.go:1202: 18:32:03.026 - 24: DEBUG: new connection from 127.0.0.1:59668
472s     app_test.go:1202: 18:32:03.046 - 24: DEBUG: new connection from 127.0.0.1:59684
472s     app_test.go:1202: 18:32:03.051 - 19: DEBUG: new connection from 127.0.0.1:43832
472s     app_test.go:1202: 18:32:03.057 - 19: DEBUG: new connection from 127.0.0.1:43846
472s     app_test.go:1202: 18:32:03.060 - 19: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s --- PASS: TestNew_FifthJoiner (0.55s)
472s === RUN   TestNew_SixthJoiner
472s     app_test.go:1202: 18:32:03.243 - 25: DEBUG: new connection from 127.0.0.1:43856
472s     app_test.go:1202: 18:32:03.248 - 25: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.251 - 25: DEBUG: new connection from 127.0.0.1:43866
472s     app_test.go:1202: 18:32:03.281 - 25: DEBUG: new connection from 127.0.0.1:43876
472s     app_test.go:1202: 18:32:03.285 - 26: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.290 - 25: DEBUG: new connection from 127.0.0.1:43890
472s     app_test.go:1202: 18:32:03.294 - 26: DEBUG: new connection from 127.0.0.1:60284
472s     app_test.go:1202: 18:32:03.334 - 25: DEBUG: new connection from 127.0.0.1:43898
472s     app_test.go:1202: 18:32:03.337 - 27: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.341 - 25: DEBUG: new connection from 127.0.0.1:43900
472s     app_test.go:1202: 18:32:03.346 - 26: DEBUG: new connection from 127.0.0.1:60298
472s     app_test.go:1202: 18:32:03.356 - 27: DEBUG: new connection from 127.0.0.1:57752
472s     app_test.go:1202: 18:32:03.361 - 27: DEBUG: new connection from 127.0.0.1:57764
472s     app_test.go:1202: 18:32:03.367 - 25: DEBUG: new connection from 127.0.0.1:43908
472s     app_test.go:1202: 18:32:03.375 - 26: DEBUG: new connection from 127.0.0.1:60308
472s     app_test.go:1202: 18:32:03.380 - 25: DEBUG: new connection from 127.0.0.1:43920
472s     app_test.go:1202: 18:32:03.417 - 25: DEBUG: new connection from 127.0.0.1:43930
472s     app_test.go:1202: 18:32:03.421 - 28: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.427 - 25: DEBUG: new connection from 127.0.0.1:43946
472s     app_test.go:1202: 18:32:03.433 - 26: DEBUG: new connection from 127.0.0.1:60322
472s     app_test.go:1202: 18:32:03.440 - 27: DEBUG: new connection from 127.0.0.1:57776
472s     app_test.go:1202: 18:32:03.445 - 28: DEBUG: new connection from 127.0.0.1:35496
472s     app_test.go:1202: 18:32:03.453 - 28: DEBUG: new connection from 127.0.0.1:35508
472s     app_test.go:1202: 18:32:03.464 - 25: DEBUG: new connection from 127.0.0.1:43958
472s     app_test.go:1202: 18:32:03.497 - 25: DEBUG: new connection from 127.0.0.1:43972
472s     app_test.go:1202: 18:32:03.501 - 29: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.507 - 25: DEBUG: new connection from 127.0.0.1:43982
472s     app_test.go:1202: 18:32:03.512 - 26: DEBUG: new connection from 127.0.0.1:60334
472s     app_test.go:1202: 18:32:03.518 - 27: DEBUG: new connection from 127.0.0.1:57782
472s     app_test.go:1202: 18:32:03.527 - 28: DEBUG: new connection from 127.0.0.1:35518
472s     app_test.go:1202: 18:32:03.532 - 29: DEBUG: new connection from 127.0.0.1:34944
472s     app_test.go:1202: 18:32:03.538 - 29: DEBUG: new connection from 127.0.0.1:34950
472s     app_test.go:1202: 18:32:03.549 - 25: DEBUG: new connection from 127.0.0.1:43994
472s     app_test.go:1202: 18:32:03.581 - 25: DEBUG: new connection from 127.0.0.1:44002
472s     app_test.go:1202: 18:32:03.586 - 30: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.593 - 25: DEBUG: new connection from 127.0.0.1:44008
472s     app_test.go:1202: 18:32:03.597 - 26: DEBUG: new connection from 127.0.0.1:60344
472s     app_test.go:1202: 18:32:03.602 - 27: DEBUG: new connection from 127.0.0.1:57798
472s     app_test.go:1202: 18:32:03.606 - 28: DEBUG: new connection from 127.0.0.1:35532
472s     app_test.go:1202: 18:32:03.611 - 29: DEBUG: new connection from 127.0.0.1:34962
472s     app_test.go:1202: 18:32:03.615 - 30: DEBUG: new connection from 127.0.0.1:59698
472s     app_test.go:1202: 18:32:03.621 - 30: DEBUG: new connection from 127.0.0.1:59712
472s     app_test.go:1202: 18:32:03.634 - 25: DEBUG: new connection from 127.0.0.1:44012
472s     app_test.go:1202: 18:32:03.669 - 25: DEBUG: new connection from 127.0.0.1:44028
472s     app_test.go:1202: 18:32:03.673 - 31: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.681 - 25: DEBUG: new connection from 127.0.0.1:44032
472s     app_test.go:1202: 18:32:03.684 - 26: DEBUG: new connection from 127.0.0.1:60354
472s     app_test.go:1202: 18:32:03.689 - 27: DEBUG: new connection from 127.0.0.1:57810
472s     app_test.go:1202: 18:32:03.692 - 28: DEBUG: new connection from 127.0.0.1:35536
472s     app_test.go:1202: 18:32:03.695 - 29: DEBUG: new connection from 127.0.0.1:34964
472s     app_test.go:1202: 18:32:03.699 - 30: DEBUG: new connection from 127.0.0.1:59714
472s     app_test.go:1202: 18:32:03.702 - 31: DEBUG: new connection from 127.0.0.1:35398
472s     app_test.go:1202: 18:32:03.705 - 25: DEBUG: new connection from 127.0.0.1:44048
472s     app_test.go:1202: 18:32:03.708 - 25: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s --- PASS: TestNew_SixthJoiner (0.64s)
472s === RUN   TestHandover_Voter
472s     app_test.go:1202: 18:32:03.880 - 32: DEBUG: new connection from 127.0.0.1:44050
472s     app_test.go:1202: 18:32:03.884 - 32: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.887 - 32: DEBUG: new connection from 127.0.0.1:44066
472s     app_test.go:1202: 18:32:03.930 - 32: DEBUG: new connection from 127.0.0.1:44068
472s     app_test.go:1202: 18:32:03.934 - 33: DEBUG: attempt 1: server 127.0.0.1:9001: connected
472s     app_test.go:1202: 18:32:03.940 - 32: DEBUG: new connection from 127.0.0.1:44084
472s     app_test.go:1202: 18:32:03.944 - 33: DEBUG: new connection from 127.0.0.1:60366
473s     app_test.go:1202: 18:32:03.981 - 32: DEBUG: new connection from 127.0.0.1:44092
473s     app_test.go:1202: 18:32:03.985 - 34: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.990 - 32: DEBUG: new connection from 127.0.0.1:44102
473s     app_test.go:1202: 18:32:03.994 - 33: DEBUG: new connection from 127.0.0.1:60374
473s     app_test.go:1202: 18:32:03.999 - 34: DEBUG: new connection from 127.0.0.1:57822
473s     app_test.go:1202: 18:32:03.004 - 34: DEBUG: new connection from 127.0.0.1:57826
473s     app_test.go:1202: 18:32:03.012 - 32: DEBUG: new connection from 127.0.0.1:44108
473s     app_test.go:1202: 18:32:03.018 - 33: DEBUG: new connection from 127.0.0.1:60382
473s     app_test.go:1202: 18:32:03.027 - 32: DEBUG: new connection from 127.0.0.1:44120
473s     app_test.go:1202: 18:32:03.066 - 32: DEBUG: new connection from 127.0.0.1:44128
473s     app_test.go:1202: 18:32:03.070 - 35: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.076 - 32: DEBUG: new connection from 127.0.0.1:44132
473s     app_test.go:1202: 18:32:03.081 - 33: DEBUG: new connection from 127.0.0.1:60386
473s     app_test.go:1202: 18:32:03.085 - 34: DEBUG: new connection from 127.0.0.1:57836
473s     app_test.go:1202: 18:32:03.090 - 35: DEBUG: new connection from 127.0.0.1:35542
473s     app_test.go:1202: 18:32:03.096 - 35: DEBUG: new connection from 127.0.0.1:35546
473s     app_test.go:1202: 18:32:03.097 - 32: DEBUG: new connection from 127.0.0.1:44144
473s     app_test.go:1202: 18:32:03.108 - 32: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.110 - 32: DEBUG: new connection from 127.0.0.1:44150
473s     app_test.go:1202: 18:32:03.127 - 32: DEBUG: new connection from 127.0.0.1:44158
473s     app_test.go:1202: 18:32:03.134 - 34: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.135 - 32: DEBUG: new connection from 127.0.0.1:44170
473s     app_test.go:1202: 18:32:03.140 - 33: DEBUG: new connection from 127.0.0.1:60402
473s     app_test.go:1202: 18:32:03.145 - 34: DEBUG: new connection from 127.0.0.1:57850
473s     app_test.go:1202: 18:32:03.150 - 35: DEBUG: new connection from 127.0.0.1:35554
473s     app_test.go:1202: 18:32:03.156 - 34: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter
473s --- PASS: TestHandover_Voter (0.40s)
473s === RUN   TestHandover_TwoNodes
473s     app_test.go:1202: 18:32:03.280 - 36: DEBUG: new connection from 127.0.0.1:44180
473s     app_test.go:1202: 18:32:03.285 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.288 - 36: DEBUG: new connection from 127.0.0.1:44192
473s     app_test.go:1202: 18:32:03.325 - 36: DEBUG: new connection from 127.0.0.1:44194
473s     app_test.go:1202: 18:32:03.328 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.333 - 36: DEBUG: new connection from 127.0.0.1:44204
473s     app_test.go:1202: 18:32:03.337 - 37: DEBUG: new connection from 127.0.0.1:60410
473s     app_test.go:1202: 18:32:03.341 - 36: DEBUG: new connection from 127.0.0.1:44220
473s     app_test.go:1202: 18:32:03.345 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.347 - 36: DEBUG: new connection from 127.0.0.1:44236
473s     app_test.go:1202: 18:32:03.352 - 37: DEBUG: new connection from 127.0.0.1:60424
473s     app_test.go:1202: 18:32:03.357 - 37: DEBUG: new connection from 127.0.0.1:60432
473s     app_test.go:1202: 18:32:03.364 - 36: DEBUG: new connection from 127.0.0.1:44238
473s     app_test.go:1202: 18:32:03.369 - 36: DEBUG: promoted 127.0.0.1:9002 from spare to voter
473s     app_test.go:1202: 18:32:03.370 - 36: DEBUG: new connection from 127.0.0.1:44240
473s     app_test.go:1202: 18:32:03.374 - 37: DEBUG: new connection from 127.0.0.1:60434
473s     app_test.go:1202: 18:32:03.382 - 36: DEBUG: new connection from 127.0.0.1:44248
473s     app_test.go:1202: 18:32:03.385 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002
473s     app_test.go:1202: 18:32:03.386 - 37: DEBUG: new connection from 127.0.0.1:60450
473s     app_test.go:1202: 18:32:03.390 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.391 - 36: DEBUG: new connection from 127.0.0.1:44250
473s     app_test.go:1202: 18:32:03.395 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002
473s     app_test.go:1202: 18:32:03.396 - 37: DEBUG: new connection from 127.0.0.1:60466
473s     app_test.go:1202: 18:32:03.399 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s --- PASS: TestHandover_TwoNodes (0.21s)
473s === RUN   TestHandover_VoterHonorFailureDomain
473s     app_test.go:1202: 18:32:03.495 - 38: DEBUG: new connection from 127.0.0.1:44254
473s     app_test.go:1202: 18:32:03.500 - 38: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.503 - 38: DEBUG: new connection from 127.0.0.1:44266
473s     app_test.go:1202: 18:32:03.541 - 38: DEBUG: new connection from 127.0.0.1:44280
473s     app_test.go:1202: 18:32:03.545 - 39: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.550 - 38: DEBUG: new connection from 127.0.0.1:44284
473s     app_test.go:1202: 18:32:03.553 - 39: DEBUG: new connection from 127.0.0.1:60474
473s     app_test.go:1202: 18:32:03.589 - 38: DEBUG: new connection from 127.0.0.1:44292
473s     app_test.go:1202: 18:32:03.593 - 40: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.597 - 38: DEBUG: new connection from 127.0.0.1:44306
473s     app_test.go:1202: 18:32:03.601 - 39: DEBUG: new connection from 127.0.0.1:60476
473s     app_test.go:1202: 18:32:03.606 - 40: DEBUG: new connection from 127.0.0.1:57866
473s     app_test.go:1202: 18:32:03.612 - 40: DEBUG: new connection from 127.0.0.1:57882
473s     app_test.go:1202: 18:32:03.618 - 38: DEBUG: new connection from 127.0.0.1:44308
473s     app_test.go:1202: 18:32:03.625 - 39: DEBUG: new connection from 127.0.0.1:60486
473s     app_test.go:1202: 18:32:03.631 - 38: DEBUG: new connection from 127.0.0.1:44320
473s     app_test.go:1202: 18:32:03.669 - 38: DEBUG: new connection from 127.0.0.1:44322
473s     app_test.go:1202: 18:32:03.672 - 41: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.677 - 38: DEBUG: new connection from 127.0.0.1:44328
473s     app_test.go:1202: 18:32:03.681 - 39: DEBUG: new connection from 127.0.0.1:60496
473s     app_test.go:1202: 18:32:03.684 - 40: DEBUG: new connection from 127.0.0.1:57886
473s     app_test.go:1202: 18:32:03.688 - 41: DEBUG: new connection from 127.0.0.1:35570
473s     app_test.go:1202: 18:32:03.694 - 41: DEBUG: new connection from 127.0.0.1:35582
473s     app_test.go:1202: 18:32:03.707 - 38: DEBUG: new connection from 127.0.0.1:44330
473s     app_test.go:1202: 18:32:03.729 - 38: DEBUG: new connection from 127.0.0.1:44340
473s     app_test.go:1202: 18:32:03.733 - 42: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.739 - 38: DEBUG: new connection from 127.0.0.1:44346
473s     app_test.go:1202: 18:32:03.744 - 39: DEBUG: new connection from 127.0.0.1:60500
473s     app_test.go:1202: 18:32:03.749 - 40: DEBUG: new connection from 127.0.0.1:57900
473s     app_test.go:1202: 18:32:03.753 - 41: DEBUG: new connection from 127.0.0.1:35598
473s     app_test.go:1202: 18:32:03.757 - 42: DEBUG: new connection from 127.0.0.1:34980
473s     app_test.go:1202: 18:32:03.766 - 42: DEBUG: new connection from 127.0.0.1:34990
473s     app_test.go:1202: 18:32:03.774 - 38: DEBUG: new connection from 127.0.0.1:44348
473s     app_test.go:1202: 18:32:03.809 - 38: DEBUG: new connection from 127.0.0.1:44364
473s     app_test.go:1202: 18:32:03.813 - 43: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.820 - 38: DEBUG: new connection from 127.0.0.1:44372
473s     app_test.go:1202: 18:32:03.825 - 39: DEBUG: new connection from 127.0.0.1:60516
473s     app_test.go:1202: 18:32:03.828 - 40: DEBUG: new connection from 127.0.0.1:57914
473s     app_test.go:1202: 18:32:03.833 - 41: DEBUG: new connection from 127.0.0.1:35606
473s     app_test.go:1202: 18:32:03.836 - 42: DEBUG: new connection from 127.0.0.1:35002
473s     app_test.go:1202: 18:32:03.840 - 43: DEBUG: new connection from 127.0.0.1:59724
473s     app_test.go:1202: 18:32:03.856 - 43: DEBUG: new connection from 127.0.0.1:59726
473s     app_test.go:1202: 18:32:03.864 - 38: DEBUG: new connection from 127.0.0.1:44380
473s     app_test.go:1202: 18:32:03.866 - 38: DEBUG: new connection from 127.0.0.1:44386
473s     app_test.go:1202: 18:32:03.876 - 38: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.878 - 38: DEBUG: new connection from 127.0.0.1:44402
473s     app_test.go:1202: 18:32:03.882 - 40: DEBUG: attempt 1: server 127.0.0.1:9001: connected
473s     app_test.go:1202: 18:32:03.883 - 38: DEBUG: new connection from 127.0.0.1:44414
473s     app_test.go:1202: 18:32:03.887 - 39: DEBUG: new connection from 127.0.0.1:60526
473s     app_test.go:1202: 18:32:03.891 - 40: DEBUG: new connection from 127.0.0.1:57920
473s     app_test.go:1202: 18:32:03.895 - 41: DEBUG: new connection from 127.0.0.1:35622
473s     app_test.go:1202: 18:32:03.899 - 42: DEBUG: new connection from 127.0.0.1:35004
473s     app_test.go:1202: 18:32:03.902 - 43: DEBUG: new connection from 127.0.0.1:59738
473s     app_test.go:1202: 18:32:03.909 - 40: DEBUG: promoted 127.0.0.1:9006 from stand-by to voter
474s --- PASS: TestHandover_VoterHonorFailureDomain (0.61s)
474s === RUN   TestHandover_SingleNode
474s --- PASS: TestHandover_SingleNode (0.04s)
474s === RUN   TestHandover_GracefulShutdown
474s --- PASS: TestHandover_GracefulShutdown (0.22s)
474s === RUN   TestHandover_StandBy
474s     app_test.go:1202: 18:32:03.363 - 44: DEBUG: new connection from 127.0.0.1:44682
474s     app_test.go:1202: 18:32:03.367 - 44: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.369 - 44: DEBUG: new connection from 127.0.0.1:44696
474s     app_test.go:1202: 18:32:03.396 - 44: DEBUG: new connection from 127.0.0.1:44704
474s     app_test.go:1202: 18:32:03.403 - 45: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.407 - 44: DEBUG: new connection from 127.0.0.1:44714
474s     app_test.go:1202: 18:32:03.411 - 45: DEBUG: new connection from 127.0.0.1:60662
474s     app_test.go:1202: 18:32:03.440 - 44: DEBUG: new connection from 127.0.0.1:44716
474s     app_test.go:1202: 18:32:03.444 - 46: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.448 - 44: DEBUG: new connection from 127.0.0.1:44718
474s     app_test.go:1202: 18:32:03.452 - 45: DEBUG: new connection from 127.0.0.1:60668
474s     app_test.go:1202: 18:32:03.456 - 46: DEBUG: new connection from 127.0.0.1:58030
474s     app_test.go:1202: 18:32:03.460 - 46: DEBUG: new connection from 127.0.0.1:58040
474s     app_test.go:1202: 18:32:03.465 - 44: DEBUG: new connection from 127.0.0.1:44726
474s     app_test.go:1202: 18:32:03.472 - 45: DEBUG: new connection from 127.0.0.1:60674
474s     app_test.go:1202: 18:32:03.477 - 44: DEBUG: new connection from 127.0.0.1:44730
474s     app_test.go:1202: 18:32:03.508 - 44: DEBUG: new connection from 127.0.0.1:44740
474s     app_test.go:1202: 18:32:03.512 - 47: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.516 - 44: DEBUG: new connection from 127.0.0.1:44748
474s     app_test.go:1202: 18:32:03.521 - 45: DEBUG: new connection from 127.0.0.1:60678
474s     app_test.go:1202: 18:32:03.524 - 46: DEBUG: new connection from 127.0.0.1:58044
474s     app_test.go:1202: 18:32:03.528 - 47: DEBUG: new connection from 127.0.0.1:35638
474s     app_test.go:1202: 18:32:03.534 - 47: DEBUG: new connection from 127.0.0.1:35640
474s     app_test.go:1202: 18:32:03.544 - 44: DEBUG: new connection from 127.0.0.1:44758
474s     app_test.go:1202: 18:32:03.568 - 44: DEBUG: new connection from 127.0.0.1:44772
474s     app_test.go:1202: 18:32:03.572 - 48: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.579 - 44: DEBUG: new connection from 127.0.0.1:44776
474s     app_test.go:1202: 18:32:03.583 - 45: DEBUG: new connection from 127.0.0.1:60684
474s     app_test.go:1202: 18:32:03.587 - 46: DEBUG: new connection from 127.0.0.1:58060
474s     app_test.go:1202: 18:32:03.590 - 47: DEBUG: new connection from 127.0.0.1:35642
474s     app_test.go:1202: 18:32:03.594 - 48: DEBUG: new connection from 127.0.0.1:35008
474s     app_test.go:1202: 18:32:03.616 - 48: DEBUG: new connection from 127.0.0.1:35024
474s     app_test.go:1202: 18:32:03.624 - 44: DEBUG: new connection from 127.0.0.1:44792
474s     app_test.go:1202: 18:32:03.661 - 44: DEBUG: new connection from 127.0.0.1:44798
474s     app_test.go:1202: 18:32:03.665 - 49: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.671 - 44: DEBUG: new connection from 127.0.0.1:44800
474s     app_test.go:1202: 18:32:03.675 - 45: DEBUG: new connection from 127.0.0.1:60692
474s     app_test.go:1202: 18:32:03.679 - 46: DEBUG: new connection from 127.0.0.1:58070
474s     app_test.go:1202: 18:32:03.683 - 47: DEBUG: new connection from 127.0.0.1:35646
474s     app_test.go:1202: 18:32:03.690 - 48: DEBUG: new connection from 127.0.0.1:35028
474s     app_test.go:1202: 18:32:03.694 - 49: DEBUG: new connection from 127.0.0.1:59740
474s     app_test.go:1202: 18:32:03.700 - 49: DEBUG: new connection from 127.0.0.1:59754
474s     app_test.go:1202: 18:32:03.711 - 44: DEBUG: new connection from 127.0.0.1:44812
474s     app_test.go:1202: 18:32:03.745 - 44: DEBUG: new connection from 127.0.0.1:44824
474s     app_test.go:1202: 18:32:03.748 - 50: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.754 - 44: DEBUG: new connection from 127.0.0.1:44834
474s     app_test.go:1202: 18:32:03.759 - 45: DEBUG: new connection from 127.0.0.1:60696
474s     app_test.go:1202: 18:32:03.763 - 46: DEBUG: new connection from 127.0.0.1:58076
474s     app_test.go:1202: 18:32:03.767 - 47: DEBUG: new connection from 127.0.0.1:35654
474s     app_test.go:1202: 18:32:03.772 - 48: DEBUG: new connection from 127.0.0.1:35034
474s     app_test.go:1202: 18:32:03.776 - 49: DEBUG: new connection from 127.0.0.1:59758
474s     app_test.go:1202: 18:32:03.780 - 50: DEBUG: new connection from 127.0.0.1:35410
474s     app_test.go:1202: 18:32:03.786 - 44: DEBUG: new connection from 127.0.0.1:44850
474s     app_test.go:1202: 18:32:03.791 - 44: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.792 - 44: DEBUG: new connection from 127.0.0.1:44854
474s     app_test.go:1202: 18:32:03.795 - 48: DEBUG: attempt 1: server 127.0.0.1:9001: connected
474s     app_test.go:1202: 18:32:03.797 - 44: DEBUG: new connection from 127.0.0.1:44860
474s     app_test.go:1202: 18:32:03.800 - 45: DEBUG: new connection from 127.0.0.1:60702
474s     app_test.go:1202: 18:32:03.804 - 46: DEBUG: new connection from 127.0.0.1:58084
474s     app_test.go:1202: 18:32:03.808 - 47: DEBUG: new connection from 127.0.0.1:35664
474s     app_test.go:1202: 18:32:03.812 - 48: DEBUG: new connection from 127.0.0.1:35038
474s     app_test.go:1202: 18:32:03.816 - 49: DEBUG: new connection from 127.0.0.1:59760
474s     app_test.go:1202: 18:32:03.819 - 50: DEBUG: new connection from 127.0.0.1:35426
474s     app_test.go:1202: 18:32:03.834 - 50: DEBUG: new connection from 127.0.0.1:35442
474s     app_test.go:1202: 18:32:03.837 - 48: DEBUG: promoted 127.0.0.1:9007 from spare to stand-by
474s     app_test.go:1202: 18:32:03.841 - 44: DEBUG: new connection from 127.0.0.1:44866
475s --- PASS: TestHandover_StandBy (0.68s)
475s === RUN   TestHandover_TransferLeadership
475s     app_test.go:1202: 18:32:03.050 - 51: DEBUG: new connection from 127.0.0.1:44878
475s     app_test.go:1202: 18:32:03.054 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.057 - 51: DEBUG: new connection from 127.0.0.1:44890
475s     app_test.go:1202: 18:32:03.092 - 51: DEBUG: new connection from 127.0.0.1:44892
475s     app_test.go:1202: 18:32:03.096 - 52: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.101 - 51: DEBUG: new connection from 127.0.0.1:44908
475s     app_test.go:1202: 18:32:03.105 - 52: DEBUG: new connection from 127.0.0.1:60712
475s     app_test.go:1202: 18:32:03.136 - 51: DEBUG: new connection from 127.0.0.1:44918
475s     app_test.go:1202: 18:32:03.140 - 53: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.143 - 51: DEBUG: new connection from 127.0.0.1:44930
475s     app_test.go:1202: 18:32:03.148 - 52: DEBUG: new connection from 127.0.0.1:60724
475s     app_test.go:1202: 18:32:03.152 - 53: DEBUG: new connection from 127.0.0.1:58096
475s     app_test.go:1202: 18:32:03.156 - 53: DEBUG: new connection from 127.0.0.1:58104
475s     app_test.go:1202: 18:32:03.162 - 51: DEBUG: new connection from 127.0.0.1:44944
475s     app_test.go:1202: 18:32:03.169 - 52: DEBUG: new connection from 127.0.0.1:60736
475s     app_test.go:1202: 18:32:03.174 - 51: DEBUG: new connection from 127.0.0.1:44954
475s     app_test.go:1202: 18:32:03.212 - 51: DEBUG: new connection from 127.0.0.1:44966
475s     app_test.go:1202: 18:32:03.216 - 54: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.221 - 51: DEBUG: new connection from 127.0.0.1:44978
475s     app_test.go:1202: 18:32:03.225 - 52: DEBUG: new connection from 127.0.0.1:60740
475s     app_test.go:1202: 18:32:03.229 - 53: DEBUG: new connection from 127.0.0.1:58116
475s     app_test.go:1202: 18:32:03.232 - 54: DEBUG: new connection from 127.0.0.1:35674
475s     app_test.go:1202: 18:32:03.237 - 54: DEBUG: new connection from 127.0.0.1:35688
475s     app_test.go:1202: 18:32:03.238 - 51: DEBUG: new connection from 127.0.0.1:44982
475s     app_test.go:1202: 18:32:03.248 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.250 - 51: DEBUG: new connection from 127.0.0.1:44992
475s     app_test.go:1202: 18:32:03.267 - 51: DEBUG: new connection from 127.0.0.1:44998
475s     app_test.go:1202: 18:32:03.273 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.276 - 51: DEBUG: new connection from 127.0.0.1:45004
475s     app_test.go:1202: 18:32:03.280 - 52: DEBUG: new connection from 127.0.0.1:60750
475s     app_test.go:1202: 18:32:03.285 - 53: DEBUG: new connection from 127.0.0.1:58122
475s     app_test.go:1202: 18:32:03.289 - 54: DEBUG: new connection from 127.0.0.1:35694
475s     app_test.go:1202: 18:32:03.295 - 51: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter
475s     app_test.go:1202: 18:32:03.297 - 51: DEBUG: new connection from 127.0.0.1:45020
475s     app_test.go:1202: 18:32:03.300 - 52: DEBUG: new connection from 127.0.0.1:60762
475s     app_test.go:1202: 18:32:03.304 - 53: DEBUG: new connection from 127.0.0.1:58124
475s     app_test.go:1202: 18:32:03.308 - 54: DEBUG: new connection from 127.0.0.1:35700
475s     app_test.go:1202: 18:32:03.314 - 53: DEBUG: new connection from 127.0.0.1:58140
475s     app_test.go:1202: 18:32:03.318 - 54: DEBUG: new connection from 127.0.0.1:35702
475s     app_test.go:1202: 18:32:03.322 - 52: DEBUG: new connection from 127.0.0.1:60778
475s     app_test.go:1202: 18:32:03.325 - 52: DEBUG: new connection from 127.0.0.1:60790
475s     app_test.go:1202: 18:32:03.335 - 51: DEBUG: new connection from 127.0.0.1:45022
475s     app_test.go:1202: 18:32:03.338 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002
475s     app_test.go:1202: 18:32:03.339 - 52: DEBUG: new connection from 127.0.0.1:60802
475s     app_test.go:1202: 18:32:03.342 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.344 - 51: DEBUG: new connection from 127.0.0.1:45032
475s     app_test.go:1202: 18:32:03.346 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002
475s     app_test.go:1202: 18:32:03.347 - 52: DEBUG: new connection from 127.0.0.1:60814
475s     app_test.go:1202: 18:32:03.350 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s --- PASS: TestHandover_TransferLeadership (0.43s)
475s === RUN   TestRolesAdjustment_ReplaceVoter
475s     app_test.go:1202: 18:32:03.483 - 55: DEBUG: new connection from 127.0.0.1:45040
475s     app_test.go:1202: 18:32:03.487 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.489 - 55: DEBUG: new connection from 127.0.0.1:45042
475s     app_test.go:1202: 18:32:03.524 - 55: DEBUG: new connection from 127.0.0.1:45046
475s     app_test.go:1202: 18:32:03.528 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.533 - 55: DEBUG: new connection from 127.0.0.1:45048
475s     app_test.go:1202: 18:32:03.537 - 56: DEBUG: new connection from 127.0.0.1:60818
475s     app_test.go:1202: 18:32:03.572 - 55: DEBUG: new connection from 127.0.0.1:45060
475s     app_test.go:1202: 18:32:03.576 - 57: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.579 - 55: DEBUG: new connection from 127.0.0.1:45072
475s     app_test.go:1202: 18:32:03.583 - 56: DEBUG: new connection from 127.0.0.1:60834
475s     app_test.go:1202: 18:32:03.590 - 57: DEBUG: new connection from 127.0.0.1:58144
475s     app_test.go:1202: 18:32:03.596 - 57: DEBUG: new connection from 127.0.0.1:58146
475s     app_test.go:1202: 18:32:03.600 - 55: DEBUG: new connection from 127.0.0.1:45074
475s     app_test.go:1202: 18:32:03.608 - 56: DEBUG: new connection from 127.0.0.1:60840
475s     app_test.go:1202: 18:32:03.613 - 55: DEBUG: new connection from 127.0.0.1:45078
475s     app_test.go:1202: 18:32:03.648 - 55: DEBUG: new connection from 127.0.0.1:45094
475s     app_test.go:1202: 18:32:03.652 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected
475s     app_test.go:1202: 18:32:03.657 - 55: DEBUG: new connection from 127.0.0.1:45110
475s     app_test.go:1202: 18:32:03.661 - 56: DEBUG: new connection from 127.0.0.1:60846
475s     app_test.go:1202: 18:32:03.664 - 57: DEBUG: new connection from 127.0.0.1:58150
475s     app_test.go:1202: 18:32:03.668 - 58: DEBUG: new connection from 127.0.0.1:35712
475s     app_test.go:1202: 18:32:03.673 - 58: DEBUG: new connection from 127.0.0.1:35718
475s     app_test.go:1202: 18:32:03.680 - 55: DEBUG: new connection from 127.0.0.1:45116
477s     app_test.go:1202: 18:32:03.494 - 55: DEBUG: new connection from 127.0.0.1:45128
477s     app_test.go:1202: 18:32:03.498 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected
477s     app_test.go:1202: 18:32:03.503 - 55: DEBUG: new connection from 127.0.0.1:45134
477s     app_test.go:1202: 18:32:03.507 - 56: DEBUG: new connection from 127.0.0.1:60860
477s     app_test.go:1202: 18:32:03.514 - 58: DEBUG: new connection from 127.0.0.1:35724
477s     app_test.go:1202: 18:32:03.543 - 55: DEBUG: new connection from 127.0.0.1:45146
477s     app_test.go:1202: 18:32:03.547 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected
477s     app_test.go:1202: 18:32:03.679 - 55: DEBUG: new connection from 127.0.0.1:45150
477s     app_test.go:1202: 18:32:03.683 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected
478s     app_test.go:1202: 18:32:03.964 - 55: DEBUG: new connection from 127.0.0.1:45154
478s     app_test.go:1202: 18:32:03.968 - 56: DEBUG: new connection from 127.0.0.1:60864
478s     app_test.go:1202: 18:32:03.974 - 58: DEBUG: new connection from 127.0.0.1:35738
478s     app_test.go:1202: 18:32:03.983 - 55: DEBUG: new connection from 127.0.0.1:45156
478s     app_test.go:1202: 18:32:03.987 - 56: DEBUG: new connection from 127.0.0.1:60874
478s     app_test.go:1202: 18:32:03.992 - 58: DEBUG: new connection from 127.0.0.1:35750
479s     app_test.go:1202: 18:32:03.552 - 55: DEBUG: new connection from 127.0.0.1:45172
479s     app_test.go:1202: 18:32:03.556 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected
479s     app_test.go:1202: 18:32:03.689 - 55: DEBUG: new connection from 127.0.0.1:45186
479s     app_test.go:1202: 18:32:03.693 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected
480s     app_test.go:1202: 18:32:03.997 - 55: DEBUG: new connection from 127.0.0.1:45200
480s     app_test.go:1202: 18:32:03.002 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected
480s     app_test.go:1202: 18:32:03.006 - 55: DEBUG: new connection from 127.0.0.1:45206
480s     app_test.go:1202: 18:32:03.010 - 56: DEBUG: new connection from 127.0.0.1:60880
480s     app_test.go:1202: 18:32:03.017 - 58: DEBUG: new connection from 127.0.0.1:35760
481s     app_test.go:1202: 18:32:03.562 - 55: DEBUG: new connection from 127.0.0.1:35784
481s     app_test.go:1202: 18:32:03.566 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected
481s     app_test.go:1202: 18:32:03.697 - 55: DEBUG: new connection from 127.0.0.1:35794
481s     app_test.go:1202: 18:32:03.702 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected
482s     app_test.go:1202: 18:32:03.021 - 55: DEBUG: new connection from 127.0.0.1:35800
482s     app_test.go:1202: 18:32:03.025 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected
482s     app_test.go:1202: 18:32:03.029 - 55: DEBUG: new connection from 127.0.0.1:35804
482s     app_test.go:1202: 18:32:03.033 - 56: DEBUG: new connection from 127.0.0.1:35968
482s     app_test.go:1202: 18:32:03.038 - 58: DEBUG: new connection from 127.0.0.1:57264
483s     app_test.go:1202: 18:32:03.572 - 55: DEBUG: new connection from 127.0.0.1:35820
483s     app_test.go:1202: 18:32:03.576 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s     app_test.go:1202: 18:32:03.705 - 55: DEBUG: new connection from 127.0.0.1:35824
483s     app_test.go:1202: 18:32:03.707 - 55: DEBUG: new connection from 127.0.0.1:35828
483s     app_test.go:1202: 18:32:03.714 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s     app_test.go:1202: 18:32:03.714 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s --- PASS: TestRolesAdjustment_ReplaceVoter (8.33s)
483s === RUN   TestRolesAdjustment_ReplaceVoterHonorFailureDomain
483s     app_test.go:1202: 18:32:03.818 - 59: DEBUG: new connection from 127.0.0.1:35838
483s     app_test.go:1202: 18:32:03.822 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s     app_test.go:1202: 18:32:03.825 - 59: DEBUG: new connection from 127.0.0.1:35844
483s     app_test.go:1202: 18:32:03.860 - 59: DEBUG: new connection from 127.0.0.1:35850
483s     app_test.go:1202: 18:32:03.867 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s     app_test.go:1202: 18:32:03.872 - 59: DEBUG: new connection from 127.0.0.1:35858
483s     app_test.go:1202: 18:32:03.876 - 60: DEBUG: new connection from 127.0.0.1:35984
483s     app_test.go:1202: 18:32:03.912 - 59: DEBUG: new connection from 127.0.0.1:35862
483s     app_test.go:1202: 18:32:03.916 - 61: DEBUG: attempt 1: server 127.0.0.1:9001: connected
483s     app_test.go:1202: 18:32:03.920 - 59: DEBUG: new connection from 127.0.0.1:35876
483s     app_test.go:1202: 18:32:03.924 - 60: DEBUG: new connection from 127.0.0.1:35992
483s     app_test.go:1202: 18:32:03.928 - 61: DEBUG: new connection from 127.0.0.1:34960
483s     app_test.go:1202: 18:32:03.933 - 61: DEBUG: new connection from 127.0.0.1:34966
483s     app_test.go:1202: 18:32:03.938 - 59: DEBUG: new connection from 127.0.0.1:35882
483s     app_test.go:1202: 18:32:03.945 - 60: DEBUG: new connection from 127.0.0.1:35994
483s     app_test.go:1202: 18:32:03.950 - 59: DEBUG: new connection from 127.0.0.1:35896
484s     app_test.go:1202: 18:32:03.988 - 59: DEBUG: new connection from 127.0.0.1:35908
484s     app_test.go:1202: 18:32:03.992 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected
484s     app_test.go:1202: 18:32:03.997 - 59: DEBUG: new connection from 127.0.0.1:35916
484s     app_test.go:1202: 18:32:03.001 - 60: DEBUG: new connection from 127.0.0.1:35996
484s     app_test.go:1202: 18:32:03.006 - 61: DEBUG: new connection from 127.0.0.1:34982
484s     app_test.go:1202: 18:32:03.009 - 62: DEBUG: new connection from 127.0.0.1:57276
484s     app_test.go:1202: 18:32:03.013 - 62: DEBUG: new connection from 127.0.0.1:57290
484s     app_test.go:1202: 18:32:03.025 - 59: DEBUG: new connection from 127.0.0.1:35924
484s     app_test.go:1202: 18:32:03.061 - 59: DEBUG: new connection from 127.0.0.1:35928
484s     app_test.go:1202: 18:32:03.065 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected
484s     app_test.go:1202: 18:32:03.072 - 59: DEBUG: new connection from 127.0.0.1:35936
484s     app_test.go:1202: 18:32:03.076 - 60: DEBUG: new connection from 127.0.0.1:36002
484s     app_test.go:1202: 18:32:03.081 - 61: DEBUG: new connection from 127.0.0.1:34990
484s     app_test.go:1202: 18:32:03.086 - 62: DEBUG: new connection from 127.0.0.1:57294
484s     app_test.go:1202: 18:32:03.090 - 63: DEBUG: new connection from 127.0.0.1:55132
484s     app_test.go:1202: 18:32:03.096 - 63: DEBUG: new connection from 127.0.0.1:55146
484s     app_test.go:1202: 18:32:03.108 - 59: DEBUG: new connection from 127.0.0.1:35938
484s     app_test.go:1202: 18:32:03.140 - 59: DEBUG: new connection from 127.0.0.1:35954
484s     app_test.go:1202: 18:32:03.144 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected
484s     app_test.go:1202: 18:32:03.150 - 59: DEBUG: new connection from 127.0.0.1:35958
484s     app_test.go:1202: 18:32:03.157 - 60: DEBUG: new connection from 127.0.0.1:36012
484s     app_test.go:1202: 18:32:03.170 - 61: DEBUG: new connection from 127.0.0.1:35000
484s     app_test.go:1202: 18:32:03.182 - 62: DEBUG: new connection from 127.0.0.1:57310
484s     app_test.go:1202: 18:32:03.188 - 63: DEBUG: new connection from 127.0.0.1:55158
484s     app_test.go:1202: 18:32:03.191 - 64: DEBUG: new connection from 127.0.0.1:59338
484s     app_test.go:1202: 18:32:03.197 - 64: DEBUG: new connection from 127.0.0.1:59354
484s     app_test.go:1202: 18:32:03.206 - 59: DEBUG: new connection from 127.0.0.1:35968
487s     app_test.go:1202: 18:32:03.831 - 59: DEBUG: new connection from 127.0.0.1:35982
487s     app_test.go:1202: 18:32:03.835 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
487s     app_test.go:1202: 18:32:03.840 - 59: DEBUG: new connection from 127.0.0.1:35986
487s     app_test.go:1202: 18:32:03.843 - 60: DEBUG: new connection from 127.0.0.1:36018
487s     app_test.go:1202: 18:32:03.849 - 62: DEBUG: new connection from 127.0.0.1:57314
487s     app_test.go:1202: 18:32:03.853 - 63: DEBUG: new connection from 127.0.0.1:55170
487s     app_test.go:1202: 18:32:03.858 - 64: DEBUG: new connection from 127.0.0.1:59362
487s     app_test.go:1202: 18:32:03.881 - 59: DEBUG: new connection from 127.0.0.1:35996
487s     app_test.go:1202: 18:32:03.888 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected
488s     app_test.go:1202: 18:32:03.021 - 59: DEBUG: new connection from 127.0.0.1:35998
488s     app_test.go:1202: 18:32:03.025 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected
488s     app_test.go:1202: 18:32:03.103 - 59: DEBUG: new connection from 127.0.0.1:36006
488s     app_test.go:1202: 18:32:03.107 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected
488s     app_test.go:1202: 18:32:03.205 - 59: DEBUG: new connection from 127.0.0.1:36012
488s     app_test.go:1202: 18:32:03.209 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected
488s     app_test.go:1202: 18:32:03.304 - 59: DEBUG: new connection from 127.0.0.1:36016
488s     app_test.go:1202: 18:32:03.308 - 60: DEBUG: new connection from 127.0.0.1:36026
488s     app_test.go:1202: 18:32:03.313 - 62: DEBUG: new connection from 127.0.0.1:57328
488s     app_test.go:1202: 18:32:03.316 - 63: DEBUG: new connection from 127.0.0.1:55182
488s     app_test.go:1202: 18:32:03.319 - 64: DEBUG: new connection from 127.0.0.1:59368
488s     app_test.go:1202: 18:32:03.326 - 59: DEBUG: new connection from 127.0.0.1:36024
488s     app_test.go:1202: 18:32:03.329 - 60: DEBUG: new connection from 127.0.0.1:36032
488s     app_test.go:1202: 18:32:03.333 - 62: DEBUG: new connection from 127.0.0.1:57342
488s     app_test.go:1202: 18:32:03.336 - 63: DEBUG: new connection from 127.0.0.1:55186
488s     app_test.go:1202: 18:32:03.339 - 64: DEBUG: new connection from 127.0.0.1:59374
491s     app_test.go:1202: 18:32:03.894 - 59: DEBUG: new connection from 127.0.0.1:50224
491s     app_test.go:1202: 18:32:03.898 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected
492s     app_test.go:1202: 18:32:03.029 - 59: DEBUG: new connection from 127.0.0.1:50236
492s     app_test.go:1202: 18:32:03.033 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected
492s     app_test.go:1202: 18:32:03.112 - 59: DEBUG: new connection from 127.0.0.1:50252
492s     app_test.go:1202: 18:32:03.115 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected
492s     app_test.go:1202: 18:32:03.214 - 59: DEBUG: new connection from 127.0.0.1:50254
492s     app_test.go:1202: 18:32:03.218 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected
492s     app_test.go:1202: 18:32:03.345 - 59: DEBUG: new connection from 127.0.0.1:50266
492s     app_test.go:1202: 18:32:03.349 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
492s     app_test.go:1202: 18:32:03.352 - 59: DEBUG: new connection from 127.0.0.1:50268
492s     app_test.go:1202: 18:32:03.356 - 60: DEBUG: new connection from 127.0.0.1:45450
492s     app_test.go:1202: 18:32:03.360 - 62: DEBUG: new connection from 127.0.0.1:48244
492s     app_test.go:1202: 18:32:03.364 - 63: DEBUG: new connection from 127.0.0.1:35058
492s     app_test.go:1202: 18:32:03.368 - 64: DEBUG: new connection from 127.0.0.1:50848
495s     app_test.go:1202: 18:32:03.902 - 59: DEBUG: new connection from 127.0.0.1:50284
495s     app_test.go:1202: 18:32:03.906 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected
496s     app_test.go:1202: 18:32:03.038 - 59: DEBUG: new connection from 127.0.0.1:50294
496s     app_test.go:1202: 18:32:03.042 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected
496s     app_test.go:1202: 18:32:03.120 - 59: DEBUG: new connection from 127.0.0.1:50300
496s     app_test.go:1202: 18:32:03.124 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected
496s     app_test.go:1202: 18:32:03.223 - 59: DEBUG: new connection from 127.0.0.1:50302
496s     app_test.go:1202: 18:32:03.226 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected
496s     app_test.go:1202: 18:32:03.372 - 59: DEBUG: new connection from 127.0.0.1:50306
496s     app_test.go:1202: 18:32:03.376 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
496s     app_test.go:1202: 18:32:03.380 - 59: DEBUG: new connection from 127.0.0.1:50316
496s     app_test.go:1202: 18:32:03.384 - 60: DEBUG: new connection from 127.0.0.1:45466
496s     app_test.go:1202: 18:32:03.388 - 62: DEBUG: new connection from 127.0.0.1:48246
496s     app_test.go:1202: 18:32:03.392 - 63: DEBUG: new connection from 127.0.0.1:35074
496s     app_test.go:1202: 18:32:03.396 - 64: DEBUG: new connection from 127.0.0.1:50856
499s     app_test.go:1202: 18:32:03.911 - 59: DEBUG: new connection from 127.0.0.1:50324
499s     app_test.go:1202: 18:32:03.915 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected
500s     app_test.go:1202: 18:32:03.049 - 59: DEBUG: new connection from 127.0.0.1:50334
500s     app_test.go:1202: 18:32:03.053 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected
500s     app_test.go:1202: 18:32:03.129 - 59: DEBUG: new connection from 127.0.0.1:50346
500s     app_test.go:1202: 18:32:03.133 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected
500s     app_test.go:1202: 18:32:03.231 - 59: DEBUG: new connection from 127.0.0.1:50358
500s     app_test.go:1202: 18:32:03.235 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected
500s     app_test.go:1202: 18:32:03.401 - 59: DEBUG: new connection from 127.0.0.1:49914
500s     app_test.go:1202: 18:32:03.405 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
500s     app_test.go:1202: 18:32:03.410 - 59: DEBUG: new connection from 127.0.0.1:49918
500s     app_test.go:1202: 18:32:03.413 - 60: DEBUG: new connection from 127.0.0.1:39998
500s     app_test.go:1202: 18:32:03.417 - 62: DEBUG: new connection from 127.0.0.1:34528
500s     app_test.go:1202: 18:32:03.421 - 63: DEBUG: new connection from 127.0.0.1:40722
500s     app_test.go:1202: 18:32:03.425 - 64: DEBUG: new connection from 127.0.0.1:53472
502s     app_test.go:1202: 18:32:03.219 - 59: DEBUG: new connection from 127.0.0.1:49922
502s     app_test.go:1202: 18:32:03.223 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s --- PASS: TestRolesAdjustment_ReplaceVoterHonorFailureDomain (18.55s)
502s === RUN   TestRolesAdjustment_ImbalancedFailureDomain
502s     app_test.go:1202: 18:32:03.370 - 65: DEBUG: new connection from 127.0.0.1:49924
502s     app_test.go:1202: 18:32:03.374 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.377 - 65: DEBUG: new connection from 127.0.0.1:49936
502s     app_test.go:1202: 18:32:03.412 - 65: DEBUG: new connection from 127.0.0.1:49940
502s     app_test.go:1202: 18:32:03.417 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.422 - 65: DEBUG: new connection from 127.0.0.1:49942
502s     app_test.go:1202: 18:32:03.425 - 66: DEBUG: new connection from 127.0.0.1:40008
502s     app_test.go:1202: 18:32:03.460 - 65: DEBUG: new connection from 127.0.0.1:49946
502s     app_test.go:1202: 18:32:03.464 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.467 - 65: DEBUG: new connection from 127.0.0.1:49960
502s     app_test.go:1202: 18:32:03.471 - 66: DEBUG: new connection from 127.0.0.1:40016
502s     app_test.go:1202: 18:32:03.475 - 67: DEBUG: new connection from 127.0.0.1:36774
502s     app_test.go:1202: 18:32:03.480 - 67: DEBUG: new connection from 127.0.0.1:36786
502s     app_test.go:1202: 18:32:03.485 - 65: DEBUG: new connection from 127.0.0.1:49968
502s     app_test.go:1202: 18:32:03.491 - 66: DEBUG: new connection from 127.0.0.1:40024
502s     app_test.go:1202: 18:32:03.496 - 65: DEBUG: new connection from 127.0.0.1:49982
502s     app_test.go:1202: 18:32:03.532 - 65: DEBUG: new connection from 127.0.0.1:49992
502s     app_test.go:1202: 18:32:03.536 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.540 - 65: DEBUG: new connection from 127.0.0.1:50002
502s     app_test.go:1202: 18:32:03.545 - 66: DEBUG: new connection from 127.0.0.1:40038
502s     app_test.go:1202: 18:32:03.548 - 67: DEBUG: new connection from 127.0.0.1:36796
502s     app_test.go:1202: 18:32:03.552 - 68: DEBUG: new connection from 127.0.0.1:34542
502s     app_test.go:1202: 18:32:03.557 - 68: DEBUG: new connection from 127.0.0.1:34548
502s     app_test.go:1202: 18:32:03.570 - 65: DEBUG: new connection from 127.0.0.1:50006
502s     app_test.go:1202: 18:32:03.600 - 65: DEBUG: new connection from 127.0.0.1:50022
502s     app_test.go:1202: 18:32:03.604 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.609 - 65: DEBUG: new connection from 127.0.0.1:50024
502s     app_test.go:1202: 18:32:03.613 - 66: DEBUG: new connection from 127.0.0.1:40046
502s     app_test.go:1202: 18:32:03.617 - 67: DEBUG: new connection from 127.0.0.1:36810
502s     app_test.go:1202: 18:32:03.621 - 68: DEBUG: new connection from 127.0.0.1:34558
502s     app_test.go:1202: 18:32:03.625 - 69: DEBUG: new connection from 127.0.0.1:40726
502s     app_test.go:1202: 18:32:03.631 - 69: DEBUG: new connection from 127.0.0.1:40740
502s     app_test.go:1202: 18:32:03.640 - 65: DEBUG: new connection from 127.0.0.1:50034
502s     app_test.go:1202: 18:32:03.664 - 65: DEBUG: new connection from 127.0.0.1:50044
502s     app_test.go:1202: 18:32:03.668 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.674 - 65: DEBUG: new connection from 127.0.0.1:50050
502s     app_test.go:1202: 18:32:03.678 - 66: DEBUG: new connection from 127.0.0.1:40056
502s     app_test.go:1202: 18:32:03.682 - 67: DEBUG: new connection from 127.0.0.1:36822
502s     app_test.go:1202: 18:32:03.688 - 68: DEBUG: new connection from 127.0.0.1:34570
502s     app_test.go:1202: 18:32:03.692 - 69: DEBUG: new connection from 127.0.0.1:40756
502s     app_test.go:1202: 18:32:03.695 - 70: DEBUG: new connection from 127.0.0.1:53478
502s     app_test.go:1202: 18:32:03.720 - 70: DEBUG: new connection from 127.0.0.1:53488
502s     app_test.go:1202: 18:32:03.731 - 65: DEBUG: new connection from 127.0.0.1:50060
502s     app_test.go:1202: 18:32:03.748 - 65: DEBUG: new connection from 127.0.0.1:50076
502s     app_test.go:1202: 18:32:03.752 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.757 - 65: DEBUG: new connection from 127.0.0.1:50084
502s     app_test.go:1202: 18:32:03.761 - 66: DEBUG: new connection from 127.0.0.1:40064
502s     app_test.go:1202: 18:32:03.766 - 67: DEBUG: new connection from 127.0.0.1:36828
502s     app_test.go:1202: 18:32:03.769 - 68: DEBUG: new connection from 127.0.0.1:34576
502s     app_test.go:1202: 18:32:03.772 - 69: DEBUG: new connection from 127.0.0.1:40772
502s     app_test.go:1202: 18:32:03.775 - 70: DEBUG: new connection from 127.0.0.1:53494
502s     app_test.go:1202: 18:32:03.779 - 71: DEBUG: new connection from 127.0.0.1:38972
502s     app_test.go:1202: 18:32:03.808 - 65: DEBUG: new connection from 127.0.0.1:50098
502s     app_test.go:1202: 18:32:03.812 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected
502s     app_test.go:1202: 18:32:03.817 - 65: DEBUG: new connection from 127.0.0.1:50106
502s     app_test.go:1202: 18:32:03.821 - 66: DEBUG: new connection from 127.0.0.1:40072
502s     app_test.go:1202: 18:32:03.825 - 67: DEBUG: new connection from 127.0.0.1:36838
502s     app_test.go:1202: 18:32:03.829 - 68: DEBUG: new connection from 127.0.0.1:34580
502s     app_test.go:1202: 18:32:03.833 - 69: DEBUG: new connection from 127.0.0.1:40786
502s     app_test.go:1202: 18:32:03.837 - 70: DEBUG: new connection from 127.0.0.1:53506
502s     app_test.go:1202: 18:32:03.841 - 71: DEBUG: new connection from 127.0.0.1:38978
502s     app_test.go:1202: 18:32:03.845 - 72: DEBUG: new connection from 127.0.0.1:44100
506s     app_test.go:1202: 18:32:03.382 - 65: DEBUG: new connection from 127.0.0.1:50110
506s     app_test.go:1202: 18:32:03.386 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.391 - 65: DEBUG: new connection from 127.0.0.1:50114
506s     app_test.go:1202: 18:32:03.394 - 66: DEBUG: new connection from 127.0.0.1:40082
506s     app_test.go:1202: 18:32:03.399 - 67: DEBUG: new connection from 127.0.0.1:36846
506s     app_test.go:1202: 18:32:03.403 - 68: DEBUG: new connection from 127.0.0.1:34592
506s     app_test.go:1202: 18:32:03.410 - 69: DEBUG: new connection from 127.0.0.1:40798
506s     app_test.go:1202: 18:32:03.416 - 70: DEBUG: new connection from 127.0.0.1:53510
506s     app_test.go:1202: 18:32:03.421 - 71: DEBUG: new connection from 127.0.0.1:38990
506s     app_test.go:1202: 18:32:03.425 - 72: DEBUG: new connection from 127.0.0.1:44108
506s     app_test.go:1202: 18:32:03.430 - 72: DEBUG: new connection from 127.0.0.1:44120
506s     app_test.go:1202: 18:32:03.430 - 65: DEBUG: new connection from 127.0.0.1:50122
506s     app_test.go:1202: 18:32:03.438 - 65: DEBUG: new connection from 127.0.0.1:50130
506s     app_test.go:1202: 18:32:03.439 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.503 - 65: DEBUG: new connection from 127.0.0.1:50142
506s     app_test.go:1202: 18:32:03.507 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.565 - 65: DEBUG: new connection from 127.0.0.1:50150
506s     app_test.go:1202: 18:32:03.569 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.632 - 65: DEBUG: new connection from 127.0.0.1:50152
506s     app_test.go:1202: 18:32:03.635 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.724 - 65: DEBUG: new connection from 127.0.0.1:50166
506s     app_test.go:1202: 18:32:03.728 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.784 - 65: DEBUG: new connection from 127.0.0.1:50168
506s     app_test.go:1202: 18:32:03.787 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.851 - 65: DEBUG: new connection from 127.0.0.1:50184
506s     app_test.go:1202: 18:32:03.859 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected
506s     app_test.go:1202: 18:32:03.863 - 65: DEBUG: new connection from 127.0.0.1:50192
506s     app_test.go:1202: 18:32:03.867 - 66: DEBUG: new connection from 127.0.0.1:40092
506s     app_test.go:1202: 18:32:03.871 - 67: DEBUG: new connection from 127.0.0.1:36854
506s     app_test.go:1202: 18:32:03.875 - 68: DEBUG: new connection from 127.0.0.1:34608
506s     app_test.go:1202: 18:32:03.879 - 69: DEBUG: new connection from 127.0.0.1:40806
506s     app_test.go:1202: 18:32:03.883 - 70: DEBUG: new connection from 127.0.0.1:53518
506s     app_test.go:1202: 18:32:03.887 - 71: DEBUG: new connection from 127.0.0.1:38994
506s     app_test.go:1202: 18:32:03.891 - 72: DEBUG: new connection from 127.0.0.1:44122
506s     app_test.go:1202: 18:32:03.900 - 65: DEBUG: new connection from 127.0.0.1:50196
506s     app_test.go:1202: 18:32:03.904 - 66: DEBUG: new connection from 127.0.0.1:40100
506s     app_test.go:1202: 18:32:03.908 - 67: DEBUG: new connection from 127.0.0.1:36862
506s     app_test.go:1202: 18:32:03.912 - 68: DEBUG: new connection from 127.0.0.1:34624
506s     app_test.go:1202: 18:32:03.915 - 69: DEBUG: new connection from 127.0.0.1:40814
506s     app_test.go:1202: 18:32:03.919 - 70: DEBUG: new connection from 127.0.0.1:53526
506s     app_test.go:1202: 18:32:03.923 - 71: DEBUG: new connection from 127.0.0.1:39004
506s     app_test.go:1202: 18:32:03.927 - 72: DEBUG: new connection from 127.0.0.1:44124
510s     app_test.go:1202: 18:32:03.446 - 65: DEBUG: new connection from 127.0.0.1:52324
510s     app_test.go:1202: 18:32:03.453 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.512 - 65: DEBUG: new connection from 127.0.0.1:52338
510s     app_test.go:1202: 18:32:03.516 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.574 - 65: DEBUG: new connection from 127.0.0.1:52346
510s     app_test.go:1202: 18:32:03.578 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.640 - 65: DEBUG: new connection from 127.0.0.1:52362
510s     app_test.go:1202: 18:32:03.644 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.732 - 65: DEBUG: new connection from 127.0.0.1:52370
510s     app_test.go:1202: 18:32:03.736 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.792 - 65: DEBUG: new connection from 127.0.0.1:52374
510s     app_test.go:1202: 18:32:03.795 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.870 - 65: DEBUG: new connection from 127.0.0.1:52388
510s     app_test.go:1202: 18:32:03.874 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.932 - 65: DEBUG: new connection from 127.0.0.1:52400
510s     app_test.go:1202: 18:32:03.935 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
510s     app_test.go:1202: 18:32:03.939 - 65: DEBUG: new connection from 127.0.0.1:52408
510s     app_test.go:1202: 18:32:03.943 - 66: DEBUG: new connection from 127.0.0.1:46814
510s     app_test.go:1202: 18:32:03.947 - 67: DEBUG: new connection from 127.0.0.1:58060
510s     app_test.go:1202: 18:32:03.950 - 68: DEBUG: new connection from 127.0.0.1:51792
510s     app_test.go:1202: 18:32:03.954 - 69: DEBUG: new connection from 127.0.0.1:60756
510s     app_test.go:1202: 18:32:03.957 - 70: DEBUG: new connection from 127.0.0.1:43844
510s     app_test.go:1202: 18:32:03.962 - 71: DEBUG: new connection from 127.0.0.1:38702
510s     app_test.go:1202: 18:32:03.966 - 72: DEBUG: new connection from 127.0.0.1:56312
511s     app_test.go:1202: 18:32:03.891 - 67: DEBUG: new connection from 127.0.0.1:58066
511s     app_test.go:1202: 18:32:03.894 - 72: DEBUG: new connection from 127.0.0.1:56328
511s     app_test.go:1202: 18:32:03.898 - 66: DEBUG: new connection from 127.0.0.1:46816
511s     app_test.go:1202: 18:32:03.899 - 66: DEBUG: new connection from 127.0.0.1:46830
514s     app_test.go:1202: 18:32:03.458 - 65: DEBUG: new connection from 127.0.0.1:52420
514s     app_test.go:1202: 18:32:03.463 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.520 - 65: DEBUG: new connection from 127.0.0.1:52422
514s     app_test.go:1202: 18:32:03.524 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.583 - 65: DEBUG: new connection from 127.0.0.1:52424
514s     app_test.go:1202: 18:32:03.588 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.648 - 65: DEBUG: new connection from 127.0.0.1:52438
514s     app_test.go:1202: 18:32:03.652 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.741 - 65: DEBUG: new connection from 127.0.0.1:52446
514s     app_test.go:1202: 18:32:03.746 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.799 - 65: DEBUG: new connection from 127.0.0.1:52462
514s     app_test.go:1202: 18:32:03.803 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected
514s     app_test.go:1202: 18:32:03.879 - 65: DEBUG: new connection from 127.0.0.1:52476
514s     app_test.go:1202: 18:32:03.882 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected
515s     app_test.go:1202: 18:32:03.970 - 65: DEBUG: new connection from 127.0.0.1:52492
515s     app_test.go:1202: 18:32:03.974 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
515s     app_test.go:1202: 18:32:03.978 - 65: DEBUG: new connection from 127.0.0.1:52506
515s     app_test.go:1202: 18:32:03.984 - 66: DEBUG: new connection from 127.0.0.1:46846
515s     app_test.go:1202: 18:32:03.989 - 67: DEBUG: new connection from 127.0.0.1:58072
515s     app_test.go:1202: 18:32:03.992 - 68: DEBUG: new connection from 127.0.0.1:51804
515s     app_test.go:1202: 18:32:03.995 - 69: DEBUG: new connection from 127.0.0.1:60768
515s     app_test.go:1202: 18:32:03.998 - 70: DEBUG: new connection from 127.0.0.1:43854
515s     app_test.go:1202: 18:32:03.001 - 71: DEBUG: new connection from 127.0.0.1:38714
515s     app_test.go:1202: 18:32:03.004 - 72: DEBUG: new connection from 127.0.0.1:56330
518s     app_test.go:1202: 18:32:03.467 - 65: DEBUG: new connection from 127.0.0.1:52512
518s     app_test.go:1202: 18:32:03.470 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.529 - 65: DEBUG: new connection from 127.0.0.1:52528
518s     app_test.go:1202: 18:32:03.533 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.593 - 65: DEBUG: new connection from 127.0.0.1:52538
518s     app_test.go:1202: 18:32:03.597 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.658 - 65: DEBUG: new connection from 127.0.0.1:52550
518s     app_test.go:1202: 18:32:03.663 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.751 - 65: DEBUG: new connection from 127.0.0.1:52554
518s     app_test.go:1202: 18:32:03.757 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.808 - 65: DEBUG: new connection from 127.0.0.1:52566
518s     app_test.go:1202: 18:32:03.812 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected
518s     app_test.go:1202: 18:32:03.887 - 65: DEBUG: new connection from 127.0.0.1:52568
518s     app_test.go:1202: 18:32:03.891 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected
519s     app_test.go:1202: 18:32:03.008 - 65: DEBUG: new connection from 127.0.0.1:52574
519s     app_test.go:1202: 18:32:03.011 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
519s     app_test.go:1202: 18:32:03.015 - 65: DEBUG: new connection from 127.0.0.1:52590
519s     app_test.go:1202: 18:32:03.019 - 66: DEBUG: new connection from 127.0.0.1:46860
519s     app_test.go:1202: 18:32:03.023 - 67: DEBUG: new connection from 127.0.0.1:58078
519s     app_test.go:1202: 18:32:03.027 - 68: DEBUG: new connection from 127.0.0.1:51820
519s     app_test.go:1202: 18:32:03.030 - 69: DEBUG: new connection from 127.0.0.1:60774
519s     app_test.go:1202: 18:32:03.036 - 70: DEBUG: new connection from 127.0.0.1:43868
519s     app_test.go:1202: 18:32:03.039 - 71: DEBUG: new connection from 127.0.0.1:38720
519s     app_test.go:1202: 18:32:03.042 - 72: DEBUG: new connection from 127.0.0.1:56336
520s     app_test.go:1202: 18:32:03.853 - 65: DEBUG: new connection from 127.0.0.1:51660
520s     app_test.go:1202: 18:32:03.857 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s --- PASS: TestRolesAdjustment_ImbalancedFailureDomain (18.64s)
521s === RUN   TestRolesAdjustment_ReplaceVoterHonorWeight
521s     app_test.go:1202: 18:32:03.022 - 73: DEBUG: new connection from 127.0.0.1:51664
521s     app_test.go:1202: 18:32:03.026 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.028 - 73: DEBUG: new connection from 127.0.0.1:51680
521s     app_test.go:1202: 18:32:03.064 - 73: DEBUG: new connection from 127.0.0.1:51682
521s     app_test.go:1202: 18:32:03.067 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.072 - 73: DEBUG: new connection from 127.0.0.1:51694
521s     app_test.go:1202: 18:32:03.075 - 74: DEBUG: new connection from 127.0.0.1:46412
521s     app_test.go:1202: 18:32:03.112 - 73: DEBUG: new connection from 127.0.0.1:51706
521s     app_test.go:1202: 18:32:03.116 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.120 - 73: DEBUG: new connection from 127.0.0.1:51716
521s     app_test.go:1202: 18:32:03.123 - 74: DEBUG: new connection from 127.0.0.1:46420
521s     app_test.go:1202: 18:32:03.127 - 75: DEBUG: new connection from 127.0.0.1:48228
521s     app_test.go:1202: 18:32:03.132 - 75: DEBUG: new connection from 127.0.0.1:48242
521s     app_test.go:1202: 18:32:03.138 - 73: DEBUG: new connection from 127.0.0.1:51726
521s     app_test.go:1202: 18:32:03.143 - 74: DEBUG: new connection from 127.0.0.1:46434
521s     app_test.go:1202: 18:32:03.149 - 73: DEBUG: new connection from 127.0.0.1:51734
521s     app_test.go:1202: 18:32:03.188 - 73: DEBUG: new connection from 127.0.0.1:51738
521s     app_test.go:1202: 18:32:03.191 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.196 - 73: DEBUG: new connection from 127.0.0.1:51748
521s     app_test.go:1202: 18:32:03.200 - 74: DEBUG: new connection from 127.0.0.1:46440
521s     app_test.go:1202: 18:32:03.204 - 75: DEBUG: new connection from 127.0.0.1:48248
521s     app_test.go:1202: 18:32:03.208 - 76: DEBUG: new connection from 127.0.0.1:60136
521s     app_test.go:1202: 18:32:03.213 - 76: DEBUG: new connection from 127.0.0.1:60140
521s     app_test.go:1202: 18:32:03.225 - 73: DEBUG: new connection from 127.0.0.1:51764
521s     app_test.go:1202: 18:32:03.252 - 73: DEBUG: new connection from 127.0.0.1:51778
521s     app_test.go:1202: 18:32:03.256 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.261 - 73: DEBUG: new connection from 127.0.0.1:51784
521s     app_test.go:1202: 18:32:03.265 - 74: DEBUG: new connection from 127.0.0.1:46446
521s     app_test.go:1202: 18:32:03.269 - 75: DEBUG: new connection from 127.0.0.1:48256
521s     app_test.go:1202: 18:32:03.272 - 76: DEBUG: new connection from 127.0.0.1:60152
521s     app_test.go:1202: 18:32:03.275 - 77: DEBUG: new connection from 127.0.0.1:53042
521s     app_test.go:1202: 18:32:03.298 - 77: DEBUG: new connection from 127.0.0.1:53052
521s     app_test.go:1202: 18:32:03.308 - 73: DEBUG: new connection from 127.0.0.1:51798
521s     app_test.go:1202: 18:32:03.340 - 73: DEBUG: new connection from 127.0.0.1:51800
521s     app_test.go:1202: 18:32:03.344 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected
521s     app_test.go:1202: 18:32:03.350 - 73: DEBUG: new connection from 127.0.0.1:51808
521s     app_test.go:1202: 18:32:03.354 - 74: DEBUG: new connection from 127.0.0.1:46450
521s     app_test.go:1202: 18:32:03.358 - 75: DEBUG: new connection from 127.0.0.1:48266
521s     app_test.go:1202: 18:32:03.361 - 76: DEBUG: new connection from 127.0.0.1:60154
521s     app_test.go:1202: 18:32:03.364 - 77: DEBUG: new connection from 127.0.0.1:53058
521s     app_test.go:1202: 18:32:03.367 - 78: DEBUG: new connection from 127.0.0.1:44218
521s     app_test.go:1202: 18:32:03.387 - 78: DEBUG: new connection from 127.0.0.1:44220
521s     app_test.go:1202: 18:32:03.397 - 73: DEBUG: new connection from 127.0.0.1:51822
525s     app_test.go:1202: 18:33:03.033 - 73: DEBUG: new connection from 127.0.0.1:51824
525s     app_test.go:1202: 18:33:03.037 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
525s     app_test.go:1202: 18:33:03.042 - 73: DEBUG: new connection from 127.0.0.1:51830
525s     app_test.go:1202: 18:33:03.046 - 74: DEBUG: new connection from 127.0.0.1:46456
525s     app_test.go:1202: 18:33:03.050 - 76: DEBUG: new connection from 127.0.0.1:60164
525s     app_test.go:1202: 18:33:03.054 - 77: DEBUG: new connection from 127.0.0.1:53074
525s     app_test.go:1202: 18:33:03.058 - 78: DEBUG: new connection from 127.0.0.1:44222
525s     app_test.go:1202: 18:33:03.081 - 73: DEBUG: new connection from 127.0.0.1:51840
525s     app_test.go:1202: 18:33:03.085 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected
525s     app_test.go:1202: 18:33:03.216 - 73: DEBUG: new connection from 127.0.0.1:51854
525s     app_test.go:1202: 18:33:03.220 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected
525s     app_test.go:1202: 18:33:03.305 - 73: DEBUG: new connection from 127.0.0.1:51860
525s     app_test.go:1202: 18:33:03.309 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected
525s     app_test.go:1202: 18:33:03.393 - 73: DEBUG: new connection from 127.0.0.1:51862
525s     app_test.go:1202: 18:33:03.398 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected
525s     app_test.go:1202: 18:33:03.505 - 73: DEBUG: new connection from 127.0.0.1:51874
525s     app_test.go:1202: 18:33:03.511 - 74: DEBUG: new connection from 127.0.0.1:46470
525s     app_test.go:1202: 18:33:03.516 - 76: DEBUG: new connection from 127.0.0.1:60168
525s     app_test.go:1202: 18:33:03.519 - 77: DEBUG: new connection from 127.0.0.1:53076
525s     app_test.go:1202: 18:33:03.523 - 78: DEBUG: new connection from 127.0.0.1:44226
525s     app_test.go:1202: 18:33:03.529 - 73: DEBUG: new connection from 127.0.0.1:51888
525s     app_test.go:1202: 18:33:03.533 - 74: DEBUG: new connection from 127.0.0.1:46486
525s     app_test.go:1202: 18:33:03.537 - 76: DEBUG: new connection from 127.0.0.1:60174
525s     app_test.go:1202: 18:33:03.539 - 77: DEBUG: new connection from 127.0.0.1:53084
525s     app_test.go:1202: 18:33:03.543 - 78: DEBUG: new connection from 127.0.0.1:44240
529s     app_test.go:1202: 18:33:03.090 - 73: DEBUG: new connection from 127.0.0.1:51902
529s     app_test.go:1202: 18:33:03.094 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected
529s     app_test.go:1202: 18:33:03.225 - 73: DEBUG: new connection from 127.0.0.1:51908
529s     app_test.go:1202: 18:33:03.229 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected
529s     app_test.go:1202: 18:33:03.314 - 73: DEBUG: new connection from 127.0.0.1:51918
529s     app_test.go:1202: 18:33:03.317 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected
529s     app_test.go:1202: 18:33:03.403 - 73: DEBUG: new connection from 127.0.0.1:51926
529s     app_test.go:1202: 18:33:03.406 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected
529s     app_test.go:1202: 18:33:03.548 - 73: DEBUG: new connection from 127.0.0.1:51930
529s     app_test.go:1202: 18:33:03.555 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
529s     app_test.go:1202: 18:33:03.559 - 73: DEBUG: new connection from 127.0.0.1:51938
529s     app_test.go:1202: 18:33:03.561 - 74: DEBUG: new connection from 127.0.0.1:46500
529s     app_test.go:1202: 18:33:03.565 - 76: DEBUG: new connection from 127.0.0.1:60188
529s     app_test.go:1202: 18:33:03.567 - 77: DEBUG: new connection from 127.0.0.1:53090
529s     app_test.go:1202: 18:33:03.571 - 78: DEBUG: new connection from 127.0.0.1:44248
533s     app_test.go:1202: 18:33:03.099 - 73: DEBUG: new connection from 127.0.0.1:42104
533s     app_test.go:1202: 18:33:03.103 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected
533s     app_test.go:1202: 18:33:03.235 - 73: DEBUG: new connection from 127.0.0.1:42114
533s     app_test.go:1202: 18:33:03.239 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected
533s     app_test.go:1202: 18:33:03.321 - 73: DEBUG: new connection from 127.0.0.1:42118
533s     app_test.go:1202: 18:33:03.325 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected
533s     app_test.go:1202: 18:33:03.410 - 73: DEBUG: new connection from 127.0.0.1:42134
533s     app_test.go:1202: 18:33:03.414 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected
533s     app_test.go:1202: 18:33:03.574 - 73: DEBUG: new connection from 127.0.0.1:42148
533s     app_test.go:1202: 18:33:03.578 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
533s     app_test.go:1202: 18:33:03.583 - 73: DEBUG: new connection from 127.0.0.1:42150
533s     app_test.go:1202: 18:33:03.586 - 74: DEBUG: new connection from 127.0.0.1:33526
533s     app_test.go:1202: 18:33:03.592 - 76: DEBUG: new connection from 127.0.0.1:57374
533s     app_test.go:1202: 18:33:03.596 - 77: DEBUG: new connection from 127.0.0.1:53466
533s     app_test.go:1202: 18:33:03.600 - 78: DEBUG: new connection from 127.0.0.1:46020
537s     app_test.go:1202: 18:33:03.108 - 73: DEBUG: new connection from 127.0.0.1:42160
537s     app_test.go:1202: 18:33:03.112 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected
537s     app_test.go:1202: 18:33:03.243 - 73: DEBUG: new connection from 127.0.0.1:42164
537s     app_test.go:1202: 18:33:03.247 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected
537s     app_test.go:1202: 18:33:03.329 - 73: DEBUG: new connection from 127.0.0.1:42172
537s     app_test.go:1202: 18:33:03.333 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected
537s     app_test.go:1202: 18:33:03.418 - 73: DEBUG: new connection from 127.0.0.1:42188
537s     app_test.go:1202: 18:33:03.422 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected
537s     app_test.go:1202: 18:33:03.604 - 73: DEBUG: new connection from 127.0.0.1:42200
537s     app_test.go:1202: 18:33:03.608 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
537s     app_test.go:1202: 18:33:03.612 - 73: DEBUG: new connection from 127.0.0.1:42204
537s     app_test.go:1202: 18:33:03.615 - 74: DEBUG: new connection from 127.0.0.1:33540
537s     app_test.go:1202: 18:33:03.620 - 76: DEBUG: new connection from 127.0.0.1:57388
537s     app_test.go:1202: 18:33:03.623 - 77: DEBUG: new connection from 127.0.0.1:53480
537s     app_test.go:1202: 18:33:03.627 - 78: DEBUG: new connection from 127.0.0.1:46028
539s     app_test.go:1202: 18:33:03.419 - 73: DEBUG: new connection from 127.0.0.1:42218
539s     app_test.go:1202: 18:33:03.426 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected
539s --- PASS: TestRolesAdjustment_ReplaceVoterHonorWeight (18.55s)
539s === RUN   TestRolesAdjustment_CantReplaceVoter
539s     app_test.go:1202: 18:33:03.574 - 79: DEBUG: new connection from 127.0.0.1:42234
539s     app_test.go:1202: 18:33:03.578 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected
539s     app_test.go:1202: 18:33:03.580 - 79: DEBUG: new connection from 127.0.0.1:42246
539s     app_test.go:1202: 18:33:03.612 - 79: DEBUG: new connection from 127.0.0.1:42260
539s     app_test.go:1202: 18:33:03.615 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected
539s     app_test.go:1202: 18:33:03.619 - 79: DEBUG: new connection from 127.0.0.1:42270
539s     app_test.go:1202: 18:33:03.623 - 80: DEBUG: new connection from 127.0.0.1:33556
539s     app_test.go:1202: 18:33:03.652 - 79: DEBUG: new connection from 127.0.0.1:42286
539s     app_test.go:1202: 18:33:03.655 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected
539s     app_test.go:1202: 18:33:03.659 - 79: DEBUG: new connection from 127.0.0.1:42292
539s     app_test.go:1202: 18:33:03.663 - 80: DEBUG: new connection from 127.0.0.1:33562
539s     app_test.go:1202: 18:33:03.667 - 81: DEBUG: new connection from 127.0.0.1:41874
539s     app_test.go:1202: 18:33:03.672 - 81: DEBUG: new connection from 127.0.0.1:41888
539s     app_test.go:1202: 18:33:03.677 - 79: DEBUG: new connection from 127.0.0.1:42304
539s     app_test.go:1202: 18:33:03.686 - 80: DEBUG: new connection from 127.0.0.1:33576
539s     app_test.go:1202: 18:33:03.691 - 79: DEBUG: new connection from 127.0.0.1:42318
539s     app_test.go:1202: 18:33:03.724 - 79: DEBUG: new connection from 127.0.0.1:42334
539s     app_test.go:1202: 18:33:03.727 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected
539s     app_test.go:1202: 18:33:03.732 - 79: DEBUG: new connection from 127.0.0.1:42342
539s     app_test.go:1202: 18:33:03.736 - 80: DEBUG: new connection from 127.0.0.1:33590
539s     app_test.go:1202: 18:33:03.740 - 81: DEBUG: new connection from 127.0.0.1:41902
539s     app_test.go:1202: 18:33:03.744 - 82: DEBUG: new connection from 127.0.0.1:57398
539s     app_test.go:1202: 18:33:03.749 - 82: DEBUG: new connection from 127.0.0.1:57412
543s     app_test.go:1202: 18:33:03.585 - 79: DEBUG: new connection from 127.0.0.1:47030
543s     app_test.go:1202: 18:33:03.589 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected
543s     app_test.go:1202: 18:33:03.594 - 79: DEBUG: new connection from 127.0.0.1:47046
543s     app_test.go:1202: 18:33:03.597 - 80: DEBUG: new connection from 127.0.0.1:59134
543s     app_test.go:1202: 18:33:03.627 - 79: DEBUG: new connection from 127.0.0.1:47052
543s     app_test.go:1202: 18:33:03.630 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected
547s     app_test.go:1202: 18:33:03.602 - 79: DEBUG: new connection from 127.0.0.1:47056
547s     app_test.go:1202: 18:33:03.605 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected
547s     app_test.go:1202: 18:33:03.609 - 79: DEBUG: new connection from 127.0.0.1:47060
547s     app_test.go:1202: 18:33:03.614 - 80: DEBUG: new connection from 127.0.0.1:59138
547s     app_test.go:1202: 18:33:03.635 - 79: DEBUG: new connection from 127.0.0.1:47074
547s     app_test.go:1202: 18:33:03.638 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.621 - 79: DEBUG: new connection from 127.0.0.1:58838
551s     app_test.go:1202: 18:33:03.625 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.629 - 79: DEBUG: new connection from 127.0.0.1:58848
551s     app_test.go:1202: 18:33:03.632 - 80: DEBUG: new connection from 127.0.0.1:57228
551s     app_test.go:1202: 18:33:03.641 - 79: DEBUG: new connection from 127.0.0.1:58860
551s     app_test.go:1202: 18:33:03.644 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.775 - 79: DEBUG: new connection from 127.0.0.1:58876
551s     app_test.go:1202: 18:33:03.778 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s --- PASS: TestRolesAdjustment_CantReplaceVoter (12.29s)
551s === RUN   TestRolesAdjustment_ReplaceStandBy
551s     app_test.go:1202: 18:33:03.862 - 83: DEBUG: new connection from 127.0.0.1:58882
551s     app_test.go:1202: 18:33:03.866 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.868 - 83: DEBUG: new connection from 127.0.0.1:58886
551s     app_test.go:1202: 18:33:03.900 - 83: DEBUG: new connection from 127.0.0.1:58888
551s     app_test.go:1202: 18:33:03.903 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.908 - 83: DEBUG: new connection from 127.0.0.1:58902
551s     app_test.go:1202: 18:33:03.911 - 84: DEBUG: new connection from 127.0.0.1:57242
551s     app_test.go:1202: 18:33:03.944 - 83: DEBUG: new connection from 127.0.0.1:58916
551s     app_test.go:1202: 18:33:03.948 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected
551s     app_test.go:1202: 18:33:03.952 - 83: DEBUG: new connection from 127.0.0.1:58918
551s     app_test.go:1202: 18:33:03.956 - 84: DEBUG: new connection from 127.0.0.1:57250
551s     app_test.go:1202: 18:33:03.963 - 85: DEBUG: new connection from 127.0.0.1:58284
551s     app_test.go:1202: 18:33:03.969 - 85: DEBUG: new connection from 127.0.0.1:58298
552s     app_test.go:1202: 18:33:03.974 - 83: DEBUG: new connection from 127.0.0.1:58930
552s     app_test.go:1202: 18:33:03.980 - 84: DEBUG: new connection from 127.0.0.1:57254
552s     app_test.go:1202: 18:33:03.985 - 83: DEBUG: new connection from 127.0.0.1:58940
552s     app_test.go:1202: 18:33:03.020 - 83: DEBUG: new connection from 127.0.0.1:58952
552s     app_test.go:1202: 18:33:03.023 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected
552s     app_test.go:1202: 18:33:03.028 - 83: DEBUG: new connection from 127.0.0.1:58968
552s     app_test.go:1202: 18:33:03.032 - 84: DEBUG: new connection from 127.0.0.1:57264
552s     app_test.go:1202: 18:33:03.036 - 85: DEBUG: new connection from 127.0.0.1:58310
552s     app_test.go:1202: 18:33:03.040 - 86: DEBUG: new connection from 127.0.0.1:43604
552s     app_test.go:1202: 18:33:03.044 - 86: DEBUG: new connection from 127.0.0.1:43606
552s     app_test.go:1202: 18:33:03.053 - 83: DEBUG: new connection from 127.0.0.1:58978
552s     app_test.go:1202: 18:33:03.084 - 83: DEBUG: new connection from 127.0.0.1:58982
552s     app_test.go:1202: 18:33:03.087 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected
552s     app_test.go:1202: 18:33:03.092 - 83: DEBUG: new connection from 127.0.0.1:58986
552s     app_test.go:1202: 18:33:03.096 - 84: DEBUG: new connection from 127.0.0.1:57268
552s     app_test.go:1202: 18:33:03.103 - 85: DEBUG: new connection from 127.0.0.1:58320
552s     app_test.go:1202: 18:33:03.106 - 86: DEBUG: new connection from 127.0.0.1:43618
552s     app_test.go:1202: 18:33:03.109 - 87: DEBUG: new connection from 127.0.0.1:40512
552s     app_test.go:1202: 18:33:03.123 - 87: DEBUG: new connection from 127.0.0.1:40522
552s     app_test.go:1202: 18:33:03.131 - 83: DEBUG: new connection from 127.0.0.1:58996
552s     app_test.go:1202: 18:33:03.164 - 83: DEBUG: new connection from 127.0.0.1:59008
552s     app_test.go:1202: 18:33:03.167 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected
552s     app_test.go:1202: 18:33:03.173 - 83: DEBUG: new connection from 127.0.0.1:59012
552s     app_test.go:1202: 18:33:03.176 - 84: DEBUG: new connection from 127.0.0.1:57274
552s     app_test.go:1202: 18:33:03.180 - 85: DEBUG: new connection from 127.0.0.1:58332
552s     app_test.go:1202: 18:33:03.184 - 86: DEBUG: new connection from 127.0.0.1:43630
552s     app_test.go:1202: 18:33:03.188 - 87: DEBUG: new connection from 127.0.0.1:40534
552s     app_test.go:1202: 18:33:03.193 - 88: DEBUG: new connection from 127.0.0.1:45204
552s     app_test.go:1202: 18:33:03.204 - 88: DEBUG: new connection from 127.0.0.1:45216
552s     app_test.go:1202: 18:33:03.214 - 83: DEBUG: new connection from 127.0.0.1:59022
552s     app_test.go:1202: 18:33:03.244 - 83: DEBUG: new connection from 127.0.0.1:59024
552s     app_test.go:1202: 18:33:03.246 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected
552s     app_test.go:1202: 18:33:03.252 - 83: DEBUG: new connection from 127.0.0.1:59034
552s     app_test.go:1202: 18:33:03.256 - 84: DEBUG: new connection from 127.0.0.1:57280
552s     app_test.go:1202: 18:33:03.260 - 85: DEBUG: new connection from 127.0.0.1:58340
552s     app_test.go:1202: 18:33:03.263 - 86: DEBUG: new connection from 127.0.0.1:43646
552s     app_test.go:1202: 18:33:03.266 - 87: DEBUG: new connection from 127.0.0.1:40536
552s     app_test.go:1202: 18:33:03.269 - 88: DEBUG: new connection from 127.0.0.1:45228
552s     app_test.go:1202: 18:33:03.272 - 89: DEBUG: new connection from 127.0.0.1:35374
556s     app_test.go:1202: 18:33:03.873 - 83: DEBUG: new connection from 127.0.0.1:59050
556s     app_test.go:1202: 18:33:03.876 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected
556s     app_test.go:1202: 18:33:03.880 - 83: DEBUG: new connection from 127.0.0.1:59054
556s     app_test.go:1202: 18:33:03.885 - 84: DEBUG: new connection from 127.0.0.1:57294
556s     app_test.go:1202: 18:33:03.891 - 85: DEBUG: new connection from 127.0.0.1:58346
556s     app_test.go:1202: 18:33:03.895 - 86: DEBUG: new connection from 127.0.0.1:43660
556s     app_test.go:1202: 18:33:03.900 - 88: DEBUG: new connection from 127.0.0.1:45244
556s     app_test.go:1202: 18:33:03.904 - 89: DEBUG: new connection from 127.0.0.1:35376
556s     app_test.go:1202: 18:33:03.909 - 89: DEBUG: new connection from 127.0.0.1:35384
556s     app_test.go:1202: 18:33:03.914 - 83: DEBUG: new connection from 127.0.0.1:59068
556s     app_test.go:1202: 18:33:03.916 - 83: DEBUG: new connection from 127.0.0.1:59076
556s     app_test.go:1202: 18:33:03.922 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected
557s     app_test.go:1202: 18:33:03.992 - 83: DEBUG: new connection from 127.0.0.1:59092
557s     app_test.go:1202: 18:33:03.996 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected
557s     app_test.go:1202: 18:33:03.050 - 83: DEBUG: new connection from 127.0.0.1:59094
557s     app_test.go:1202: 18:33:03.053 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected
557s     app_test.go:1202: 18:33:03.211 - 83: DEBUG: new connection from 127.0.0.1:59098
557s     app_test.go:1202: 18:33:03.214 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected
557s     app_test.go:1202: 18:33:03.276 - 83: DEBUG: new connection from 127.0.0.1:59114
557s     app_test.go:1202: 18:33:03.279 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected
557s     app_test.go:1202: 18:33:03.346 - 83: DEBUG: new connection from 127.0.0.1:59122
557s     app_test.go:1202: 18:33:03.350 - 84: DEBUG: new connection from 127.0.0.1:57304
557s     app_test.go:1202: 18:33:03.355 - 85: DEBUG: new connection from 127.0.0.1:58350
557s     app_test.go:1202: 18:33:03.361 - 86: DEBUG: new connection from 127.0.0.1:43668
557s     app_test.go:1202: 18:33:03.365 - 88: DEBUG: new connection from 127.0.0.1:45256
557s     app_test.go:1202: 18:33:03.369 - 89: DEBUG: new connection from 127.0.0.1:35392
557s     app_test.go:1202: 18:33:03.377 - 83: DEBUG: new connection from 127.0.0.1:59138
557s     app_test.go:1202: 18:33:03.380 - 84: DEBUG: new connection from 127.0.0.1:57306
557s     app_test.go:1202: 18:33:03.384 - 85: DEBUG: new connection from 127.0.0.1:58358
557s     app_test.go:1202: 18:33:03.387 - 86: DEBUG: new connection from 127.0.0.1:43682
557s     app_test.go:1202: 18:33:03.390 - 88: DEBUG: new connection from 127.0.0.1:45268
557s     app_test.go:1202: 18:33:03.393 - 89: DEBUG: new connection from 127.0.0.1:35406
561s     app_test.go:1202: 18:33:03.926 - 83: DEBUG: new connection from 127.0.0.1:38572
561s     app_test.go:1202: 18:33:03.931 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.001 - 83: DEBUG: new connection from 127.0.0.1:38574
562s     app_test.go:1202: 18:33:03.005 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.058 - 83: DEBUG: new connection from 127.0.0.1:38590
562s     app_test.go:1202: 18:33:03.061 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.218 - 83: DEBUG: new connection from 127.0.0.1:38604
562s     app_test.go:1202: 18:33:03.223 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.284 - 83: DEBUG: new connection from 127.0.0.1:38608
562s     app_test.go:1202: 18:33:03.289 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.397 - 83: DEBUG: new connection from 127.0.0.1:38616
562s     app_test.go:1202: 18:33:03.401 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected
562s     app_test.go:1202: 18:33:03.405 - 83: DEBUG: new connection from 127.0.0.1:38628
562s     app_test.go:1202: 18:33:03.408 - 84: DEBUG: new connection from 127.0.0.1:42906
562s     app_test.go:1202: 18:33:03.412 - 85: DEBUG: new connection from 127.0.0.1:52832
562s     app_test.go:1202: 18:33:03.416 - 86: DEBUG: new connection from 127.0.0.1:35636
562s     app_test.go:1202: 18:33:03.421 - 88: DEBUG: new connection from 127.0.0.1:45006
562s     app_test.go:1202: 18:33:03.425 - 89: DEBUG: new connection from 127.0.0.1:33572
566s     app_test.go:1202: 18:33:03.935 - 83: DEBUG: new connection from 127.0.0.1:38640
566s     app_test.go:1202: 18:33:03.939 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.010 - 83: DEBUG: new connection from 127.0.0.1:38650
567s     app_test.go:1202: 18:33:03.014 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.066 - 83: DEBUG: new connection from 127.0.0.1:38660
567s     app_test.go:1202: 18:33:03.070 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.227 - 83: DEBUG: new connection from 127.0.0.1:38668
567s     app_test.go:1202: 18:33:03.231 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.296 - 83: DEBUG: new connection from 127.0.0.1:38680
567s     app_test.go:1202: 18:33:03.300 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.429 - 83: DEBUG: new connection from 127.0.0.1:38692
567s     app_test.go:1202: 18:33:03.433 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected
567s     app_test.go:1202: 18:33:03.437 - 83: DEBUG: new connection from 127.0.0.1:38698
567s     app_test.go:1202: 18:33:03.443 - 84: DEBUG: new connection from 127.0.0.1:42918
567s     app_test.go:1202: 18:33:03.447 - 85: DEBUG: new connection from 127.0.0.1:52838
567s     app_test.go:1202: 18:33:03.450 - 86: DEBUG: new connection from 127.0.0.1:35640
567s     app_test.go:1202: 18:33:03.453 - 88: DEBUG: new connection from 127.0.0.1:45020
567s     app_test.go:1202: 18:33:03.456 - 89: DEBUG: new connection from 127.0.0.1:33580
571s     app_test.go:1202: 18:33:03.944 - 83: DEBUG: new connection from 127.0.0.1:37292
571s     app_test.go:1202: 18:33:03.949 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.019 - 83: DEBUG: new connection from 127.0.0.1:37302
572s     app_test.go:1202: 18:33:03.023 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.074 - 83: DEBUG: new connection from 127.0.0.1:37318
572s     app_test.go:1202: 18:33:03.078 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.235 - 83: DEBUG: new connection from 127.0.0.1:37326
572s     app_test.go:1202: 18:33:03.240 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.299 - 83: DEBUG: new connection from 127.0.0.1:37342
572s     app_test.go:1202: 18:33:03.303 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.304 - 83: DEBUG: new connection from 127.0.0.1:37344
572s     app_test.go:1202: 18:33:03.310 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s --- PASS: TestRolesAdjustment_ReplaceStandBy (20.62s)
572s === RUN   TestRolesAdjustment_ReplaceStandByHonorFailureDomains
572s     app_test.go:1202: 18:33:03.479 - 90: DEBUG: new connection from 127.0.0.1:37358
572s     app_test.go:1202: 18:33:03.482 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.485 - 90: DEBUG: new connection from 127.0.0.1:37362
572s     app_test.go:1202: 18:33:03.520 - 90: DEBUG: new connection from 127.0.0.1:37370
572s     app_test.go:1202: 18:33:03.526 - 91: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.531 - 90: DEBUG: new connection from 127.0.0.1:37384
572s     app_test.go:1202: 18:33:03.536 - 91: DEBUG: new connection from 127.0.0.1:44782
572s     app_test.go:1202: 18:33:03.572 - 90: DEBUG: new connection from 127.0.0.1:37400
572s     app_test.go:1202: 18:33:03.576 - 92: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.580 - 90: DEBUG: new connection from 127.0.0.1:37412
572s     app_test.go:1202: 18:33:03.583 - 91: DEBUG: new connection from 127.0.0.1:44784
572s     app_test.go:1202: 18:33:03.587 - 92: DEBUG: new connection from 127.0.0.1:51516
572s     app_test.go:1202: 18:33:03.591 - 92: DEBUG: new connection from 127.0.0.1:51528
572s     app_test.go:1202: 18:33:03.607 - 90: DEBUG: new connection from 127.0.0.1:37414
572s     app_test.go:1202: 18:33:03.614 - 91: DEBUG: new connection from 127.0.0.1:44792
572s     app_test.go:1202: 18:33:03.620 - 90: DEBUG: new connection from 127.0.0.1:37422
572s     app_test.go:1202: 18:33:03.656 - 90: DEBUG: new connection from 127.0.0.1:37432
572s     app_test.go:1202: 18:33:03.660 - 93: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.666 - 90: DEBUG: new connection from 127.0.0.1:37434
572s     app_test.go:1202: 18:33:03.669 - 91: DEBUG: new connection from 127.0.0.1:44794
572s     app_test.go:1202: 18:33:03.674 - 92: DEBUG: new connection from 127.0.0.1:51538
572s     app_test.go:1202: 18:33:03.678 - 93: DEBUG: new connection from 127.0.0.1:45310
572s     app_test.go:1202: 18:33:03.684 - 93: DEBUG: new connection from 127.0.0.1:45324
572s     app_test.go:1202: 18:33:03.696 - 90: DEBUG: new connection from 127.0.0.1:37448
572s     app_test.go:1202: 18:33:03.724 - 90: DEBUG: new connection from 127.0.0.1:37452
572s     app_test.go:1202: 18:33:03.729 - 94: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.735 - 90: DEBUG: new connection from 127.0.0.1:37468
572s     app_test.go:1202: 18:33:03.738 - 91: DEBUG: new connection from 127.0.0.1:44796
572s     app_test.go:1202: 18:33:03.742 - 92: DEBUG: new connection from 127.0.0.1:51542
572s     app_test.go:1202: 18:33:03.746 - 93: DEBUG: new connection from 127.0.0.1:45332
572s     app_test.go:1202: 18:33:03.750 - 94: DEBUG: new connection from 127.0.0.1:33088
572s     app_test.go:1202: 18:33:03.755 - 94: DEBUG: new connection from 127.0.0.1:33100
572s     app_test.go:1202: 18:33:03.782 - 90: DEBUG: new connection from 127.0.0.1:37478
572s     app_test.go:1202: 18:33:03.812 - 90: DEBUG: new connection from 127.0.0.1:37494
572s     app_test.go:1202: 18:33:03.816 - 95: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.822 - 90: DEBUG: new connection from 127.0.0.1:37498
572s     app_test.go:1202: 18:33:03.826 - 91: DEBUG: new connection from 127.0.0.1:44812
572s     app_test.go:1202: 18:33:03.832 - 92: DEBUG: new connection from 127.0.0.1:51556
572s     app_test.go:1202: 18:33:03.836 - 93: DEBUG: new connection from 127.0.0.1:45346
572s     app_test.go:1202: 18:33:03.840 - 94: DEBUG: new connection from 127.0.0.1:33108
572s     app_test.go:1202: 18:33:03.843 - 95: DEBUG: new connection from 127.0.0.1:48716
572s     app_test.go:1202: 18:33:03.863 - 95: DEBUG: new connection from 127.0.0.1:48724
572s     app_test.go:1202: 18:33:03.874 - 90: DEBUG: new connection from 127.0.0.1:37512
572s     app_test.go:1202: 18:33:03.908 - 90: DEBUG: new connection from 127.0.0.1:37516
572s     app_test.go:1202: 18:33:03.912 - 96: DEBUG: attempt 1: server 127.0.0.1:9001: connected
572s     app_test.go:1202: 18:33:03.919 - 90: DEBUG: new connection from 127.0.0.1:37522
572s     app_test.go:1202: 18:33:03.923 - 91: DEBUG: new connection from 127.0.0.1:44826
572s     app_test.go:1202: 18:33:03.927 - 92: DEBUG: new connection from 127.0.0.1:51562
572s     app_test.go:1202: 18:33:03.931 - 93: DEBUG: new connection from 127.0.0.1:45356
572s     app_test.go:1202: 18:33:03.935 - 94: DEBUG: new connection from 127.0.0.1:33120
572s     app_test.go:1202: 18:33:03.939 - 95: DEBUG: new connection from 127.0.0.1:48736
572s     app_test.go:1202: 18:33:03.944 - 96: DEBUG: new connection from 127.0.0.1:44156
573s     app_test.go:1202: 18:33:03.972 - 90: DEBUG: new connection from 127.0.0.1:37528
573s     app_test.go:1202: 18:33:03.976 - 97: DEBUG: attempt 1: server 127.0.0.1:9001: connected
573s     app_test.go:1202: 18:33:03.982 - 90: DEBUG: new connection from 127.0.0.1:37542
573s     app_test.go:1202: 18:33:03.986 - 91: DEBUG: new connection from 127.0.0.1:44842
573s     app_test.go:1202: 18:33:03.990 - 92: DEBUG: new connection from 127.0.0.1:51574
573s     app_test.go:1202: 18:33:03.994 - 93: DEBUG: new connection from 127.0.0.1:45368
573s     app_test.go:1202: 18:33:03.998 - 94: DEBUG: new connection from 127.0.0.1:33132
573s     app_test.go:1202: 18:33:03.002 - 95: DEBUG: new connection from 127.0.0.1:48750
573s     app_test.go:1202: 18:33:03.005 - 96: DEBUG: new connection from 127.0.0.1:44170
573s     app_test.go:1202: 18:33:03.009 - 97: DEBUG: new connection from 127.0.0.1:37526
573s     app_test.go:1202: 18:33:03.032 - 90: DEBUG: new connection from 127.0.0.1:37548
573s     app_test.go:1202: 18:33:03.036 - 98: DEBUG: attempt 1: server 127.0.0.1:9001: connected
573s     app_test.go:1202: 18:33:03.043 - 90: DEBUG: new connection from 127.0.0.1:37552
573s     app_test.go:1202: 18:33:03.047 - 91: DEBUG: new connection from 127.0.0.1:44856
573s     app_test.go:1202: 18:33:03.051 - 92: DEBUG: new connection from 127.0.0.1:51588
573s     app_test.go:1202: 18:33:03.056 - 93: DEBUG: new connection from 127.0.0.1:45370
573s     app_test.go:1202: 18:33:03.060 - 94: DEBUG: new connection from 127.0.0.1:33144
573s     app_test.go:1202: 18:33:03.067 - 95: DEBUG: new connection from 127.0.0.1:48758
573s     app_test.go:1202: 18:33:03.071 - 96: DEBUG: new connection from 127.0.0.1:44182
573s     app_test.go:1202: 18:33:03.075 - 97: DEBUG: new connection from 127.0.0.1:37530
573s     app_test.go:1202: 18:33:03.078 - 98: DEBUG: new connection from 127.0.0.1:51816
577s     app_test.go:1202: 18:33:03.490 - 90: DEBUG: new connection from 127.0.0.1:37558
577s     app_test.go:1202: 18:33:03.494 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.499 - 90: DEBUG: new connection from 127.0.0.1:37568
577s     app_test.go:1202: 18:33:03.504 - 91: DEBUG: new connection from 127.0.0.1:44866
577s     app_test.go:1202: 18:33:03.508 - 92: DEBUG: new connection from 127.0.0.1:51594
577s     app_test.go:1202: 18:33:03.512 - 93: DEBUG: new connection from 127.0.0.1:45380
577s     app_test.go:1202: 18:33:03.517 - 95: DEBUG: new connection from 127.0.0.1:48774
577s     app_test.go:1202: 18:33:03.521 - 96: DEBUG: new connection from 127.0.0.1:44186
577s     app_test.go:1202: 18:33:03.525 - 97: DEBUG: new connection from 127.0.0.1:37534
577s     app_test.go:1202: 18:33:03.528 - 98: DEBUG: new connection from 127.0.0.1:51820
577s     app_test.go:1202: 18:33:03.535 - 97: DEBUG: new connection from 127.0.0.1:37538
577s     app_test.go:1202: 18:33:03.540 - 90: DEBUG: new connection from 127.0.0.1:37584
577s     app_test.go:1202: 18:33:03.540 - 90: DEBUG: new connection from 127.0.0.1:37586
577s     app_test.go:1202: 18:33:03.550 - 91: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.627 - 90: DEBUG: new connection from 127.0.0.1:37594
577s     app_test.go:1202: 18:33:03.630 - 92: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.687 - 90: DEBUG: new connection from 127.0.0.1:37608
577s     app_test.go:1202: 18:33:03.690 - 93: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.870 - 90: DEBUG: new connection from 127.0.0.1:37612
577s     app_test.go:1202: 18:33:03.872 - 95: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.949 - 90: DEBUG: new connection from 127.0.0.1:37616
577s     app_test.go:1202: 18:33:03.952 - 96: DEBUG: attempt 1: server 127.0.0.1:9001: connected
577s     app_test.go:1202: 18:33:03.962 - 90: DEBUG: new connection from 127.0.0.1:37626
577s     app_test.go:1202: 18:33:03.966 - 91: DEBUG: new connection from 127.0.0.1:44870
578s     app_test.go:1202: 18:33:03.970 - 92: DEBUG: new connection from 127.0.0.1:51610
578s     app_test.go:1202: 18:33:03.974 - 93: DEBUG: new connection from 127.0.0.1:45382
578s     app_test.go:1202: 18:33:03.977 - 95: DEBUG: new connection from 127.0.0.1:48776
578s     app_test.go:1202: 18:33:03.980 - 96: DEBUG: new connection from 127.0.0.1:44194
578s     app_test.go:1202: 18:33:03.983 - 97: DEBUG: new connection from 127.0.0.1:37548
578s     app_test.go:1202: 18:33:03.986 - 98: DEBUG: new connection from 127.0.0.1:51836
578s     app_test.go:1202: 18:33:03.992 - 90: DEBUG: new connection from 127.0.0.1:37636
578s     app_test.go:1202: 18:33:03.995 - 91: DEBUG: new connection from 127.0.0.1:44874
578s     app_test.go:1202: 18:33:03.999 - 92: DEBUG: new connection from 127.0.0.1:51626
578s     app_test.go:1202: 18:33:03.003 - 93: DEBUG: new connection from 127.0.0.1:45396
578s     app_test.go:1202: 18:33:03.007 - 95: DEBUG: new connection from 127.0.0.1:48778
578s     app_test.go:1202: 18:33:03.010 - 96: DEBUG: new connection from 127.0.0.1:44206
578s     app_test.go:1202: 18:33:03.012 - 90: DEBUG: new connection from 127.0.0.1:37648
578s     app_test.go:1202: 18:33:03.016 - 97: DEBUG: new connection from 127.0.0.1:37558
578s     app_test.go:1202: 18:33:03.018 - 97: DEBUG: attempt 1: server 127.0.0.1:9001: connected
578s     app_test.go:1202: 18:33:03.019 - 98: DEBUG: new connection from 127.0.0.1:51848
578s     app_test.go:1202: 18:33:03.083 - 90: DEBUG: new connection from 127.0.0.1:37650
578s     app_test.go:1202: 18:33:03.086 - 98: DEBUG: attempt 1: server 127.0.0.1:9001: connected
582s     app_test.go:1202: 18:33:03.555 - 90: DEBUG: new connection from 127.0.0.1:48506
582s     app_test.go:1202: 18:33:03.559 - 91: DEBUG: attempt 1: server 127.0.0.1:9001: connected
582s     app_test.go:1202: 18:33:03.633 - 90: DEBUG: new connection from 127.0.0.1:48508
582s     app_test.go:1202: 18:33:03.636 - 92: DEBUG: attempt 1: server 127.0.0.1:9001: connected
582s     app_test.go:1202: 18:33:03.695 - 90: DEBUG: new connection from 127.0.0.1:48522
582s     app_test.go:1202: 18:33:03.699 - 93: DEBUG: attempt 1: server 127.0.0.1:9001: connected
582s     app_test.go:1202: 18:33:03.876 - 90: DEBUG: new connection from 127.0.0.1:48524
582s     app_test.go:1202: 18:33:03.880 - 95: DEBUG: attempt 1: server 127.0.0.1:9001: connected
582s     app_test.go:1202: 18:33:03.956 - 90: DEBUG: new connection from 127.0.0.1:48528
582s     app_test.go:1202: 18:33:03.960 - 96: DEBUG: attempt 1: server 127.0.0.1:9001: connected
583s     app_test.go:1202: 18:33:03.026 - 90: DEBUG: new connection from 127.0.0.1:48538
583s     app_test.go:1202: 18:33:03.026 - 90: DEBUG: new connection from 127.0.0.1:48542
583s     app_test.go:1202: 18:33:03.033 - 97: DEBUG: attempt 1: server 127.0.0.1:9001: connected
583s     app_test.go:1202: 18:33:03.033 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
583s     app_test.go:1202: 18:33:03.043 - 90: DEBUG: new connection from 127.0.0.1:48544
583s     app_test.go:1202: 18:33:03.047 - 91: DEBUG: new connection from 127.0.0.1:47850
583s     app_test.go:1202: 18:33:03.051 - 92: DEBUG: new connection from 127.0.0.1:53508
583s     app_test.go:1202: 18:33:03.055 - 93: DEBUG: new connection from 127.0.0.1:52318
583s     app_test.go:1202: 18:33:03.060 - 95: DEBUG: new connection from 127.0.0.1:54322
583s     app_test.go:1202: 18:33:03.063 - 96: DEBUG: new connection from 127.0.0.1:48922
583s     app_test.go:1202: 18:33:03.066 - 97: DEBUG: new connection from 127.0.0.1:53870
583s     app_test.go:1202: 18:33:03.069 - 98: DEBUG: new connection from 127.0.0.1:33620
583s     app_test.go:1202: 18:33:03.089 - 90: DEBUG: new connection from 127.0.0.1:48556
583s     app_test.go:1202: 18:33:03.092 - 98: DEBUG: attempt 1: server 127.0.0.1:9001: connected
587s     app_test.go:1202: 18:34:03.564 - 90: DEBUG: new connection from 127.0.0.1:48564
587s     app_test.go:1202: 18:34:03.568 - 91: DEBUG: attempt 1: server 127.0.0.1:9001: connected
587s     app_test.go:1202: 18:34:03.640 - 90: DEBUG: new connection from 127.0.0.1:48568
587s     app_test.go:1202: 18:34:03.644 - 92: DEBUG: attempt 1: server 127.0.0.1:9001: connected
587s     app_test.go:1202: 18:34:03.704 - 90: DEBUG: new connection from 127.0.0.1:48582
587s     app_test.go:1202: 18:34:03.708 - 93: DEBUG: attempt 1: server 127.0.0.1:9001: connected
587s     app_test.go:1202: 18:34:03.884 - 90: DEBUG: new connection from 127.0.0.1:48596
587s     app_test.go:1202: 18:34:03.888 - 95: DEBUG: attempt 1: server 127.0.0.1:9001: connected
588s     app_test.go:1202: 18:34:03.967 - 90: DEBUG: new connection from 127.0.0.1:48604
588s     app_test.go:1202: 18:34:03.973 - 96: DEBUG: attempt 1: server 127.0.0.1:9001: connected
588s     app_test.go:1202: 18:34:03.042 - 90: DEBUG: new connection from 127.0.0.1:48610
588s     app_test.go:1202: 18:34:03.046 - 97: DEBUG: attempt 1: server 127.0.0.1:9001: connected
588s     app_test.go:1202: 18:34:03.072 - 90: DEBUG: new connection from 127.0.0.1:48622
588s     app_test.go:1202: 18:34:03.077 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
588s     app_test.go:1202: 18:34:03.081 - 90: DEBUG: new connection from 127.0.0.1:48636
588s     app_test.go:1202: 18:34:03.085 - 91: DEBUG: new connection from 127.0.0.1:47854
588s     app_test.go:1202: 18:34:03.089 - 92: DEBUG: new connection from 127.0.0.1:53518
588s     app_test.go:1202: 18:34:03.093 - 93: DEBUG: new connection from 127.0.0.1:52328
588s     app_test.go:1202: 18:34:03.096 - 90: DEBUG: new connection from 127.0.0.1:48640
588s     app_test.go:1202: 18:34:03.100 - 95: DEBUG: new connection from 127.0.0.1:54334
588s     app_test.go:1202: 18:34:03.101 - 98: DEBUG: attempt 1: server 127.0.0.1:9001: connected
588s     app_test.go:1202: 18:34:03.106 - 96: DEBUG: new connection from 127.0.0.1:48930
588s     app_test.go:1202: 18:34:03.112 - 97: DEBUG: new connection from 127.0.0.1:53878
588s     app_test.go:1202: 18:34:03.116 - 98: DEBUG: new connection from 127.0.0.1:33636
592s     app_test.go:1202: 18:34:03.572 - 90: DEBUG: new connection from 127.0.0.1:49880
592s     app_test.go:1202: 18:34:03.580 - 91: DEBUG: attempt 1: server 127.0.0.1:9001: connected
592s     app_test.go:1202: 18:34:03.650 - 90: DEBUG: new connection from 127.0.0.1:49896
592s     app_test.go:1202: 18:34:03.655 - 92: DEBUG: attempt 1: server 127.0.0.1:9001: connected
592s     app_test.go:1202: 18:34:03.713 - 90: DEBUG: new connection from 127.0.0.1:49900
592s     app_test.go:1202: 18:34:03.717 - 93: DEBUG: attempt 1: server 127.0.0.1:9001: connected
592s     app_test.go:1202: 18:34:03.893 - 90: DEBUG: new connection from 127.0.0.1:49910
592s     app_test.go:1202: 18:34:03.897 - 95: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.978 - 90: DEBUG: new connection from 127.0.0.1:49922
593s     app_test.go:1202: 18:34:03.981 - 96: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.052 - 90: DEBUG: new connection from 127.0.0.1:49938
593s     app_test.go:1202: 18:34:03.056 - 97: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.107 - 90: DEBUG: new connection from 127.0.0.1:49940
593s     app_test.go:1202: 18:34:03.111 - 90: DEBUG: new connection from 127.0.0.1:49956
593s     app_test.go:1202: 18:34:03.112 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.116 - 98: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.126 - 90: DEBUG: new connection from 127.0.0.1:49958
593s     app_test.go:1202: 18:34:03.130 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected
593s     app_test.go:1202: 18:34:03.134 - 90: DEBUG: new connection from 127.0.0.1:49970
593s     app_test.go:1202: 18:34:03.137 - 91: DEBUG: new connection from 127.0.0.1:37238
593s     app_test.go:1202: 18:34:03.142 - 92: DEBUG: new connection from 127.0.0.1:33080
593s     app_test.go:1202: 18:34:03.151 - 93: DEBUG: new connection from 127.0.0.1:44544
593s --- PASS: TestRolesAdjustment_ReplaceStandByHonorFailureDomains (20.81s)
593s === RUN   TestOpen
593s     app_test.go:1202: 18:34:03.290 - 99: DEBUG: new connection from 127.0.0.1:50800
593s     app_test.go:1202: 18:34:03.291 - 99: DEBUG: new connection from 127.0.0.1:50816
593s     app_test.go:1202: 18:34:03.299 - 99: DEBUG: attempt 1: server 127.0.0.1:9000: connected
593s     app_test.go:1202: 18:34:03.299 - 99: DEBUG: attempt 1: server 127.0.0.1:9000: connected
593s     app_test.go:1202: 18:34:03.303 - 99: DEBUG: new connection from 127.0.0.1:50828
593s --- PASS: TestOpen (0.07s)
593s === RUN   TestOpenDisk
593s     app_test.go:1202: 18:34:03.365 - 100: DEBUG: new connection from 127.0.0.1:50840
593s     app_test.go:1202: 18:34:03.367 - 100: DEBUG: new connection from 127.0.0.1:50846
593s     app_test.go:1202: 18:34:03.372 - 100: DEBUG: attempt 1: server 127.0.0.1:9000: connected
593s     app_test.go:1202: 18:34:03.372 - 100: DEBUG: attempt 1: server 127.0.0.1:9000: connected
593s     app_test.go:1202: 18:34:03.378 - 100: DEBUG: new connection from 127.0.0.1:50862
593s --- PASS: TestOpenDisk (0.07s)
593s === RUN   TestOptions
593s --- PASS: TestOptions (0.04s)
593s === RUN   TestProxy_Error
593s     app_test.go:1202: 18:34:03.470 - 102: DEBUG: new connection from 127.0.0.1:50866
593s     app_test.go:1202: 18:34:03.470 - 102: DEBUG: new connection from 127.0.0.1:50874
593s     app_test.go:1202: 18:34:03.476 - 102: DEBUG: attempt 1: server 127.0.0.1:9000: connected
593s     app_test.go:1202: 18:34:03.479 - 102: DEBUG: new connection from 127.0.0.1:50888
593s --- PASS: TestProxy_Error (0.39s)
593s === RUN   TestReady_Cancel
593s     app_test.go:1202: 18:34:03.868 - 103: WARN: attempt 1: server 127.0.0.1:9001: dial: dial tcp 127.0.0.1:9001: connect: connection refused
594s --- PASS: TestReady_Cancel (0.24s)
594s === RUN   TestExternalConnWithTCP
594s     app_test.go:1227: 18:34:03.114 - 104: DEBUG: attempt 1: server 127.0.0.1:9191: connected
594s     app_test.go:1227: 18:34:03.145 - 105: DEBUG: attempt 1: server 127.0.0.1:9191: connected
594s     app_test.go:1227: 18:34:03.177 - 106: DEBUG: attempt 1: server 127.0.0.1:9191: connected
594s     app_test.go:1227: 18:34:03.198 - 104: DEBUG: attempt 1: server 127.0.0.1:9191: connected
594s --- PASS: TestExternalConnWithTCP (0.19s)
594s === RUN   TestExternalConnWithPipe
594s     app_test.go:1227: 18:34:03.302 - 107: DEBUG: attempt 1: server first: connected
594s     app_test.go:1227: 18:34:03.332 - 108: DEBUG: attempt 1: server first: connected
594s     app_test.go:1227: 18:34:03.364 - 109: DEBUG: attempt 1: server first: connected
594s     app_test.go:1227: 18:34:03.381 - 107: DEBUG: attempt 1: server first: connected
594s --- PASS: TestExternalConnWithPipe (0.19s)
594s === RUN   TestParallelNewApp
594s === PAUSE TestParallelNewApp
594s === RUN   Test_TxRowsAffected
594s     app_test.go:1227: 18:34:03.486 - 110: DEBUG: attempt 1: server 127.0.0.1:9001: connected
594s     app_test.go:1227: 18:34:03.490 - 110: DEBUG: attempt 1: server 127.0.0.1:9001: connected
594s --- PASS: Test_TxRowsAffected (0.06s)
594s === CONT  TestParallelNewApp
594s === RUN   TestParallelNewApp/run-0
594s === PAUSE TestParallelNewApp/run-0
594s === RUN   TestParallelNewApp/run-1
594s === PAUSE TestParallelNewApp/run-1
594s === RUN   TestParallelNewApp/run-2
594s === PAUSE TestParallelNewApp/run-2
594s === RUN   TestParallelNewApp/run-3
594s === PAUSE TestParallelNewApp/run-3
594s === RUN   TestParallelNewApp/run-4
594s === PAUSE TestParallelNewApp/run-4
594s === RUN   TestParallelNewApp/run-5
594s === PAUSE TestParallelNewApp/run-5
594s === RUN   TestParallelNewApp/run-6
594s === PAUSE TestParallelNewApp/run-6
594s === RUN   TestParallelNewApp/run-7
594s === PAUSE TestParallelNewApp/run-7
594s === RUN   TestParallelNewApp/run-8
594s === PAUSE TestParallelNewApp/run-8
594s === RUN   TestParallelNewApp/run-9
594s === PAUSE TestParallelNewApp/run-9
594s === RUN   TestParallelNewApp/run-10
594s === PAUSE TestParallelNewApp/run-10
594s === RUN   TestParallelNewApp/run-11
594s === PAUSE TestParallelNewApp/run-11
594s === RUN   TestParallelNewApp/run-12
594s === PAUSE TestParallelNewApp/run-12
594s === RUN   TestParallelNewApp/run-13
594s === PAUSE TestParallelNewApp/run-13
594s === RUN   TestParallelNewApp/run-14
594s === PAUSE TestParallelNewApp/run-14
594s === RUN   TestParallelNewApp/run-15
594s === PAUSE TestParallelNewApp/run-15
594s === RUN   TestParallelNewApp/run-16
594s === PAUSE TestParallelNewApp/run-16
594s === RUN   TestParallelNewApp/run-17
594s === PAUSE TestParallelNewApp/run-17
594s === RUN   TestParallelNewApp/run-18
594s === PAUSE TestParallelNewApp/run-18
594s === RUN   TestParallelNewApp/run-19
594s === PAUSE TestParallelNewApp/run-19
594s === RUN   TestParallelNewApp/run-20
594s === PAUSE TestParallelNewApp/run-20
594s === RUN   TestParallelNewApp/run-21
594s === PAUSE TestParallelNewApp/run-21
594s === RUN   TestParallelNewApp/run-22
594s === PAUSE TestParallelNewApp/run-22
594s === RUN   TestParallelNewApp/run-23
594s === PAUSE TestParallelNewApp/run-23
594s === RUN   TestParallelNewApp/run-24
594s === PAUSE TestParallelNewApp/run-24
594s === RUN   TestParallelNewApp/run-25
594s === PAUSE TestParallelNewApp/run-25
594s === RUN   TestParallelNewApp/run-26
594s === PAUSE TestParallelNewApp/run-26
594s === RUN   TestParallelNewApp/run-27
594s === PAUSE TestParallelNewApp/run-27
594s === RUN   TestParallelNewApp/run-28
594s === PAUSE TestParallelNewApp/run-28
594s === RUN   TestParallelNewApp/run-29
594s === PAUSE TestParallelNewApp/run-29
594s === RUN   TestParallelNewApp/run-30
594s === PAUSE TestParallelNewApp/run-30
594s === RUN   TestParallelNewApp/run-31
594s === PAUSE TestParallelNewApp/run-31
594s === RUN   TestParallelNewApp/run-32
594s === PAUSE TestParallelNewApp/run-32
594s === RUN   TestParallelNewApp/run-33
594s === PAUSE TestParallelNewApp/run-33
594s === RUN   TestParallelNewApp/run-34
594s === PAUSE TestParallelNewApp/run-34
594s === RUN   TestParallelNewApp/run-35
594s === PAUSE TestParallelNewApp/run-35
594s === RUN   TestParallelNewApp/run-36
594s === PAUSE TestParallelNewApp/run-36
594s === RUN   TestParallelNewApp/run-37
594s === PAUSE TestParallelNewApp/run-37
594s === RUN   TestParallelNewApp/run-38
594s === PAUSE TestParallelNewApp/run-38
594s === RUN   TestParallelNewApp/run-39
594s === PAUSE TestParallelNewApp/run-39
594s === RUN   TestParallelNewApp/run-40
594s === PAUSE TestParallelNewApp/run-40
594s === RUN   TestParallelNewApp/run-41
594s === PAUSE TestParallelNewApp/run-41
594s === RUN   TestParallelNewApp/run-42
594s === PAUSE TestParallelNewApp/run-42
594s === RUN   TestParallelNewApp/run-43
594s === PAUSE TestParallelNewApp/run-43
594s === RUN   TestParallelNewApp/run-44
594s === PAUSE TestParallelNewApp/run-44
594s === RUN   TestParallelNewApp/run-45
594s === PAUSE TestParallelNewApp/run-45
594s === RUN   TestParallelNewApp/run-46
594s === PAUSE TestParallelNewApp/run-46
594s === RUN   TestParallelNewApp/run-47
594s === PAUSE TestParallelNewApp/run-47
594s === RUN   TestParallelNewApp/run-48
594s === PAUSE TestParallelNewApp/run-48
594s === RUN   TestParallelNewApp/run-49
594s === PAUSE TestParallelNewApp/run-49
594s === RUN   TestParallelNewApp/run-50
594s === PAUSE TestParallelNewApp/run-50
594s === RUN   TestParallelNewApp/run-51
594s === PAUSE TestParallelNewApp/run-51
594s === RUN   TestParallelNewApp/run-52
594s === PAUSE TestParallelNewApp/run-52
594s === RUN   TestParallelNewApp/run-53
594s === PAUSE TestParallelNewApp/run-53
594s === RUN   TestParallelNewApp/run-54
594s === PAUSE TestParallelNewApp/run-54
594s === RUN   TestParallelNewApp/run-55
594s === PAUSE TestParallelNewApp/run-55
594s === RUN   TestParallelNewApp/run-56
594s === PAUSE TestParallelNewApp/run-56
594s === RUN   TestParallelNewApp/run-57
594s === PAUSE TestParallelNewApp/run-57
594s === RUN   TestParallelNewApp/run-58
594s === PAUSE TestParallelNewApp/run-58
594s === RUN   TestParallelNewApp/run-59
594s === PAUSE TestParallelNewApp/run-59
594s === RUN   TestParallelNewApp/run-60
594s === PAUSE TestParallelNewApp/run-60
594s === RUN   TestParallelNewApp/run-61
594s === PAUSE TestParallelNewApp/run-61
594s === RUN   TestParallelNewApp/run-62
594s === PAUSE TestParallelNewApp/run-62
594s === RUN   TestParallelNewApp/run-63
594s === PAUSE TestParallelNewApp/run-63
594s === RUN   TestParallelNewApp/run-64
594s === PAUSE TestParallelNewApp/run-64
594s === RUN   TestParallelNewApp/run-65
594s === PAUSE TestParallelNewApp/run-65
594s === RUN   TestParallelNewApp/run-66
594s === PAUSE TestParallelNewApp/run-66
594s === RUN   TestParallelNewApp/run-67
594s === PAUSE TestParallelNewApp/run-67
594s === RUN   TestParallelNewApp/run-68
594s === PAUSE TestParallelNewApp/run-68
594s === RUN   TestParallelNewApp/run-69
594s === PAUSE TestParallelNewApp/run-69
594s === RUN   TestParallelNewApp/run-70
594s === PAUSE TestParallelNewApp/run-70
594s === RUN   TestParallelNewApp/run-71
594s === PAUSE TestParallelNewApp/run-71
594s === RUN   TestParallelNewApp/run-72
594s === PAUSE TestParallelNewApp/run-72
594s === RUN   TestParallelNewApp/run-73
594s === PAUSE TestParallelNewApp/run-73
594s === RUN   TestParallelNewApp/run-74
594s === PAUSE TestParallelNewApp/run-74
594s === RUN   TestParallelNewApp/run-75
594s === PAUSE TestParallelNewApp/run-75
594s === RUN   TestParallelNewApp/run-76
594s === PAUSE TestParallelNewApp/run-76
594s === RUN   TestParallelNewApp/run-77
594s === PAUSE TestParallelNewApp/run-77
594s === RUN   TestParallelNewApp/run-78
594s === PAUSE TestParallelNewApp/run-78
594s === RUN   TestParallelNewApp/run-79
594s === PAUSE TestParallelNewApp/run-79
594s === RUN   TestParallelNewApp/run-80
594s === PAUSE TestParallelNewApp/run-80
594s === RUN   TestParallelNewApp/run-81
594s === PAUSE TestParallelNewApp/run-81
594s === RUN   TestParallelNewApp/run-82
594s === PAUSE TestParallelNewApp/run-82
594s === RUN   TestParallelNewApp/run-83
594s === PAUSE TestParallelNewApp/run-83
594s === RUN   TestParallelNewApp/run-84
594s === PAUSE TestParallelNewApp/run-84
594s === RUN   TestParallelNewApp/run-85
594s === PAUSE TestParallelNewApp/run-85
594s === RUN   TestParallelNewApp/run-86
594s === PAUSE TestParallelNewApp/run-86
594s === RUN   TestParallelNewApp/run-87
594s === PAUSE TestParallelNewApp/run-87
594s === RUN   TestParallelNewApp/run-88
594s === PAUSE TestParallelNewApp/run-88
594s === RUN   TestParallelNewApp/run-89
594s === PAUSE TestParallelNewApp/run-89
594s === RUN   TestParallelNewApp/run-90
594s === PAUSE TestParallelNewApp/run-90
594s === RUN   TestParallelNewApp/run-91
594s === PAUSE TestParallelNewApp/run-91
594s === RUN   TestParallelNewApp/run-92
594s === PAUSE TestParallelNewApp/run-92
594s === RUN   TestParallelNewApp/run-93
594s === PAUSE TestParallelNewApp/run-93
594s === RUN   TestParallelNewApp/run-94
594s === PAUSE TestParallelNewApp/run-94
594s === RUN   TestParallelNewApp/run-95
594s === PAUSE TestParallelNewApp/run-95
594s === RUN   TestParallelNewApp/run-96
594s === PAUSE TestParallelNewApp/run-96
594s === RUN   TestParallelNewApp/run-97
594s === PAUSE TestParallelNewApp/run-97
594s === RUN   TestParallelNewApp/run-98
594s === PAUSE TestParallelNewApp/run-98
594s === RUN   TestParallelNewApp/run-99
594s === PAUSE TestParallelNewApp/run-99
594s === CONT  TestParallelNewApp/run-0
594s === CONT  TestParallelNewApp/run-99
594s === CONT  TestParallelNewApp/run-98
594s === CONT  TestParallelNewApp/run-97
594s === CONT  TestParallelNewApp/run-96
594s === CONT  TestParallelNewApp/run-95
594s === CONT  TestParallelNewApp/run-94
594s === CONT  TestParallelNewApp/run-93
594s === CONT  TestParallelNewApp/run-92
594s === CONT  TestParallelNewApp/run-91
594s === CONT  TestParallelNewApp/run-90
594s === CONT  TestParallelNewApp/run-89
594s === CONT  TestParallelNewApp/run-88
595s === CONT  TestParallelNewApp/run-87
595s === CONT  TestParallelNewApp/run-86
595s === CONT  TestParallelNewApp/run-85
595s === CONT  TestParallelNewApp/run-84
595s === CONT  TestParallelNewApp/run-83
595s === CONT  TestParallelNewApp/run-82
595s === CONT  TestParallelNewApp/run-81
595s === CONT  TestParallelNewApp/run-80
595s === CONT  TestParallelNewApp/run-79
595s === CONT  TestParallelNewApp/run-78
595s === CONT  TestParallelNewApp/run-77
595s === CONT  TestParallelNewApp/run-76
595s === CONT  TestParallelNewApp/run-75
595s === CONT  TestParallelNewApp/run-74
595s === CONT  TestParallelNewApp/run-73
595s === CONT  TestParallelNewApp/run-72
595s === CONT  TestParallelNewApp/run-71
595s === CONT  TestParallelNewApp/run-70
595s === CONT  TestParallelNewApp/run-69
595s === CONT  TestParallelNewApp/run-68
595s === CONT  TestParallelNewApp/run-67
595s === CONT  TestParallelNewApp/run-66
595s === CONT  TestParallelNewApp/run-65
595s === CONT  TestParallelNewApp/run-64
595s === CONT  TestParallelNewApp/run-63
595s === CONT  TestParallelNewApp/run-62
595s === CONT  TestParallelNewApp/run-61
595s === CONT  TestParallelNewApp/run-60
596s === CONT  TestParallelNewApp/run-59
596s === CONT  TestParallelNewApp/run-58
596s === CONT  TestParallelNewApp/run-57
596s === CONT  TestParallelNewApp/run-56
596s === CONT  TestParallelNewApp/run-55
596s === CONT  TestParallelNewApp/run-54
596s === CONT  TestParallelNewApp/run-53
596s === CONT  TestParallelNewApp/run-52
596s === CONT  TestParallelNewApp/run-51
596s === CONT  TestParallelNewApp/run-50
596s === CONT  TestParallelNewApp/run-49
596s === CONT  TestParallelNewApp/run-48
596s === CONT  TestParallelNewApp/run-47
596s === CONT  TestParallelNewApp/run-46
596s === CONT  TestParallelNewApp/run-45
596s === CONT  TestParallelNewApp/run-44
596s === CONT  TestParallelNewApp/run-43
596s === CONT  TestParallelNewApp/run-42
596s === CONT  TestParallelNewApp/run-41
596s === CONT  TestParallelNewApp/run-40
596s === CONT  TestParallelNewApp/run-39
596s === CONT  TestParallelNewApp/run-38
596s === CONT  TestParallelNewApp/run-37
596s === CONT  TestParallelNewApp/run-36
596s === CONT  TestParallelNewApp/run-35
596s === CONT  TestParallelNewApp/run-34
596s === CONT  TestParallelNewApp/run-33
597s === CONT  TestParallelNewApp/run-32
597s === CONT  TestParallelNewApp/run-31
597s === CONT  TestParallelNewApp/run-30
597s === CONT  TestParallelNewApp/run-29
597s === CONT  TestParallelNewApp/run-28
597s === CONT  TestParallelNewApp/run-27
597s === CONT  TestParallelNewApp/run-26
597s === CONT  TestParallelNewApp/run-25
597s === CONT  TestParallelNewApp/run-24
597s === CONT  TestParallelNewApp/run-23
597s === CONT  TestParallelNewApp/run-22
597s === CONT  TestParallelNewApp/run-21
597s === CONT  TestParallelNewApp/run-20
597s === CONT  TestParallelNewApp/run-19
597s === CONT  TestParallelNewApp/run-18
597s === CONT  TestParallelNewApp/run-17
597s === CONT  TestParallelNewApp/run-16
597s === CONT  TestParallelNewApp/run-15
597s === CONT  TestParallelNewApp/run-14
597s === CONT  TestParallelNewApp/run-13
597s === CONT  TestParallelNewApp/run-12
597s === CONT  TestParallelNewApp/run-11
597s === CONT  TestParallelNewApp/run-10
597s === CONT  TestParallelNewApp/run-9
597s === CONT  TestParallelNewApp/run-8
597s === CONT  TestParallelNewApp/run-7
597s === CONT  TestParallelNewApp/run-6
598s === CONT  TestParallelNewApp/run-5
598s === CONT  TestParallelNewApp/run-4
598s === CONT  TestParallelNewApp/run-3
598s === CONT  TestParallelNewApp/run-2
598s === CONT  TestParallelNewApp/run-1
598s --- PASS: TestParallelNewApp (0.00s)
598s     --- PASS: TestParallelNewApp/run-0 (0.04s)
598s     --- PASS: TestParallelNewApp/run-99 (0.04s)
598s     --- PASS: TestParallelNewApp/run-98 (0.04s)
598s     --- PASS: TestParallelNewApp/run-97 (0.04s)
598s     --- PASS: TestParallelNewApp/run-96 (0.04s)
598s     --- PASS: TestParallelNewApp/run-95 (0.04s)
598s     --- PASS: TestParallelNewApp/run-94 (0.04s)
598s     --- PASS: TestParallelNewApp/run-93 (0.04s)
598s     --- PASS: TestParallelNewApp/run-92 (0.04s)
598s     --- PASS: TestParallelNewApp/run-91 (0.04s)
598s     --- PASS: TestParallelNewApp/run-90 (0.04s)
598s     --- PASS: TestParallelNewApp/run-89 (0.04s)
598s     --- PASS: TestParallelNewApp/run-88 (0.04s)
598s     --- PASS: TestParallelNewApp/run-87 (0.03s)
598s     --- PASS: TestParallelNewApp/run-86 (0.04s)
598s     --- PASS: TestParallelNewApp/run-85 (0.03s)
598s     --- PASS: TestParallelNewApp/run-84 (0.03s)
598s     --- PASS: TestParallelNewApp/run-83 (0.04s)
598s     --- PASS: TestParallelNewApp/run-82 (0.03s)
598s     --- PASS: TestParallelNewApp/run-81 (0.04s)
598s     --- PASS: TestParallelNewApp/run-80 (0.04s)
598s     --- PASS: TestParallelNewApp/run-79 (0.04s)
598s     --- PASS: TestParallelNewApp/run-78 (0.04s)
598s     --- PASS: TestParallelNewApp/run-77 (0.04s)
598s     --- PASS: TestParallelNewApp/run-76 (0.04s)
598s     --- PASS: TestParallelNewApp/run-75 (0.04s)
598s     --- PASS: TestParallelNewApp/run-74 (0.04s)
598s     --- PASS: TestParallelNewApp/run-73 (0.04s)
598s     --- PASS: TestParallelNewApp/run-72 (0.04s)
598s     --- PASS: TestParallelNewApp/run-71 (0.04s)
598s     --- PASS: TestParallelNewApp/run-70 (0.04s)
598s     --- PASS: TestParallelNewApp/run-69 (0.04s)
598s     --- PASS: TestParallelNewApp/run-68 (0.04s)
598s     --- PASS: TestParallelNewApp/run-67 (0.04s)
598s     --- PASS: TestParallelNewApp/run-66 (0.04s)
598s     --- PASS: TestParallelNewApp/run-65 (0.04s)
598s     --- PASS: TestParallelNewApp/run-64 (0.03s)
598s     --- PASS: TestParallelNewApp/run-63 (0.04s)
598s     --- PASS: TestParallelNewApp/run-62 (0.04s)
598s     --- PASS: TestParallelNewApp/run-61 (0.04s)
598s     --- PASS: TestParallelNewApp/run-60 (0.04s)
598s     --- PASS: TestParallelNewApp/run-59 (0.04s)
598s     --- PASS: TestParallelNewApp/run-58 (0.04s)
598s     --- PASS: TestParallelNewApp/run-57 (0.04s)
598s     --- PASS: TestParallelNewApp/run-56 (0.04s)
598s     --- PASS: TestParallelNewApp/run-55 (0.03s)
598s     --- PASS: TestParallelNewApp/run-54 (0.03s)
598s     --- PASS: TestParallelNewApp/run-53 (0.04s)
598s     --- PASS: TestParallelNewApp/run-52 (0.04s)
598s     --- PASS: TestParallelNewApp/run-51 (0.03s)
598s     --- PASS: TestParallelNewApp/run-50 (0.04s)
598s     --- PASS: TestParallelNewApp/run-49 (0.04s)
598s     --- PASS: TestParallelNewApp/run-48 (0.04s)
598s     --- PASS: TestParallelNewApp/run-47 (0.04s)
598s     --- PASS: TestParallelNewApp/run-46 (0.04s)
598s     --- PASS: TestParallelNewApp/run-45 (0.04s)
598s     --- PASS: TestParallelNewApp/run-44 (0.04s)
598s     --- PASS: TestParallelNewApp/run-43 (0.04s)
598s     --- PASS: TestParallelNewApp/run-42 (0.04s)
598s     --- PASS: TestParallelNewApp/run-41 (0.04s)
598s     --- PASS: TestParallelNewApp/run-40 (0.04s)
598s     --- PASS: TestParallelNewApp/run-39 (0.03s)
598s     --- PASS: TestParallelNewApp/run-38 (0.04s)
598s     --- PASS: TestParallelNewApp/run-37 (0.04s)
598s     --- PASS: TestParallelNewApp/run-36 (0.04s)
598s     --- PASS: TestParallelNewApp/run-35 (0.04s)
598s     --- PASS: TestParallelNewApp/run-34 (0.04s)
598s     --- PASS: TestParallelNewApp/run-33 (0.04s)
598s     --- PASS: TestParallelNewApp/run-32 (0.04s)
598s     --- PASS: TestParallelNewApp/run-31 (0.04s)
598s     --- PASS: TestParallelNewApp/run-30 (0.04s)
598s     --- PASS: TestParallelNewApp/run-29 (0.04s)
598s     --- PASS: TestParallelNewApp/run-28 (0.04s)
598s     --- PASS: TestParallelNewApp/run-27 (0.04s)
598s     --- PASS: TestParallelNewApp/run-26 (0.04s)
598s     --- PASS: TestParallelNewApp/run-25 (0.04s)
598s     --- PASS: TestParallelNewApp/run-24 (0.04s)
598s     --- PASS: TestParallelNewApp/run-23 (0.04s)
598s     --- PASS: TestParallelNewApp/run-22 (0.04s)
598s     --- PASS: TestParallelNewApp/run-21 (0.04s)
598s     --- PASS: TestParallelNewApp/run-20 (0.04s)
598s     --- PASS: TestParallelNewApp/run-19 (0.04s)
598s     --- PASS: TestParallelNewApp/run-18 (0.04s)
598s     --- PASS: TestParallelNewApp/run-17 (0.03s)
598s     --- PASS: TestParallelNewApp/run-16 (0.03s)
598s     --- PASS: TestParallelNewApp/run-15 (0.03s)
598s     --- PASS: TestParallelNewApp/run-14 (0.04s)
598s     --- PASS: TestParallelNewApp/run-13 (0.03s)
598s     --- PASS: TestParallelNewApp/run-12 (0.04s)
598s     --- PASS: TestParallelNewApp/run-11 (0.04s)
598s     --- PASS: TestParallelNewApp/run-10 (0.04s)
598s     --- PASS: TestParallelNewApp/run-9 (0.04s)
598s     --- PASS: TestParallelNewApp/run-8 (0.04s)
598s     --- PASS: TestParallelNewApp/run-7 (0.03s)
598s     --- PASS: TestParallelNewApp/run-6 (0.04s)
598s     --- PASS: TestParallelNewApp/run-5 (0.03s)
598s     --- PASS: TestParallelNewApp/run-4 (0.04s)
598s     --- PASS: TestParallelNewApp/run-3 (0.04s)
598s     --- PASS: TestParallelNewApp/run-2 (0.04s)
598s     --- PASS: TestParallelNewApp/run-1 (0.04s)
598s === RUN   Example
598s --- PASS: Example (0.07s)
598s PASS
598s ok  	github.com/canonical/go-dqlite/app	127.960s
599s === RUN   TestNew_Default
600s Benchmark done. Results available here:
600s /tmp/dqlite-app-test-3701987113/results
600s --- PASS: TestNew_Default (1.07s)
600s === RUN   TestNew_KvReadWrite
601s Benchmark done. Results available here:
601s /tmp/dqlite-app-test-1287711696/results
601s --- PASS: TestNew_KvReadWrite (1.09s)
601s === RUN   TestNew_ClusteredKvReadWrite
604s Benchmark done. Results available here:
604s /tmp/dqlite-app-test-543794491/results
604s --- PASS: TestNew_ClusteredKvReadWrite (2.16s)
604s === RUN   TestNew_ClusteredTimeout
606s --- PASS: TestNew_ClusteredTimeout (2.08s)
606s PASS
606s ok  	github.com/canonical/go-dqlite/benchmark	6.437s
607s === RUN   TestClient_Leader
607s --- PASS: TestClient_Leader (0.05s)
607s === RUN   TestClient_Dump
607s --- PASS: TestClient_Dump (0.07s)
607s === RUN   TestClient_Cluster
607s --- PASS: TestClient_Cluster (0.03s)
607s === RUN   TestClient_Transfer
607s --- PASS: TestClient_Transfer (0.11s)
607s === RUN   TestClient_Describe
607s --- PASS: TestClient_Describe (0.03s)
607s === RUN   TestMembership
608s --- PASS: TestMembership (0.14s)
608s === RUN   TestDefaultNodeStore
608s --- PASS: TestDefaultNodeStore (0.00s)
608s === RUN   TestConfigMultiThread
608s --- PASS: TestConfigMultiThread (0.00s)
608s PASS
608s ok  	github.com/canonical/go-dqlite/client	0.444s
613s ?   	github.com/canonical/go-dqlite/cmd/dqlite	[no test files]
613s ?   	github.com/canonical/go-dqlite/cmd/dqlite-benchmark	[no test files]
613s ?   	github.com/canonical/go-dqlite/cmd/dqlite-demo	[no test files]
614s === RUN   TestDriver_Open
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestDriver_Open (0.03s)
614s === RUN   TestDriver_Prepare
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestDriver_Prepare (0.04s)
614s === RUN   TestConn_Exec
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_Exec (0.03s)
614s === RUN   TestConn_Query
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_Query (0.03s)
614s === RUN   TestConn_QueryRow
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_QueryRow (0.04s)
614s === RUN   TestConn_QueryBlob
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_QueryBlob (0.04s)
614s === RUN   TestStmt_Exec
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestStmt_Exec (0.03s)
614s === RUN   TestStmt_ExecManyParams
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestStmt_ExecManyParams (0.03s)
614s === RUN   TestStmt_Query
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestStmt_Query (0.04s)
614s === RUN   TestStmt_QueryManyParams
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestStmt_QueryManyParams (0.03s)
614s === RUN   TestConn_QueryParams
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_QueryParams (0.04s)
614s === RUN   TestConn_QueryManyParams
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_QueryManyParams (0.03s)
614s === RUN   TestConn_ExecManyParams
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: TestConn_ExecManyParams (0.03s)
614s === RUN   Test_ColumnTypesEmpty
614s     driver_test.go:439: this currently fails if the result set is empty, is dqlite skipping the header if empty set?
614s --- SKIP: Test_ColumnTypesEmpty (0.00s)
614s === RUN   Test_ColumnTypesExists
614s     func.go:15: DEBUG: attempt 1: server @1: connected
614s --- PASS: Test_ColumnTypesExists (0.04s)
614s === RUN   Test_ColumnTypesEnd
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: Test_ColumnTypesEnd (0.03s)
615s === RUN   Test_ZeroColumns
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: Test_ZeroColumns (0.05s)
615s === RUN   TestIntegration_DatabaseSQL
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_DatabaseSQL (0.16s)
615s === RUN   TestIntegration_ConstraintError
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_ConstraintError (0.16s)
615s === RUN   TestIntegration_ExecBindError
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_ExecBindError (0.06s)
615s === RUN   TestIntegration_QueryBindError
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_QueryBindError (0.03s)
615s === RUN   TestIntegration_LargeQuery
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_LargeQuery (0.24s)
615s === RUN   TestIntegration_Recover
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s     func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe
615s     func.go:15: DEBUG: attempt 1: server @1: connected
615s --- PASS: TestIntegration_Recover (0.16s)
615s === RUN   TestIntegration_PingOnlyWorksOnceLeaderElected
615s     func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused
615s     func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1
615s     func.go:15: WARN: attempt 1: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused
616s     func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused
616s     func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1
616s     func.go:15: WARN: attempt 2: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused
616s     func.go:15: WARN: attempt 3: server @1: dial: dial unix @1: connect: connection refused
616s     func.go:15: DEBUG: attempt 3: server @2: connect to reported leader @1
616s     func.go:15: WARN: attempt 3: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused
617s     func.go:15: WARN: attempt 1: server @1: no known leader
617s     func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1
617s     func.go:15: WARN: attempt 1: server @2: reported leader server is not the leader
617s     func.go:15: WARN: attempt 2: server @1: no known leader
617s     func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1
617s     func.go:15: WARN: attempt 2: server @2: reported leader server is not the leader
617s     func.go:15: WARN: attempt 3: server @1: no known leader
617s     func.go:15: DEBUG: attempt 3: server @2: connect to reported leader @1
617s     func.go:15: WARN: attempt 3: server @2: reported leader server is not the leader
618s     func.go:15: WARN: attempt 4: server @1: no known leader
618s     func.go:15: DEBUG: attempt 4: server @2: connect to reported leader @1
618s     func.go:15: WARN: attempt 4: server @2: reported leader server is not the leader
619s     func.go:15: WARN: attempt 5: server @1: no known leader
619s     func.go:15: DEBUG: attempt 5: server @2: connect to reported leader @1
619s     func.go:15: WARN: attempt 5: server @2: reported leader server is not the leader
620s     func.go:15: WARN: attempt 6: server @1: no known leader
620s     func.go:15: WARN: attempt 6: server @2: no known leader
621s     func.go:15: DEBUG: attempt 7: server @1: connected
621s --- PASS: TestIntegration_PingOnlyWorksOnceLeaderElected (5.98s)
621s === RUN   TestIntegration_HighAvailability
621s     func.go:15: DEBUG: attempt 1: server @1: connected
624s     func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe
624s     func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused
624s     func.go:15: WARN: attempt 1: server @2: no known leader
624s     func.go:15: WARN: attempt 1: server @3: no known leader
624s     func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused
624s     func.go:15: WARN: attempt 2: server @2: no known leader
624s     func.go:15: WARN: attempt 2: server @3: no known leader
624s     func.go:15: WARN: attempt 3: server @1: dial: dial unix @1: connect: connection refused
624s     func.go:15: WARN: attempt 3: server @2: no known leader
624s     func.go:15: WARN: attempt 3: server @3: no known leader
625s     func.go:15: WARN: attempt 4: server @1: dial: dial unix @1: connect: connection refused
625s     func.go:15: WARN: attempt 4: server @2: no known leader
625s     func.go:15: WARN: attempt 4: server @3: no known leader
626s     func.go:15: WARN: attempt 5: server @1: dial: dial unix @1: connect: connection refused
626s     func.go:15: WARN: attempt 5: server @2: no known leader
626s     func.go:15: WARN: attempt 5: server @3: no known leader
627s     func.go:15: WARN: attempt 6: server @1: dial: dial unix @1: connect: connection refused
627s     func.go:15: DEBUG: attempt 6: server @2: connected
627s --- PASS: TestIntegration_HighAvailability (5.68s)
627s === RUN   TestIntegration_LeadershipTransfer
627s     func.go:15: DEBUG: attempt 1: server @1: connected
627s     func.go:15: DEBUG: leadership lost (10250 - not leader)
627s     func.go:15: DEBUG: attempt 1: server @1: connect to reported leader @2
627s     func.go:15: DEBUG: attempt 1: server @1: connected
627s --- PASS: TestIntegration_LeadershipTransfer (0.16s)
627s === RUN   TestIntegration_LeadershipTransfer_Tx
627s     func.go:15: DEBUG: attempt 1: server @1: connected
627s     func.go:15: DEBUG: leadership lost (10250 - not leader)
627s     func.go:15: DEBUG: attempt 1: server @1: connect to reported leader @2
627s     func.go:15: DEBUG: attempt 1: server @1: connected
627s --- PASS: TestIntegration_LeadershipTransfer_Tx (0.17s)
627s === RUN   TestOptions
627s --- PASS: TestOptions (0.00s)
627s === RUN   TestIntegration_ColumnTypeName
627s     func.go:15: DEBUG: attempt 1: server @1: connected
627s --- PASS: TestIntegration_ColumnTypeName (0.06s)
627s === RUN   TestIntegration_SqlNullTime
627s     func.go:15: DEBUG: attempt 1: server @1: connected
628s --- PASS: TestIntegration_SqlNullTime (0.06s)
628s PASS
628s ok  	github.com/canonical/go-dqlite/driver	13.503s
628s === RUN   TestNode_Create
628s --- PASS: TestNode_Create (0.03s)
628s === RUN   TestNode_Start
628s --- PASS: TestNode_Start (0.04s)
628s === RUN   TestNode_Restart
629s --- PASS: TestNode_Restart (0.06s)
629s === RUN   TestNode_Start_Inet
629s --- PASS: TestNode_Start_Inet (0.02s)
629s === RUN   TestNode_Leader
629s --- PASS: TestNode_Leader (0.04s)
629s === RUN   TestNode_Autorecovery
629s --- PASS: TestNode_Autorecovery (0.02s)
629s PASS
629s ok  	github.com/canonical/go-dqlite/internal/bindings	0.225s
632s === RUN   TestMessage_StaticBytesAlignment
632s --- PASS: TestMessage_StaticBytesAlignment (0.00s)
632s === RUN   TestMessage_putBlob
632s === RUN   TestMessage_putBlob/16
632s === RUN   TestMessage_putBlob/16#01
632s === RUN   TestMessage_putBlob/24
632s --- PASS: TestMessage_putBlob (0.00s)
632s     --- PASS: TestMessage_putBlob/16 (0.00s)
632s     --- PASS: TestMessage_putBlob/16#01 (0.00s)
632s     --- PASS: TestMessage_putBlob/24 (0.00s)
632s === RUN   TestMessage_putString
632s === RUN   TestMessage_putString/hello
632s === RUN   TestMessage_putString/hello!!
632s === RUN   TestMessage_putString/hello_world
632s --- PASS: TestMessage_putString (0.00s)
632s     --- PASS: TestMessage_putString/hello (0.00s)
632s     --- PASS: TestMessage_putString/hello!! (0.00s)
632s     --- PASS: TestMessage_putString/hello_world (0.00s)
632s === RUN   TestMessage_putUint8
632s --- PASS: TestMessage_putUint8 (0.00s)
632s === RUN   TestMessage_putUint16
632s --- PASS: TestMessage_putUint16 (0.00s)
632s === RUN   TestMessage_putUint32
632s --- PASS: TestMessage_putUint32 (0.00s)
632s === RUN   TestMessage_putUint64
632s --- PASS: TestMessage_putUint64 (0.00s)
632s === RUN   TestMessage_putNamedValues
632s --- PASS: TestMessage_putNamedValues (0.00s)
632s === RUN   TestMessage_putNamedValues32
632s --- PASS: TestMessage_putNamedValues32 (0.00s)
632s === RUN   TestMessage_putHeader
632s --- PASS: TestMessage_putHeader (0.00s)
632s === RUN   TestMessage_getString
632s === RUN   TestMessage_getString/hello
632s === RUN   TestMessage_getString/hello!!
632s === RUN   TestMessage_getString/hello!!!
632s === RUN   TestMessage_getString/hello_world
632s --- PASS: TestMessage_getString (0.00s)
632s     --- PASS: TestMessage_getString/hello (0.00s)
632s     --- PASS: TestMessage_getString/hello!! (0.00s)
632s     --- PASS: TestMessage_getString/hello!!! (0.00s)
632s     --- PASS: TestMessage_getString/hello_world (0.00s)
632s === RUN   TestMessage_getBlob
632s === RUN   TestMessage_getBlob/16
632s === RUN   TestMessage_getBlob/16#01
632s === RUN   TestMessage_getBlob/24
632s --- PASS: TestMessage_getBlob (0.00s)
632s     --- PASS: TestMessage_getBlob/16 (0.00s)
632s     --- PASS: TestMessage_getBlob/16#01 (0.00s)
632s     --- PASS: TestMessage_getBlob/24 (0.00s)
632s === RUN   TestMessage_getString_Overflow_WordBoundary
632s --- PASS: TestMessage_getString_Overflow_WordBoundary (0.00s)
632s === RUN   TestConnector_Success
632s     connector_test.go:304: DEBUG: attempt 1: server @test-0: connected
632s --- PASS: TestConnector_Success (0.03s)
632s === RUN   TestConnector_LimitRetries
632s     connector_test.go:304: WARN: attempt 1: server @test-123: dial: dial unix @test-123: connect: connection refused
633s     connector_test.go:304: WARN: attempt 2: server @test-123: dial: dial unix @test-123: connect: connection refused
633s     connector_test.go:304: WARN: attempt 3: server @test-123: dial: dial unix @test-123: connect: connection refused
633s --- PASS: TestConnector_LimitRetries (0.60s)
633s === RUN   TestConnector_DialTimeout
633s     connector_test.go:64: Skipping network test
633s --- SKIP: TestConnector_DialTimeout (0.00s)
633s === RUN   TestConnector_EmptyNodeStore
633s --- PASS: TestConnector_EmptyNodeStore (0.20s)
633s === RUN   TestConnector_ContextCanceled
633s     connector_test.go:99: Skipping network test
633s --- SKIP: TestConnector_ContextCanceled (0.00s)
633s === RUN   TestConnector_AttemptTimeout
633s     func.go:15: WARN: attempt 1: server @1234: call leader (budget 99.889599ms): receive: header: read unix @->@1234: i/o timeout
634s     func.go:15: WARN: attempt 2: server @1234: call leader (budget 99.797625ms): receive: header: read unix @->@1234: i/o timeout
634s --- PASS: TestConnector_AttemptTimeout (0.40s)
634s === RUN   TestProtocol_RequestWithDynamicBuffer
634s     func.go:15: DEBUG: attempt 1: server @test-0: connected
634s --- PASS: TestProtocol_RequestWithDynamicBuffer (0.06s)
634s === RUN   TestProtocol_Prepare
634s     func.go:15: DEBUG: attempt 1: server @test-0: connected
634s --- PASS: TestProtocol_Prepare (0.03s)
634s PASS
634s ok  	github.com/canonical/go-dqlite/internal/protocol	1.344s
634s ?   	github.com/canonical/go-dqlite/internal/shell	[no test files]
635s === RUN   Test_TestFunc
635s     func.go:15: INFO: hello
635s --- PASS: Test_TestFunc (0.00s)
635s === RUN   TestLevel_String
635s --- PASS: TestLevel_String (0.00s)
635s PASS
635s ok  	github.com/canonical/go-dqlite/logging	0.006s
635s ?   	github.com/canonical/go-dqlite/tracing	[no test files]
635s autopkgtest [18:34:51]: test dh-golang-autopkgtest: -----------------------]
636s autopkgtest [18:34:52]: test dh-golang-autopkgtest:  - - - - - - - - - - results - - - - - - - - - -
636s dh-golang-autopkgtest PASS
637s autopkgtest [18:34:53]: @@@@@@@@@@@@@@@@@@@@ summary
637s dh-golang-autopkgtest PASS
674s Creating nova instance adt-noble-arm64-golang-github-canonical-go-dqlite-20240319-182416-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-arm64-server-20240319.img (UUID bd25b89b-8264-4402-95d9-d9c88f21f275)...