https://launchpad.net/ubuntu/+archive/test-rebuild-20211217-jammy-glibc/+build/22879446 RUN: /usr/share/launchpad-buildd/bin/builder-prep Kernel version: Linux lgw01-amd64-004 4.15.0-166-generic #174-Ubuntu SMP Wed Dec 8 19:07:44 UTC 2021 x86_64 Buildd toolchain package versions: launchpad-buildd_205~511~ubuntu18.04.1 python3-lpbuildd_205~511~ubuntu18.04.1 sbuild_0.75.0-1ubuntu1 bzr-builder_0.7.3+bzr174~ppa13~ubuntu16.04.1 bzr_2.7.0+bzr6622-10 git-build-recipe_0.3.6~git201906051340.ff11471~ubuntu18.04.1 git_1:2.17.1-1ubuntu0.9 dpkg-dev_1.19.0.5ubuntu2.3 python-debian_0.1.32 python3-debian_0.1.32. Syncing the system clock with the buildd NTP service... 11 Jan 01:45:50 ntpdate[1714]: adjust time server 10.211.37.1 offset -0.000022 sec RUN: /usr/share/launchpad-buildd/bin/in-target unpack-chroot --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 --image-type chroot /home/buildd/filecache-default/b0c128df17a460089eca69348f06144377489985 Creating target for build PACKAGEBUILD-22879446 RUN: /usr/share/launchpad-buildd/bin/in-target mount-chroot --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 Starting target for build PACKAGEBUILD-22879446 RUN: /usr/share/launchpad-buildd/bin/in-target override-sources-list --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 'deb http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy main' 'deb http://ftpmaster.internal/ubuntu jammy main restricted universe multiverse' Overriding sources.list in build-PACKAGEBUILD-22879446 RUN: /usr/share/launchpad-buildd/bin/in-target add-trusted-keys --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 Adding trusted keys to build-PACKAGEBUILD-22879446 Warning: apt-key is deprecated. Manage keyring files in trusted.gpg.d instead (see apt-key(8)). OK Warning: apt-key is deprecated. Manage keyring files in trusted.gpg.d instead (see apt-key(8)). /etc/apt/trusted.gpg -------------------- pub rsa1024 2009-10-22 [SC] 60C3 1780 3A41 BA51 845E 371A 1E93 77A2 BA9E F27F uid [ unknown] Launchpad Toolchain builds /etc/apt/trusted.gpg.d/ubuntu-keyring-2012-cdimage.gpg ------------------------------------------------------ pub rsa4096 2012-05-11 [SC] 8439 38DF 228D 22F7 B374 2BC0 D94A A3F0 EFE2 1092 uid [ unknown] Ubuntu CD Image Automatic Signing Key (2012) /etc/apt/trusted.gpg.d/ubuntu-keyring-2018-archive.gpg ------------------------------------------------------ pub rsa4096 2018-09-17 [SC] F6EC B376 2474 EDA9 D21B 7022 8719 20D1 991B C93C uid [ unknown] Ubuntu Archive Automatic Signing Key (2018) RUN: /usr/share/launchpad-buildd/bin/in-target update-debian-chroot --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 Updating target for build PACKAGEBUILD-22879446 Get:1 http://ftpmaster.internal/ubuntu jammy InRelease [270 kB] Get:2 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy InRelease [17.5 kB] Get:3 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main amd64 Packages [9920 B] Get:4 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main Translation-en [2136 B] Get:5 http://ftpmaster.internal/ubuntu jammy/main amd64 Packages [1407 kB] Get:6 http://ftpmaster.internal/ubuntu jammy/main Translation-en [514 kB] Get:7 http://ftpmaster.internal/ubuntu jammy/restricted amd64 Packages [93.8 kB] Get:8 http://ftpmaster.internal/ubuntu jammy/restricted Translation-en [13.3 kB] Get:9 http://ftpmaster.internal/ubuntu jammy/universe amd64 Packages [13.8 MB] Get:10 http://ftpmaster.internal/ubuntu jammy/universe Translation-en [5593 kB] Get:11 http://ftpmaster.internal/ubuntu jammy/multiverse amd64 Packages [216 kB] Get:12 http://ftpmaster.internal/ubuntu jammy/multiverse Translation-en [111 kB] Fetched 22.0 MB in 4s (6184 kB/s) Reading package lists... Reading package lists... Building dependency tree... Reading state information... Calculating upgrade... The following package was automatically installed and is no longer required: libssl1.1 Use 'sudo apt autoremove' to remove it. The following packages will be REMOVED: libsemanage1* The following NEW packages will be installed: libsemanage2 libsepol2 libssl3 The following packages will be upgraded: apt base-files bash binutils binutils-common binutils-x86-64-linux-gnu bsdutils bzip2 ca-certificates cpp-11 dash debconf debianutils dpkg dpkg-dev e2fsprogs g++-11 gcc-11 gcc-11-base gpg gpg-agent gpgconf gpgv grep init init-system-helpers libapparmor1 libapt-pkg6.0 libasan6 libatomic1 libattr1 libbinutils libblkid1 libbz2-1.0 libc-bin libc-dev-bin libc6 libc6-dev libcc1-0 libcom-err2 libcrypt-dev libcrypt1 libcryptsetup12 libctf-nobfd0 libctf0 libdpkg-perl libext2fs2 libgcc-11-dev libgcc-s1 libgcrypt20 libgdbm-compat4 libgdbm6 libgnutls30 libgomp1 libgpg-error0 libgssapi-krb5-2 libidn2-0 libip4tc2 libisl23 libitm1 libk5crypto3 libkmod2 libkrb5-3 libkrb5support0 liblsan0 libmount1 libmpc3 libncurses6 libncursesw6 libp11-kit0 libpam-modules libpam-modules-bin libpam-runtime libpam0g libpcre2-8-0 libquadmath0 libreadline8 libseccomp2 libselinux1 libsemanage-common libsmartcols1 libsqlite3-0 libss2 libstdc++-11-dev libstdc++6 libsystemd0 libtasn1-6 libtinfo6 libtsan0 libubsan1 libudev1 libuuid1 libzstd1 lockfile-progs login logsave lto-disabled-list make mount ncurses-base ncurses-bin openssl passwd pkgbinarymangler readline-common sed sensible-utils systemd systemd-sysv systemd-timesyncd tzdata usrmerge util-linux 113 upgraded, 3 newly installed, 1 to remove and 0 not upgraded. Need to get 88.9 MB of archives. After this operation, 355 MB disk space will be freed. Get:1 http://ftpmaster.internal/ubuntu jammy/main amd64 libcrypt-dev amd64 1:4.4.27-1 [112 kB] Get:2 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main amd64 libc6-dev amd64 2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 [1896 kB] Get:3 http://ftpmaster.internal/ubuntu jammy/main amd64 debconf all 1.5.79 [126 kB] Get:4 http://ftpmaster.internal/ubuntu jammy/main amd64 libpam0g amd64 1.4.0-10ubuntu2 [61.5 kB] Get:5 http://ftpmaster.internal/ubuntu jammy/main amd64 libcrypt1 amd64 1:4.4.27-1 [82.0 kB] Get:6 http://ftpmaster.internal/ubuntu jammy/main amd64 libcc1-0 amd64 11.2.0-13ubuntu1 [53.9 kB] Get:7 http://ftpmaster.internal/ubuntu jammy/main amd64 gcc-11-base amd64 11.2.0-13ubuntu1 [21.1 kB] Get:8 http://ftpmaster.internal/ubuntu jammy/main amd64 libgcc-s1 amd64 11.2.0-13ubuntu1 [45.5 kB] Get:9 http://ftpmaster.internal/ubuntu jammy/main amd64 libgomp1 amd64 11.2.0-13ubuntu1 [117 kB] Get:10 http://ftpmaster.internal/ubuntu jammy/main amd64 libitm1 amd64 11.2.0-13ubuntu1 [30.0 kB] Get:11 http://ftpmaster.internal/ubuntu jammy/main amd64 libatomic1 amd64 11.2.0-13ubuntu1 [9892 B] Get:12 http://ftpmaster.internal/ubuntu jammy/main amd64 libasan6 amd64 11.2.0-13ubuntu1 [2281 kB] Get:13 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main amd64 libc-dev-bin amd64 2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 [20.3 kB] Get:14 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main amd64 libc6 amd64 2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 [3037 kB] Get:15 http://ppa.launchpad.net/ubuntu-toolchain-r/glibc/ubuntu jammy/main amd64 libc-bin amd64 2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 [702 kB] Get:16 http://ftpmaster.internal/ubuntu jammy/main amd64 liblsan0 amd64 11.2.0-13ubuntu1 [976 kB] Get:17 http://ftpmaster.internal/ubuntu jammy/main amd64 libtsan0 amd64 11.2.0-13ubuntu1 [2260 kB] Get:18 http://ftpmaster.internal/ubuntu jammy/main amd64 libubsan1 amd64 11.2.0-13ubuntu1 [921 kB] Get:19 http://ftpmaster.internal/ubuntu jammy/main amd64 libquadmath0 amd64 11.2.0-13ubuntu1 [154 kB] Get:20 http://ftpmaster.internal/ubuntu jammy/main amd64 g++-11 amd64 11.2.0-13ubuntu1 [11.4 MB] Get:21 http://ftpmaster.internal/ubuntu jammy/main amd64 libstdc++-11-dev amd64 11.2.0-13ubuntu1 [2103 kB] Get:22 http://ftpmaster.internal/ubuntu jammy/main amd64 libgcc-11-dev amd64 11.2.0-13ubuntu1 [2527 kB] Get:23 http://ftpmaster.internal/ubuntu jammy/main amd64 gcc-11 amd64 11.2.0-13ubuntu1 [20.1 MB] Get:24 http://ftpmaster.internal/ubuntu jammy/main amd64 cpp-11 amd64 11.2.0-13ubuntu1 [9960 kB] Get:25 http://ftpmaster.internal/ubuntu jammy/main amd64 libstdc++6 amd64 11.2.0-13ubuntu1 [652 kB] Get:26 http://ftpmaster.internal/ubuntu jammy/main amd64 libisl23 amd64 0.24-2 [728 kB] Get:27 http://ftpmaster.internal/ubuntu jammy/main amd64 libmpc3 amd64 1.2.1-1 [46.9 kB] Get:28 http://ftpmaster.internal/ubuntu jammy/main amd64 libzstd1 amd64 1.4.8+dfsg-3 [324 kB] Get:29 http://ftpmaster.internal/ubuntu jammy/main amd64 libctf0 amd64 2.37-10ubuntu1 [103 kB] Get:30 http://ftpmaster.internal/ubuntu jammy/main amd64 libctf-nobfd0 amd64 2.37-10ubuntu1 [106 kB] Get:31 http://ftpmaster.internal/ubuntu jammy/main amd64 libbinutils amd64 2.37-10ubuntu1 [653 kB] Get:32 http://ftpmaster.internal/ubuntu jammy/main amd64 binutils-common amd64 2.37-10ubuntu1 [213 kB] Get:33 http://ftpmaster.internal/ubuntu jammy/main amd64 binutils amd64 2.37-10ubuntu1 [3192 B] Get:34 http://ftpmaster.internal/ubuntu jammy/main amd64 binutils-x86-64-linux-gnu amd64 2.37-10ubuntu1 [2314 kB] Get:35 http://ftpmaster.internal/ubuntu jammy/main amd64 base-files amd64 12ubuntu2 [63.3 kB] Get:36 http://ftpmaster.internal/ubuntu jammy/main amd64 debianutils amd64 5.5-1ubuntu1 [107 kB] Get:37 http://ftpmaster.internal/ubuntu jammy/main amd64 bash amd64 5.1-6ubuntu1 [769 kB] Get:38 http://ftpmaster.internal/ubuntu jammy/main amd64 bsdutils amd64 1:2.37.2-4ubuntu1 [80.9 kB] Get:39 http://ftpmaster.internal/ubuntu jammy/main amd64 libgpg-error0 amd64 1.43-1 [69.6 kB] Get:40 http://ftpmaster.internal/ubuntu jammy/main amd64 libgcrypt20 amd64 1.9.4-3ubuntu2 [515 kB] Get:41 http://ftpmaster.internal/ubuntu jammy/main amd64 bzip2 amd64 1.0.8-5 [34.8 kB] Get:42 http://ftpmaster.internal/ubuntu jammy/main amd64 libbz2-1.0 amd64 1.0.8-5 [34.5 kB] Get:43 http://ftpmaster.internal/ubuntu jammy/main amd64 libssl3 amd64 3.0.0-1ubuntu1 [1896 kB] Get:44 http://ftpmaster.internal/ubuntu jammy/main amd64 libblkid1 amd64 2.37.2-4ubuntu1 [103 kB] Get:45 http://ftpmaster.internal/ubuntu jammy/main amd64 libuuid1 amd64 2.37.2-4ubuntu1 [23.8 kB] Get:46 http://ftpmaster.internal/ubuntu jammy/main amd64 libcryptsetup12 amd64 2:2.4.2-1ubuntu4 [208 kB] Get:47 http://ftpmaster.internal/ubuntu jammy/main amd64 libidn2-0 amd64 2.3.2-2 [66.5 kB] Get:48 http://ftpmaster.internal/ubuntu jammy/main amd64 libp11-kit0 amd64 0.24.0-6 [252 kB] Get:49 http://ftpmaster.internal/ubuntu jammy/main amd64 libtasn1-6 amd64 4.18.0-4 [42.9 kB] Get:50 http://ftpmaster.internal/ubuntu jammy/main amd64 libgnutls30 amd64 3.7.2-4ubuntu1 [956 kB] Get:51 http://ftpmaster.internal/ubuntu jammy/main amd64 systemd-sysv amd64 249.5-2ubuntu3 [10.5 kB] Get:52 http://ftpmaster.internal/ubuntu jammy/main amd64 systemd-timesyncd amd64 249.5-2ubuntu3 [30.9 kB] Get:53 http://ftpmaster.internal/ubuntu jammy/main amd64 libapparmor1 amd64 3.0.3-0ubuntu5 [38.0 kB] Get:54 http://ftpmaster.internal/ubuntu jammy/main amd64 libip4tc2 amd64 1.8.7-1ubuntu4 [19.8 kB] Get:55 http://ftpmaster.internal/ubuntu jammy/main amd64 libkmod2 amd64 28-1ubuntu5 [48.0 kB] Get:56 http://ftpmaster.internal/ubuntu jammy/main amd64 libpcre2-8-0 amd64 10.39-3 [220 kB] Get:57 http://ftpmaster.internal/ubuntu jammy/main amd64 libselinux1 amd64 3.3-1 [74.6 kB] Get:58 http://ftpmaster.internal/ubuntu jammy/main amd64 libmount1 amd64 2.37.2-4ubuntu1 [122 kB] Get:59 http://ftpmaster.internal/ubuntu jammy/main amd64 libseccomp2 amd64 2.5.2-2ubuntu2 [48.3 kB] Get:60 http://ftpmaster.internal/ubuntu jammy/main amd64 login amd64 1:4.8.1-2ubuntu1 [188 kB] Get:61 http://ftpmaster.internal/ubuntu jammy/main amd64 util-linux amd64 2.37.2-4ubuntu1 [1063 kB] Get:62 http://ftpmaster.internal/ubuntu jammy/main amd64 mount amd64 2.37.2-4ubuntu1 [114 kB] Get:63 http://ftpmaster.internal/ubuntu jammy/main amd64 systemd amd64 249.5-2ubuntu3 [4542 kB] Get:64 http://ftpmaster.internal/ubuntu jammy/main amd64 libsystemd0 amd64 249.5-2ubuntu3 [318 kB] Get:65 http://ftpmaster.internal/ubuntu jammy/main amd64 libudev1 amd64 249.5-2ubuntu3 [77.9 kB] Get:66 http://ftpmaster.internal/ubuntu jammy/main amd64 libapt-pkg6.0 amd64 2.3.14 [905 kB] Get:67 http://ftpmaster.internal/ubuntu jammy/main amd64 dpkg amd64 1.20.9ubuntu3 [1266 kB] Get:68 http://ftpmaster.internal/ubuntu jammy/main amd64 dash amd64 0.5.11+git20210903+057cd650a4ed-3 [91.8 kB] Get:69 http://ftpmaster.internal/ubuntu jammy/main amd64 grep amd64 3.7-1 [156 kB] Get:70 http://ftpmaster.internal/ubuntu jammy/main amd64 libncurses6 amd64 6.3-1 [111 kB] Get:71 http://ftpmaster.internal/ubuntu jammy/main amd64 libncursesw6 amd64 6.3-1 [147 kB] Get:72 http://ftpmaster.internal/ubuntu jammy/main amd64 libtinfo6 amd64 6.3-1 [104 kB] Get:73 http://ftpmaster.internal/ubuntu jammy/main amd64 ncurses-bin amd64 6.3-1 [184 kB] Get:74 http://ftpmaster.internal/ubuntu jammy/main amd64 sed amd64 4.8-1ubuntu1 [188 kB] Get:75 http://ftpmaster.internal/ubuntu jammy/main amd64 init-system-helpers all 1.61 [39.3 kB] Get:76 http://ftpmaster.internal/ubuntu jammy/main amd64 ncurses-base all 6.3-1 [19.9 kB] Get:77 http://ftpmaster.internal/ubuntu jammy/main amd64 gpgv amd64 2.2.27-3ubuntu1 [137 kB] Get:78 http://ftpmaster.internal/ubuntu jammy/main amd64 apt amd64 2.3.14 [1387 kB] Get:79 http://ftpmaster.internal/ubuntu jammy/main amd64 libsepol2 amd64 3.3-1 [281 kB] Get:80 http://ftpmaster.internal/ubuntu jammy/main amd64 libsemanage-common all 3.3-1 [10.1 kB] Get:81 http://ftpmaster.internal/ubuntu jammy/main amd64 libsemanage2 amd64 3.3-1 [92.5 kB] Get:82 http://ftpmaster.internal/ubuntu jammy/main amd64 passwd amd64 1:4.8.1-2ubuntu1 [765 kB] Get:83 http://ftpmaster.internal/ubuntu jammy/main amd64 libpam-modules-bin amd64 1.4.0-10ubuntu2 [37.6 kB] Get:84 http://ftpmaster.internal/ubuntu jammy/main amd64 libpam-modules amd64 1.4.0-10ubuntu2 [280 kB] Get:85 http://ftpmaster.internal/ubuntu jammy/main amd64 logsave amd64 1.46.5-1ubuntu1 [10.9 kB] Get:86 http://ftpmaster.internal/ubuntu jammy/main amd64 libext2fs2 amd64 1.46.5-1ubuntu1 [209 kB] Get:87 http://ftpmaster.internal/ubuntu jammy/main amd64 e2fsprogs amd64 1.46.5-1ubuntu1 [590 kB] Get:88 http://ftpmaster.internal/ubuntu jammy/main amd64 init amd64 1.61 [6102 B] Get:89 http://ftpmaster.internal/ubuntu jammy/main amd64 libattr1 amd64 1:2.5.1-1 [13.3 kB] Get:90 http://ftpmaster.internal/ubuntu jammy/main amd64 libcom-err2 amd64 1.46.5-1ubuntu1 [10.0 kB] Get:91 http://ftpmaster.internal/ubuntu jammy/main amd64 libk5crypto3 amd64 1.19.2-0ubuntu1 [86.3 kB] Get:92 http://ftpmaster.internal/ubuntu jammy/main amd64 libkrb5support0 amd64 1.19.2-0ubuntu1 [32.4 kB] Get:93 http://ftpmaster.internal/ubuntu jammy/main amd64 libkrb5-3 amd64 1.19.2-0ubuntu1 [356 kB] Get:94 http://ftpmaster.internal/ubuntu jammy/main amd64 libgssapi-krb5-2 amd64 1.19.2-0ubuntu1 [144 kB] Get:95 http://ftpmaster.internal/ubuntu jammy/main amd64 libpam-runtime all 1.4.0-10ubuntu2 [40.2 kB] Get:96 http://ftpmaster.internal/ubuntu jammy/main amd64 libsmartcols1 amd64 2.37.2-4ubuntu1 [50.9 kB] Get:97 http://ftpmaster.internal/ubuntu jammy/main amd64 libss2 amd64 1.46.5-1ubuntu1 [12.3 kB] Get:98 http://ftpmaster.internal/ubuntu jammy/main amd64 sensible-utils all 0.0.17 [20.1 kB] Get:99 http://ftpmaster.internal/ubuntu jammy/main amd64 usrmerge all 25ubuntu2 [54.7 kB] Get:100 http://ftpmaster.internal/ubuntu jammy/main amd64 openssl amd64 3.0.0-1ubuntu1 [1180 kB] Get:101 http://ftpmaster.internal/ubuntu jammy/main amd64 ca-certificates all 20211016 [148 kB] Get:102 http://ftpmaster.internal/ubuntu jammy/main amd64 readline-common all 8.1.2-1 [53.5 kB] Get:103 http://ftpmaster.internal/ubuntu jammy/main amd64 libreadline8 amd64 8.1.2-1 [153 kB] Get:104 http://ftpmaster.internal/ubuntu jammy/main amd64 libsqlite3-0 amd64 3.36.0-2 [641 kB] Get:105 http://ftpmaster.internal/ubuntu jammy/main amd64 tzdata all 2021e-1ubuntu1 [343 kB] Get:106 http://ftpmaster.internal/ubuntu jammy/main amd64 libgdbm6 amd64 1.22-1 [35.2 kB] Get:107 http://ftpmaster.internal/ubuntu jammy/main amd64 dpkg-dev all 1.20.9ubuntu3 [933 kB] Get:108 http://ftpmaster.internal/ubuntu jammy/main amd64 libdpkg-perl all 1.20.9ubuntu3 [235 kB] Get:109 http://ftpmaster.internal/ubuntu jammy/main amd64 make amd64 4.3-4ubuntu2 [179 kB] Get:110 http://ftpmaster.internal/ubuntu jammy/main amd64 lto-disabled-list all 18 [12.2 kB] Get:111 http://ftpmaster.internal/ubuntu jammy/main amd64 gpg amd64 2.2.27-3ubuntu1 [517 kB] Get:112 http://ftpmaster.internal/ubuntu jammy/main amd64 gpgconf amd64 2.2.27-3ubuntu1 [94.4 kB] Get:113 http://ftpmaster.internal/ubuntu jammy/main amd64 gpg-agent amd64 2.2.27-3ubuntu1 [209 kB] Get:114 http://ftpmaster.internal/ubuntu jammy/main amd64 libgdbm-compat4 amd64 1.22-1 [6450 B] Get:115 http://ftpmaster.internal/ubuntu jammy/main amd64 lockfile-progs amd64 0.1.19 [10.0 kB] Get:116 http://ftpmaster.internal/ubuntu jammy/main amd64 pkgbinarymangler all 149 [32.4 kB] debconf: delaying package configuration, since apt-utils is not installed Fetched 88.9 MB in 2s (37.1 MB/s) (Reading database ... 13258 files and directories currently installed.) Preparing to unpack .../libcrypt-dev_1%3a4.4.27-1_amd64.deb ... Unpacking libcrypt-dev:amd64 (1:4.4.27-1) over (1:4.4.18-4ubuntu2) ... Preparing to unpack .../libc6-dev_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2_amd64.deb ... Unpacking libc6-dev:amd64 (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) over (2.34-0ubuntu3) ... Preparing to unpack .../libc-dev-bin_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2_amd64.deb ... Unpacking libc-dev-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) over (2.34-0ubuntu3) ... Preparing to unpack .../debconf_1.5.79_all.deb ... Unpacking debconf (1.5.79) over (1.5.77) ... Setting up debconf (1.5.79) ... (Reading database ... 13261 files and directories currently installed.) Preparing to unpack .../libpam0g_1.4.0-10ubuntu2_amd64.deb ... Unpacking libpam0g:amd64 (1.4.0-10ubuntu2) over (1.3.1-5ubuntu11) ... Setting up libpam0g:amd64 (1.4.0-10ubuntu2) ... Checking for services that may need to be restarted...Checking init scripts... Nothing to restart. (Reading database ... 13261 files and directories currently installed.) Preparing to unpack .../libcrypt1_1%3a4.4.27-1_amd64.deb ... Unpacking libcrypt1:amd64 (1:4.4.27-1) over (1:4.4.18-4ubuntu2) ... Setting up libcrypt1:amd64 (1:4.4.27-1) ... (Reading database ... 13261 files and directories currently installed.) Preparing to unpack .../libcc1-0_11.2.0-13ubuntu1_amd64.deb ... Unpacking libcc1-0:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../gcc-11-base_11.2.0-13ubuntu1_amd64.deb ... Unpacking gcc-11-base:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Setting up gcc-11-base:amd64 (11.2.0-13ubuntu1) ... (Reading database ... 13261 files and directories currently installed.) Preparing to unpack .../libgcc-s1_11.2.0-13ubuntu1_amd64.deb ... Unpacking libgcc-s1:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Setting up libgcc-s1:amd64 (11.2.0-13ubuntu1) ... (Reading database ... 13261 files and directories currently installed.) Preparing to unpack .../00-libgomp1_11.2.0-13ubuntu1_amd64.deb ... Unpacking libgomp1:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../01-libitm1_11.2.0-13ubuntu1_amd64.deb ... Unpacking libitm1:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../02-libatomic1_11.2.0-13ubuntu1_amd64.deb ... Unpacking libatomic1:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../03-libasan6_11.2.0-13ubuntu1_amd64.deb ... Unpacking libasan6:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../04-liblsan0_11.2.0-13ubuntu1_amd64.deb ... Unpacking liblsan0:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../05-libtsan0_11.2.0-13ubuntu1_amd64.deb ... Unpacking libtsan0:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../06-libubsan1_11.2.0-13ubuntu1_amd64.deb ... Unpacking libubsan1:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../07-libquadmath0_11.2.0-13ubuntu1_amd64.deb ... Unpacking libquadmath0:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../08-g++-11_11.2.0-13ubuntu1_amd64.deb ... Unpacking g++-11 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../09-libstdc++-11-dev_11.2.0-13ubuntu1_amd64.deb ... Unpacking libstdc++-11-dev:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../10-libgcc-11-dev_11.2.0-13ubuntu1_amd64.deb ... Unpacking libgcc-11-dev:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../11-gcc-11_11.2.0-13ubuntu1_amd64.deb ... Unpacking gcc-11 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../12-cpp-11_11.2.0-13ubuntu1_amd64.deb ... Unpacking cpp-11 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Preparing to unpack .../13-libstdc++6_11.2.0-13ubuntu1_amd64.deb ... Unpacking libstdc++6:amd64 (11.2.0-13ubuntu1) over (11.2.0-7ubuntu2) ... Setting up libstdc++6:amd64 (11.2.0-13ubuntu1) ... (Reading database ... 13263 files and directories currently installed.) Preparing to unpack .../libisl23_0.24-2_amd64.deb ... Unpacking libisl23:amd64 (0.24-2) over (0.24-1build1) ... Preparing to unpack .../libmpc3_1.2.1-1_amd64.deb ... Unpacking libmpc3:amd64 (1.2.1-1) over (1.2.0-1build2) ... Preparing to unpack .../libzstd1_1.4.8+dfsg-3_amd64.deb ... Unpacking libzstd1:amd64 (1.4.8+dfsg-3) over (1.4.8+dfsg-2.1build1) ... Setting up libzstd1:amd64 (1.4.8+dfsg-3) ... (Reading database ... 13263 files and directories currently installed.) Preparing to unpack .../0-libctf0_2.37-10ubuntu1_amd64.deb ... Unpacking libctf0:amd64 (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../1-libctf-nobfd0_2.37-10ubuntu1_amd64.deb ... Unpacking libctf-nobfd0:amd64 (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../2-libbinutils_2.37-10ubuntu1_amd64.deb ... Unpacking libbinutils:amd64 (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../3-binutils-common_2.37-10ubuntu1_amd64.deb ... Unpacking binutils-common:amd64 (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../4-binutils_2.37-10ubuntu1_amd64.deb ... Unpacking binutils (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../5-binutils-x86-64-linux-gnu_2.37-10ubuntu1_amd64.deb ... Unpacking binutils-x86-64-linux-gnu (2.37-10ubuntu1) over (2.37-7ubuntu1) ... Preparing to unpack .../6-libc6_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2_amd64.deb ... Unpacking libc6:amd64 (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) over (2.34-0ubuntu3) ... Setting up libc6:amd64 (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... (Reading database ... 13263 files and directories currently installed.) Preparing to unpack .../base-files_12ubuntu2_amd64.deb ... Unpacking base-files (12ubuntu2) over (12ubuntu1) ... Setting up base-files (12ubuntu2) ... (Reading database ... 13263 files and directories currently installed.) Preparing to unpack .../debianutils_5.5-1ubuntu1_amd64.deb ... Unpacking debianutils (5.5-1ubuntu1) over (4.11.2build1) ... Setting up debianutils (5.5-1ubuntu1) ... update-alternatives: using /usr/bin/which.debianutils to provide /usr/bin/which (which) in auto mode (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../bash_5.1-6ubuntu1_amd64.deb ... Unpacking bash (5.1-6ubuntu1) over (5.1-3ubuntu2) ... Setting up bash (5.1-6ubuntu1) ... update-alternatives: using /usr/share/man/man7/bash-builtins.7.gz to provide /usr/share/man/man7/builtins.7.gz (builtins.7.gz) in auto mode (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../bsdutils_1%3a2.37.2-4ubuntu1_amd64.deb ... Unpacking bsdutils (1:2.37.2-4ubuntu1) over (1:2.36.1-8ubuntu1) ... Setting up bsdutils (1:2.37.2-4ubuntu1) ... (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../libgpg-error0_1.43-1_amd64.deb ... Unpacking libgpg-error0:amd64 (1.43-1) over (1.38-2build2) ... Setting up libgpg-error0:amd64 (1.43-1) ... (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../libgcrypt20_1.9.4-3ubuntu2_amd64.deb ... Unpacking libgcrypt20:amd64 (1.9.4-3ubuntu2) over (1.8.7-5ubuntu2) ... Setting up libgcrypt20:amd64 (1.9.4-3ubuntu2) ... (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../bzip2_1.0.8-5_amd64.deb ... Unpacking bzip2 (1.0.8-5) over (1.0.8-4ubuntu4) ... Preparing to unpack .../libbz2-1.0_1.0.8-5_amd64.deb ... Unpacking libbz2-1.0:amd64 (1.0.8-5) over (1.0.8-4ubuntu4) ... Setting up libbz2-1.0:amd64 (1.0.8-5) ... Selecting previously unselected package libssl3:amd64. (Reading database ... 13267 files and directories currently installed.) Preparing to unpack .../libssl3_3.0.0-1ubuntu1_amd64.deb ... Unpacking libssl3:amd64 (3.0.0-1ubuntu1) ... Setting up libssl3:amd64 (3.0.0-1ubuntu1) ... (Reading database ... 13278 files and directories currently installed.) Preparing to unpack .../libblkid1_2.37.2-4ubuntu1_amd64.deb ... Unpacking libblkid1:amd64 (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Setting up libblkid1:amd64 (2.37.2-4ubuntu1) ... (Reading database ... 13278 files and directories currently installed.) Preparing to unpack .../libuuid1_2.37.2-4ubuntu1_amd64.deb ... Unpacking libuuid1:amd64 (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Setting up libuuid1:amd64 (2.37.2-4ubuntu1) ... (Reading database ... 13278 files and directories currently installed.) Preparing to unpack .../libcryptsetup12_2%3a2.4.2-1ubuntu4_amd64.deb ... Unpacking libcryptsetup12:amd64 (2:2.4.2-1ubuntu4) over (2:2.3.6-0ubuntu1) ... Preparing to unpack .../libidn2-0_2.3.2-2_amd64.deb ... Unpacking libidn2-0:amd64 (2.3.2-2) over (2.3.1-1build1) ... Setting up libidn2-0:amd64 (2.3.2-2) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libp11-kit0_0.24.0-6_amd64.deb ... Unpacking libp11-kit0:amd64 (0.24.0-6) over (0.23.22-1build1) ... Setting up libp11-kit0:amd64 (0.24.0-6) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libtasn1-6_4.18.0-4_amd64.deb ... Unpacking libtasn1-6:amd64 (4.18.0-4) over (4.16.0-2build1) ... Setting up libtasn1-6:amd64 (4.18.0-4) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libgnutls30_3.7.2-4ubuntu1_amd64.deb ... Unpacking libgnutls30:amd64 (3.7.2-4ubuntu1) over (3.7.1-5ubuntu1) ... Setting up libgnutls30:amd64 (3.7.2-4ubuntu1) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../0-systemd-sysv_249.5-2ubuntu3_amd64.deb ... Unpacking systemd-sysv (249.5-2ubuntu3) over (248.3-1ubuntu8) ... Preparing to unpack .../1-systemd-timesyncd_249.5-2ubuntu3_amd64.deb ... Unpacking systemd-timesyncd (249.5-2ubuntu3) over (248.3-1ubuntu8) ... Preparing to unpack .../2-libapparmor1_3.0.3-0ubuntu5_amd64.deb ... Unpacking libapparmor1:amd64 (3.0.3-0ubuntu5) over (3.0.3-0ubuntu1) ... Preparing to unpack .../3-libip4tc2_1.8.7-1ubuntu4_amd64.deb ... Unpacking libip4tc2:amd64 (1.8.7-1ubuntu4) over (1.8.7-1ubuntu3) ... Preparing to unpack .../4-libkmod2_28-1ubuntu5_amd64.deb ... Unpacking libkmod2:amd64 (28-1ubuntu5) over (28-1ubuntu4) ... Preparing to unpack .../5-libpcre2-8-0_10.39-3_amd64.deb ... Unpacking libpcre2-8-0:amd64 (10.39-3) over (10.37-0ubuntu2) ... Setting up libpcre2-8-0:amd64 (10.39-3) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libselinux1_3.3-1_amd64.deb ... Unpacking libselinux1:amd64 (3.3-1) over (3.1-3build2) ... Setting up libselinux1:amd64 (3.3-1) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libmount1_2.37.2-4ubuntu1_amd64.deb ... Unpacking libmount1:amd64 (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Setting up libmount1:amd64 (2.37.2-4ubuntu1) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libseccomp2_2.5.2-2ubuntu2_amd64.deb ... Unpacking libseccomp2:amd64 (2.5.2-2ubuntu2) over (2.5.1-1ubuntu1) ... Setting up libseccomp2:amd64 (2.5.2-2ubuntu2) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../login_1%3a4.8.1-2ubuntu1_amd64.deb ... Unpacking login (1:4.8.1-2ubuntu1) over (1:4.8.1-1ubuntu9) ... Setting up login (1:4.8.1-2ubuntu1) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../util-linux_2.37.2-4ubuntu1_amd64.deb ... Unpacking util-linux (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Setting up util-linux (2.37.2-4ubuntu1) ... (Reading database ... 13275 files and directories currently installed.) Preparing to unpack .../mount_2.37.2-4ubuntu1_amd64.deb ... Unpacking mount (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Preparing to unpack .../systemd_249.5-2ubuntu3_amd64.deb ... Unpacking systemd (249.5-2ubuntu3) over (248.3-1ubuntu8) ... Preparing to unpack .../libsystemd0_249.5-2ubuntu3_amd64.deb ... Unpacking libsystemd0:amd64 (249.5-2ubuntu3) over (248.3-1ubuntu8) ... Setting up libsystemd0:amd64 (249.5-2ubuntu3) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../libudev1_249.5-2ubuntu3_amd64.deb ... Unpacking libudev1:amd64 (249.5-2ubuntu3) over (248.3-1ubuntu8) ... Setting up libudev1:amd64 (249.5-2ubuntu3) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../libapt-pkg6.0_2.3.14_amd64.deb ... Unpacking libapt-pkg6.0:amd64 (2.3.14) over (2.3.9) ... Setting up libapt-pkg6.0:amd64 (2.3.14) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../dpkg_1.20.9ubuntu3_amd64.deb ... Unpacking dpkg (1.20.9ubuntu3) over (1.20.9ubuntu2) ... Setting up dpkg (1.20.9ubuntu3) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../dash_0.5.11+git20210903+057cd650a4ed-3_amd64.deb ... Unpacking dash (0.5.11+git20210903+057cd650a4ed-3) over (0.5.11+git20210120+802ebd4-1build1) ... Setting up dash (0.5.11+git20210903+057cd650a4ed-3) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../archives/grep_3.7-1_amd64.deb ... Unpacking grep (3.7-1) over (3.7-0ubuntu1) ... Setting up grep (3.7-1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../libncurses6_6.3-1_amd64.deb ... Unpacking libncurses6:amd64 (6.3-1) over (6.2+20201114-2build2) ... Preparing to unpack .../libncursesw6_6.3-1_amd64.deb ... Unpacking libncursesw6:amd64 (6.3-1) over (6.2+20201114-2build2) ... Preparing to unpack .../libtinfo6_6.3-1_amd64.deb ... Unpacking libtinfo6:amd64 (6.3-1) over (6.2+20201114-2build2) ... Setting up libtinfo6:amd64 (6.3-1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../ncurses-bin_6.3-1_amd64.deb ... Unpacking ncurses-bin (6.3-1) over (6.2+20201114-2build2) ... Setting up ncurses-bin (6.3-1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../sed_4.8-1ubuntu1_amd64.deb ... Unpacking sed (4.8-1ubuntu1) over (4.7-1ubuntu2) ... Setting up sed (4.8-1ubuntu1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../init-system-helpers_1.61_all.deb ... Unpacking init-system-helpers (1.61) over (1.60build1) ... Setting up init-system-helpers (1.61) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../libc-bin_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2_amd64.deb ... Unpacking libc-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) over (2.34-0ubuntu3) ... Setting up libc-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../ncurses-base_6.3-1_all.deb ... Unpacking ncurses-base (6.3-1) over (6.2+20201114-2build2) ... Setting up ncurses-base (6.3-1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../gpgv_2.2.27-3ubuntu1_amd64.deb ... Unpacking gpgv (2.2.27-3ubuntu1) over (2.2.20-1ubuntu4) ... Setting up gpgv (2.2.27-3ubuntu1) ... (Reading database ... 13277 files and directories currently installed.) Preparing to unpack .../archives/apt_2.3.14_amd64.deb ... Unpacking apt (2.3.14) over (2.3.9) ... Setting up apt (2.3.14) ... Installing new version of config file /etc/cron.daily/apt-compat ... Selecting previously unselected package libsepol2:amd64. (Reading database ... 13276 files and directories currently installed.) Preparing to unpack .../libsepol2_3.3-1_amd64.deb ... Unpacking libsepol2:amd64 (3.3-1) ... Setting up libsepol2:amd64 (3.3-1) ... (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libsemanage-common_3.3-1_all.deb ... Unpacking libsemanage-common (3.3-1) over (3.1-1ubuntu3) ... Setting up libsemanage-common (3.3-1) ... Selecting previously unselected package libsemanage2:amd64. (Reading database ... 13280 files and directories currently installed.) Preparing to unpack .../libsemanage2_3.3-1_amd64.deb ... Unpacking libsemanage2:amd64 (3.3-1) ... Setting up libsemanage2:amd64 (3.3-1) ... (Reading database ... 13284 files and directories currently installed.) Preparing to unpack .../passwd_1%3a4.8.1-2ubuntu1_amd64.deb ... Unpacking passwd (1:4.8.1-2ubuntu1) over (1:4.8.1-1ubuntu9) ... Setting up passwd (1:4.8.1-2ubuntu1) ... (Reading database ... 13291 files and directories currently installed.) Removing libsemanage1:amd64 (3.1-1ubuntu3) ... (Reading database ... 13287 files and directories currently installed.) Preparing to unpack .../libpam-modules-bin_1.4.0-10ubuntu2_amd64.deb ... Unpacking libpam-modules-bin (1.4.0-10ubuntu2) over (1.3.1-5ubuntu11) ... Setting up libpam-modules-bin (1.4.0-10ubuntu2) ... (Reading database ... 13285 files and directories currently installed.) Preparing to unpack .../libpam-modules_1.4.0-10ubuntu2_amd64.deb ... Unpacking libpam-modules:amd64 (1.4.0-10ubuntu2) over (1.3.1-5ubuntu11) ... Setting up libpam-modules:amd64 (1.4.0-10ubuntu2) ... Installing new version of config file /etc/security/namespace.conf ... Installing new version of config file /etc/security/pam_env.conf ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../logsave_1.46.5-1ubuntu1_amd64.deb ... Unpacking logsave (1.46.5-1ubuntu1) over (1.46.3-1ubuntu3) ... Preparing to unpack .../libext2fs2_1.46.5-1ubuntu1_amd64.deb ... Unpacking libext2fs2:amd64 (1.46.5-1ubuntu1) over (1.46.3-1ubuntu3) ... Setting up libext2fs2:amd64 (1.46.5-1ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../e2fsprogs_1.46.5-1ubuntu1_amd64.deb ... Unpacking e2fsprogs (1.46.5-1ubuntu1) over (1.46.3-1ubuntu3) ... Setting up libapparmor1:amd64 (3.0.3-0ubuntu5) ... Setting up libcryptsetup12:amd64 (2:2.4.2-1ubuntu4) ... Setting up libip4tc2:amd64 (1.8.7-1ubuntu4) ... Setting up libkmod2:amd64 (28-1ubuntu5) ... Setting up mount (2.37.2-4ubuntu1) ... Setting up systemd (249.5-2ubuntu3) ... Installing new version of config file /etc/systemd/networkd.conf ... Installing new version of config file /etc/systemd/resolved.conf ... Initializing machine ID from random generator. Setting up systemd-sysv (249.5-2ubuntu3) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../archives/init_1.61_amd64.deb ... Unpacking init (1.61) over (1.60build1) ... Preparing to unpack .../libattr1_1%3a2.5.1-1_amd64.deb ... Unpacking libattr1:amd64 (1:2.5.1-1) over (1:2.4.48-6build2) ... Setting up libattr1:amd64 (1:2.5.1-1) ... Installing new version of config file /etc/xattr.conf ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libcom-err2_1.46.5-1ubuntu1_amd64.deb ... Unpacking libcom-err2:amd64 (1.46.5-1ubuntu1) over (1.46.3-1ubuntu3) ... Setting up libcom-err2:amd64 (1.46.5-1ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libk5crypto3_1.19.2-0ubuntu1_amd64.deb ... Unpacking libk5crypto3:amd64 (1.19.2-0ubuntu1) over (1.18.3-6) ... Setting up libk5crypto3:amd64 (1.19.2-0ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libkrb5support0_1.19.2-0ubuntu1_amd64.deb ... Unpacking libkrb5support0:amd64 (1.19.2-0ubuntu1) over (1.18.3-6) ... Setting up libkrb5support0:amd64 (1.19.2-0ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libkrb5-3_1.19.2-0ubuntu1_amd64.deb ... Unpacking libkrb5-3:amd64 (1.19.2-0ubuntu1) over (1.18.3-6) ... Setting up libkrb5-3:amd64 (1.19.2-0ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libgssapi-krb5-2_1.19.2-0ubuntu1_amd64.deb ... Unpacking libgssapi-krb5-2:amd64 (1.19.2-0ubuntu1) over (1.18.3-6) ... Setting up libgssapi-krb5-2:amd64 (1.19.2-0ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libpam-runtime_1.4.0-10ubuntu2_all.deb ... Unpacking libpam-runtime (1.4.0-10ubuntu2) over (1.3.1-5ubuntu11) ... Setting up libpam-runtime (1.4.0-10ubuntu2) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../libsmartcols1_2.37.2-4ubuntu1_amd64.deb ... Unpacking libsmartcols1:amd64 (2.37.2-4ubuntu1) over (2.36.1-8ubuntu1) ... Setting up libsmartcols1:amd64 (2.37.2-4ubuntu1) ... (Reading database ... 13286 files and directories currently installed.) Preparing to unpack .../00-libss2_1.46.5-1ubuntu1_amd64.deb ... Unpacking libss2:amd64 (1.46.5-1ubuntu1) over (1.46.3-1ubuntu3) ... Preparing to unpack .../01-sensible-utils_0.0.17_all.deb ... Unpacking sensible-utils (0.0.17) over (0.0.14) ... Preparing to unpack .../02-usrmerge_25ubuntu2_all.deb ... Unpacking usrmerge (25ubuntu2) over (25ubuntu1) ... Preparing to unpack .../03-openssl_3.0.0-1ubuntu1_amd64.deb ... Unpacking openssl (3.0.0-1ubuntu1) over (1.1.1l-1ubuntu1) ... Preparing to unpack .../04-ca-certificates_20211016_all.deb ... Unpacking ca-certificates (20211016) over (20210119ubuntu1) ... Preparing to unpack .../05-readline-common_8.1.2-1_all.deb ... Unpacking readline-common (8.1.2-1) over (8.1-2build1) ... Preparing to unpack .../06-libreadline8_8.1.2-1_amd64.deb ... Unpacking libreadline8:amd64 (8.1.2-1) over (8.1-2build1) ... Preparing to unpack .../07-libsqlite3-0_3.36.0-2_amd64.deb ... Unpacking libsqlite3-0:amd64 (3.36.0-2) over (3.35.5-1) ... Preparing to unpack .../08-tzdata_2021e-1ubuntu1_all.deb ... Unpacking tzdata (2021e-1ubuntu1) over (2021a-2ubuntu1) ... Preparing to unpack .../09-libgdbm6_1.22-1_amd64.deb ... Unpacking libgdbm6:amd64 (1.22-1) over (1.19-2build1) ... Preparing to unpack .../10-dpkg-dev_1.20.9ubuntu3_all.deb ... Unpacking dpkg-dev (1.20.9ubuntu3) over (1.20.9ubuntu2) ... Preparing to unpack .../11-libdpkg-perl_1.20.9ubuntu3_all.deb ... Unpacking libdpkg-perl (1.20.9ubuntu3) over (1.20.9ubuntu2) ... Preparing to unpack .../12-make_4.3-4ubuntu2_amd64.deb ... Unpacking make (4.3-4ubuntu2) over (4.3-4ubuntu1) ... Preparing to unpack .../13-lto-disabled-list_18_all.deb ... Unpacking lto-disabled-list (18) over (16) ... Preparing to unpack .../14-gpg_2.2.27-3ubuntu1_amd64.deb ... Unpacking gpg (2.2.27-3ubuntu1) over (2.2.20-1ubuntu4) ... Preparing to unpack .../15-gpgconf_2.2.27-3ubuntu1_amd64.deb ... Unpacking gpgconf (2.2.27-3ubuntu1) over (2.2.20-1ubuntu4) ... Preparing to unpack .../16-gpg-agent_2.2.27-3ubuntu1_amd64.deb ... Unpacking gpg-agent (2.2.27-3ubuntu1) over (2.2.20-1ubuntu4) ... Preparing to unpack .../17-libgdbm-compat4_1.22-1_amd64.deb ... Unpacking libgdbm-compat4:amd64 (1.22-1) over (1.19-2build1) ... Preparing to unpack .../18-lockfile-progs_0.1.19_amd64.deb ... Unpacking lockfile-progs (0.1.19) over (0.1.18build1) ... Preparing to unpack .../19-pkgbinarymangler_149_all.deb ... Unpacking pkgbinarymangler (149) over (148) ... Setting up lto-disabled-list (18) ... Setting up init (1.61) ... Setting up libsqlite3-0:amd64 (3.36.0-2) ... Setting up binutils-common:amd64 (2.37-10ubuntu1) ... Setting up libctf-nobfd0:amd64 (2.37-10ubuntu1) ... Setting up libgomp1:amd64 (11.2.0-13ubuntu1) ... Setting up bzip2 (1.0.8-5) ... Setting up libasan6:amd64 (11.2.0-13ubuntu1) ... Setting up tzdata (2021e-1ubuntu1) ... Current default time zone: 'Etc/UTC' Local time is now: Tue Jan 11 01:46:20 UTC 2022. Universal Time is now: Tue Jan 11 01:46:20 UTC 2022. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up make (4.3-4ubuntu2) ... Setting up libncurses6:amd64 (6.3-1) ... Setting up libquadmath0:amd64 (11.2.0-13ubuntu1) ... Setting up libmpc3:amd64 (1.2.1-1) ... Setting up systemd-timesyncd (249.5-2ubuntu3) ... Setting up lockfile-progs (0.1.19) ... Setting up libatomic1:amd64 (11.2.0-13ubuntu1) ... Setting up usrmerge (25ubuntu2) ... Setting up libss2:amd64 (1.46.5-1ubuntu1) ... Setting up libncursesw6:amd64 (6.3-1) ... Setting up libdpkg-perl (1.20.9ubuntu3) ... Setting up logsave (1.46.5-1ubuntu1) ... Setting up libubsan1:amd64 (11.2.0-13ubuntu1) ... Setting up sensible-utils (0.0.17) ... Setting up libcrypt-dev:amd64 (1:4.4.27-1) ... Setting up libbinutils:amd64 (2.37-10ubuntu1) ... Setting up libisl23:amd64 (0.24-2) ... Setting up libc-dev-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... Setting up openssl (3.0.0-1ubuntu1) ... Installing new version of config file /etc/ssl/openssl.cnf ... Setting up readline-common (8.1.2-1) ... Setting up libcc1-0:amd64 (11.2.0-13ubuntu1) ... Setting up liblsan0:amd64 (11.2.0-13ubuntu1) ... Setting up libitm1:amd64 (11.2.0-13ubuntu1) ... Setting up libgdbm6:amd64 (1.22-1) ... Setting up libtsan0:amd64 (11.2.0-13ubuntu1) ... Setting up libctf0:amd64 (2.37-10ubuntu1) ... Setting up cpp-11 (11.2.0-13ubuntu1) ... Setting up pkgbinarymangler (149) ... Setting up libreadline8:amd64 (8.1.2-1) ... Setting up e2fsprogs (1.46.5-1ubuntu1) ... Installing new version of config file /etc/mke2fs.conf ... Setting up ca-certificates (20211016) ... Updating certificates in /etc/ssl/certs... rehash: warning: skipping ca-certificates.crt,it does not contain exactly one certificate or CRL 7 added, 8 removed; done. Setting up libgdbm-compat4:amd64 (1.22-1) ... Setting up libgcc-11-dev:amd64 (11.2.0-13ubuntu1) ... Setting up gpgconf (2.2.27-3ubuntu1) ... Setting up libc6-dev:amd64 (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... Setting up gpg (2.2.27-3ubuntu1) ... Setting up binutils-x86-64-linux-gnu (2.37-10ubuntu1) ... Setting up gpg-agent (2.2.27-3ubuntu1) ... Setting up binutils (2.37-10ubuntu1) ... Setting up dpkg-dev (1.20.9ubuntu3) ... Setting up libstdc++-11-dev:amd64 (11.2.0-13ubuntu1) ... Setting up gcc-11 (11.2.0-13ubuntu1) ... Setting up g++-11 (11.2.0-13ubuntu1) ... Processing triggers for libc-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... Processing triggers for ca-certificates (20211016) ... Updating certificates in /etc/ssl/certs... 0 added, 0 removed; done. Running hooks in /etc/ca-certificates/update.d... done. RUN: /usr/share/launchpad-buildd/bin/sbuild-package PACKAGEBUILD-22879446 amd64 jammy -c chroot:build-PACKAGEBUILD-22879446 --arch=amd64 --dist=jammy --nolog -A golang-github-canonical-go-dqlite_1.8.0-1.dsc Initiating build PACKAGEBUILD-22879446 with 4 jobs across 4 processor cores. Kernel reported to sbuild: 4.15.0-166-generic #174-Ubuntu SMP Wed Dec 8 19:07:44 UTC 2021 x86_64 sbuild (Debian sbuild) 0.75.0 (21 Mar 2018) on lgw01-amd64-004.buildd +===================================================================================+ | golang-github-canonical-go-dqlite 1.8.0-1 (amd64) Tue, 11 Jan 2022 01:46:24 +0000 | +===================================================================================+ Package: golang-github-canonical-go-dqlite Version: 1.8.0-1 Source Version: 1.8.0-1 Distribution: jammy Machine Architecture: amd64 Host Architecture: amd64 Build Architecture: amd64 Build Type: binary I: NOTICE: Log filtering will replace 'home/buildd/build-PACKAGEBUILD-22879446/chroot-autobuild' with '<>' +------------------------------------------------------------------------------+ | Fetch source files | +------------------------------------------------------------------------------+ Local sources ------------- golang-github-canonical-go-dqlite_1.8.0-1.dsc exists in .; copying to chroot I: NOTICE: Log filtering will replace 'build/golang-github-canonical-go-dqlite-3vR3yU/golang-github-canonical-go-dqlite-1.8.0' with '<>' I: NOTICE: Log filtering will replace 'build/golang-github-canonical-go-dqlite-3vR3yU' with '<>' +------------------------------------------------------------------------------+ | Install build-essential | +------------------------------------------------------------------------------+ Setup apt archive ----------------- Merged Build-Depends: build-essential, fakeroot Filtered Build-Depends: build-essential, fakeroot dpkg-deb: building package 'sbuild-build-depends-core-dummy' in '/<>/resolver-1qgCtp/apt_archive/sbuild-build-depends-core-dummy.deb'. dpkg-scanpackages: warning: Packages in archive but missing from override file: dpkg-scanpackages: warning: sbuild-build-depends-core-dummy dpkg-scanpackages: info: Wrote 1 entries to output Packages file. Ign:1 copy:/<>/resolver-1qgCtp/apt_archive ./ InRelease Get:2 copy:/<>/resolver-1qgCtp/apt_archive ./ Release [957 B] Ign:3 copy:/<>/resolver-1qgCtp/apt_archive ./ Release.gpg Get:4 copy:/<>/resolver-1qgCtp/apt_archive ./ Sources [349 B] Get:5 copy:/<>/resolver-1qgCtp/apt_archive ./ Packages [433 B] Fetched 1739 B in 0s (98.0 kB/s) Reading package lists... Reading package lists... Install core build dependencies (apt-based resolver) ---------------------------------------------------- Installing build dependencies Reading package lists... Building dependency tree... Reading state information... The following packages were automatically installed and are no longer required: libssl1.1 systemd-timesyncd Use 'apt autoremove' to remove them. The following NEW packages will be installed: sbuild-build-depends-core-dummy 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Need to get 652 B of archives. After this operation, 0 B of additional disk space will be used. Get:1 copy:/<>/resolver-1qgCtp/apt_archive ./ sbuild-build-depends-core-dummy 0.invalid.0 [652 B] debconf: delaying package configuration, since apt-utils is not installed Fetched 652 B in 0s (0 B/s) Selecting previously unselected package sbuild-build-depends-core-dummy. (Reading database ... 13447 files and directories currently installed.) Preparing to unpack .../sbuild-build-depends-core-dummy_0.invalid.0_amd64.deb ... Unpacking sbuild-build-depends-core-dummy (0.invalid.0) ... Setting up sbuild-build-depends-core-dummy (0.invalid.0) ... +------------------------------------------------------------------------------+ | Check architectures | +------------------------------------------------------------------------------+ Arch check ok (amd64 included in any all) +------------------------------------------------------------------------------+ | Install package build dependencies | +------------------------------------------------------------------------------+ Setup apt archive ----------------- Merged Build-Depends: debhelper-compat (= 13), libdqlite-dev, libraft-dev, dh-golang, golang-any, golang-github-ghodss-yaml-dev, golang-github-mattn-go-sqlite3-dev, golang-github-peterh-liner-dev, golang-github-pkg-errors-dev, golang-github-rican7-retry-dev, golang-github-spf13-cobra-dev, golang-github-stretchr-testify-dev, golang-golang-x-sys-dev Filtered Build-Depends: debhelper-compat (= 13), libdqlite-dev, libraft-dev, dh-golang, golang-any, golang-github-ghodss-yaml-dev, golang-github-mattn-go-sqlite3-dev, golang-github-peterh-liner-dev, golang-github-pkg-errors-dev, golang-github-rican7-retry-dev, golang-github-spf13-cobra-dev, golang-github-stretchr-testify-dev, golang-golang-x-sys-dev dpkg-deb: building package 'sbuild-build-depends-golang-github-canonical-go-dqlite-dummy' in '/<>/resolver-1qgCtp/apt_archive/sbuild-build-depends-golang-github-canonical-go-dqlite-dummy.deb'. dpkg-scanpackages: warning: Packages in archive but missing from override file: dpkg-scanpackages: warning: sbuild-build-depends-core-dummy sbuild-build-depends-golang-github-canonical-go-dqlite-dummy dpkg-scanpackages: info: Wrote 2 entries to output Packages file. Ign:1 copy:/<>/resolver-1qgCtp/apt_archive ./ InRelease Get:2 copy:/<>/resolver-1qgCtp/apt_archive ./ Release [963 B] Ign:3 copy:/<>/resolver-1qgCtp/apt_archive ./ Release.gpg Get:4 copy:/<>/resolver-1qgCtp/apt_archive ./ Sources [620 B] Get:5 copy:/<>/resolver-1qgCtp/apt_archive ./ Packages [702 B] Fetched 2285 B in 0s (130 kB/s) Reading package lists... Reading package lists... Install golang-github-canonical-go-dqlite build dependencies (apt-based resolver) --------------------------------------------------------------------------------- Installing build dependencies Reading package lists... Building dependency tree... Reading state information... The following packages were automatically installed and are no longer required: libssl1.1 systemd-timesyncd Use 'apt autoremove' to remove them. The following additional packages will be installed: autoconf automake autopoint autotools-dev bsdextrautils debhelper debugedit dh-autoreconf dh-golang dh-strip-nondeterminism dwz file gettext gettext-base golang-1.17-go golang-1.17-src golang-any golang-github-burntsushi-toml-dev golang-github-cpuguy83-go-md2man-v2-dev golang-github-davecgh-go-spew-dev golang-github-fsnotify-fsnotify-dev golang-github-ghodss-yaml-dev golang-github-hashicorp-hcl-dev golang-github-kr-fs-dev golang-github-magiconair-properties-dev golang-github-mattn-go-sqlite3-dev golang-github-mitchellh-go-homedir-dev golang-github-mitchellh-mapstructure-dev golang-github-pelletier-go-toml-dev golang-github-peterh-liner-dev golang-github-pkg-errors-dev golang-github-pkg-sftp-dev golang-github-pmezard-go-difflib-dev golang-github-rican7-retry-dev golang-github-russross-blackfriday-v2-dev golang-github-shurcool-sanitized-anchor-name-dev golang-github-spf13-afero-dev golang-github-spf13-cast-dev golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev golang-github-spf13-pflag-dev golang-github-spf13-viper-dev golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev golang-golang-x-net-dev golang-golang-x-sys-dev golang-golang-x-term-dev golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev golang-gopkg-yaml.v3-dev golang-src groff-base intltool-debian libarchive-zip-perl libdebhelper-perl libdqlite-dev libdqlite0 libdw1 libelf1 libfile-stripnondeterminism-perl libicu67 libmagic-mgc libmagic1 libpipeline1 libraft-dev libraft0 libsigsegv2 libsqlite3-dev libsub-override-perl libtool libuchardet0 libuv1 libxml2 m4 man-db po-debconf Suggested packages: autoconf-archive gnu-standards autoconf-doc dh-make gettext-doc libasprintf-dev libgettextpo-dev bzr | brz git mercurial subversion groff sqlite3-doc libtool-doc gfortran | fortran95-compiler gcj-jdk m4-doc apparmor less www-browser libmail-box-perl Recommended packages: curl | wget | lynx pkg-config libarchive-cpio-perl libltdl-dev libmail-sendmail-perl The following NEW packages will be installed: autoconf automake autopoint autotools-dev bsdextrautils debhelper debugedit dh-autoreconf dh-golang dh-strip-nondeterminism dwz file gettext gettext-base golang-1.17-go golang-1.17-src golang-any golang-github-burntsushi-toml-dev golang-github-cpuguy83-go-md2man-v2-dev golang-github-davecgh-go-spew-dev golang-github-fsnotify-fsnotify-dev golang-github-ghodss-yaml-dev golang-github-hashicorp-hcl-dev golang-github-kr-fs-dev golang-github-magiconair-properties-dev golang-github-mattn-go-sqlite3-dev golang-github-mitchellh-go-homedir-dev golang-github-mitchellh-mapstructure-dev golang-github-pelletier-go-toml-dev golang-github-peterh-liner-dev golang-github-pkg-errors-dev golang-github-pkg-sftp-dev golang-github-pmezard-go-difflib-dev golang-github-rican7-retry-dev golang-github-russross-blackfriday-v2-dev golang-github-shurcool-sanitized-anchor-name-dev golang-github-spf13-afero-dev golang-github-spf13-cast-dev golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev golang-github-spf13-pflag-dev golang-github-spf13-viper-dev golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev golang-golang-x-net-dev golang-golang-x-sys-dev golang-golang-x-term-dev golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev golang-gopkg-yaml.v3-dev golang-src groff-base intltool-debian libarchive-zip-perl libdebhelper-perl libdqlite-dev libdqlite0 libdw1 libelf1 libfile-stripnondeterminism-perl libicu67 libmagic-mgc libmagic1 libpipeline1 libraft-dev libraft0 libsigsegv2 libsqlite3-dev libsub-override-perl libtool libuchardet0 libuv1 libxml2 m4 man-db po-debconf sbuild-build-depends-golang-github-canonical-go-dqlite-dummy 0 upgraded, 81 newly installed, 0 to remove and 0 not upgraded. Need to get 105 MB of archives. After this operation, 553 MB of additional disk space will be used. Get:1 copy:/<>/resolver-1qgCtp/apt_archive ./ sbuild-build-depends-golang-github-canonical-go-dqlite-dummy 0.invalid.0 [780 B] Get:2 http://ftpmaster.internal/ubuntu jammy/main amd64 libelf1 amd64 0.186-1 [51.4 kB] Get:3 http://ftpmaster.internal/ubuntu jammy/main amd64 libicu67 amd64 67.1-7ubuntu1 [10.1 MB] Get:4 http://ftpmaster.internal/ubuntu jammy/main amd64 libxml2 amd64 2.9.12+dfsg-5 [761 kB] Get:5 http://ftpmaster.internal/ubuntu jammy/main amd64 bsdextrautils amd64 2.37.2-4ubuntu1 [71.1 kB] Get:6 http://ftpmaster.internal/ubuntu jammy/main amd64 libmagic-mgc amd64 1:5.41-2 [257 kB] Get:7 http://ftpmaster.internal/ubuntu jammy/main amd64 libmagic1 amd64 1:5.41-2 [87.3 kB] Get:8 http://ftpmaster.internal/ubuntu jammy/main amd64 file amd64 1:5.41-2 [21.5 kB] Get:9 http://ftpmaster.internal/ubuntu jammy/main amd64 gettext-base amd64 0.21-4ubuntu3 [36.6 kB] Get:10 http://ftpmaster.internal/ubuntu jammy/main amd64 libuchardet0 amd64 0.0.7-1build1 [76.7 kB] Get:11 http://ftpmaster.internal/ubuntu jammy/main amd64 groff-base amd64 1.22.4-8 [952 kB] Get:12 http://ftpmaster.internal/ubuntu jammy/main amd64 libpipeline1 amd64 1.5.5-1 [23.5 kB] Get:13 http://ftpmaster.internal/ubuntu jammy/main amd64 libuv1 amd64 1.42.0-1 [92.3 kB] Get:14 http://ftpmaster.internal/ubuntu jammy/main amd64 man-db amd64 2.9.4-4 [1179 kB] Get:15 http://ftpmaster.internal/ubuntu jammy/main amd64 libsigsegv2 amd64 2.13-1ubuntu2 [14.6 kB] Get:16 http://ftpmaster.internal/ubuntu jammy/main amd64 m4 amd64 1.4.18-5ubuntu1 [199 kB] Get:17 http://ftpmaster.internal/ubuntu jammy/main amd64 autoconf all 2.71-2 [338 kB] Get:18 http://ftpmaster.internal/ubuntu jammy/main amd64 autotools-dev all 20180224.1+nmu1 [39.4 kB] Get:19 http://ftpmaster.internal/ubuntu jammy/main amd64 automake all 1:1.16.5-1.1 [558 kB] Get:20 http://ftpmaster.internal/ubuntu jammy/main amd64 autopoint all 0.21-4ubuntu3 [422 kB] Get:21 http://ftpmaster.internal/ubuntu jammy/main amd64 libdebhelper-perl all 13.5.2ubuntu1 [66.0 kB] Get:22 http://ftpmaster.internal/ubuntu jammy/main amd64 libtool all 2.4.6-15build1 [164 kB] Get:23 http://ftpmaster.internal/ubuntu jammy/main amd64 dh-autoreconf all 20 [16.1 kB] Get:24 http://ftpmaster.internal/ubuntu jammy/main amd64 libarchive-zip-perl all 1.68-1 [90.2 kB] Get:25 http://ftpmaster.internal/ubuntu jammy/main amd64 libsub-override-perl all 0.09-2 [9532 B] Get:26 http://ftpmaster.internal/ubuntu jammy/main amd64 libfile-stripnondeterminism-perl all 1.13.0-1 [18.1 kB] Get:27 http://ftpmaster.internal/ubuntu jammy/main amd64 dh-strip-nondeterminism all 1.13.0-1 [5344 B] Get:28 http://ftpmaster.internal/ubuntu jammy/main amd64 libdw1 amd64 0.186-1 [251 kB] Get:29 http://ftpmaster.internal/ubuntu jammy/main amd64 debugedit amd64 1:5.0-4 [47.1 kB] Get:30 http://ftpmaster.internal/ubuntu jammy/main amd64 dwz amd64 0.14-1build1 [104 kB] Get:31 http://ftpmaster.internal/ubuntu jammy/main amd64 gettext amd64 0.21-4ubuntu3 [824 kB] Get:32 http://ftpmaster.internal/ubuntu jammy/main amd64 intltool-debian all 0.35.0+20060710.5 [24.9 kB] Get:33 http://ftpmaster.internal/ubuntu jammy/main amd64 po-debconf all 1.0.21+nmu1 [233 kB] Get:34 http://ftpmaster.internal/ubuntu jammy/main amd64 debhelper all 13.5.2ubuntu1 [926 kB] Get:35 http://ftpmaster.internal/ubuntu jammy/main amd64 golang-1.17-src all 1.17.3-1ubuntu1 [15.9 MB] Get:36 http://ftpmaster.internal/ubuntu jammy/main amd64 golang-1.17-go amd64 1.17.3-1ubuntu1 [61.2 MB] Get:37 http://ftpmaster.internal/ubuntu jammy/main amd64 golang-src all 2:1.17~1 [4522 B] Get:38 http://ftpmaster.internal/ubuntu jammy/main amd64 golang-go amd64 2:1.17~1 [41.9 kB] Get:39 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-any amd64 2:1.17~1 [2844 B] Get:40 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-pmezard-go-difflib-dev all 1.0.0-3 [12.4 kB] Get:41 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-shurcool-sanitized-anchor-name-dev all 1.0.0-2 [4036 B] Get:42 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-russross-blackfriday-v2-dev all 2.1.0-1 [79.6 kB] Get:43 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-cpuguy83-go-md2man-v2-dev all 2.0.0+ds-5 [9192 B] Get:44 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-rican7-retry-dev all 0.1.0-2 [7000 B] Get:45 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-davecgh-go-spew-dev all 1.1.1-2 [29.7 kB] Get:46 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-stretchr-objx-dev all 0.3.0-1 [25.4 kB] Get:47 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-gopkg-yaml.v3-dev all 3.0.0~git20210107.496545a-1 [74.7 kB] Get:48 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-stretchr-testify-dev all 1.7.0+git20210824.ab6dc32-1 [65.5 kB] Get:49 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-subosito-gotenv-dev all 1.2.0+git20190917.de67a66-2 [7452 B] Get:50 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-golang-x-sys-dev all 0.0~git20211216.1d35b9e-1 [378 kB] Get:51 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-golang-x-term-dev all 0.0~git20210615.6886f2d-1 [14.7 kB] Get:52 http://ftpmaster.internal/ubuntu jammy/universe amd64 libraft0 amd64 0.11.2+git211214-1 [78.2 kB] Get:53 http://ftpmaster.internal/ubuntu jammy/universe amd64 libdqlite0 amd64 1.9.0+git211116-1 [64.9 kB] Get:54 http://ftpmaster.internal/ubuntu jammy/main amd64 libsqlite3-dev amd64 3.36.0-2 [815 kB] Get:55 http://ftpmaster.internal/ubuntu jammy/universe amd64 libdqlite-dev amd64 1.9.0+git211116-1 [79.2 kB] Get:56 http://ftpmaster.internal/ubuntu jammy/universe amd64 libraft-dev amd64 0.11.2+git211214-1 [126 kB] Get:57 http://ftpmaster.internal/ubuntu jammy/main amd64 dh-golang all 1.53 [21.4 kB] Get:58 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-burntsushi-toml-dev all 0.4.1+git20210923.e0af6a2-1 [50.0 kB] Get:59 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-fsnotify-fsnotify-dev all 1.5.1-1 [24.1 kB] Get:60 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-gopkg-yaml.v2-dev all 2.4.0-1 [61.1 kB] Get:61 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-ghodss-yaml-dev all 1.0.0-1.1 [13.2 kB] Get:62 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-hashicorp-hcl-dev all 1.0.0-1.1 [58.9 kB] Get:63 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-kr-fs-dev all 0.1.0-1 [6372 B] Get:64 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-magiconair-properties-dev all 1.8.5-1 [27.8 kB] Get:65 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-golang-x-text-dev all 0.3.7-1 [4555 kB] Get:66 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-golang-x-net-dev all 1:0.0+git20211209.491a49a+dfsg-1 [702 kB] Get:67 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-mattn-go-sqlite3-dev all 1.6.0~ds1-2 [57.9 kB] Get:68 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-mitchellh-go-homedir-dev all 1.1.0-1 [5208 B] Get:69 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-mitchellh-mapstructure-dev all 1.4.3-1 [27.2 kB] Get:70 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-pelletier-go-toml-dev all 1.9.4-1 [79.6 kB] Get:71 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-peterh-liner-dev all 0.0~git20171122.3681c2a-3 [19.0 kB] Get:72 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-pkg-errors-dev all 0.9.1-2 [13.4 kB] Get:73 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-golang-x-crypto-dev all 1:0.0~git20211202.5770296-1 [1583 kB] Get:74 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-pkg-sftp-dev all 1.13.4-1 [98.5 kB] Get:75 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-afero-dev all 1.6.0-1 [48.3 kB] Get:76 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-cast-dev all 1.4.1-1 [12.8 kB] Get:77 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-pflag-dev all 1.0.5-2 [42.3 kB] Get:78 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-jwalterweatherman-dev all 1.1.0+really1.1.0-1 [7328 B] Get:79 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-gopkg-ini.v1-dev all 1.66.2-1 [40.7 kB] Get:80 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-viper-dev all 1.10.1-1 [65.5 kB] Get:81 http://ftpmaster.internal/ubuntu jammy/universe amd64 golang-github-spf13-cobra-dev all 1.2.1-2 [106 kB] debconf: delaying package configuration, since apt-utils is not installed Fetched 105 MB in 5s (21.1 MB/s) Selecting previously unselected package libelf1:amd64. (Reading database ... 13447 files and directories currently installed.) Preparing to unpack .../00-libelf1_0.186-1_amd64.deb ... Unpacking libelf1:amd64 (0.186-1) ... Selecting previously unselected package libicu67:amd64. Preparing to unpack .../01-libicu67_67.1-7ubuntu1_amd64.deb ... Unpacking libicu67:amd64 (67.1-7ubuntu1) ... Selecting previously unselected package libxml2:amd64. Preparing to unpack .../02-libxml2_2.9.12+dfsg-5_amd64.deb ... Unpacking libxml2:amd64 (2.9.12+dfsg-5) ... Selecting previously unselected package bsdextrautils. Preparing to unpack .../03-bsdextrautils_2.37.2-4ubuntu1_amd64.deb ... Unpacking bsdextrautils (2.37.2-4ubuntu1) ... Selecting previously unselected package libmagic-mgc. Preparing to unpack .../04-libmagic-mgc_1%3a5.41-2_amd64.deb ... Unpacking libmagic-mgc (1:5.41-2) ... Selecting previously unselected package libmagic1:amd64. Preparing to unpack .../05-libmagic1_1%3a5.41-2_amd64.deb ... Unpacking libmagic1:amd64 (1:5.41-2) ... Selecting previously unselected package file. Preparing to unpack .../06-file_1%3a5.41-2_amd64.deb ... Unpacking file (1:5.41-2) ... Selecting previously unselected package gettext-base. Preparing to unpack .../07-gettext-base_0.21-4ubuntu3_amd64.deb ... Unpacking gettext-base (0.21-4ubuntu3) ... Selecting previously unselected package libuchardet0:amd64. Preparing to unpack .../08-libuchardet0_0.0.7-1build1_amd64.deb ... Unpacking libuchardet0:amd64 (0.0.7-1build1) ... Selecting previously unselected package groff-base. Preparing to unpack .../09-groff-base_1.22.4-8_amd64.deb ... Unpacking groff-base (1.22.4-8) ... Selecting previously unselected package libpipeline1:amd64. Preparing to unpack .../10-libpipeline1_1.5.5-1_amd64.deb ... Unpacking libpipeline1:amd64 (1.5.5-1) ... Selecting previously unselected package libuv1:amd64. Preparing to unpack .../11-libuv1_1.42.0-1_amd64.deb ... Unpacking libuv1:amd64 (1.42.0-1) ... Selecting previously unselected package man-db. Preparing to unpack .../12-man-db_2.9.4-4_amd64.deb ... Unpacking man-db (2.9.4-4) ... Selecting previously unselected package libsigsegv2:amd64. Preparing to unpack .../13-libsigsegv2_2.13-1ubuntu2_amd64.deb ... Unpacking libsigsegv2:amd64 (2.13-1ubuntu2) ... Selecting previously unselected package m4. Preparing to unpack .../14-m4_1.4.18-5ubuntu1_amd64.deb ... Unpacking m4 (1.4.18-5ubuntu1) ... Selecting previously unselected package autoconf. Preparing to unpack .../15-autoconf_2.71-2_all.deb ... Unpacking autoconf (2.71-2) ... Selecting previously unselected package autotools-dev. Preparing to unpack .../16-autotools-dev_20180224.1+nmu1_all.deb ... Unpacking autotools-dev (20180224.1+nmu1) ... Selecting previously unselected package automake. Preparing to unpack .../17-automake_1%3a1.16.5-1.1_all.deb ... Unpacking automake (1:1.16.5-1.1) ... Selecting previously unselected package autopoint. Preparing to unpack .../18-autopoint_0.21-4ubuntu3_all.deb ... Unpacking autopoint (0.21-4ubuntu3) ... Selecting previously unselected package libdebhelper-perl. Preparing to unpack .../19-libdebhelper-perl_13.5.2ubuntu1_all.deb ... Unpacking libdebhelper-perl (13.5.2ubuntu1) ... Selecting previously unselected package libtool. Preparing to unpack .../20-libtool_2.4.6-15build1_all.deb ... Unpacking libtool (2.4.6-15build1) ... Selecting previously unselected package dh-autoreconf. Preparing to unpack .../21-dh-autoreconf_20_all.deb ... Unpacking dh-autoreconf (20) ... Selecting previously unselected package libarchive-zip-perl. Preparing to unpack .../22-libarchive-zip-perl_1.68-1_all.deb ... Unpacking libarchive-zip-perl (1.68-1) ... Selecting previously unselected package libsub-override-perl. Preparing to unpack .../23-libsub-override-perl_0.09-2_all.deb ... Unpacking libsub-override-perl (0.09-2) ... Selecting previously unselected package libfile-stripnondeterminism-perl. Preparing to unpack .../24-libfile-stripnondeterminism-perl_1.13.0-1_all.deb ... Unpacking libfile-stripnondeterminism-perl (1.13.0-1) ... Selecting previously unselected package dh-strip-nondeterminism. Preparing to unpack .../25-dh-strip-nondeterminism_1.13.0-1_all.deb ... Unpacking dh-strip-nondeterminism (1.13.0-1) ... Selecting previously unselected package libdw1:amd64. Preparing to unpack .../26-libdw1_0.186-1_amd64.deb ... Unpacking libdw1:amd64 (0.186-1) ... Selecting previously unselected package debugedit. Preparing to unpack .../27-debugedit_1%3a5.0-4_amd64.deb ... Unpacking debugedit (1:5.0-4) ... Selecting previously unselected package dwz. Preparing to unpack .../28-dwz_0.14-1build1_amd64.deb ... Unpacking dwz (0.14-1build1) ... Selecting previously unselected package gettext. Preparing to unpack .../29-gettext_0.21-4ubuntu3_amd64.deb ... Unpacking gettext (0.21-4ubuntu3) ... Selecting previously unselected package intltool-debian. Preparing to unpack .../30-intltool-debian_0.35.0+20060710.5_all.deb ... Unpacking intltool-debian (0.35.0+20060710.5) ... Selecting previously unselected package po-debconf. Preparing to unpack .../31-po-debconf_1.0.21+nmu1_all.deb ... Unpacking po-debconf (1.0.21+nmu1) ... Selecting previously unselected package debhelper. Preparing to unpack .../32-debhelper_13.5.2ubuntu1_all.deb ... Unpacking debhelper (13.5.2ubuntu1) ... Selecting previously unselected package golang-1.17-src. Preparing to unpack .../33-golang-1.17-src_1.17.3-1ubuntu1_all.deb ... Unpacking golang-1.17-src (1.17.3-1ubuntu1) ... Selecting previously unselected package golang-1.17-go. Preparing to unpack .../34-golang-1.17-go_1.17.3-1ubuntu1_amd64.deb ... Unpacking golang-1.17-go (1.17.3-1ubuntu1) ... Selecting previously unselected package golang-src. Preparing to unpack .../35-golang-src_2%3a1.17~1_all.deb ... Unpacking golang-src (2:1.17~1) ... Selecting previously unselected package golang-go:amd64. Preparing to unpack .../36-golang-go_2%3a1.17~1_amd64.deb ... Unpacking golang-go:amd64 (2:1.17~1) ... Selecting previously unselected package golang-any:amd64. Preparing to unpack .../37-golang-any_2%3a1.17~1_amd64.deb ... Unpacking golang-any:amd64 (2:1.17~1) ... Selecting previously unselected package golang-github-pmezard-go-difflib-dev. Preparing to unpack .../38-golang-github-pmezard-go-difflib-dev_1.0.0-3_all.deb ... Unpacking golang-github-pmezard-go-difflib-dev (1.0.0-3) ... Selecting previously unselected package golang-github-shurcool-sanitized-anchor-name-dev. Preparing to unpack .../39-golang-github-shurcool-sanitized-anchor-name-dev_1.0.0-2_all.deb ... Unpacking golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-2) ... Selecting previously unselected package golang-github-russross-blackfriday-v2-dev. Preparing to unpack .../40-golang-github-russross-blackfriday-v2-dev_2.1.0-1_all.deb ... Unpacking golang-github-russross-blackfriday-v2-dev (2.1.0-1) ... Selecting previously unselected package golang-github-cpuguy83-go-md2man-v2-dev. Preparing to unpack .../41-golang-github-cpuguy83-go-md2man-v2-dev_2.0.0+ds-5_all.deb ... Unpacking golang-github-cpuguy83-go-md2man-v2-dev (2.0.0+ds-5) ... Selecting previously unselected package golang-github-rican7-retry-dev. Preparing to unpack .../42-golang-github-rican7-retry-dev_0.1.0-2_all.deb ... Unpacking golang-github-rican7-retry-dev (0.1.0-2) ... Selecting previously unselected package golang-github-davecgh-go-spew-dev. Preparing to unpack .../43-golang-github-davecgh-go-spew-dev_1.1.1-2_all.deb ... Unpacking golang-github-davecgh-go-spew-dev (1.1.1-2) ... Selecting previously unselected package golang-github-stretchr-objx-dev. Preparing to unpack .../44-golang-github-stretchr-objx-dev_0.3.0-1_all.deb ... Unpacking golang-github-stretchr-objx-dev (0.3.0-1) ... Selecting previously unselected package golang-gopkg-yaml.v3-dev. Preparing to unpack .../45-golang-gopkg-yaml.v3-dev_3.0.0~git20210107.496545a-1_all.deb ... Unpacking golang-gopkg-yaml.v3-dev (3.0.0~git20210107.496545a-1) ... Selecting previously unselected package golang-github-stretchr-testify-dev. Preparing to unpack .../46-golang-github-stretchr-testify-dev_1.7.0+git20210824.ab6dc32-1_all.deb ... Unpacking golang-github-stretchr-testify-dev (1.7.0+git20210824.ab6dc32-1) ... Selecting previously unselected package golang-github-subosito-gotenv-dev. Preparing to unpack .../47-golang-github-subosito-gotenv-dev_1.2.0+git20190917.de67a66-2_all.deb ... Unpacking golang-github-subosito-gotenv-dev (1.2.0+git20190917.de67a66-2) ... Selecting previously unselected package golang-golang-x-sys-dev. Preparing to unpack .../48-golang-golang-x-sys-dev_0.0~git20211216.1d35b9e-1_all.deb ... Unpacking golang-golang-x-sys-dev (0.0~git20211216.1d35b9e-1) ... Selecting previously unselected package golang-golang-x-term-dev. Preparing to unpack .../49-golang-golang-x-term-dev_0.0~git20210615.6886f2d-1_all.deb ... Unpacking golang-golang-x-term-dev (0.0~git20210615.6886f2d-1) ... Selecting previously unselected package libraft0:amd64. Preparing to unpack .../50-libraft0_0.11.2+git211214-1_amd64.deb ... Unpacking libraft0:amd64 (0.11.2+git211214-1) ... Selecting previously unselected package libdqlite0:amd64. Preparing to unpack .../51-libdqlite0_1.9.0+git211116-1_amd64.deb ... Unpacking libdqlite0:amd64 (1.9.0+git211116-1) ... Selecting previously unselected package libsqlite3-dev:amd64. Preparing to unpack .../52-libsqlite3-dev_3.36.0-2_amd64.deb ... Unpacking libsqlite3-dev:amd64 (3.36.0-2) ... Selecting previously unselected package libdqlite-dev:amd64. Preparing to unpack .../53-libdqlite-dev_1.9.0+git211116-1_amd64.deb ... Unpacking libdqlite-dev:amd64 (1.9.0+git211116-1) ... Selecting previously unselected package libraft-dev:amd64. Preparing to unpack .../54-libraft-dev_0.11.2+git211214-1_amd64.deb ... Unpacking libraft-dev:amd64 (0.11.2+git211214-1) ... Selecting previously unselected package dh-golang. Preparing to unpack .../55-dh-golang_1.53_all.deb ... Unpacking dh-golang (1.53) ... Selecting previously unselected package golang-github-burntsushi-toml-dev. Preparing to unpack .../56-golang-github-burntsushi-toml-dev_0.4.1+git20210923.e0af6a2-1_all.deb ... Unpacking golang-github-burntsushi-toml-dev (0.4.1+git20210923.e0af6a2-1) ... Selecting previously unselected package golang-github-fsnotify-fsnotify-dev. Preparing to unpack .../57-golang-github-fsnotify-fsnotify-dev_1.5.1-1_all.deb ... Unpacking golang-github-fsnotify-fsnotify-dev (1.5.1-1) ... Selecting previously unselected package golang-gopkg-yaml.v2-dev. Preparing to unpack .../58-golang-gopkg-yaml.v2-dev_2.4.0-1_all.deb ... Unpacking golang-gopkg-yaml.v2-dev (2.4.0-1) ... Selecting previously unselected package golang-github-ghodss-yaml-dev. Preparing to unpack .../59-golang-github-ghodss-yaml-dev_1.0.0-1.1_all.deb ... Unpacking golang-github-ghodss-yaml-dev (1.0.0-1.1) ... Selecting previously unselected package golang-github-hashicorp-hcl-dev. Preparing to unpack .../60-golang-github-hashicorp-hcl-dev_1.0.0-1.1_all.deb ... Unpacking golang-github-hashicorp-hcl-dev (1.0.0-1.1) ... Selecting previously unselected package golang-github-kr-fs-dev. Preparing to unpack .../61-golang-github-kr-fs-dev_0.1.0-1_all.deb ... Unpacking golang-github-kr-fs-dev (0.1.0-1) ... Selecting previously unselected package golang-github-magiconair-properties-dev. Preparing to unpack .../62-golang-github-magiconair-properties-dev_1.8.5-1_all.deb ... Unpacking golang-github-magiconair-properties-dev (1.8.5-1) ... Selecting previously unselected package golang-golang-x-text-dev. Preparing to unpack .../63-golang-golang-x-text-dev_0.3.7-1_all.deb ... Unpacking golang-golang-x-text-dev (0.3.7-1) ... Selecting previously unselected package golang-golang-x-net-dev. Preparing to unpack .../64-golang-golang-x-net-dev_1%3a0.0+git20211209.491a49a+dfsg-1_all.deb ... Unpacking golang-golang-x-net-dev (1:0.0+git20211209.491a49a+dfsg-1) ... Selecting previously unselected package golang-github-mattn-go-sqlite3-dev. Preparing to unpack .../65-golang-github-mattn-go-sqlite3-dev_1.6.0~ds1-2_all.deb ... Unpacking golang-github-mattn-go-sqlite3-dev (1.6.0~ds1-2) ... Selecting previously unselected package golang-github-mitchellh-go-homedir-dev. Preparing to unpack .../66-golang-github-mitchellh-go-homedir-dev_1.1.0-1_all.deb ... Unpacking golang-github-mitchellh-go-homedir-dev (1.1.0-1) ... Selecting previously unselected package golang-github-mitchellh-mapstructure-dev. Preparing to unpack .../67-golang-github-mitchellh-mapstructure-dev_1.4.3-1_all.deb ... Unpacking golang-github-mitchellh-mapstructure-dev (1.4.3-1) ... Selecting previously unselected package golang-github-pelletier-go-toml-dev. Preparing to unpack .../68-golang-github-pelletier-go-toml-dev_1.9.4-1_all.deb ... Unpacking golang-github-pelletier-go-toml-dev (1.9.4-1) ... Selecting previously unselected package golang-github-peterh-liner-dev. Preparing to unpack .../69-golang-github-peterh-liner-dev_0.0~git20171122.3681c2a-3_all.deb ... Unpacking golang-github-peterh-liner-dev (0.0~git20171122.3681c2a-3) ... Selecting previously unselected package golang-github-pkg-errors-dev. Preparing to unpack .../70-golang-github-pkg-errors-dev_0.9.1-2_all.deb ... Unpacking golang-github-pkg-errors-dev (0.9.1-2) ... Selecting previously unselected package golang-golang-x-crypto-dev. Preparing to unpack .../71-golang-golang-x-crypto-dev_1%3a0.0~git20211202.5770296-1_all.deb ... Unpacking golang-golang-x-crypto-dev (1:0.0~git20211202.5770296-1) ... Selecting previously unselected package golang-github-pkg-sftp-dev. Preparing to unpack .../72-golang-github-pkg-sftp-dev_1.13.4-1_all.deb ... Unpacking golang-github-pkg-sftp-dev (1.13.4-1) ... Selecting previously unselected package golang-github-spf13-afero-dev. Preparing to unpack .../73-golang-github-spf13-afero-dev_1.6.0-1_all.deb ... Unpacking golang-github-spf13-afero-dev (1.6.0-1) ... Selecting previously unselected package golang-github-spf13-cast-dev. Preparing to unpack .../74-golang-github-spf13-cast-dev_1.4.1-1_all.deb ... Unpacking golang-github-spf13-cast-dev (1.4.1-1) ... Selecting previously unselected package golang-github-spf13-pflag-dev. Preparing to unpack .../75-golang-github-spf13-pflag-dev_1.0.5-2_all.deb ... Unpacking golang-github-spf13-pflag-dev (1.0.5-2) ... Selecting previously unselected package golang-github-spf13-jwalterweatherman-dev. Preparing to unpack .../76-golang-github-spf13-jwalterweatherman-dev_1.1.0+really1.1.0-1_all.deb ... Unpacking golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-1) ... Selecting previously unselected package golang-gopkg-ini.v1-dev. Preparing to unpack .../77-golang-gopkg-ini.v1-dev_1.66.2-1_all.deb ... Unpacking golang-gopkg-ini.v1-dev (1.66.2-1) ... Selecting previously unselected package golang-github-spf13-viper-dev. Preparing to unpack .../78-golang-github-spf13-viper-dev_1.10.1-1_all.deb ... Unpacking golang-github-spf13-viper-dev (1.10.1-1) ... Selecting previously unselected package golang-github-spf13-cobra-dev. Preparing to unpack .../79-golang-github-spf13-cobra-dev_1.2.1-2_all.deb ... Unpacking golang-github-spf13-cobra-dev (1.2.1-2) ... Selecting previously unselected package sbuild-build-depends-golang-github-canonical-go-dqlite-dummy. Preparing to unpack .../80-sbuild-build-depends-golang-github-canonical-go-dqlite-dummy_0.invalid.0_amd64.deb ... Unpacking sbuild-build-depends-golang-github-canonical-go-dqlite-dummy (0.invalid.0) ... Setting up libpipeline1:amd64 (1.5.5-1) ... Setting up golang-gopkg-yaml.v2-dev (2.4.0-1) ... Setting up golang-github-mitchellh-go-homedir-dev (1.1.0-1) ... Setting up golang-github-mitchellh-mapstructure-dev (1.4.3-1) ... Setting up bsdextrautils (2.37.2-4ubuntu1) ... update-alternatives: using /usr/bin/write.ul to provide /usr/bin/write (write) in auto mode Setting up golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-2) ... Setting up libicu67:amd64 (67.1-7ubuntu1) ... Setting up golang-github-stretchr-objx-dev (0.3.0-1) ... Setting up libmagic-mgc (1:5.41-2) ... Setting up golang-github-pkg-errors-dev (0.9.1-2) ... Setting up libarchive-zip-perl (1.68-1) ... Setting up golang-gopkg-yaml.v3-dev (3.0.0~git20210107.496545a-1) ... Setting up libdebhelper-perl (13.5.2ubuntu1) ... Setting up golang-github-burntsushi-toml-dev (0.4.1+git20210923.e0af6a2-1) ... Setting up golang-golang-x-sys-dev (0.0~git20211216.1d35b9e-1) ... Setting up golang-github-kr-fs-dev (0.1.0-1) ... Setting up libmagic1:amd64 (1:5.41-2) ... Setting up golang-github-pmezard-go-difflib-dev (1.0.0-3) ... Setting up gettext-base (0.21-4ubuntu3) ... Setting up golang-golang-x-term-dev (0.0~git20210615.6886f2d-1) ... Setting up file (1:5.41-2) ... Setting up golang-1.17-src (1.17.3-1ubuntu1) ... Setting up golang-github-peterh-liner-dev (0.0~git20171122.3681c2a-3) ... Setting up golang-github-spf13-pflag-dev (1.0.5-2) ... Setting up golang-github-davecgh-go-spew-dev (1.1.1-2) ... Setting up autotools-dev (20180224.1+nmu1) ... Setting up libuv1:amd64 (1.42.0-1) ... Setting up libsqlite3-dev:amd64 (3.36.0-2) ... Setting up libraft0:amd64 (0.11.2+git211214-1) ... Setting up golang-github-stretchr-testify-dev (1.7.0+git20210824.ab6dc32-1) ... Setting up libsigsegv2:amd64 (2.13-1ubuntu2) ... Setting up libraft-dev:amd64 (0.11.2+git211214-1) ... Setting up golang-gopkg-ini.v1-dev (1.66.2-1) ... Setting up autopoint (0.21-4ubuntu3) ... Setting up golang-github-magiconair-properties-dev (1.8.5-1) ... Setting up golang-github-hashicorp-hcl-dev (1.0.0-1.1) ... Setting up golang-github-rican7-retry-dev (0.1.0-2) ... Setting up golang-1.17-go (1.17.3-1ubuntu1) ... Setting up golang-golang-x-text-dev (0.3.7-1) ... Setting up libuchardet0:amd64 (0.0.7-1build1) ... Setting up golang-github-spf13-cast-dev (1.4.1-1) ... Setting up golang-github-fsnotify-fsnotify-dev (1.5.1-1) ... Setting up libsub-override-perl (0.09-2) ... Setting up golang-github-pelletier-go-toml-dev (1.9.4-1) ... Setting up golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-1) ... Setting up libdqlite0:amd64 (1.9.0+git211116-1) ... Setting up golang-github-ghodss-yaml-dev (1.0.0-1.1) ... Setting up golang-src (2:1.17~1) ... Setting up libelf1:amd64 (0.186-1) ... Setting up libxml2:amd64 (2.9.12+dfsg-5) ... Setting up libfile-stripnondeterminism-perl (1.13.0-1) ... Setting up libdqlite-dev:amd64 (1.9.0+git211116-1) ... Setting up libdw1:amd64 (0.186-1) ... Setting up gettext (0.21-4ubuntu3) ... Setting up golang-github-russross-blackfriday-v2-dev (2.1.0-1) ... Setting up libtool (2.4.6-15build1) ... Setting up golang-go:amd64 (2:1.17~1) ... Setting up golang-github-subosito-gotenv-dev (1.2.0+git20190917.de67a66-2) ... Setting up m4 (1.4.18-5ubuntu1) ... Setting up golang-any:amd64 (2:1.17~1) ... Setting up intltool-debian (0.35.0+20060710.5) ... Setting up golang-golang-x-net-dev (1:0.0+git20211209.491a49a+dfsg-1) ... Setting up autoconf (2.71-2) ... Setting up dh-strip-nondeterminism (1.13.0-1) ... Setting up dwz (0.14-1build1) ... Setting up groff-base (1.22.4-8) ... Setting up debugedit (1:5.0-4) ... Setting up golang-golang-x-crypto-dev (1:0.0~git20211202.5770296-1) ... Setting up automake (1:1.16.5-1.1) ... update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode Setting up golang-github-cpuguy83-go-md2man-v2-dev (2.0.0+ds-5) ... Setting up po-debconf (1.0.21+nmu1) ... Setting up golang-github-pkg-sftp-dev (1.13.4-1) ... Setting up man-db (2.9.4-4) ... Not building database; man-db/auto-update is not 'true'. Created symlink /etc/systemd/system/timers.target.wants/man-db.timer → /lib/systemd/system/man-db.timer. Setting up dh-autoreconf (20) ... Setting up golang-github-mattn-go-sqlite3-dev (1.6.0~ds1-2) ... Setting up golang-github-spf13-afero-dev (1.6.0-1) ... Setting up debhelper (13.5.2ubuntu1) ... Setting up golang-github-spf13-viper-dev (1.10.1-1) ... Setting up dh-golang (1.53) ... Setting up golang-github-spf13-cobra-dev (1.2.1-2) ... Setting up sbuild-build-depends-golang-github-canonical-go-dqlite-dummy (0.invalid.0) ... Processing triggers for libc-bin (2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2) ... +------------------------------------------------------------------------------+ | Build environment | +------------------------------------------------------------------------------+ Kernel: Linux 4.15.0-166-generic amd64 (x86_64) Toolchain package versions: binutils_2.37-10ubuntu1 dpkg-dev_1.20.9ubuntu3 g++-11_11.2.0-13ubuntu1 gcc-11_11.2.0-13ubuntu1 libc6-dev_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 libstdc++-11-dev_11.2.0-13ubuntu1 libstdc++6_11.2.0-13ubuntu1 linux-libc-dev_5.13.0-19.19 Package versions: adduser_3.118ubuntu5 advancecomp_2.1-2.1ubuntu1 apt_2.3.14 autoconf_2.71-2 automake_1:1.16.5-1.1 autopoint_0.21-4ubuntu3 autotools-dev_20180224.1+nmu1 base-files_12ubuntu2 base-passwd_3.5.52 bash_5.1-6ubuntu1 binutils_2.37-10ubuntu1 binutils-common_2.37-10ubuntu1 binutils-x86-64-linux-gnu_2.37-10ubuntu1 bsdextrautils_2.37.2-4ubuntu1 bsdutils_1:2.37.2-4ubuntu1 build-essential_12.9ubuntu2 bzip2_1.0.8-5 ca-certificates_20211016 coreutils_8.32-4ubuntu3 cpp_4:11.2.0-1ubuntu1 cpp-11_11.2.0-13ubuntu1 dash_0.5.11+git20210903+057cd650a4ed-3 debconf_1.5.79 debhelper_13.5.2ubuntu1 debianutils_5.5-1ubuntu1 debugedit_1:5.0-4 dh-autoreconf_20 dh-golang_1.53 dh-strip-nondeterminism_1.13.0-1 diffutils_1:3.8-0ubuntu1 dpkg_1.20.9ubuntu3 dpkg-dev_1.20.9ubuntu3 dwz_0.14-1build1 e2fsprogs_1.46.5-1ubuntu1 fakeroot_1.25.3-1.1ubuntu3 file_1:5.41-2 findutils_4.8.0-1ubuntu2 g++_4:11.2.0-1ubuntu1 g++-11_11.2.0-13ubuntu1 gcc_4:11.2.0-1ubuntu1 gcc-11_11.2.0-13ubuntu1 gcc-11-base_11.2.0-13ubuntu1 gettext_0.21-4ubuntu3 gettext-base_0.21-4ubuntu3 golang-1.17-go_1.17.3-1ubuntu1 golang-1.17-src_1.17.3-1ubuntu1 golang-any_2:1.17~1 golang-github-burntsushi-toml-dev_0.4.1+git20210923.e0af6a2-1 golang-github-cpuguy83-go-md2man-v2-dev_2.0.0+ds-5 golang-github-davecgh-go-spew-dev_1.1.1-2 golang-github-fsnotify-fsnotify-dev_1.5.1-1 golang-github-ghodss-yaml-dev_1.0.0-1.1 golang-github-hashicorp-hcl-dev_1.0.0-1.1 golang-github-kr-fs-dev_0.1.0-1 golang-github-magiconair-properties-dev_1.8.5-1 golang-github-mattn-go-sqlite3-dev_1.6.0~ds1-2 golang-github-mitchellh-go-homedir-dev_1.1.0-1 golang-github-mitchellh-mapstructure-dev_1.4.3-1 golang-github-pelletier-go-toml-dev_1.9.4-1 golang-github-peterh-liner-dev_0.0~git20171122.3681c2a-3 golang-github-pkg-errors-dev_0.9.1-2 golang-github-pkg-sftp-dev_1.13.4-1 golang-github-pmezard-go-difflib-dev_1.0.0-3 golang-github-rican7-retry-dev_0.1.0-2 golang-github-russross-blackfriday-v2-dev_2.1.0-1 golang-github-shurcool-sanitized-anchor-name-dev_1.0.0-2 golang-github-spf13-afero-dev_1.6.0-1 golang-github-spf13-cast-dev_1.4.1-1 golang-github-spf13-cobra-dev_1.2.1-2 golang-github-spf13-jwalterweatherman-dev_1.1.0+really1.1.0-1 golang-github-spf13-pflag-dev_1.0.5-2 golang-github-spf13-viper-dev_1.10.1-1 golang-github-stretchr-objx-dev_0.3.0-1 golang-github-stretchr-testify-dev_1.7.0+git20210824.ab6dc32-1 golang-github-subosito-gotenv-dev_1.2.0+git20190917.de67a66-2 golang-go_2:1.17~1 golang-golang-x-crypto-dev_1:0.0~git20211202.5770296-1 golang-golang-x-net-dev_1:0.0+git20211209.491a49a+dfsg-1 golang-golang-x-sys-dev_0.0~git20211216.1d35b9e-1 golang-golang-x-term-dev_0.0~git20210615.6886f2d-1 golang-golang-x-text-dev_0.3.7-1 golang-gopkg-ini.v1-dev_1.66.2-1 golang-gopkg-yaml.v2-dev_2.4.0-1 golang-gopkg-yaml.v3-dev_3.0.0~git20210107.496545a-1 golang-src_2:1.17~1 gpg_2.2.27-3ubuntu1 gpg-agent_2.2.27-3ubuntu1 gpgconf_2.2.27-3ubuntu1 gpgv_2.2.27-3ubuntu1 grep_3.7-1 groff-base_1.22.4-8 gzip_1.10-4ubuntu2 hostname_3.23ubuntu1 init_1.61 init-system-helpers_1.61 intltool-debian_0.35.0+20060710.5 libacl1_2.2.53-10ubuntu2 libapparmor1_3.0.3-0ubuntu5 libapt-pkg6.0_2.3.14 libarchive-zip-perl_1.68-1 libargon2-1_0~20171227-0.2build22 libasan6_11.2.0-13ubuntu1 libassuan0_2.5.5-1 libatomic1_11.2.0-13ubuntu1 libattr1_1:2.5.1-1 libaudit-common_1:3.0-2ubuntu3 libaudit1_1:3.0-2ubuntu3 libbinutils_2.37-10ubuntu1 libblkid1_2.37.2-4ubuntu1 libbz2-1.0_1.0.8-5 libc-bin_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 libc-dev-bin_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 libc6_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 libc6-dev_2.34.9000-368-g57e349b1b0-0ubuntu1~ppa2 libcap-ng0_0.7.9-2.2build2 libcap2_1:2.44-1build2 libcc1-0_11.2.0-13ubuntu1 libcom-err2_1.46.5-1ubuntu1 libcrypt-dev_1:4.4.27-1 libcrypt1_1:4.4.27-1 libcryptsetup12_2:2.4.2-1ubuntu4 libctf-nobfd0_2.37-10ubuntu1 libctf0_2.37-10ubuntu1 libdb5.3_5.3.28+dfsg1-0.8ubuntu2 libdebconfclient0_0.256ubuntu4 libdebhelper-perl_13.5.2ubuntu1 libdevmapper1.02.1_2:1.02.175-2.1ubuntu3 libdpkg-perl_1.20.9ubuntu3 libdqlite-dev_1.9.0+git211116-1 libdqlite0_1.9.0+git211116-1 libdw1_0.186-1 libelf1_0.186-1 libext2fs2_1.46.5-1ubuntu1 libfakeroot_1.25.3-1.1ubuntu3 libffi8_3.4.2-1ubuntu5 libfile-stripnondeterminism-perl_1.13.0-1 libgcc-11-dev_11.2.0-13ubuntu1 libgcc-s1_11.2.0-13ubuntu1 libgcrypt20_1.9.4-3ubuntu2 libgdbm-compat4_1.22-1 libgdbm6_1.22-1 libgmp10_2:6.2.1+dfsg-1ubuntu3 libgnutls30_3.7.2-4ubuntu1 libgomp1_11.2.0-13ubuntu1 libgpg-error0_1.43-1 libgssapi-krb5-2_1.19.2-0ubuntu1 libhogweed6_3.7.3-1build1 libicu67_67.1-7ubuntu1 libidn2-0_2.3.2-2 libip4tc2_1.8.7-1ubuntu4 libisl23_0.24-2 libitm1_11.2.0-13ubuntu1 libjson-c5_0.15-2build3 libk5crypto3_1.19.2-0ubuntu1 libkeyutils1_1.6.1-2ubuntu2 libkmod2_28-1ubuntu5 libkrb5-3_1.19.2-0ubuntu1 libkrb5support0_1.19.2-0ubuntu1 liblockfile-bin_1.17-1build1 liblockfile1_1.17-1build1 liblsan0_11.2.0-13ubuntu1 liblz4-1_1.9.3-2build1 liblzma5_5.2.5-2build1 libmagic-mgc_1:5.41-2 libmagic1_1:5.41-2 libmount1_2.37.2-4ubuntu1 libmpc3_1.2.1-1 libmpfr6_4.1.0-3build2 libncurses6_6.3-1 libncursesw6_6.3-1 libnettle8_3.7.3-1build1 libnpth0_1.6-3build1 libnsl-dev_1.3.0-2build1 libnsl2_1.3.0-2build1 libp11-kit0_0.24.0-6 libpam-modules_1.4.0-10ubuntu2 libpam-modules-bin_1.4.0-10ubuntu2 libpam-runtime_1.4.0-10ubuntu2 libpam0g_1.4.0-10ubuntu2 libpcre2-8-0_10.39-3 libpcre3_2:8.39-13build4 libperl5.32_5.32.1-3ubuntu3 libpipeline1_1.5.5-1 libpng16-16_1.6.37-3build4 libprocps8_2:3.3.17-5ubuntu3 libquadmath0_11.2.0-13ubuntu1 libraft-dev_0.11.2+git211214-1 libraft0_0.11.2+git211214-1 libreadline8_8.1.2-1 libseccomp2_2.5.2-2ubuntu2 libselinux1_3.3-1 libsemanage-common_3.3-1 libsemanage2_3.3-1 libsepol1_3.1-1ubuntu2 libsepol2_3.3-1 libsigsegv2_2.13-1ubuntu2 libsmartcols1_2.37.2-4ubuntu1 libsqlite3-0_3.36.0-2 libsqlite3-dev_3.36.0-2 libss2_1.46.5-1ubuntu1 libssl1.1_1.1.1l-1ubuntu1 libssl3_3.0.0-1ubuntu1 libstdc++-11-dev_11.2.0-13ubuntu1 libstdc++6_11.2.0-13ubuntu1 libsub-override-perl_0.09-2 libsystemd0_249.5-2ubuntu3 libtasn1-6_4.18.0-4 libtinfo6_6.3-1 libtirpc-common_1.3.2-2 libtirpc-dev_1.3.2-2 libtirpc3_1.3.2-2 libtool_2.4.6-15build1 libtsan0_11.2.0-13ubuntu1 libubsan1_11.2.0-13ubuntu1 libuchardet0_0.0.7-1build1 libudev1_249.5-2ubuntu3 libunistring2_0.9.10-6 libuuid1_2.37.2-4ubuntu1 libuv1_1.42.0-1 libxml2_2.9.12+dfsg-5 libxxhash0_0.8.0-2build1 libzstd1_1.4.8+dfsg-3 linux-libc-dev_5.13.0-19.19 lockfile-progs_0.1.19 login_1:4.8.1-2ubuntu1 logsave_1.46.5-1ubuntu1 lsb-base_11.1.0ubuntu3 lto-disabled-list_18 m4_1.4.18-5ubuntu1 make_4.3-4ubuntu2 man-db_2.9.4-4 mawk_1.3.4.20200120-2build1 mount_2.37.2-4ubuntu1 ncurses-base_6.3-1 ncurses-bin_6.3-1 openssl_3.0.0-1ubuntu1 optipng_0.7.7-2 passwd_1:4.8.1-2ubuntu1 patch_2.7.6-7build1 perl_5.32.1-3ubuntu3 perl-base_5.32.1-3ubuntu3 perl-modules-5.32_5.32.1-3ubuntu3 pinentry-curses_1.1.1-1build1 pkgbinarymangler_149 po-debconf_1.0.21+nmu1 policyrcd-script-zg2_0.1-3 procps_2:3.3.17-5ubuntu3 readline-common_8.1.2-1 rpcsvc-proto_1.4.2-0ubuntu5 sbuild-build-depends-core-dummy_0.invalid.0 sbuild-build-depends-golang-github-canonical-go-dqlite-dummy_0.invalid.0 sed_4.8-1ubuntu1 sensible-utils_0.0.17 systemd_249.5-2ubuntu3 systemd-sysv_249.5-2ubuntu3 systemd-timesyncd_249.5-2ubuntu3 sysvinit-utils_2.96-7ubuntu2 tar_1.34+dfsg-1build2 tzdata_2021e-1ubuntu1 ubuntu-keyring_2021.03.26 usrmerge_25ubuntu2 util-linux_2.37.2-4ubuntu1 xz-utils_5.2.5-2build1 zlib1g_1:1.2.11.dfsg-2ubuntu7 +------------------------------------------------------------------------------+ | Build | +------------------------------------------------------------------------------+ Unpack source ------------- gpgv: Signature made Mon Oct 26 14:34:49 2020 UTC gpgv: using RSA key 6E817B38120E7BBDDF623F51D8A39A530F0DCCCB gpgv: Can't check signature: No public key dpkg-source: warning: failed to verify signature on ./golang-github-canonical-go-dqlite_1.8.0-1.dsc dpkg-source: info: extracting golang-github-canonical-go-dqlite in /<> dpkg-source: info: unpacking golang-github-canonical-go-dqlite_1.8.0.orig.tar.gz dpkg-source: info: unpacking golang-github-canonical-go-dqlite_1.8.0-1.debian.tar.xz Check disk space ---------------- Sufficient free space for build User Environment ---------------- APT_CONFIG=/var/lib/sbuild/apt.conf DEB_BUILD_OPTIONS=noautodbgsym parallel=4 HOME=/sbuild-nonexistent LANG=C.UTF-8 LC_ALL=C.UTF-8 LOGNAME=buildd PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games SCHROOT_ALIAS_NAME=build-PACKAGEBUILD-22879446 SCHROOT_CHROOT_NAME=build-PACKAGEBUILD-22879446 SCHROOT_COMMAND=env SCHROOT_GID=2501 SCHROOT_GROUP=buildd SCHROOT_SESSION_ID=build-PACKAGEBUILD-22879446 SCHROOT_UID=2001 SCHROOT_USER=buildd SHELL=/bin/sh TERM=unknown USER=buildd V=1 dpkg-buildpackage ----------------- dpkg-buildpackage: info: source package golang-github-canonical-go-dqlite dpkg-buildpackage: info: source version 1.8.0-1 dpkg-buildpackage: info: source distribution unstable dpkg-source --before-build . dpkg-buildpackage: info: host architecture amd64 debian/rules clean dh clean --builddirectory=_build --buildsystem=golang --with=golang dh_auto_clean -O--builddirectory=_build -O--buildsystem=golang dh_autoreconf_clean -O--builddirectory=_build -O--buildsystem=golang dh_clean -O--builddirectory=_build -O--buildsystem=golang debian/rules binary dh binary --builddirectory=_build --buildsystem=golang --with=golang dh_update_autotools_config -O--builddirectory=_build -O--buildsystem=golang dh_autoreconf -O--builddirectory=_build -O--buildsystem=golang dh_auto_configure -O--builddirectory=_build -O--buildsystem=golang dh_auto_build -O--builddirectory=_build -O--buildsystem=golang cd _build && go install -trimpath -v -p 4 github.com/canonical/go-dqlite github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite/cmd/dqlite 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/logging github.com/canonical/go-dqlite/internal/protocol github.com/canonical/go-dqlite/internal/shell internal/unsafeheader internal/abi internal/goexperiment internal/cpu runtime/internal/atomic runtime/internal/sys runtime/internal/math internal/itoa math/bits unicode/utf8 internal/race internal/bytealg sync/atomic math unicode container/list crypto/internal/subtle runtime crypto/subtle unicode/utf16 vendor/golang.org/x/crypto/cryptobyte/asn1 internal/nettrace vendor/golang.org/x/crypto/internal/subtle encoding container/ring golang.org/x/sys/internal/unsafeheader internal/reflectlite sync internal/testlog internal/singleflight math/rand runtime/cgo internal/sysinfo errors sort strconv io internal/oserror syscall path bytes reflect hash crypto crypto/elliptic/internal/fiat internal/syscall/unix time internal/syscall/execenv strings crypto/internal/randutil bufio crypto/hmac internal/poll io/fs context crypto/rc4 vendor/golang.org/x/net/dns/dnsmessage vendor/golang.org/x/crypto/hkdf internal/fmtsort encoding/binary os github.com/Rican7/retry/backoff github.com/Rican7/retry/jitter github.com/Rican7/retry/strategy github.com/Rican7/retry regexp/syntax crypto/cipher crypto/sha512 crypto/aes fmt crypto/des crypto/ed25519/internal/edwards25519/field crypto/md5 crypto/sha1 crypto/ed25519/internal/edwards25519 crypto/sha256 encoding/base64 encoding/pem math/big encoding/hex net net/url path/filepath vendor/golang.org/x/crypto/chacha20 vendor/golang.org/x/crypto/poly1305 io/ioutil vendor/golang.org/x/crypto/curve25519 vendor/golang.org/x/sys/cpu database/sql/driver vendor/golang.org/x/crypto/chacha20poly1305 database/sql flag crypto/elliptic encoding/asn1 vendor/golang.org/x/crypto/cryptobyte crypto/rand crypto/ed25519 crypto/rsa crypto/dsa crypto/x509/pkix runtime/debug crypto/ecdsa runtime/trace github.com/pkg/errors testing encoding/json regexp gopkg.in/yaml.v2 github.com/canonical/go-dqlite/internal/logging github.com/mattn/go-sqlite3 log os/signal github.com/peterh/liner encoding/csv crypto/x509 github.com/spf13/pflag github.com/ghodss/yaml text/template/parse crypto/tls text/template golang.org/x/sys/unix github.com/spf13/cobra compress/flate github.com/canonical/go-dqlite/internal/protocol hash/crc32 vendor/golang.org/x/text/transform compress/gzip vendor/golang.org/x/text/unicode/bidi vendor/golang.org/x/text/unicode/norm github.com/canonical/go-dqlite/internal/bindings vendor/golang.org/x/text/secure/bidirule net/textproto vendor/golang.org/x/net/http2/hpack vendor/golang.org/x/net/idna mime vendor/golang.org/x/net/http/httpguts vendor/golang.org/x/net/http/httpproxy mime/quotedprintable net/http/httptrace mime/multipart net/http/internal net/http/internal/ascii net/http github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite github.com/canonical/go-dqlite/driver github.com/canonical/go-dqlite/internal/shell github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/cmd/dqlite github.com/canonical/go-dqlite/cmd/dqlite-demo dh_auto_test -O--builddirectory=_build -O--buildsystem=golang cd _build && go test -vet=off -v -p 4 github.com/canonical/go-dqlite github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite/cmd/dqlite 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/logging github.com/canonical/go-dqlite/internal/protocol github.com/canonical/go-dqlite/internal/shell ? github.com/canonical/go-dqlite [no test files] === RUN TestNew_PristineDefault --- PASS: TestNew_PristineDefault (0.06s) === RUN TestNew_PristineJoiner app_test.go:945: 01:47:01.413 - 2: DEBUG: new connection from 127.0.0.1:59990 app_test.go:945: 01:47:01.451 - 2: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.451 - 2: DEBUG: new connection from 127.0.0.1:59992 app_test.go:945: 01:47:01.452 - 2: DEBUG: new connection from 127.0.0.1:59994 app_test.go:945: 01:47:01.491 - 3: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.497 - 2: DEBUG: new connection from 127.0.0.1:59998 app_test.go:945: 01:47:01.535 - 3: DEBUG: new connection from 127.0.0.1:46180 app_test.go:945: 01:47:01.579 - 2: DEBUG: new connection from 127.0.0.1:60002 app_test.go:945: 01:47:01.631 - 2: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_PristineJoiner (0.30s) === RUN TestNew_JoinerRestart app_test.go:945: 01:47:01.729 - 4: DEBUG: new connection from 127.0.0.1:60004 app_test.go:945: 01:47:01.766 - 4: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.767 - 4: DEBUG: new connection from 127.0.0.1:60006 app_test.go:945: 01:47:01.844 - 4: DEBUG: new connection from 127.0.0.1:60008 app_test.go:945: 01:47:01.880 - 5: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.895 - 4: DEBUG: new connection from 127.0.0.1:60010 app_test.go:945: 01:47:01.932 - 5: DEBUG: new connection from 127.0.0.1:46192 app_test.go:945: 01:47:01.011 - 4: DEBUG: new connection from 127.0.0.1:60014 app_test.go:945: 01:47:01.053 - 6: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.053 - 4: DEBUG: new connection from 127.0.0.1:60016 app_test.go:945: 01:47:01.092 - 6: DEBUG: new connection from 127.0.0.1:46198 --- PASS: TestNew_JoinerRestart (0.50s) === RUN TestNew_SecondJoiner app_test.go:945: 01:47:01.214 - 7: DEBUG: new connection from 127.0.0.1:60020 app_test.go:945: 01:47:01.252 - 7: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.252 - 7: DEBUG: new connection from 127.0.0.1:60022 app_test.go:945: 01:47:01.264 - 7: DEBUG: new connection from 127.0.0.1:60024 app_test.go:945: 01:47:01.306 - 8: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.309 - 7: DEBUG: new connection from 127.0.0.1:60026 app_test.go:945: 01:47:01.348 - 8: DEBUG: new connection from 127.0.0.1:46208 app_test.go:945: 01:47:01.427 - 7: DEBUG: new connection from 127.0.0.1:60030 app_test.go:945: 01:47:01.466 - 9: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.466 - 7: DEBUG: new connection from 127.0.0.1:60032 app_test.go:945: 01:47:01.504 - 8: DEBUG: new connection from 127.0.0.1:46214 app_test.go:945: 01:47:01.544 - 9: DEBUG: new connection from 127.0.0.1:41328 app_test.go:945: 01:47:01.582 - 9: DEBUG: new connection from 127.0.0.1:41330 app_test.go:945: 01:47:01.624 - 7: DEBUG: new connection from 127.0.0.1:60040 app_test.go:945: 01:47:01.184 - 8: DEBUG: new connection from 127.0.0.1:46222 app_test.go:945: 01:47:01.224 - 7: DEBUG: new connection from 127.0.0.1:60044 app_test.go:945: 01:47:01.181 - 7: DEBUG: new connection from 127.0.0.1:60050 app_test.go:945: 01:47:01.218 - 7: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_SecondJoiner (2.16s) === RUN TestNew_ThirdJoiner app_test.go:945: 01:47:01.374 - 10: DEBUG: new connection from 127.0.0.1:60054 app_test.go:945: 01:47:01.422 - 10: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.423 - 10: DEBUG: new connection from 127.0.0.1:60056 app_test.go:945: 01:47:01.499 - 10: DEBUG: new connection from 127.0.0.1:60058 app_test.go:945: 01:47:01.537 - 11: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.540 - 10: DEBUG: new connection from 127.0.0.1:60060 app_test.go:945: 01:47:01.576 - 11: DEBUG: new connection from 127.0.0.1:46242 app_test.go:945: 01:47:01.655 - 10: DEBUG: new connection from 127.0.0.1:60064 app_test.go:945: 01:47:01.691 - 12: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.692 - 10: DEBUG: new connection from 127.0.0.1:60066 app_test.go:945: 01:47:01.728 - 11: DEBUG: new connection from 127.0.0.1:46248 app_test.go:945: 01:47:01.765 - 12: DEBUG: new connection from 127.0.0.1:41362 app_test.go:945: 01:47:01.846 - 12: DEBUG: new connection from 127.0.0.1:41364 app_test.go:945: 01:47:01.885 - 10: DEBUG: new connection from 127.0.0.1:60074 app_test.go:945: 01:47:01.843 - 11: DEBUG: new connection from 127.0.0.1:46256 app_test.go:945: 01:47:01.898 - 10: DEBUG: new connection from 127.0.0.1:60078 app_test.go:945: 01:47:01.875 - 10: DEBUG: new connection from 127.0.0.1:60080 app_test.go:945: 01:47:01.929 - 13: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.931 - 10: DEBUG: new connection from 127.0.0.1:60082 app_test.go:945: 01:47:01.978 - 11: DEBUG: new connection from 127.0.0.1:46264 app_test.go:945: 01:47:01.015 - 12: DEBUG: new connection from 127.0.0.1:41378 app_test.go:945: 01:47:01.071 - 13: DEBUG: new connection from 127.0.0.1:41928 app_test.go:945: 01:47:01.118 - 13: DEBUG: new connection from 127.0.0.1:41930 app_test.go:945: 01:47:01.119 - 10: DEBUG: new connection from 127.0.0.1:60092 app_test.go:945: 01:47:01.156 - 10: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_ThirdJoiner (2.94s) === RUN TestNew_FourthJoiner app_test.go:945: 01:47:01.310 - 14: DEBUG: new connection from 127.0.0.1:60094 app_test.go:945: 01:47:01.368 - 14: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.369 - 14: DEBUG: new connection from 127.0.0.1:60096 app_test.go:945: 01:47:01.464 - 14: DEBUG: new connection from 127.0.0.1:60098 app_test.go:945: 01:47:01.518 - 15: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.523 - 14: DEBUG: new connection from 127.0.0.1:60100 app_test.go:945: 01:47:01.585 - 15: DEBUG: new connection from 127.0.0.1:46282 app_test.go:945: 01:47:01.680 - 14: DEBUG: new connection from 127.0.0.1:60104 app_test.go:945: 01:47:01.729 - 16: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.732 - 14: DEBUG: new connection from 127.0.0.1:60106 app_test.go:945: 01:47:01.800 - 15: DEBUG: new connection from 127.0.0.1:46288 app_test.go:945: 01:47:01.841 - 16: DEBUG: new connection from 127.0.0.1:41402 app_test.go:945: 01:47:01.885 - 16: DEBUG: new connection from 127.0.0.1:41404 app_test.go:945: 01:47:01.923 - 14: DEBUG: new connection from 127.0.0.1:60114 app_test.go:945: 01:47:01.774 - 15: DEBUG: new connection from 127.0.0.1:46296 app_test.go:945: 01:47:01.834 - 14: DEBUG: new connection from 127.0.0.1:60118 app_test.go:945: 01:47:01.816 - 14: DEBUG: new connection from 127.0.0.1:60120 app_test.go:945: 01:47:01.872 - 17: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.874 - 14: DEBUG: new connection from 127.0.0.1:60122 app_test.go:945: 01:47:01.913 - 15: DEBUG: new connection from 127.0.0.1:46304 app_test.go:945: 01:47:01.952 - 16: DEBUG: new connection from 127.0.0.1:41418 app_test.go:945: 01:47:01.001 - 17: DEBUG: new connection from 127.0.0.1:41968 app_test.go:945: 01:47:01.062 - 17: DEBUG: new connection from 127.0.0.1:41970 app_test.go:945: 01:47:01.100 - 14: DEBUG: new connection from 127.0.0.1:60132 app_test.go:945: 01:47:01.119 - 14: DEBUG: new connection from 127.0.0.1:60134 app_test.go:945: 01:47:01.151 - 18: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.152 - 14: DEBUG: new connection from 127.0.0.1:60136 app_test.go:945: 01:47:01.189 - 15: DEBUG: new connection from 127.0.0.1:46318 app_test.go:945: 01:47:01.244 - 16: DEBUG: new connection from 127.0.0.1:41432 app_test.go:945: 01:47:01.286 - 17: DEBUG: new connection from 127.0.0.1:41982 app_test.go:945: 01:47:01.322 - 18: DEBUG: new connection from 127.0.0.1:55446 app_test.go:945: 01:47:01.359 - 18: DEBUG: new connection from 127.0.0.1:55448 app_test.go:945: 01:47:01.359 - 14: DEBUG: new connection from 127.0.0.1:60148 app_test.go:945: 01:47:01.401 - 14: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_FourthJoiner (3.26s) === RUN TestNew_FifthJoiner app_test.go:945: 01:47:01.567 - 19: DEBUG: new connection from 127.0.0.1:60150 app_test.go:945: 01:47:01.621 - 19: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.622 - 19: DEBUG: new connection from 127.0.0.1:60152 app_test.go:945: 01:47:01.723 - 19: DEBUG: new connection from 127.0.0.1:60154 app_test.go:945: 01:47:01.802 - 20: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.805 - 19: DEBUG: new connection from 127.0.0.1:60156 app_test.go:945: 01:47:01.861 - 20: DEBUG: new connection from 127.0.0.1:46338 app_test.go:945: 01:47:01.939 - 19: DEBUG: new connection from 127.0.0.1:60160 app_test.go:945: 01:47:01.003 - 21: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.004 - 19: DEBUG: new connection from 127.0.0.1:60162 app_test.go:945: 01:47:01.052 - 20: DEBUG: new connection from 127.0.0.1:46344 app_test.go:945: 01:47:01.093 - 21: DEBUG: new connection from 127.0.0.1:41458 app_test.go:945: 01:47:01.136 - 21: DEBUG: new connection from 127.0.0.1:41460 app_test.go:945: 01:47:01.188 - 19: DEBUG: new connection from 127.0.0.1:60170 app_test.go:945: 01:47:01.030 - 20: DEBUG: new connection from 127.0.0.1:46352 app_test.go:945: 01:47:01.083 - 19: DEBUG: new connection from 127.0.0.1:60174 app_test.go:945: 01:47:01.068 - 19: DEBUG: new connection from 127.0.0.1:60176 app_test.go:945: 01:47:01.106 - 22: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.107 - 19: DEBUG: new connection from 127.0.0.1:60178 app_test.go:945: 01:47:01.149 - 20: DEBUG: new connection from 127.0.0.1:46360 app_test.go:945: 01:47:01.186 - 21: DEBUG: new connection from 127.0.0.1:41474 app_test.go:945: 01:47:01.222 - 22: DEBUG: new connection from 127.0.0.1:42024 app_test.go:945: 01:47:01.267 - 22: DEBUG: new connection from 127.0.0.1:42026 app_test.go:945: 01:47:01.300 - 19: DEBUG: new connection from 127.0.0.1:60188 app_test.go:945: 01:47:01.305 - 19: DEBUG: new connection from 127.0.0.1:60190 app_test.go:945: 01:47:01.338 - 23: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.340 - 19: DEBUG: new connection from 127.0.0.1:60192 app_test.go:945: 01:47:01.395 - 20: DEBUG: new connection from 127.0.0.1:46374 app_test.go:945: 01:47:01.441 - 21: DEBUG: new connection from 127.0.0.1:41488 app_test.go:945: 01:47:01.479 - 22: DEBUG: new connection from 127.0.0.1:42038 app_test.go:945: 01:47:01.517 - 23: DEBUG: new connection from 127.0.0.1:55502 app_test.go:945: 01:47:01.557 - 23: DEBUG: new connection from 127.0.0.1:55504 app_test.go:945: 01:47:01.595 - 19: DEBUG: new connection from 127.0.0.1:60204 app_test.go:945: 01:47:01.605 - 19: DEBUG: new connection from 127.0.0.1:60206 app_test.go:945: 01:47:01.640 - 24: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.643 - 19: DEBUG: new connection from 127.0.0.1:60208 app_test.go:945: 01:47:01.679 - 20: DEBUG: new connection from 127.0.0.1:46390 app_test.go:945: 01:47:01.717 - 21: DEBUG: new connection from 127.0.0.1:41504 app_test.go:945: 01:47:01.754 - 22: DEBUG: new connection from 127.0.0.1:42054 app_test.go:945: 01:47:01.791 - 23: DEBUG: new connection from 127.0.0.1:55518 app_test.go:945: 01:47:01.829 - 24: DEBUG: new connection from 127.0.0.1:52794 app_test.go:945: 01:47:01.868 - 24: DEBUG: new connection from 127.0.0.1:52796 app_test.go:945: 01:47:01.869 - 19: DEBUG: new connection from 127.0.0.1:60222 app_test.go:945: 01:47:01.919 - 19: DEBUG: new connection from 127.0.0.1:60224 app_test.go:945: 01:47:01.921 - 19: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_FifthJoiner (3.57s) === RUN TestNew_SixthJoiner app_test.go:945: 01:47:01.138 - 25: DEBUG: new connection from 127.0.0.1:60226 app_test.go:945: 01:47:01.178 - 25: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.180 - 25: DEBUG: new connection from 127.0.0.1:60228 app_test.go:945: 01:47:01.267 - 25: DEBUG: new connection from 127.0.0.1:60230 app_test.go:945: 01:47:01.322 - 26: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.326 - 25: DEBUG: new connection from 127.0.0.1:60232 app_test.go:945: 01:47:01.367 - 26: DEBUG: new connection from 127.0.0.1:46414 app_test.go:945: 01:47:01.459 - 25: DEBUG: new connection from 127.0.0.1:60236 app_test.go:945: 01:47:01.509 - 27: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.512 - 25: DEBUG: new connection from 127.0.0.1:60238 app_test.go:945: 01:47:01.563 - 26: DEBUG: new connection from 127.0.0.1:46420 app_test.go:945: 01:47:01.602 - 27: DEBUG: new connection from 127.0.0.1:41534 app_test.go:945: 01:47:01.648 - 27: DEBUG: new connection from 127.0.0.1:41536 app_test.go:945: 01:47:01.686 - 25: DEBUG: new connection from 127.0.0.1:60246 app_test.go:945: 01:47:01.609 - 26: DEBUG: new connection from 127.0.0.1:46428 app_test.go:945: 01:47:01.679 - 25: DEBUG: new connection from 127.0.0.1:60250 app_test.go:945: 01:47:01.644 - 25: DEBUG: new connection from 127.0.0.1:60252 app_test.go:945: 01:47:01.714 - 28: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.716 - 25: DEBUG: new connection from 127.0.0.1:60254 app_test.go:945: 01:47:01.757 - 26: DEBUG: new connection from 127.0.0.1:46436 app_test.go:945: 01:47:01.796 - 27: DEBUG: new connection from 127.0.0.1:41550 app_test.go:945: 01:47:01.841 - 28: DEBUG: new connection from 127.0.0.1:42100 app_test.go:945: 01:47:01.884 - 28: DEBUG: new connection from 127.0.0.1:42102 app_test.go:945: 01:47:01.928 - 25: DEBUG: new connection from 127.0.0.1:60264 app_test.go:945: 01:47:01.955 - 25: DEBUG: new connection from 127.0.0.1:60266 app_test.go:945: 01:47:01.968 - 29: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.970 - 25: DEBUG: new connection from 127.0.0.1:60268 app_test.go:945: 01:47:01.008 - 26: DEBUG: new connection from 127.0.0.1:46450 app_test.go:945: 01:47:01.057 - 27: DEBUG: new connection from 127.0.0.1:41564 app_test.go:945: 01:47:01.093 - 28: DEBUG: new connection from 127.0.0.1:42114 app_test.go:945: 01:47:01.130 - 29: DEBUG: new connection from 127.0.0.1:55578 app_test.go:945: 01:47:01.166 - 29: DEBUG: new connection from 127.0.0.1:55580 app_test.go:945: 01:47:01.208 - 25: DEBUG: new connection from 127.0.0.1:60280 app_test.go:945: 01:47:01.211 - 25: DEBUG: new connection from 127.0.0.1:60282 app_test.go:945: 01:47:01.263 - 30: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.267 - 25: DEBUG: new connection from 127.0.0.1:60284 app_test.go:945: 01:47:01.318 - 26: DEBUG: new connection from 127.0.0.1:46466 app_test.go:945: 01:47:01.358 - 27: DEBUG: new connection from 127.0.0.1:41580 app_test.go:945: 01:47:01.406 - 28: DEBUG: new connection from 127.0.0.1:42130 app_test.go:945: 01:47:01.462 - 29: DEBUG: new connection from 127.0.0.1:55594 app_test.go:945: 01:47:01.500 - 30: DEBUG: new connection from 127.0.0.1:52870 app_test.go:945: 01:47:01.537 - 30: DEBUG: new connection from 127.0.0.1:52872 app_test.go:945: 01:47:01.575 - 25: DEBUG: new connection from 127.0.0.1:60298 app_test.go:945: 01:47:01.583 - 25: DEBUG: new connection from 127.0.0.1:60300 app_test.go:945: 01:47:01.611 - 31: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.613 - 25: DEBUG: new connection from 127.0.0.1:60302 app_test.go:945: 01:47:01.650 - 26: DEBUG: new connection from 127.0.0.1:46484 app_test.go:945: 01:47:01.686 - 27: DEBUG: new connection from 127.0.0.1:41598 app_test.go:945: 01:47:01.742 - 28: DEBUG: new connection from 127.0.0.1:42148 app_test.go:945: 01:47:01.780 - 29: DEBUG: new connection from 127.0.0.1:55612 app_test.go:945: 01:47:01.816 - 30: DEBUG: new connection from 127.0.0.1:52888 app_test.go:945: 01:47:01.852 - 31: DEBUG: new connection from 127.0.0.1:35306 app_test.go:945: 01:47:01.896 - 25: DEBUG: new connection from 127.0.0.1:60316 app_test.go:945: 01:47:01.935 - 25: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestNew_SixthJoiner (3.99s) === RUN TestHandover_Voter app_test.go:945: 01:47:01.130 - 32: DEBUG: new connection from 127.0.0.1:60318 app_test.go:945: 01:47:01.168 - 32: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.168 - 32: DEBUG: new connection from 127.0.0.1:60320 app_test.go:945: 01:47:01.247 - 32: DEBUG: new connection from 127.0.0.1:60322 app_test.go:945: 01:47:01.284 - 33: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.287 - 32: DEBUG: new connection from 127.0.0.1:60324 app_test.go:945: 01:47:01.332 - 33: DEBUG: new connection from 127.0.0.1:46506 app_test.go:945: 01:47:01.403 - 32: DEBUG: new connection from 127.0.0.1:60328 app_test.go:945: 01:47:01.440 - 34: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.441 - 32: DEBUG: new connection from 127.0.0.1:60330 app_test.go:945: 01:47:01.480 - 33: DEBUG: new connection from 127.0.0.1:46512 app_test.go:945: 01:47:01.520 - 34: DEBUG: new connection from 127.0.0.1:41626 app_test.go:945: 01:47:01.559 - 34: DEBUG: new connection from 127.0.0.1:41628 app_test.go:945: 01:47:01.600 - 32: DEBUG: new connection from 127.0.0.1:60338 app_test.go:945: 01:47:01.093 - 33: DEBUG: new connection from 127.0.0.1:46520 app_test.go:945: 01:47:01.139 - 32: DEBUG: new connection from 127.0.0.1:60342 app_test.go:945: 01:47:01.139 - 32: DEBUG: new connection from 127.0.0.1:60344 app_test.go:945: 01:47:01.175 - 35: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.177 - 32: DEBUG: new connection from 127.0.0.1:60346 app_test.go:945: 01:47:01.214 - 33: DEBUG: new connection from 127.0.0.1:46528 app_test.go:945: 01:47:01.252 - 34: DEBUG: new connection from 127.0.0.1:41642 app_test.go:945: 01:47:01.289 - 35: DEBUG: new connection from 127.0.0.1:42192 app_test.go:945: 01:47:01.331 - 35: DEBUG: new connection from 127.0.0.1:42194 app_test.go:945: 01:47:01.332 - 32: DEBUG: new connection from 127.0.0.1:60356 app_test.go:945: 01:47:01.369 - 32: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.370 - 32: DEBUG: new connection from 127.0.0.1:60358 app_test.go:945: 01:47:01.373 - 32: DEBUG: new connection from 127.0.0.1:60360 app_test.go:945: 01:47:01.408 - 34: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.409 - 32: DEBUG: new connection from 127.0.0.1:60362 app_test.go:945: 01:47:01.454 - 33: DEBUG: new connection from 127.0.0.1:46544 app_test.go:945: 01:47:01.492 - 34: DEBUG: new connection from 127.0.0.1:41658 app_test.go:945: 01:47:01.532 - 35: DEBUG: new connection from 127.0.0.1:42208 app_test.go:945: 01:47:01.096 - 34: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter --- PASS: TestHandover_Voter (3.16s) === RUN TestHandover_TwoNodes app_test.go:945: 01:47:01.281 - 36: DEBUG: new connection from 127.0.0.1:60370 app_test.go:945: 01:47:01.320 - 36: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.321 - 36: DEBUG: new connection from 127.0.0.1:60372 app_test.go:945: 01:47:01.399 - 36: DEBUG: new connection from 127.0.0.1:60374 app_test.go:945: 01:47:01.437 - 37: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.440 - 36: DEBUG: new connection from 127.0.0.1:60376 app_test.go:945: 01:47:01.476 - 37: DEBUG: new connection from 127.0.0.1:46558 app_test.go:945: 01:47:01.512 - 36: DEBUG: new connection from 127.0.0.1:60380 app_test.go:945: 01:47:01.548 - 36: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.549 - 36: DEBUG: new connection from 127.0.0.1:60382 app_test.go:945: 01:47:01.585 - 37: DEBUG: new connection from 127.0.0.1:46564 app_test.go:945: 01:47:01.621 - 37: DEBUG: new connection from 127.0.0.1:46566 app_test.go:945: 01:47:01.658 - 36: DEBUG: new connection from 127.0.0.1:60388 app_test.go:945: 01:47:01.249 - 36: DEBUG: promoted 127.0.0.1:9002 from spare to voter app_test.go:945: 01:47:01.249 - 36: DEBUG: new connection from 127.0.0.1:60390 app_test.go:945: 01:47:01.288 - 37: DEBUG: new connection from 127.0.0.1:46572 app_test.go:945: 01:47:01.330 - 36: WARN: transfer leadership to 127.0.0.1:9002: leadership transfer failed (1) app_test.go:317: Error Trace: app_test.go:317 Error: Received unexpected error: transfer leadership: leadership transfer failed (1) Test: TestHandover_TwoNodes --- FAIL: TestHandover_TwoNodes (1.16s) === RUN TestHandover_VoterHonorFailureDomain app_test.go:945: 01:47:01.445 - 38: DEBUG: new connection from 127.0.0.1:60394 app_test.go:945: 01:47:01.488 - 38: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.489 - 38: DEBUG: new connection from 127.0.0.1:60396 app_test.go:945: 01:47:01.567 - 38: DEBUG: new connection from 127.0.0.1:60398 app_test.go:945: 01:47:01.603 - 39: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.607 - 38: DEBUG: new connection from 127.0.0.1:60400 app_test.go:945: 01:47:01.649 - 39: DEBUG: new connection from 127.0.0.1:46582 app_test.go:945: 01:47:01.731 - 38: DEBUG: new connection from 127.0.0.1:60404 app_test.go:945: 01:47:01.769 - 40: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.771 - 38: DEBUG: new connection from 127.0.0.1:60406 app_test.go:945: 01:47:01.809 - 39: DEBUG: new connection from 127.0.0.1:46588 app_test.go:945: 01:47:01.851 - 40: DEBUG: new connection from 127.0.0.1:41702 app_test.go:945: 01:47:01.895 - 40: DEBUG: new connection from 127.0.0.1:41704 app_test.go:945: 01:47:01.935 - 38: DEBUG: new connection from 127.0.0.1:60414 app_test.go:945: 01:47:01.408 - 39: DEBUG: new connection from 127.0.0.1:46596 app_test.go:945: 01:47:01.462 - 38: DEBUG: new connection from 127.0.0.1:60418 app_test.go:945: 01:47:01.443 - 38: DEBUG: new connection from 127.0.0.1:60420 app_test.go:945: 01:47:01.485 - 41: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.486 - 38: DEBUG: new connection from 127.0.0.1:60422 app_test.go:945: 01:47:01.525 - 39: DEBUG: new connection from 127.0.0.1:46604 app_test.go:945: 01:47:01.561 - 40: DEBUG: new connection from 127.0.0.1:41718 app_test.go:945: 01:47:01.599 - 41: DEBUG: new connection from 127.0.0.1:42268 app_test.go:945: 01:47:01.657 - 41: DEBUG: new connection from 127.0.0.1:42270 app_test.go:945: 01:47:01.700 - 38: DEBUG: new connection from 127.0.0.1:60432 app_test.go:945: 01:47:01.713 - 38: DEBUG: new connection from 127.0.0.1:60434 app_test.go:945: 01:47:01.748 - 42: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:47:01.749 - 38: DEBUG: new connection from 127.0.0.1:60436 app_test.go:945: 01:47:01.795 - 39: DEBUG: new connection from 127.0.0.1:46618 app_test.go:945: 01:47:01.832 - 40: DEBUG: new connection from 127.0.0.1:41732 app_test.go:945: 01:47:01.872 - 41: DEBUG: new connection from 127.0.0.1:42282 app_test.go:945: 01:47:01.913 - 42: DEBUG: new connection from 127.0.0.1:55746 app_test.go:945: 01:47:01.954 - 42: DEBUG: new connection from 127.0.0.1:55748 app_test.go:945: 01:48:01.001 - 38: DEBUG: new connection from 127.0.0.1:60448 app_test.go:945: 01:48:01.019 - 38: DEBUG: new connection from 127.0.0.1:60450 app_test.go:945: 01:48:01.051 - 43: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.053 - 38: DEBUG: new connection from 127.0.0.1:60452 app_test.go:945: 01:48:01.095 - 39: DEBUG: new connection from 127.0.0.1:46634 app_test.go:945: 01:48:01.144 - 40: DEBUG: new connection from 127.0.0.1:41748 app_test.go:945: 01:48:01.182 - 41: DEBUG: new connection from 127.0.0.1:42298 app_test.go:945: 01:48:01.225 - 42: DEBUG: new connection from 127.0.0.1:55762 app_test.go:945: 01:48:01.264 - 43: DEBUG: new connection from 127.0.0.1:53038 app_test.go:945: 01:48:01.301 - 43: DEBUG: new connection from 127.0.0.1:53040 app_test.go:945: 01:48:01.302 - 38: DEBUG: new connection from 127.0.0.1:60466 app_test.go:945: 01:48:01.340 - 38: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.340 - 38: DEBUG: new connection from 127.0.0.1:60468 app_test.go:945: 01:48:01.342 - 38: DEBUG: new connection from 127.0.0.1:60470 app_test.go:945: 01:48:01.379 - 40: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.379 - 38: DEBUG: new connection from 127.0.0.1:60472 app_test.go:945: 01:48:01.416 - 39: DEBUG: new connection from 127.0.0.1:46654 app_test.go:945: 01:48:01.457 - 40: DEBUG: new connection from 127.0.0.1:41768 app_test.go:945: 01:48:01.493 - 41: DEBUG: new connection from 127.0.0.1:42318 app_test.go:945: 01:48:01.531 - 42: DEBUG: new connection from 127.0.0.1:55782 app_test.go:945: 01:48:01.573 - 43: DEBUG: new connection from 127.0.0.1:53058 app_test.go:945: 01:48:01.907 - 40: DEBUG: promoted 127.0.0.1:9006 from stand-by to voter --- PASS: TestHandover_VoterHonorFailureDomain (3.72s) === RUN TestHandover_SingleNode --- PASS: TestHandover_SingleNode (0.04s) === RUN TestHandover_GracefulShutdown --- PASS: TestHandover_GracefulShutdown (2.14s) === RUN TestHandover_StandBy app_test.go:945: 01:48:01.348 - 44: DEBUG: new connection from 127.0.0.1:60578 app_test.go:945: 01:48:01.388 - 44: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.389 - 44: DEBUG: new connection from 127.0.0.1:60580 app_test.go:945: 01:48:01.463 - 44: DEBUG: new connection from 127.0.0.1:60582 app_test.go:945: 01:48:01.512 - 45: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.516 - 44: DEBUG: new connection from 127.0.0.1:60584 app_test.go:945: 01:48:01.558 - 45: DEBUG: new connection from 127.0.0.1:46766 app_test.go:945: 01:48:01.631 - 44: DEBUG: new connection from 127.0.0.1:60588 app_test.go:945: 01:48:01.678 - 46: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.679 - 44: DEBUG: new connection from 127.0.0.1:60590 app_test.go:945: 01:48:01.716 - 45: DEBUG: new connection from 127.0.0.1:46772 app_test.go:945: 01:48:01.754 - 46: DEBUG: new connection from 127.0.0.1:41886 app_test.go:945: 01:48:01.798 - 46: DEBUG: new connection from 127.0.0.1:41888 app_test.go:945: 01:48:01.837 - 44: DEBUG: new connection from 127.0.0.1:60598 app_test.go:945: 01:48:01.303 - 45: DEBUG: new connection from 127.0.0.1:46780 app_test.go:945: 01:48:01.358 - 44: DEBUG: new connection from 127.0.0.1:60602 app_test.go:945: 01:48:01.339 - 44: DEBUG: new connection from 127.0.0.1:60604 app_test.go:945: 01:48:01.378 - 47: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.380 - 44: DEBUG: new connection from 127.0.0.1:60606 app_test.go:945: 01:48:01.426 - 45: DEBUG: new connection from 127.0.0.1:46788 app_test.go:945: 01:48:01.475 - 46: DEBUG: new connection from 127.0.0.1:41902 app_test.go:945: 01:48:01.516 - 47: DEBUG: new connection from 127.0.0.1:42452 app_test.go:945: 01:48:01.579 - 47: DEBUG: new connection from 127.0.0.1:42454 app_test.go:945: 01:48:01.621 - 44: DEBUG: new connection from 127.0.0.1:60616 app_test.go:945: 01:48:01.623 - 44: DEBUG: new connection from 127.0.0.1:60618 app_test.go:945: 01:48:01.679 - 48: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.681 - 44: DEBUG: new connection from 127.0.0.1:60620 app_test.go:945: 01:48:01.718 - 45: DEBUG: new connection from 127.0.0.1:46802 app_test.go:945: 01:48:01.756 - 46: DEBUG: new connection from 127.0.0.1:41916 app_test.go:945: 01:48:01.794 - 47: DEBUG: new connection from 127.0.0.1:42466 app_test.go:945: 01:48:01.830 - 48: DEBUG: new connection from 127.0.0.1:55930 app_test.go:945: 01:48:01.869 - 48: DEBUG: new connection from 127.0.0.1:55932 app_test.go:945: 01:48:01.912 - 44: DEBUG: new connection from 127.0.0.1:60632 app_test.go:945: 01:48:01.919 - 44: DEBUG: new connection from 127.0.0.1:60634 app_test.go:945: 01:48:01.974 - 49: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.976 - 44: DEBUG: new connection from 127.0.0.1:60636 app_test.go:945: 01:48:01.012 - 45: DEBUG: new connection from 127.0.0.1:46818 app_test.go:945: 01:48:01.050 - 46: DEBUG: new connection from 127.0.0.1:41932 app_test.go:945: 01:48:01.087 - 47: DEBUG: new connection from 127.0.0.1:42482 app_test.go:945: 01:48:01.123 - 48: DEBUG: new connection from 127.0.0.1:55946 app_test.go:945: 01:48:01.162 - 49: DEBUG: new connection from 127.0.0.1:53222 app_test.go:945: 01:48:01.199 - 49: DEBUG: new connection from 127.0.0.1:53224 app_test.go:945: 01:48:01.231 - 44: DEBUG: new connection from 127.0.0.1:60650 app_test.go:945: 01:48:01.242 - 44: DEBUG: new connection from 127.0.0.1:60652 app_test.go:945: 01:48:01.273 - 50: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.276 - 44: DEBUG: new connection from 127.0.0.1:60654 app_test.go:945: 01:48:01.316 - 45: DEBUG: new connection from 127.0.0.1:46836 app_test.go:945: 01:48:01.354 - 46: DEBUG: new connection from 127.0.0.1:41950 app_test.go:945: 01:48:01.394 - 47: DEBUG: new connection from 127.0.0.1:42500 app_test.go:945: 01:48:01.431 - 48: DEBUG: new connection from 127.0.0.1:55964 app_test.go:945: 01:48:01.468 - 49: DEBUG: new connection from 127.0.0.1:53240 app_test.go:945: 01:48:01.504 - 50: DEBUG: new connection from 127.0.0.1:35658 app_test.go:945: 01:48:01.543 - 44: DEBUG: new connection from 127.0.0.1:60668 app_test.go:945: 01:48:01.580 - 44: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.581 - 44: DEBUG: new connection from 127.0.0.1:60670 app_test.go:945: 01:48:01.625 - 48: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.625 - 44: DEBUG: new connection from 127.0.0.1:60672 app_test.go:945: 01:48:01.667 - 45: DEBUG: new connection from 127.0.0.1:46854 app_test.go:945: 01:48:01.707 - 46: DEBUG: new connection from 127.0.0.1:41968 app_test.go:945: 01:48:01.748 - 47: DEBUG: new connection from 127.0.0.1:42518 app_test.go:945: 01:48:01.785 - 48: DEBUG: new connection from 127.0.0.1:55982 app_test.go:945: 01:48:01.829 - 49: DEBUG: new connection from 127.0.0.1:53258 app_test.go:945: 01:48:01.870 - 50: DEBUG: new connection from 127.0.0.1:35676 app_test.go:945: 01:48:01.910 - 50: DEBUG: new connection from 127.0.0.1:35678 app_test.go:945: 01:48:01.911 - 48: DEBUG: promoted 127.0.0.1:9007 from spare to stand-by --- PASS: TestHandover_StandBy (3.86s) === RUN TestHandover_TransferLeadership app_test.go:945: 01:48:01.202 - 51: DEBUG: new connection from 127.0.0.1:60688 app_test.go:945: 01:48:01.246 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.246 - 51: DEBUG: new connection from 127.0.0.1:60690 app_test.go:945: 01:48:01.323 - 51: DEBUG: new connection from 127.0.0.1:60692 app_test.go:945: 01:48:01.361 - 52: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.364 - 51: DEBUG: new connection from 127.0.0.1:60694 app_test.go:945: 01:48:01.412 - 52: DEBUG: new connection from 127.0.0.1:46876 app_test.go:945: 01:48:01.492 - 51: DEBUG: new connection from 127.0.0.1:60698 app_test.go:945: 01:48:01.529 - 53: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.530 - 51: DEBUG: new connection from 127.0.0.1:60700 app_test.go:945: 01:48:01.568 - 52: DEBUG: new connection from 127.0.0.1:46882 app_test.go:945: 01:48:01.604 - 53: DEBUG: new connection from 127.0.0.1:41996 app_test.go:945: 01:48:01.648 - 53: DEBUG: new connection from 127.0.0.1:41998 app_test.go:945: 01:48:01.686 - 51: DEBUG: new connection from 127.0.0.1:60708 app_test.go:945: 01:48:01.165 - 52: DEBUG: new connection from 127.0.0.1:46890 app_test.go:945: 01:48:01.211 - 51: DEBUG: new connection from 127.0.0.1:60712 app_test.go:945: 01:48:01.203 - 51: DEBUG: new connection from 127.0.0.1:60714 app_test.go:945: 01:48:01.249 - 54: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.251 - 51: DEBUG: new connection from 127.0.0.1:60716 app_test.go:945: 01:48:01.295 - 52: DEBUG: new connection from 127.0.0.1:46898 app_test.go:945: 01:48:01.332 - 53: DEBUG: new connection from 127.0.0.1:42012 app_test.go:945: 01:48:01.371 - 54: DEBUG: new connection from 127.0.0.1:42562 app_test.go:945: 01:48:01.408 - 54: DEBUG: new connection from 127.0.0.1:42564 app_test.go:945: 01:48:01.409 - 51: DEBUG: new connection from 127.0.0.1:60726 app_test.go:945: 01:48:01.452 - 51: DEBUG: new connection from 127.0.0.1:60728 app_test.go:945: 01:48:01.461 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.461 - 51: DEBUG: new connection from 127.0.0.1:60730 app_test.go:945: 01:48:01.499 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.500 - 51: DEBUG: new connection from 127.0.0.1:60732 app_test.go:945: 01:48:01.539 - 52: DEBUG: new connection from 127.0.0.1:46914 app_test.go:945: 01:48:01.576 - 53: DEBUG: new connection from 127.0.0.1:42028 app_test.go:945: 01:48:01.617 - 54: DEBUG: new connection from 127.0.0.1:42578 app_test.go:945: 01:48:01.167 - 51: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter app_test.go:945: 01:48:01.168 - 51: DEBUG: new connection from 127.0.0.1:60740 app_test.go:945: 01:48:01.215 - 52: DEBUG: new connection from 127.0.0.1:46922 app_test.go:945: 01:48:01.265 - 53: DEBUG: new connection from 127.0.0.1:42036 app_test.go:945: 01:48:01.303 - 54: DEBUG: new connection from 127.0.0.1:42586 app_test.go:945: 01:48:01.344 - 52: DEBUG: new connection from 127.0.0.1:46928 app_test.go:945: 01:48:01.346 - 53: DEBUG: new connection from 127.0.0.1:42042 app_test.go:945: 01:48:01.386 - 54: DEBUG: new connection from 127.0.0.1:42592 app_test.go:945: 01:48:01.393 - 54: DEBUG: new connection from 127.0.0.1:42594 app_test.go:945: 01:48:01.436 - 51: DEBUG: new connection from 127.0.0.1:60756 app_test.go:945: 01:48:01.479 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9004 app_test.go:945: 01:48:01.479 - 54: DEBUG: new connection from 127.0.0.1:42598 app_test.go:945: 01:48:01.516 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.517 - 53: DEBUG: new connection from 127.0.0.1:42052 app_test.go:945: 01:48:01.518 - 51: DEBUG: new connection from 127.0.0.1:60762 app_test.go:945: 01:48:01.562 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002 app_test.go:945: 01:48:01.562 - 52: DEBUG: new connection from 127.0.0.1:46944 app_test.go:945: 01:48:01.572 - 52: DEBUG: new connection from 127.0.0.1:46946 app_test.go:945: 01:48:01.606 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.620 - 51: DEBUG: new connection from 127.0.0.1:60768 app_test.go:945: 01:48:01.671 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9003 app_test.go:945: 01:48:01.671 - 53: DEBUG: new connection from 127.0.0.1:42062 app_test.go:945: 01:48:01.721 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.723 - 51: DEBUG: new connection from 127.0.0.1:60772 app_test.go:945: 01:48:01.775 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9003 app_test.go:945: 01:48:01.775 - 53: DEBUG: new connection from 127.0.0.1:42066 app_test.go:945: 01:48:01.811 - 51: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestHandover_TransferLeadership (3.80s) === RUN TestRolesAdjustment_ReplaceVoter app_test.go:945: 01:48:01.002 - 55: DEBUG: new connection from 127.0.0.1:60776 app_test.go:945: 01:48:01.050 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.051 - 55: DEBUG: new connection from 127.0.0.1:60778 app_test.go:945: 01:48:01.120 - 55: DEBUG: new connection from 127.0.0.1:60780 app_test.go:945: 01:48:01.165 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.168 - 55: DEBUG: new connection from 127.0.0.1:60782 app_test.go:945: 01:48:01.215 - 56: DEBUG: new connection from 127.0.0.1:46964 app_test.go:945: 01:48:01.311 - 55: DEBUG: new connection from 127.0.0.1:60786 app_test.go:945: 01:48:01.369 - 57: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.370 - 55: DEBUG: new connection from 127.0.0.1:60788 app_test.go:945: 01:48:01.418 - 56: DEBUG: new connection from 127.0.0.1:46970 app_test.go:945: 01:48:01.459 - 57: DEBUG: new connection from 127.0.0.1:42084 app_test.go:945: 01:48:01.501 - 57: DEBUG: new connection from 127.0.0.1:42086 app_test.go:945: 01:48:01.542 - 55: DEBUG: new connection from 127.0.0.1:60796 app_test.go:945: 01:48:01.591 - 55: DEBUG: new connection from 127.0.0.1:60798 app_test.go:945: 01:48:01.629 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.630 - 55: DEBUG: new connection from 127.0.0.1:60800 app_test.go:945: 01:48:01.667 - 56: DEBUG: new connection from 127.0.0.1:46982 app_test.go:945: 01:48:01.704 - 57: DEBUG: new connection from 127.0.0.1:42096 app_test.go:945: 01:48:01.741 - 55: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.741 - 55: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.741 - 55: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.765 - 55: DEBUG: new connection from 127.0.0.1:60806 app_test.go:945: 01:48:01.830 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.242 - 55: DEBUG: new connection from 127.0.0.1:60808 app_test.go:945: 01:48:01.286 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.287 - 55: DEBUG: new connection from 127.0.0.1:60810 app_test.go:945: 01:48:01.325 - 56: DEBUG: new connection from 127.0.0.1:46992 app_test.go:945: 01:48:01.362 - 55: DEBUG: new connection from 127.0.0.1:60814 app_test.go:945: 01:48:01.362 - 57: DEBUG: new connection from 127.0.0.1:42108 app_test.go:945: 01:48:01.410 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.412 - 55: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.412 - 55: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.412 - 55: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.462 - 56: DEBUG: new connection from 127.0.0.1:46998 app_test.go:945: 01:48:01.501 - 55: DEBUG: new connection from 127.0.0.1:60820 app_test.go:945: 01:48:01.912 - 55: DEBUG: new connection from 127.0.0.1:60822 app_test.go:945: 01:48:01.912 - 55: DEBUG: new connection from 127.0.0.1:60824 app_test.go:945: 01:48:01.953 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.958 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.959 - 55: DEBUG: new connection from 127.0.0.1:60826 app_test.go:945: 01:48:01.996 - 56: DEBUG: new connection from 127.0.0.1:47008 app_test.go:945: 01:48:01.037 - 57: DEBUG: new connection from 127.0.0.1:42122 app_test.go:945: 01:48:01.074 - 55: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.074 - 55: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.455 - 55: DEBUG: new connection from 127.0.0.1:60832 app_test.go:945: 01:48:01.499 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.507 - 55: DEBUG: new connection from 127.0.0.1:60834 app_test.go:945: 01:48:01.548 - 58: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.550 - 55: DEBUG: new connection from 127.0.0.1:60836 app_test.go:945: 01:48:01.600 - 55: DEBUG: new connection from 127.0.0.1:60838 app_test.go:945: 01:48:01.600 - 56: DEBUG: new connection from 127.0.0.1:47020 app_test.go:945: 01:48:01.649 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.650 - 57: DEBUG: new connection from 127.0.0.1:42134 app_test.go:945: 01:48:01.651 - 55: DEBUG: new connection from 127.0.0.1:60844 app_test.go:945: 01:48:01.693 - 58: DEBUG: new connection from 127.0.0.1:42686 app_test.go:945: 01:48:01.703 - 56: DEBUG: new connection from 127.0.0.1:47028 app_test.go:945: 01:48:01.737 - 58: DEBUG: new connection from 127.0.0.1:42690 app_test.go:945: 01:48:01.753 - 58: DEBUG: new connection from 127.0.0.1:42694 app_test.go:945: 01:48:01.779 - 55: DEBUG: new connection from 127.0.0.1:60856 app_test.go:945: 01:48:01.001 - 55: DEBUG: new connection from 127.0.0.1:60858 app_test.go:945: 01:48:01.040 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.239 - 55: DEBUG: new connection from 127.0.0.1:60860 app_test.go:945: 01:48:01.282 - 58: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.463 - 55: DEBUG: new connection from 127.0.0.1:60864 app_test.go:945: 01:48:01.505 - 56: DEBUG: new connection from 127.0.0.1:47046 app_test.go:945: 01:48:01.542 - 55: DEBUG: new connection from 127.0.0.1:60868 app_test.go:945: 01:48:01.571 - 58: DEBUG: new connection from 127.0.0.1:42712 app_test.go:945: 01:48:01.588 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.611 - 55: DEBUG: new connection from 127.0.0.1:60874 app_test.go:945: 01:48:01.647 - 56: DEBUG: new connection from 127.0.0.1:47056 app_test.go:945: 01:48:01.684 - 58: DEBUG: new connection from 127.0.0.1:42720 app_test.go:945: 01:48:01.783 - 55: DEBUG: new connection from 127.0.0.1:60882 app_test.go:945: 01:48:01.841 - 58: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.090 - 55: DEBUG: new connection from 127.0.0.1:60884 app_test.go:945: 01:48:01.150 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.220 - 55: DEBUG: new connection from 127.0.0.1:60886 app_test.go:945: 01:48:01.257 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.258 - 55: DEBUG: new connection from 127.0.0.1:60888 app_test.go:945: 01:48:01.318 - 56: DEBUG: new connection from 127.0.0.1:47070 app_test.go:945: 01:48:01.371 - 55: DEBUG: new connection from 127.0.0.1:60892 app_test.go:945: 01:48:01.372 - 58: DEBUG: new connection from 127.0.0.1:42736 app_test.go:945: 01:48:01.427 - 58: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.652 - 55: DEBUG: new connection from 127.0.0.1:60900 app_test.go:945: 01:48:01.702 - 56: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.768 - 55: DEBUG: new connection from 127.0.0.1:60902 app_test.go:945: 01:48:01.812 - 55: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestRolesAdjustment_ReplaceVoter (4.97s) === RUN TestRolesAdjustment_ReplaceVoterHonorFailureDomain app_test.go:945: 01:48:01.966 - 59: DEBUG: new connection from 127.0.0.1:60904 app_test.go:945: 01:48:01.022 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.023 - 59: DEBUG: new connection from 127.0.0.1:60906 app_test.go:945: 01:48:01.124 - 59: DEBUG: new connection from 127.0.0.1:60908 app_test.go:945: 01:48:01.168 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.172 - 59: DEBUG: new connection from 127.0.0.1:60910 app_test.go:945: 01:48:01.218 - 60: DEBUG: new connection from 127.0.0.1:47092 app_test.go:945: 01:48:01.299 - 59: DEBUG: new connection from 127.0.0.1:60914 app_test.go:945: 01:48:01.337 - 61: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.339 - 59: DEBUG: new connection from 127.0.0.1:60916 app_test.go:945: 01:48:01.380 - 60: DEBUG: new connection from 127.0.0.1:47098 app_test.go:945: 01:48:01.416 - 61: DEBUG: new connection from 127.0.0.1:42212 app_test.go:945: 01:48:01.461 - 61: DEBUG: new connection from 127.0.0.1:42214 app_test.go:945: 01:48:01.501 - 59: DEBUG: new connection from 127.0.0.1:60924 app_test.go:945: 01:48:01.572 - 59: DEBUG: new connection from 127.0.0.1:60926 app_test.go:945: 01:48:01.609 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.610 - 59: DEBUG: new connection from 127.0.0.1:60928 app_test.go:945: 01:48:01.647 - 60: DEBUG: new connection from 127.0.0.1:47110 app_test.go:945: 01:48:01.684 - 61: DEBUG: new connection from 127.0.0.1:42224 app_test.go:945: 01:48:01.721 - 59: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.721 - 59: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.721 - 59: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.758 - 59: DEBUG: new connection from 127.0.0.1:60934 app_test.go:945: 01:48:01.802 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.222 - 59: DEBUG: new connection from 127.0.0.1:60936 app_test.go:945: 01:48:01.261 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.263 - 59: DEBUG: new connection from 127.0.0.1:60938 app_test.go:945: 01:48:01.301 - 60: DEBUG: new connection from 127.0.0.1:47120 app_test.go:945: 01:48:01.303 - 59: DEBUG: new connection from 127.0.0.1:60942 app_test.go:945: 01:48:01.341 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.362 - 61: DEBUG: new connection from 127.0.0.1:42236 app_test.go:945: 01:48:01.403 - 59: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.403 - 59: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.403 - 59: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.434 - 60: DEBUG: new connection from 127.0.0.1:47126 app_test.go:945: 01:48:01.475 - 59: DEBUG: new connection from 127.0.0.1:60948 app_test.go:945: 01:48:01.843 - 59: DEBUG: new connection from 127.0.0.1:60950 app_test.go:945: 01:48:01.887 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.904 - 59: DEBUG: new connection from 127.0.0.1:60952 app_test.go:945: 01:48:01.943 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.944 - 59: DEBUG: new connection from 127.0.0.1:60954 app_test.go:945: 01:48:01.991 - 60: DEBUG: new connection from 127.0.0.1:47136 app_test.go:945: 01:48:01.029 - 61: DEBUG: new connection from 127.0.0.1:42250 app_test.go:945: 01:48:01.070 - 59: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.070 - 59: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.389 - 59: DEBUG: new connection from 127.0.0.1:60960 app_test.go:945: 01:48:01.428 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.471 - 59: DEBUG: new connection from 127.0.0.1:60962 app_test.go:945: 01:48:01.530 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.532 - 59: DEBUG: new connection from 127.0.0.1:60964 app_test.go:945: 01:48:01.577 - 59: DEBUG: new connection from 127.0.0.1:60966 app_test.go:945: 01:48:01.577 - 60: DEBUG: new connection from 127.0.0.1:47148 app_test.go:945: 01:48:01.614 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.615 - 59: DEBUG: new connection from 127.0.0.1:60970 app_test.go:945: 01:48:01.630 - 61: DEBUG: new connection from 127.0.0.1:42264 app_test.go:945: 01:48:01.666 - 60: DEBUG: new connection from 127.0.0.1:47154 app_test.go:945: 01:48:01.679 - 62: DEBUG: new connection from 127.0.0.1:42816 app_test.go:945: 01:48:01.705 - 61: DEBUG: new connection from 127.0.0.1:42270 app_test.go:945: 01:48:01.722 - 62: DEBUG: new connection from 127.0.0.1:42820 app_test.go:945: 01:48:01.743 - 62: DEBUG: new connection from 127.0.0.1:42822 app_test.go:945: 01:48:01.762 - 59: DEBUG: new connection from 127.0.0.1:60984 app_test.go:945: 01:48:01.771 - 59: DEBUG: new connection from 127.0.0.1:60986 app_test.go:945: 01:48:01.798 - 59: WARN: change 127.0.0.1:9004 from spare to stand-by: server role is not valid (1) app_test.go:945: 01:48:01.798 - 59: WARN: adjust roles: could not assign role stand-by to any node app_test.go:945: 01:48:01.810 - 63: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.813 - 59: DEBUG: new connection from 127.0.0.1:60988 app_test.go:945: 01:48:01.850 - 60: DEBUG: new connection from 127.0.0.1:47170 app_test.go:945: 01:48:01.887 - 61: DEBUG: new connection from 127.0.0.1:42284 app_test.go:945: 01:48:01.924 - 62: DEBUG: new connection from 127.0.0.1:42834 app_test.go:945: 01:48:01.932 - 59: DEBUG: new connection from 127.0.0.1:60996 app_test.go:945: 01:48:01.934 - 59: DEBUG: new connection from 127.0.0.1:60998 app_test.go:945: 01:48:01.961 - 63: DEBUG: new connection from 127.0.0.1:56302 app_test.go:945: 01:48:01.970 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.971 - 61: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.999 - 63: DEBUG: new connection from 127.0.0.1:56304 app_test.go:945: 01:48:01.038 - 59: DEBUG: new connection from 127.0.0.1:32772 app_test.go:945: 01:48:01.039 - 59: DEBUG: new connection from 127.0.0.1:32774 app_test.go:945: 01:48:01.079 - 64: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.081 - 59: DEBUG: new connection from 127.0.0.1:32776 app_test.go:945: 01:48:01.117 - 60: DEBUG: new connection from 127.0.0.1:47190 app_test.go:945: 01:48:01.155 - 61: DEBUG: new connection from 127.0.0.1:42304 app_test.go:945: 01:48:01.191 - 62: DEBUG: new connection from 127.0.0.1:42854 app_test.go:945: 01:48:01.228 - 63: DEBUG: new connection from 127.0.0.1:56318 app_test.go:945: 01:48:01.231 - 59: DEBUG: new connection from 127.0.0.1:32786 app_test.go:945: 01:48:01.267 - 64: DEBUG: new connection from 127.0.0.1:53596 app_test.go:945: 01:48:01.270 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.304 - 59: DEBUG: new connection from 127.0.0.1:32790 app_test.go:945: 01:48:01.304 - 64: DEBUG: new connection from 127.0.0.1:53600 app_test.go:945: 01:48:01.347 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.348 - 59: DEBUG: new connection from 127.0.0.1:32794 app_test.go:945: 01:48:01.349 - 59: DEBUG: new connection from 127.0.0.1:32796 app_test.go:945: 01:48:01.403 - 60: DEBUG: new connection from 127.0.0.1:47210 app_test.go:945: 01:48:01.470 - 62: DEBUG: new connection from 127.0.0.1:42874 app_test.go:945: 01:48:01.472 - 59: DEBUG: new connection from 127.0.0.1:32804 app_test.go:945: 01:48:01.501 - 59: DEBUG: new connection from 127.0.0.1:32806 app_test.go:945: 01:48:01.520 - 63: DEBUG: new connection from 127.0.0.1:56342 app_test.go:945: 01:48:01.532 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.558 - 63: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.580 - 64: DEBUG: new connection from 127.0.0.1:53618 app_test.go:945: 01:48:01.771 - 59: DEBUG: new connection from 127.0.0.1:32812 app_test.go:945: 01:48:01.807 - 59: DEBUG: new connection from 127.0.0.1:32814 app_test.go:945: 01:48:01.808 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.844 - 64: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.937 - 59: DEBUG: new connection from 127.0.0.1:32818 app_test.go:945: 01:48:01.978 - 60: DEBUG: new connection from 127.0.0.1:47232 app_test.go:945: 01:48:01.025 - 62: DEBUG: new connection from 127.0.0.1:42896 app_test.go:945: 01:48:01.043 - 59: DEBUG: new connection from 127.0.0.1:32826 app_test.go:945: 01:48:01.063 - 59: DEBUG: new connection from 127.0.0.1:32828 app_test.go:945: 01:48:01.073 - 63: DEBUG: new connection from 127.0.0.1:56364 app_test.go:945: 01:48:01.086 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.102 - 63: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.123 - 64: DEBUG: new connection from 127.0.0.1:53640 app_test.go:945: 01:48:01.164 - 59: DEBUG: new connection from 127.0.0.1:32834 app_test.go:945: 01:48:01.200 - 60: DEBUG: new connection from 127.0.0.1:47248 app_test.go:945: 01:48:01.243 - 62: DEBUG: new connection from 127.0.0.1:42912 app_test.go:945: 01:48:01.280 - 63: DEBUG: new connection from 127.0.0.1:56376 app_test.go:945: 01:48:01.319 - 64: DEBUG: new connection from 127.0.0.1:53652 app_test.go:945: 01:48:01.319 - 59: DEBUG: new connection from 127.0.0.1:32846 app_test.go:945: 01:48:01.355 - 59: DEBUG: new connection from 127.0.0.1:32848 app_test.go:945: 01:48:01.355 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.393 - 64: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.588 - 59: DEBUG: new connection from 127.0.0.1:32850 app_test.go:945: 01:48:01.604 - 59: DEBUG: new connection from 127.0.0.1:32852 app_test.go:945: 01:48:01.633 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.653 - 63: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.857 - 59: DEBUG: new connection from 127.0.0.1:32854 app_test.go:945: 01:48:01.877 - 59: DEBUG: new connection from 127.0.0.1:32856 app_test.go:945: 01:48:01.895 - 59: DEBUG: new connection from 127.0.0.1:32858 app_test.go:945: 01:48:01.895 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.918 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.919 - 59: DEBUG: new connection from 127.0.0.1:32860 app_test.go:945: 01:48:01.951 - 64: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.959 - 60: DEBUG: new connection from 127.0.0.1:47276 app_test.go:945: 01:48:01.007 - 62: DEBUG: new connection from 127.0.0.1:42940 app_test.go:945: 01:48:01.049 - 63: DEBUG: new connection from 127.0.0.1:56404 app_test.go:945: 01:48:01.087 - 64: DEBUG: new connection from 127.0.0.1:53680 app_test.go:945: 01:48:01.137 - 59: DEBUG: new connection from 127.0.0.1:32874 app_test.go:945: 01:48:01.159 - 59: DEBUG: new connection from 127.0.0.1:32876 app_test.go:945: 01:48:01.175 - 60: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.198 - 63: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.341 - 59: DEBUG: new connection from 127.0.0.1:32878 app_test.go:945: 01:48:01.380 - 59: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.398 - 59: DEBUG: new connection from 127.0.0.1:32880 app_test.go:945: 01:48:01.438 - 62: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestRolesAdjustment_ReplaceVoterHonorFailureDomain (5.63s) === RUN TestRolesAdjustment_ReplaceVoterHonorWeight app_test.go:945: 01:48:01.607 - 65: DEBUG: new connection from 127.0.0.1:32886 app_test.go:945: 01:48:01.646 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.647 - 65: DEBUG: new connection from 127.0.0.1:32888 app_test.go:945: 01:48:01.732 - 65: DEBUG: new connection from 127.0.0.1:32890 app_test.go:945: 01:48:01.769 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.773 - 65: DEBUG: new connection from 127.0.0.1:32892 app_test.go:945: 01:48:01.811 - 66: DEBUG: new connection from 127.0.0.1:47306 app_test.go:945: 01:48:01.891 - 65: DEBUG: new connection from 127.0.0.1:32896 app_test.go:945: 01:48:01.936 - 67: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.938 - 65: DEBUG: new connection from 127.0.0.1:32898 app_test.go:945: 01:48:01.975 - 66: DEBUG: new connection from 127.0.0.1:47312 app_test.go:945: 01:48:01.013 - 67: DEBUG: new connection from 127.0.0.1:42426 app_test.go:945: 01:48:01.060 - 67: DEBUG: new connection from 127.0.0.1:42428 app_test.go:945: 01:48:01.102 - 65: DEBUG: new connection from 127.0.0.1:32906 app_test.go:945: 01:48:01.190 - 65: DEBUG: new connection from 127.0.0.1:32908 app_test.go:945: 01:48:01.229 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.230 - 65: DEBUG: new connection from 127.0.0.1:32910 app_test.go:945: 01:48:01.285 - 66: DEBUG: new connection from 127.0.0.1:47324 app_test.go:945: 01:48:01.341 - 67: DEBUG: new connection from 127.0.0.1:42438 app_test.go:945: 01:48:01.379 - 65: DEBUG: new connection from 127.0.0.1:32916 app_test.go:945: 01:48:01.380 - 65: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.390 - 65: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.390 - 65: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.416 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.565 - 66: DEBUG: new connection from 127.0.0.1:47330 app_test.go:945: 01:48:01.604 - 65: DEBUG: new connection from 127.0.0.1:32920 app_test.go:945: 01:48:01.890 - 65: DEBUG: new connection from 127.0.0.1:32922 app_test.go:945: 01:48:01.928 - 65: DEBUG: new connection from 127.0.0.1:32924 app_test.go:945: 01:48:01.929 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.930 - 65: DEBUG: new connection from 127.0.0.1:32926 app_test.go:945: 01:48:01.970 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.980 - 66: DEBUG: new connection from 127.0.0.1:47340 app_test.go:945: 01:48:01.023 - 67: DEBUG: new connection from 127.0.0.1:42454 app_test.go:945: 01:48:01.060 - 65: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.061 - 65: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.472 - 65: DEBUG: new connection from 127.0.0.1:32932 app_test.go:945: 01:48:01.515 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.562 - 65: DEBUG: new connection from 127.0.0.1:32934 app_test.go:945: 01:48:01.600 - 65: DEBUG: new connection from 127.0.0.1:32936 app_test.go:945: 01:48:01.611 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.613 - 65: DEBUG: new connection from 127.0.0.1:32938 app_test.go:945: 01:48:01.644 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.646 - 65: DEBUG: new connection from 127.0.0.1:32940 app_test.go:945: 01:48:01.661 - 66: DEBUG: new connection from 127.0.0.1:47354 app_test.go:945: 01:48:01.688 - 66: DEBUG: new connection from 127.0.0.1:47356 app_test.go:945: 01:48:01.701 - 67: DEBUG: new connection from 127.0.0.1:42470 app_test.go:945: 01:48:01.731 - 67: DEBUG: new connection from 127.0.0.1:42472 app_test.go:945: 01:48:01.774 - 68: DEBUG: new connection from 127.0.0.1:43022 app_test.go:945: 01:48:01.820 - 68: DEBUG: new connection from 127.0.0.1:43024 app_test.go:945: 01:48:01.872 - 65: DEBUG: new connection from 127.0.0.1:32954 app_test.go:945: 01:48:01.875 - 65: DEBUG: new connection from 127.0.0.1:32956 app_test.go:945: 01:48:01.922 - 69: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.924 - 65: DEBUG: new connection from 127.0.0.1:32958 app_test.go:945: 01:48:01.978 - 66: DEBUG: new connection from 127.0.0.1:47372 app_test.go:945: 01:48:01.022 - 65: DEBUG: new connection from 127.0.0.1:32962 app_test.go:945: 01:48:01.029 - 67: DEBUG: new connection from 127.0.0.1:42488 app_test.go:945: 01:48:01.071 - 65: DEBUG: new connection from 127.0.0.1:32966 app_test.go:945: 01:48:01.071 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.081 - 68: DEBUG: new connection from 127.0.0.1:43040 app_test.go:945: 01:48:01.125 - 69: DEBUG: new connection from 127.0.0.1:56504 app_test.go:945: 01:48:01.127 - 67: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.174 - 69: DEBUG: new connection from 127.0.0.1:56506 app_test.go:945: 01:48:01.216 - 65: DEBUG: new connection from 127.0.0.1:32974 app_test.go:945: 01:48:01.244 - 65: DEBUG: new connection from 127.0.0.1:32976 app_test.go:945: 01:48:01.256 - 65: DEBUG: new connection from 127.0.0.1:32978 app_test.go:945: 01:48:01.283 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.284 - 70: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.285 - 65: DEBUG: new connection from 127.0.0.1:32980 app_test.go:945: 01:48:01.286 - 65: DEBUG: new connection from 127.0.0.1:32982 app_test.go:945: 01:48:01.322 - 65: DEBUG: new connection from 127.0.0.1:32984 app_test.go:945: 01:48:01.345 - 66: DEBUG: new connection from 127.0.0.1:47398 app_test.go:945: 01:48:01.375 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.375 - 66: DEBUG: new connection from 127.0.0.1:47400 app_test.go:945: 01:48:01.425 - 67: DEBUG: new connection from 127.0.0.1:42514 app_test.go:945: 01:48:01.427 - 67: DEBUG: new connection from 127.0.0.1:42516 app_test.go:945: 01:48:01.470 - 68: DEBUG: new connection from 127.0.0.1:43066 app_test.go:945: 01:48:01.478 - 68: DEBUG: new connection from 127.0.0.1:43068 app_test.go:945: 01:48:01.529 - 69: DEBUG: new connection from 127.0.0.1:56532 app_test.go:945: 01:48:01.529 - 69: DEBUG: new connection from 127.0.0.1:56534 app_test.go:945: 01:48:01.574 - 65: DEBUG: new connection from 127.0.0.1:33002 app_test.go:945: 01:48:01.581 - 70: DEBUG: new connection from 127.0.0.1:53812 app_test.go:945: 01:48:01.590 - 70: DEBUG: new connection from 127.0.0.1:53814 app_test.go:945: 01:48:01.626 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.631 - 65: DEBUG: new connection from 127.0.0.1:33008 app_test.go:945: 01:48:01.644 - 70: DEBUG: new connection from 127.0.0.1:53818 app_test.go:945: 01:48:01.646 - 65: WARN: change 127.0.0.1:9006 from spare to stand-by: server role is not valid (1) app_test.go:945: 01:48:01.646 - 65: WARN: adjust roles: could not assign role stand-by to any node app_test.go:945: 01:48:01.675 - 65: DEBUG: new connection from 127.0.0.1:33012 app_test.go:945: 01:48:01.690 - 65: DEBUG: new connection from 127.0.0.1:33014 app_test.go:945: 01:48:01.701 - 67: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.728 - 69: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.878 - 65: DEBUG: new connection from 127.0.0.1:33016 app_test.go:945: 01:48:01.928 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.129 - 65: DEBUG: new connection from 127.0.0.1:33018 app_test.go:945: 01:48:01.152 - 65: DEBUG: new connection from 127.0.0.1:33020 app_test.go:945: 01:48:01.152 - 65: DEBUG: new connection from 127.0.0.1:33022 app_test.go:945: 01:48:01.177 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.207 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.208 - 65: DEBUG: new connection from 127.0.0.1:33024 app_test.go:945: 01:48:01.208 - 70: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.233 - 65: DEBUG: new connection from 127.0.0.1:33026 app_test.go:945: 01:48:01.258 - 66: DEBUG: new connection from 127.0.0.1:47440 app_test.go:945: 01:48:01.293 - 69: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.318 - 68: DEBUG: new connection from 127.0.0.1:43104 app_test.go:945: 01:48:01.380 - 69: DEBUG: new connection from 127.0.0.1:56568 app_test.go:945: 01:48:01.430 - 65: DEBUG: new connection from 127.0.0.1:33036 app_test.go:945: 01:48:01.460 - 70: DEBUG: new connection from 127.0.0.1:53846 app_test.go:945: 01:48:01.486 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.526 - 65: DEBUG: new connection from 127.0.0.1:33042 app_test.go:945: 01:48:01.592 - 66: DEBUG: new connection from 127.0.0.1:47456 app_test.go:945: 01:48:01.633 - 68: DEBUG: new connection from 127.0.0.1:43120 app_test.go:945: 01:48:01.673 - 69: DEBUG: new connection from 127.0.0.1:56584 app_test.go:945: 01:48:01.693 - 65: DEBUG: new connection from 127.0.0.1:33052 app_test.go:945: 01:48:01.714 - 65: DEBUG: new connection from 127.0.0.1:33054 app_test.go:945: 01:48:01.732 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.736 - 70: DEBUG: new connection from 127.0.0.1:53864 app_test.go:945: 01:48:01.791 - 70: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.796 - 65: DEBUG: new connection from 127.0.0.1:33058 app_test.go:945: 01:48:01.800 - 65: DEBUG: new connection from 127.0.0.1:33060 app_test.go:945: 01:48:01.843 - 69: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.858 - 66: DEBUG: new connection from 127.0.0.1:47474 app_test.go:945: 01:48:01.941 - 68: DEBUG: new connection from 127.0.0.1:43138 app_test.go:945: 01:48:01.995 - 65: DEBUG: new connection from 127.0.0.1:33068 app_test.go:945: 01:48:01.016 - 69: DEBUG: new connection from 127.0.0.1:56604 app_test.go:945: 01:48:01.037 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.071 - 70: DEBUG: new connection from 127.0.0.1:53880 app_test.go:945: 01:48:01.233 - 65: DEBUG: new connection from 127.0.0.1:33074 app_test.go:945: 01:48:01.282 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.293 - 65: DEBUG: new connection from 127.0.0.1:33076 app_test.go:945: 01:48:01.330 - 70: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.345 - 65: DEBUG: new connection from 127.0.0.1:33078 app_test.go:945: 01:48:01.391 - 69: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.540 - 65: DEBUG: new connection from 127.0.0.1:33082 app_test.go:945: 01:48:01.592 - 68: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.610 - 65: DEBUG: new connection from 127.0.0.1:33084 app_test.go:945: 01:48:01.658 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.659 - 65: DEBUG: new connection from 127.0.0.1:33086 app_test.go:945: 01:48:01.715 - 66: DEBUG: new connection from 127.0.0.1:47500 app_test.go:945: 01:48:01.771 - 68: DEBUG: new connection from 127.0.0.1:43166 app_test.go:945: 01:48:01.771 - 65: DEBUG: new connection from 127.0.0.1:33090 app_test.go:945: 01:48:01.791 - 65: DEBUG: new connection from 127.0.0.1:33096 app_test.go:945: 01:48:01.820 - 65: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.828 - 69: DEBUG: new connection from 127.0.0.1:56632 app_test.go:945: 01:48:01.852 - 66: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.867 - 65: DEBUG: new connection from 127.0.0.1:33106 app_test.go:945: 01:48:01.919 - 66: DEBUG: new connection from 127.0.0.1:47520 --- PASS: TestRolesAdjustment_ReplaceVoterHonorWeight (5.43s) === RUN TestRolesAdjustment_CantReplaceVoter app_test.go:945: 01:48:01.030 - 71: DEBUG: new connection from 127.0.0.1:33118 app_test.go:945: 01:48:01.068 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.069 - 71: DEBUG: new connection from 127.0.0.1:33120 app_test.go:945: 01:48:01.175 - 71: DEBUG: new connection from 127.0.0.1:33122 app_test.go:945: 01:48:01.213 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.217 - 71: DEBUG: new connection from 127.0.0.1:33124 app_test.go:945: 01:48:01.255 - 72: DEBUG: new connection from 127.0.0.1:47538 app_test.go:945: 01:48:01.352 - 71: DEBUG: new connection from 127.0.0.1:33128 app_test.go:945: 01:48:01.388 - 73: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.390 - 71: DEBUG: new connection from 127.0.0.1:33130 app_test.go:945: 01:48:01.426 - 72: DEBUG: new connection from 127.0.0.1:47544 app_test.go:945: 01:48:01.462 - 73: DEBUG: new connection from 127.0.0.1:42658 app_test.go:945: 01:48:01.505 - 73: DEBUG: new connection from 127.0.0.1:42660 app_test.go:945: 01:48:01.547 - 71: DEBUG: new connection from 127.0.0.1:33138 app_test.go:945: 01:48:01.638 - 71: DEBUG: new connection from 127.0.0.1:33140 app_test.go:945: 01:48:01.678 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.679 - 71: DEBUG: new connection from 127.0.0.1:33142 app_test.go:945: 01:48:01.716 - 72: DEBUG: new connection from 127.0.0.1:47556 app_test.go:945: 01:48:01.754 - 73: DEBUG: new connection from 127.0.0.1:42670 app_test.go:945: 01:48:01.791 - 71: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.791 - 71: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.791 - 71: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.798 - 71: DEBUG: new connection from 127.0.0.1:33148 app_test.go:945: 01:48:01.842 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.291 - 71: DEBUG: new connection from 127.0.0.1:33150 app_test.go:945: 01:48:01.330 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.334 - 71: DEBUG: new connection from 127.0.0.1:33152 app_test.go:945: 01:48:01.359 - 71: DEBUG: new connection from 127.0.0.1:33154 app_test.go:945: 01:48:01.381 - 72: DEBUG: new connection from 127.0.0.1:47568 app_test.go:945: 01:48:01.396 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.426 - 73: DEBUG: new connection from 127.0.0.1:42682 app_test.go:945: 01:48:01.467 - 71: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.467 - 71: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.468 - 71: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.492 - 72: DEBUG: new connection from 127.0.0.1:47572 app_test.go:945: 01:48:01.536 - 71: DEBUG: new connection from 127.0.0.1:33162 app_test.go:945: 01:48:01.898 - 71: DEBUG: new connection from 127.0.0.1:33164 app_test.go:945: 01:48:01.949 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.968 - 71: DEBUG: new connection from 127.0.0.1:33166 app_test.go:945: 01:48:01.016 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.017 - 71: DEBUG: new connection from 127.0.0.1:33168 app_test.go:945: 01:48:01.056 - 72: DEBUG: new connection from 127.0.0.1:47582 app_test.go:945: 01:48:01.094 - 73: DEBUG: new connection from 127.0.0.1:42696 app_test.go:945: 01:48:01.138 - 71: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.138 - 71: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.451 - 71: DEBUG: new connection from 127.0.0.1:33174 app_test.go:945: 01:48:01.533 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.552 - 71: DEBUG: new connection from 127.0.0.1:33176 app_test.go:945: 01:48:01.620 - 74: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.622 - 71: DEBUG: new connection from 127.0.0.1:33178 app_test.go:945: 01:48:01.639 - 71: DEBUG: new connection from 127.0.0.1:33180 app_test.go:945: 01:48:01.683 - 72: DEBUG: new connection from 127.0.0.1:47594 app_test.go:945: 01:48:01.685 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.686 - 71: DEBUG: new connection from 127.0.0.1:33184 app_test.go:945: 01:48:01.741 - 72: DEBUG: new connection from 127.0.0.1:47598 app_test.go:945: 01:48:01.743 - 73: DEBUG: new connection from 127.0.0.1:42712 app_test.go:945: 01:48:01.788 - 74: DEBUG: new connection from 127.0.0.1:43262 app_test.go:945: 01:48:01.819 - 73: DEBUG: new connection from 127.0.0.1:42716 app_test.go:945: 01:48:01.857 - 74: DEBUG: new connection from 127.0.0.1:43266 app_test.go:945: 01:48:01.034 - 71: DEBUG: new connection from 127.0.0.1:33198 app_test.go:945: 01:48:01.090 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.361 - 71: DEBUG: new connection from 127.0.0.1:33200 app_test.go:945: 01:48:01.420 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.421 - 71: DEBUG: new connection from 127.0.0.1:33202 app_test.go:945: 01:48:01.471 - 72: DEBUG: new connection from 127.0.0.1:47616 app_test.go:945: 01:48:01.593 - 71: DEBUG: new connection from 127.0.0.1:33214 app_test.go:945: 01:48:01.652 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.024 - 71: DEBUG: new connection from 127.0.0.1:33216 app_test.go:945: 01:48:01.076 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.077 - 71: DEBUG: new connection from 127.0.0.1:33218 app_test.go:945: 01:48:01.136 - 72: DEBUG: new connection from 127.0.0.1:47632 app_test.go:945: 01:48:01.179 - 71: DEBUG: new connection from 127.0.0.1:33222 app_test.go:945: 01:48:01.242 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.702 - 71: DEBUG: new connection from 127.0.0.1:33232 app_test.go:945: 01:48:01.754 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.757 - 71: DEBUG: new connection from 127.0.0.1:33234 app_test.go:945: 01:48:01.757 - 71: DEBUG: new connection from 127.0.0.1:33236 app_test.go:945: 01:48:01.803 - 72: DEBUG: new connection from 127.0.0.1:47650 app_test.go:945: 01:48:01.812 - 72: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.900 - 71: DEBUG: new connection from 127.0.0.1:33244 app_test.go:945: 01:48:01.941 - 71: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestRolesAdjustment_CantReplaceVoter (5.03s) === RUN TestRolesAdjustment_ReplaceStandBy app_test.go:945: 01:48:01.085 - 75: DEBUG: new connection from 127.0.0.1:33246 app_test.go:945: 01:48:01.162 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.163 - 75: DEBUG: new connection from 127.0.0.1:33248 app_test.go:945: 01:48:01.275 - 75: DEBUG: new connection from 127.0.0.1:33250 app_test.go:945: 01:48:01.316 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.320 - 75: DEBUG: new connection from 127.0.0.1:33252 app_test.go:945: 01:48:01.378 - 76: DEBUG: new connection from 127.0.0.1:47666 app_test.go:945: 01:48:01.480 - 75: DEBUG: new connection from 127.0.0.1:33256 app_test.go:945: 01:48:01.530 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.532 - 75: DEBUG: new connection from 127.0.0.1:33258 app_test.go:945: 01:48:01.578 - 76: DEBUG: new connection from 127.0.0.1:47672 app_test.go:945: 01:48:01.630 - 77: DEBUG: new connection from 127.0.0.1:42786 app_test.go:945: 01:48:01.686 - 77: DEBUG: new connection from 127.0.0.1:42788 app_test.go:945: 01:48:01.729 - 75: DEBUG: new connection from 127.0.0.1:33266 app_test.go:945: 01:48:01.739 - 75: DEBUG: new connection from 127.0.0.1:33268 app_test.go:945: 01:48:01.782 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.785 - 75: DEBUG: new connection from 127.0.0.1:33270 app_test.go:945: 01:48:01.822 - 76: DEBUG: new connection from 127.0.0.1:47684 app_test.go:945: 01:48:01.860 - 77: DEBUG: new connection from 127.0.0.1:42798 app_test.go:945: 01:48:01.897 - 75: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.897 - 75: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.897 - 75: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.937 - 75: DEBUG: new connection from 127.0.0.1:33276 app_test.go:945: 01:48:01.987 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.398 - 75: DEBUG: new connection from 127.0.0.1:33278 app_test.go:945: 01:48:01.437 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.438 - 75: DEBUG: new connection from 127.0.0.1:33280 app_test.go:945: 01:48:01.484 - 76: DEBUG: new connection from 127.0.0.1:47694 app_test.go:945: 01:48:01.499 - 75: DEBUG: new connection from 127.0.0.1:33284 app_test.go:945: 01:48:01.526 - 77: DEBUG: new connection from 127.0.0.1:42810 app_test.go:945: 01:48:01.543 - 76: DEBUG: new connection from 127.0.0.1:47700 app_test.go:945: 01:48:01.548 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.567 - 75: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.567 - 75: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.567 - 75: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.589 - 75: DEBUG: new connection from 127.0.0.1:33290 app_test.go:945: 01:48:01.050 - 75: DEBUG: new connection from 127.0.0.1:33292 app_test.go:945: 01:48:01.093 - 75: DEBUG: new connection from 127.0.0.1:33294 app_test.go:945: 01:48:01.094 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.136 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.137 - 75: DEBUG: new connection from 127.0.0.1:33296 app_test.go:945: 01:48:01.177 - 76: DEBUG: new connection from 127.0.0.1:47710 app_test.go:945: 01:48:01.216 - 77: DEBUG: new connection from 127.0.0.1:42824 app_test.go:945: 01:48:01.269 - 75: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.269 - 75: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.575 - 75: DEBUG: new connection from 127.0.0.1:33302 app_test.go:945: 01:48:01.596 - 75: DEBUG: new connection from 127.0.0.1:33304 app_test.go:945: 01:48:01.619 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.621 - 75: DEBUG: new connection from 127.0.0.1:33306 app_test.go:945: 01:48:01.648 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.667 - 76: DEBUG: new connection from 127.0.0.1:47720 app_test.go:945: 01:48:01.708 - 77: DEBUG: new connection from 127.0.0.1:42834 app_test.go:945: 01:48:01.747 - 78: DEBUG: new connection from 127.0.0.1:43384 app_test.go:945: 01:48:01.776 - 75: DEBUG: new connection from 127.0.0.1:33314 app_test.go:945: 01:48:01.790 - 78: DEBUG: new connection from 127.0.0.1:43388 app_test.go:945: 01:48:01.822 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.824 - 75: DEBUG: new connection from 127.0.0.1:33318 app_test.go:945: 01:48:01.840 - 75: DEBUG: new connection from 127.0.0.1:33320 app_test.go:945: 01:48:01.843 - 75: DEBUG: new connection from 127.0.0.1:33322 app_test.go:945: 01:48:01.878 - 76: DEBUG: new connection from 127.0.0.1:47736 app_test.go:945: 01:48:01.887 - 79: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.889 - 75: DEBUG: new connection from 127.0.0.1:33326 app_test.go:945: 01:48:01.917 - 77: DEBUG: new connection from 127.0.0.1:42852 app_test.go:945: 01:48:01.936 - 76: DEBUG: new connection from 127.0.0.1:47742 app_test.go:945: 01:48:01.971 - 78: DEBUG: new connection from 127.0.0.1:43404 app_test.go:945: 01:48:01.984 - 77: DEBUG: new connection from 127.0.0.1:42858 app_test.go:945: 01:48:01.024 - 78: DEBUG: new connection from 127.0.0.1:43408 app_test.go:945: 01:48:01.064 - 75: DEBUG: new connection from 127.0.0.1:33338 app_test.go:945: 01:48:01.064 - 79: DEBUG: new connection from 127.0.0.1:56874 app_test.go:945: 01:48:01.104 - 79: DEBUG: new connection from 127.0.0.1:56876 app_test.go:945: 01:48:01.129 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.143 - 75: DEBUG: new connection from 127.0.0.1:33344 app_test.go:945: 01:48:01.146 - 75: DEBUG: new connection from 127.0.0.1:33346 app_test.go:945: 01:48:01.150 - 75: DEBUG: new connection from 127.0.0.1:33348 app_test.go:945: 01:48:01.194 - 80: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.195 - 75: DEBUG: new connection from 127.0.0.1:33350 app_test.go:945: 01:48:01.203 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.232 - 76: DEBUG: new connection from 127.0.0.1:47764 app_test.go:945: 01:48:01.273 - 77: DEBUG: new connection from 127.0.0.1:42878 app_test.go:945: 01:48:01.292 - 75: DEBUG: new connection from 127.0.0.1:33356 app_test.go:945: 01:48:01.315 - 78: DEBUG: new connection from 127.0.0.1:43430 app_test.go:945: 01:48:01.343 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.361 - 79: DEBUG: new connection from 127.0.0.1:56894 app_test.go:945: 01:48:01.408 - 80: DEBUG: new connection from 127.0.0.1:54170 app_test.go:945: 01:48:01.461 - 80: DEBUG: new connection from 127.0.0.1:54172 app_test.go:945: 01:48:01.512 - 75: DEBUG: new connection from 127.0.0.1:33366 app_test.go:945: 01:48:01.519 - 75: DEBUG: new connection from 127.0.0.1:33368 app_test.go:945: 01:48:01.536 - 75: DEBUG: new connection from 127.0.0.1:33370 app_test.go:945: 01:48:01.579 - 81: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.582 - 75: DEBUG: new connection from 127.0.0.1:33372 app_test.go:945: 01:48:01.605 - 75: DEBUG: new connection from 127.0.0.1:33374 app_test.go:945: 01:48:01.619 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.621 - 75: DEBUG: new connection from 127.0.0.1:33376 app_test.go:945: 01:48:01.636 - 75: DEBUG: new connection from 127.0.0.1:33378 app_test.go:945: 01:48:01.645 - 76: DEBUG: new connection from 127.0.0.1:47792 app_test.go:945: 01:48:01.679 - 79: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.682 - 76: DEBUG: new connection from 127.0.0.1:47794 app_test.go:945: 01:48:01.685 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.694 - 77: DEBUG: new connection from 127.0.0.1:42908 app_test.go:945: 01:48:01.705 - 75: DEBUG: new connection from 127.0.0.1:33386 app_test.go:945: 01:48:01.752 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.759 - 78: DEBUG: new connection from 127.0.0.1:43460 app_test.go:945: 01:48:01.777 - 77: DEBUG: new connection from 127.0.0.1:42914 app_test.go:945: 01:48:01.797 - 79: DEBUG: new connection from 127.0.0.1:56926 app_test.go:945: 01:48:01.836 - 78: DEBUG: new connection from 127.0.0.1:43466 app_test.go:945: 01:48:01.844 - 80: DEBUG: new connection from 127.0.0.1:54204 app_test.go:945: 01:48:01.844 - 75: DEBUG: new connection from 127.0.0.1:33398 app_test.go:945: 01:48:01.873 - 79: DEBUG: new connection from 127.0.0.1:56934 app_test.go:945: 01:48:01.894 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.897 - 81: DEBUG: new connection from 127.0.0.1:36626 app_test.go:945: 01:48:01.958 - 80: DEBUG: new connection from 127.0.0.1:54212 app_test.go:945: 01:48:01.962 - 75: DEBUG: new connection from 127.0.0.1:33406 app_test.go:945: 01:48:01.017 - 80: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.065 - 81: DEBUG: new connection from 127.0.0.1:36634 app_test.go:945: 01:48:01.120 - 81: DEBUG: new connection from 127.0.0.1:36636 app_test.go:945: 01:48:01.120 - 75: DEBUG: new connection from 127.0.0.1:33414 app_test.go:945: 01:48:01.159 - 75: DEBUG: new connection from 127.0.0.1:33416 app_test.go:945: 01:48:01.160 - 76: DEBUG: new connection from 127.0.0.1:47830 app_test.go:945: 01:48:01.187 - 75: DEBUG: new connection from 127.0.0.1:33420 app_test.go:945: 01:48:01.211 - 77: DEBUG: new connection from 127.0.0.1:42946 app_test.go:945: 01:48:01.227 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.278 - 75: DEBUG: new connection from 127.0.0.1:33424 app_test.go:945: 01:48:01.279 - 78: DEBUG: new connection from 127.0.0.1:43498 app_test.go:945: 01:48:01.320 - 80: DEBUG: new connection from 127.0.0.1:54238 app_test.go:945: 01:48:01.337 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.377 - 81: DEBUG: new connection from 127.0.0.1:36656 app_test.go:945: 01:48:01.420 - 75: DEBUG: new connection from 127.0.0.1:33434 app_test.go:945: 01:48:01.421 - 75: DEBUG: new connection from 127.0.0.1:33436 app_test.go:945: 01:48:01.452 - 75: DEBUG: new connection from 127.0.0.1:33438 app_test.go:945: 01:48:01.467 - 76: DEBUG: new connection from 127.0.0.1:47852 app_test.go:945: 01:48:01.473 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.501 - 81: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.520 - 77: DEBUG: new connection from 127.0.0.1:42966 app_test.go:945: 01:48:01.521 - 75: DEBUG: new connection from 127.0.0.1:33444 app_test.go:945: 01:48:01.572 - 78: DEBUG: new connection from 127.0.0.1:43518 app_test.go:945: 01:48:01.603 - 80: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.624 - 80: DEBUG: new connection from 127.0.0.1:54258 app_test.go:945: 01:48:01.726 - 81: DEBUG: new connection from 127.0.0.1:36676 app_test.go:945: 01:48:01.728 - 75: DEBUG: new connection from 127.0.0.1:33454 app_test.go:945: 01:48:01.777 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.839 - 75: DEBUG: new connection from 127.0.0.1:33456 app_test.go:945: 01:48:01.877 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.975 - 75: DEBUG: new connection from 127.0.0.1:33458 app_test.go:945: 01:48:01.027 - 75: DEBUG: new connection from 127.0.0.1:33460 app_test.go:945: 01:48:01.028 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.071 - 81: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.105 - 75: DEBUG: new connection from 127.0.0.1:33464 app_test.go:945: 01:48:01.147 - 80: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.279 - 75: DEBUG: new connection from 127.0.0.1:33466 app_test.go:945: 01:48:01.340 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.340 - 75: DEBUG: new connection from 127.0.0.1:33468 app_test.go:945: 01:48:01.380 - 75: DEBUG: new connection from 127.0.0.1:33470 app_test.go:945: 01:48:01.398 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.399 - 75: DEBUG: new connection from 127.0.0.1:33472 app_test.go:945: 01:48:01.438 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.438 - 76: DEBUG: new connection from 127.0.0.1:47886 app_test.go:945: 01:48:01.481 - 77: DEBUG: new connection from 127.0.0.1:43000 app_test.go:945: 01:48:01.521 - 78: DEBUG: new connection from 127.0.0.1:43550 app_test.go:945: 01:48:01.539 - 75: DEBUG: new connection from 127.0.0.1:33480 app_test.go:945: 01:48:01.565 - 80: DEBUG: new connection from 127.0.0.1:54292 app_test.go:945: 01:48:01.579 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.579 - 75: DEBUG: new connection from 127.0.0.1:33486 app_test.go:945: 01:48:01.619 - 81: DEBUG: new connection from 127.0.0.1:36712 app_test.go:945: 01:48:01.632 - 81: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.660 - 75: DEBUG: new connection from 127.0.0.1:33490 app_test.go:945: 01:48:01.723 - 80: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.844 - 75: DEBUG: new connection from 127.0.0.1:33492 app_test.go:945: 01:48:01.897 - 77: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.940 - 75: DEBUG: new connection from 127.0.0.1:33494 app_test.go:945: 01:48:01.987 - 76: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.987 - 75: DEBUG: new connection from 127.0.0.1:33496 app_test.go:945: 01:48:01.028 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.082 - 75: DEBUG: new connection from 127.0.0.1:33502 app_test.go:945: 01:48:01.129 - 78: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.161 - 75: DEBUG: new connection from 127.0.0.1:33504 app_test.go:945: 01:48:01.207 - 75: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.208 - 75: DEBUG: new connection from 127.0.0.1:33506 --- PASS: TestRolesAdjustment_ReplaceStandBy (6.27s) === RUN TestRolesAdjustment_ReplaceStandByHonorFailureDomains app_test.go:945: 01:48:01.326 - 82: DEBUG: new connection from 127.0.0.1:33520 app_test.go:945: 01:48:01.373 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.374 - 82: DEBUG: new connection from 127.0.0.1:33522 app_test.go:945: 01:48:01.452 - 82: DEBUG: new connection from 127.0.0.1:33524 app_test.go:945: 01:48:01.498 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.503 - 82: DEBUG: new connection from 127.0.0.1:33526 app_test.go:945: 01:48:01.548 - 83: DEBUG: new connection from 127.0.0.1:47940 app_test.go:945: 01:48:01.636 - 82: DEBUG: new connection from 127.0.0.1:33530 app_test.go:945: 01:48:01.680 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.682 - 82: DEBUG: new connection from 127.0.0.1:33532 app_test.go:945: 01:48:01.719 - 83: DEBUG: new connection from 127.0.0.1:47946 app_test.go:945: 01:48:01.772 - 84: DEBUG: new connection from 127.0.0.1:43060 app_test.go:945: 01:48:01.831 - 84: DEBUG: new connection from 127.0.0.1:43062 app_test.go:945: 01:48:01.890 - 82: DEBUG: new connection from 127.0.0.1:33540 app_test.go:945: 01:48:01.919 - 82: DEBUG: new connection from 127.0.0.1:33542 app_test.go:945: 01:48:01.967 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.968 - 82: DEBUG: new connection from 127.0.0.1:33544 app_test.go:945: 01:48:01.032 - 83: DEBUG: new connection from 127.0.0.1:47958 app_test.go:945: 01:48:01.123 - 82: DEBUG: new connection from 127.0.0.1:33548 app_test.go:945: 01:48:01.123 - 84: DEBUG: new connection from 127.0.0.1:43074 app_test.go:945: 01:48:01.190 - 82: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.190 - 82: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.190 - 82: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.197 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.691 - 82: DEBUG: new connection from 127.0.0.1:33552 app_test.go:945: 01:48:01.699 - 82: DEBUG: new connection from 127.0.0.1:33554 app_test.go:945: 01:48:01.741 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.743 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.745 - 82: DEBUG: new connection from 127.0.0.1:33556 app_test.go:945: 01:48:01.793 - 83: DEBUG: new connection from 127.0.0.1:47970 app_test.go:945: 01:48:01.796 - 83: DEBUG: new connection from 127.0.0.1:47972 app_test.go:945: 01:48:01.832 - 84: DEBUG: new connection from 127.0.0.1:43086 app_test.go:945: 01:48:01.859 - 82: DEBUG: new connection from 127.0.0.1:33564 app_test.go:945: 01:48:01.873 - 82: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.874 - 82: WARN: change 127.0.0.1:9003 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.874 - 82: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.242 - 82: DEBUG: new connection from 127.0.0.1:33566 app_test.go:945: 01:48:01.281 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.374 - 82: DEBUG: new connection from 127.0.0.1:33568 app_test.go:945: 01:48:01.411 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.414 - 82: DEBUG: new connection from 127.0.0.1:33570 app_test.go:945: 01:48:01.455 - 83: DEBUG: new connection from 127.0.0.1:47984 app_test.go:945: 01:48:01.497 - 84: DEBUG: new connection from 127.0.0.1:43098 app_test.go:945: 01:48:01.538 - 82: WARN: change 127.0.0.1:9002 from spare to voter: a configuration change is already in progress (5) app_test.go:945: 01:48:01.538 - 82: WARN: adjust roles: could not assign role voter to any node app_test.go:945: 01:48:01.783 - 82: DEBUG: new connection from 127.0.0.1:33576 app_test.go:945: 01:48:01.832 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.852 - 82: DEBUG: new connection from 127.0.0.1:33578 app_test.go:945: 01:48:01.893 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.896 - 82: DEBUG: new connection from 127.0.0.1:33580 app_test.go:945: 01:48:01.941 - 83: DEBUG: new connection from 127.0.0.1:47994 app_test.go:945: 01:48:01.978 - 84: DEBUG: new connection from 127.0.0.1:43108 app_test.go:945: 01:48:01.019 - 85: DEBUG: new connection from 127.0.0.1:43658 app_test.go:945: 01:48:01.039 - 82: DEBUG: new connection from 127.0.0.1:33588 app_test.go:945: 01:48:01.071 - 85: DEBUG: new connection from 127.0.0.1:43662 app_test.go:945: 01:48:01.080 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.081 - 82: DEBUG: new connection from 127.0.0.1:33592 app_test.go:945: 01:48:01.120 - 82: DEBUG: new connection from 127.0.0.1:33594 app_test.go:945: 01:48:01.121 - 82: DEBUG: new connection from 127.0.0.1:33596 app_test.go:945: 01:48:01.133 - 83: DEBUG: new connection from 127.0.0.1:48010 app_test.go:945: 01:48:01.174 - 86: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.176 - 84: DEBUG: new connection from 127.0.0.1:43124 app_test.go:945: 01:48:01.176 - 82: DEBUG: new connection from 127.0.0.1:33602 app_test.go:945: 01:48:01.215 - 83: DEBUG: new connection from 127.0.0.1:48016 app_test.go:945: 01:48:01.233 - 85: DEBUG: new connection from 127.0.0.1:43678 app_test.go:945: 01:48:01.260 - 84: DEBUG: new connection from 127.0.0.1:43132 app_test.go:945: 01:48:01.305 - 82: DEBUG: new connection from 127.0.0.1:33610 app_test.go:945: 01:48:01.306 - 85: DEBUG: new connection from 127.0.0.1:43684 app_test.go:945: 01:48:01.348 - 82: DEBUG: new connection from 127.0.0.1:33614 app_test.go:945: 01:48:01.350 - 86: DEBUG: new connection from 127.0.0.1:57150 app_test.go:945: 01:48:01.353 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.407 - 86: DEBUG: new connection from 127.0.0.1:57152 app_test.go:945: 01:48:01.418 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.452 - 82: DEBUG: new connection from 127.0.0.1:33620 app_test.go:945: 01:48:01.497 - 82: DEBUG: new connection from 127.0.0.1:33622 app_test.go:945: 01:48:01.506 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.509 - 82: DEBUG: new connection from 127.0.0.1:33624 app_test.go:945: 01:48:01.561 - 83: DEBUG: new connection from 127.0.0.1:48038 app_test.go:945: 01:48:01.580 - 82: DEBUG: new connection from 127.0.0.1:33628 app_test.go:945: 01:48:01.604 - 84: DEBUG: new connection from 127.0.0.1:43154 app_test.go:945: 01:48:01.639 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.649 - 85: DEBUG: new connection from 127.0.0.1:43704 app_test.go:945: 01:48:01.699 - 86: DEBUG: new connection from 127.0.0.1:57168 app_test.go:945: 01:48:01.752 - 87: DEBUG: new connection from 127.0.0.1:54444 app_test.go:945: 01:48:01.772 - 82: DEBUG: new connection from 127.0.0.1:33638 app_test.go:945: 01:48:01.825 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.829 - 82: DEBUG: new connection from 127.0.0.1:33640 app_test.go:945: 01:48:01.833 - 87: DEBUG: new connection from 127.0.0.1:54450 app_test.go:945: 01:48:01.855 - 82: DEBUG: new connection from 127.0.0.1:33644 app_test.go:945: 01:48:01.872 - 82: DEBUG: new connection from 127.0.0.1:33646 app_test.go:945: 01:48:01.884 - 83: DEBUG: new connection from 127.0.0.1:48060 app_test.go:945: 01:48:01.910 - 82: DEBUG: new connection from 127.0.0.1:33650 app_test.go:945: 01:48:01.924 - 84: DEBUG: new connection from 127.0.0.1:43176 app_test.go:945: 01:48:01.935 - 82: DEBUG: new connection from 127.0.0.1:33654 app_test.go:945: 01:48:01.935 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.960 - 82: DEBUG: new connection from 127.0.0.1:33656 app_test.go:945: 01:48:01.973 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.976 - 85: DEBUG: new connection from 127.0.0.1:43730 app_test.go:945: 01:48:01.982 - 86: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.982 - 82: DEBUG: new connection from 127.0.0.1:33660 app_test.go:945: 01:48:01.999 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.032 - 83: DEBUG: new connection from 127.0.0.1:48074 app_test.go:945: 01:48:01.033 - 86: DEBUG: new connection from 127.0.0.1:57198 app_test.go:945: 01:48:01.082 - 84: DEBUG: new connection from 127.0.0.1:43190 app_test.go:945: 01:48:01.098 - 87: DEBUG: new connection from 127.0.0.1:54476 app_test.go:945: 01:48:01.143 - 82: DEBUG: new connection from 127.0.0.1:33670 app_test.go:945: 01:48:01.143 - 85: DEBUG: new connection from 127.0.0.1:43744 app_test.go:945: 01:48:01.170 - 82: WARN: change 127.0.0.1:9006 from spare to stand-by: server role is not valid (1) app_test.go:945: 01:48:01.170 - 82: WARN: adjust roles: could not assign role stand-by to any node app_test.go:945: 01:48:01.199 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.199 - 86: DEBUG: new connection from 127.0.0.1:57208 app_test.go:945: 01:48:01.269 - 87: DEBUG: new connection from 127.0.0.1:54484 app_test.go:945: 01:48:01.317 - 88: DEBUG: new connection from 127.0.0.1:36902 app_test.go:945: 01:48:01.336 - 82: DEBUG: new connection from 127.0.0.1:33680 app_test.go:945: 01:48:01.405 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.415 - 82: DEBUG: new connection from 127.0.0.1:33682 app_test.go:945: 01:48:01.473 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.474 - 82: DEBUG: new connection from 127.0.0.1:33684 app_test.go:945: 01:48:01.477 - 82: DEBUG: new connection from 127.0.0.1:33686 app_test.go:945: 01:48:01.509 - 82: DEBUG: new connection from 127.0.0.1:33688 app_test.go:945: 01:48:01.509 - 82: DEBUG: new connection from 127.0.0.1:33690 app_test.go:945: 01:48:01.513 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.536 - 83: DEBUG: new connection from 127.0.0.1:48104 app_test.go:945: 01:48:01.558 - 86: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.574 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.578 - 84: DEBUG: new connection from 127.0.0.1:43218 app_test.go:945: 01:48:01.639 - 85: DEBUG: new connection from 127.0.0.1:43768 app_test.go:945: 01:48:01.674 - 82: DEBUG: new connection from 127.0.0.1:33698 app_test.go:945: 01:48:01.691 - 86: DEBUG: new connection from 127.0.0.1:57234 app_test.go:945: 01:48:01.702 - 82: DEBUG: new connection from 127.0.0.1:33702 app_test.go:945: 01:48:01.739 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.742 - 82: DEBUG: new connection from 127.0.0.1:33704 app_test.go:945: 01:48:01.746 - 87: DEBUG: new connection from 127.0.0.1:54514 app_test.go:945: 01:48:01.761 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.788 - 88: DEBUG: new connection from 127.0.0.1:36932 app_test.go:945: 01:48:01.802 - 83: DEBUG: new connection from 127.0.0.1:48122 app_test.go:945: 01:48:01.839 - 89: DEBUG: new connection from 127.0.0.1:44360 app_test.go:945: 01:48:01.853 - 84: DEBUG: new connection from 127.0.0.1:43238 app_test.go:945: 01:48:01.874 - 82: DEBUG: new connection from 127.0.0.1:33716 app_test.go:945: 01:48:01.897 - 85: DEBUG: new connection from 127.0.0.1:43790 app_test.go:945: 01:48:01.907 - 82: DEBUG: new connection from 127.0.0.1:33720 app_test.go:945: 01:48:01.929 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.947 - 82: DEBUG: new connection from 127.0.0.1:33722 app_test.go:945: 01:48:01.952 - 86: DEBUG: new connection from 127.0.0.1:57258 app_test.go:945: 01:48:01.966 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.999 - 87: DEBUG: new connection from 127.0.0.1:54534 app_test.go:945: 01:48:01.005 - 90: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.007 - 82: DEBUG: new connection from 127.0.0.1:33728 app_test.go:945: 01:48:01.020 - 82: DEBUG: new connection from 127.0.0.1:33730 app_test.go:945: 01:48:01.049 - 88: DEBUG: new connection from 127.0.0.1:36956 app_test.go:945: 01:48:01.062 - 82: DEBUG: new connection from 127.0.0.1:33734 app_test.go:945: 01:48:01.063 - 83: DEBUG: new connection from 127.0.0.1:48148 app_test.go:945: 01:48:01.075 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.076 - 82: DEBUG: new connection from 127.0.0.1:33738 app_test.go:945: 01:48:01.095 - 89: DEBUG: new connection from 127.0.0.1:44388 app_test.go:945: 01:48:01.125 - 86: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.126 - 84: DEBUG: new connection from 127.0.0.1:43266 app_test.go:945: 01:48:01.139 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.178 - 85: DEBUG: new connection from 127.0.0.1:43816 app_test.go:945: 01:48:01.234 - 86: DEBUG: new connection from 127.0.0.1:57280 app_test.go:945: 01:48:01.263 - 82: DEBUG: new connection from 127.0.0.1:33748 app_test.go:945: 01:48:01.289 - 87: DEBUG: new connection from 127.0.0.1:54558 app_test.go:945: 01:48:01.345 - 88: DEBUG: new connection from 127.0.0.1:36976 app_test.go:945: 01:48:01.348 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.398 - 82: DEBUG: new connection from 127.0.0.1:33754 app_test.go:945: 01:48:01.412 - 89: DEBUG: new connection from 127.0.0.1:44404 app_test.go:945: 01:48:01.431 - 82: DEBUG: new connection from 127.0.0.1:33758 app_test.go:945: 01:48:01.444 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.469 - 82: DEBUG: new connection from 127.0.0.1:33760 app_test.go:945: 01:48:01.480 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.505 - 90: DEBUG: new connection from 127.0.0.1:44586 app_test.go:945: 01:48:01.552 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.596 - 82: DEBUG: new connection from 127.0.0.1:33764 app_test.go:945: 01:48:01.636 - 82: DEBUG: new connection from 127.0.0.1:33766 app_test.go:945: 01:48:01.641 - 82: DEBUG: new connection from 127.0.0.1:33768 app_test.go:945: 01:48:01.653 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.689 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.691 - 82: DEBUG: new connection from 127.0.0.1:33770 app_test.go:945: 01:48:01.699 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.740 - 83: DEBUG: new connection from 127.0.0.1:48184 app_test.go:945: 01:48:01.800 - 84: DEBUG: new connection from 127.0.0.1:43300 app_test.go:945: 01:48:01.850 - 85: DEBUG: new connection from 127.0.0.1:43850 app_test.go:945: 01:48:01.850 - 82: DEBUG: new connection from 127.0.0.1:33780 app_test.go:945: 01:48:01.898 - 87: DEBUG: new connection from 127.0.0.1:54592 app_test.go:945: 01:48:01.916 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.946 - 82: DEBUG: new connection from 127.0.0.1:33786 app_test.go:945: 01:48:01.947 - 88: DEBUG: new connection from 127.0.0.1:37012 app_test.go:945: 01:48:01.995 - 82: DEBUG: new connection from 127.0.0.1:33790 app_test.go:945: 01:48:01.998 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.012 - 89: DEBUG: new connection from 127.0.0.1:44440 app_test.go:945: 01:48:01.045 - 82: DEBUG: new connection from 127.0.0.1:33794 app_test.go:945: 01:48:01.048 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.055 - 82: DEBUG: new connection from 127.0.0.1:33796 app_test.go:945: 01:48:01.075 - 90: DEBUG: new connection from 127.0.0.1:44622 app_test.go:945: 01:48:01.083 - 90: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.129 - 89: DEBUG: new connection from 127.0.0.1:44448 app_test.go:945: 01:48:01.131 - 82: DEBUG: new connection from 127.0.0.1:33802 app_test.go:945: 01:48:01.135 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.156 - 82: DEBUG: new connection from 127.0.0.1:33804 app_test.go:945: 01:48:01.169 - 83: DEBUG: new connection from 127.0.0.1:48218 app_test.go:945: 01:48:01.196 - 82: DEBUG: new connection from 127.0.0.1:33808 app_test.go:945: 01:48:01.207 - 82: DEBUG: new connection from 127.0.0.1:33810 app_test.go:945: 01:48:01.224 - 84: DEBUG: new connection from 127.0.0.1:43336 app_test.go:945: 01:48:01.231 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.257 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.283 - 85: DEBUG: new connection from 127.0.0.1:43886 app_test.go:945: 01:48:01.334 - 87: DEBUG: new connection from 127.0.0.1:54626 app_test.go:945: 01:48:01.371 - 88: DEBUG: new connection from 127.0.0.1:37044 app_test.go:945: 01:48:01.409 - 89: DEBUG: new connection from 127.0.0.1:44470 app_test.go:945: 01:48:01.419 - 82: DEBUG: new connection from 127.0.0.1:33824 app_test.go:945: 01:48:01.448 - 90: DEBUG: new connection from 127.0.0.1:44650 app_test.go:945: 01:48:01.467 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.504 - 82: DEBUG: new connection from 127.0.0.1:33828 app_test.go:945: 01:48:01.505 - 82: DEBUG: new connection from 127.0.0.1:33830 app_test.go:945: 01:48:01.555 - 82: DEBUG: new connection from 127.0.0.1:33832 app_test.go:945: 01:48:01.555 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.556 - 83: DEBUG: new connection from 127.0.0.1:48246 app_test.go:945: 01:48:01.587 - 82: DEBUG: new connection from 127.0.0.1:33836 app_test.go:945: 01:48:01.600 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.610 - 84: DEBUG: new connection from 127.0.0.1:43362 app_test.go:945: 01:48:01.636 - 82: DEBUG: new connection from 127.0.0.1:33840 app_test.go:945: 01:48:01.649 - 90: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.673 - 85: DEBUG: new connection from 127.0.0.1:43914 app_test.go:945: 01:48:01.705 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.712 - 87: DEBUG: new connection from 127.0.0.1:54654 app_test.go:945: 01:48:01.748 - 82: DEBUG: new connection from 127.0.0.1:33848 app_test.go:945: 01:48:01.764 - 82: DEBUG: new connection from 127.0.0.1:33850 app_test.go:945: 01:48:01.764 - 88: DEBUG: new connection from 127.0.0.1:37076 app_test.go:945: 01:48:01.808 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.819 - 89: DEBUG: new connection from 127.0.0.1:44504 app_test.go:945: 01:48:01.826 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.857 - 90: DEBUG: new connection from 127.0.0.1:44682 app_test.go:945: 01:48:01.969 - 82: DEBUG: new connection from 127.0.0.1:33860 app_test.go:945: 01:48:01.021 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.058 - 82: DEBUG: new connection from 127.0.0.1:33862 app_test.go:945: 01:48:01.101 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.102 - 82: DEBUG: new connection from 127.0.0.1:33864 app_test.go:945: 01:48:01.139 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.151 - 82: DEBUG: new connection from 127.0.0.1:33866 app_test.go:945: 01:48:01.202 - 90: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.208 - 82: DEBUG: new connection from 127.0.0.1:33868 app_test.go:945: 01:48:01.246 - 87: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.310 - 82: DEBUG: new connection from 127.0.0.1:33870 app_test.go:945: 01:48:01.348 - 82: DEBUG: new connection from 127.0.0.1:33872 app_test.go:945: 01:48:01.349 - 84: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.394 - 83: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.394 - 82: DEBUG: new connection from 127.0.0.1:33874 app_test.go:945: 01:48:01.442 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.443 - 82: DEBUG: new connection from 127.0.0.1:33876 app_test.go:945: 01:48:01.480 - 83: DEBUG: new connection from 127.0.0.1:48290 app_test.go:945: 01:48:01.522 - 84: DEBUG: new connection from 127.0.0.1:43404 app_test.go:945: 01:48:01.522 - 82: DEBUG: new connection from 127.0.0.1:33882 app_test.go:945: 01:48:01.561 - 85: DEBUG: new connection from 127.0.0.1:43956 app_test.go:945: 01:48:01.575 - 85: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.580 - 82: DEBUG: new connection from 127.0.0.1:33886 app_test.go:945: 01:48:01.603 - 82: DEBUG: new connection from 127.0.0.1:33888 app_test.go:945: 01:48:01.610 - 87: DEBUG: new connection from 127.0.0.1:54700 app_test.go:945: 01:48:01.625 - 82: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.645 - 82: DEBUG: new connection from 127.0.0.1:33894 app_test.go:945: 01:48:01.647 - 89: DEBUG: attempt 0: server 127.0.0.1:9001: connected app_test.go:945: 01:48:01.654 - 88: DEBUG: new connection from 127.0.0.1:37120 app_test.go:945: 01:48:01.686 - 88: DEBUG: attempt 0: server 127.0.0.1:9001: connected --- PASS: TestRolesAdjustment_ReplaceStandByHonorFailureDomains (7.62s) === RUN TestOpen app_test.go:945: 01:48:01.950 - 91: DEBUG: new connection from 10.222.158.139:59856 app_test.go:945: 01:48:01.950 - 91: DEBUG: new connection from 10.222.158.139:59858 app_test.go:945: 01:48:01.005 - 91: DEBUG: attempt 0: server 10.222.158.139:9000: connected app_test.go:945: 01:48:01.005 - 91: DEBUG: attempt 0: server 10.222.158.139:9000: connected app_test.go:945: 01:48:01.007 - 91: DEBUG: new connection from 10.222.158.139:59860 --- PASS: TestOpen (0.17s) === RUN TestProxy_Error app_test.go:945: 01:48:01.126 - 92: DEBUG: new connection from 127.0.0.1:38842 app_test.go:945: 01:48:01.126 - 92: DEBUG: new connection from 127.0.0.1:38844 app_test.go:945: 01:48:01.177 - 92: DEBUG: attempt 0: server 127.0.0.1:9000: connected app_test.go:945: 01:48:01.178 - 92: DEBUG: new connection from 127.0.0.1:38846 --- PASS: TestProxy_Error (0.45s) === RUN TestReady_Cancel app_test.go:945: 01:48:01.563 - 93: WARN: attempt 0: server 127.0.0.1:9001: dial: dial tcp 127.0.0.1:9001: connect: connection refused --- PASS: TestReady_Cancel (0.24s) === RUN Example --- PASS: Example (0.08s) FAIL FAIL github.com/canonical/go-dqlite/app 70.540s === RUN TestClient_Leader --- PASS: TestClient_Leader (0.05s) === RUN TestClient_Dump --- PASS: TestClient_Dump (0.08s) === RUN TestClient_Cluster --- PASS: TestClient_Cluster (0.04s) === RUN TestClient_Transfer client_test.go:117: Error Trace: client_test.go:117 Error: Received unexpected error: leadership transfer failed (1) Test: TestClient_Transfer --- FAIL: TestClient_Transfer (1.10s) === RUN TestClient_Describe --- PASS: TestClient_Describe (0.05s) === RUN TestMembership --- PASS: TestMembership (1.08s) === RUN TestDefaultNodeStore --- PASS: TestDefaultNodeStore (0.00s) FAIL FAIL github.com/canonical/go-dqlite/client 2.405s ? github.com/canonical/go-dqlite/cmd/dqlite [no test files] ? github.com/canonical/go-dqlite/cmd/dqlite-demo [no test files] === RUN TestDriver_Open func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestDriver_Open (0.05s) === RUN TestDriver_Prepare func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestDriver_Prepare (0.05s) === RUN TestConn_Exec func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestConn_Exec (0.04s) === RUN TestConn_Query func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestConn_Query (0.04s) === RUN TestConn_QueryRow func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestConn_QueryRow (0.04s) === RUN TestConn_QueryBlob func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestConn_QueryBlob (0.05s) === RUN TestStmt_Exec func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestStmt_Exec (0.04s) === RUN TestStmt_Query func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestStmt_Query (0.06s) === RUN TestConn_QueryParams func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestConn_QueryParams (0.05s) === RUN Test_ColumnTypesEmpty driver_test.go:322: this currently fails if the result set is empty, is dqlite skipping the header if empty set? --- SKIP: Test_ColumnTypesEmpty (0.00s) === RUN Test_ColumnTypesExists func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: Test_ColumnTypesExists (0.06s) === RUN Test_ColumnTypesEnd func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: Test_ColumnTypesEnd (0.05s) === RUN TestIntegration_DatabaseSQL func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_DatabaseSQL (2.12s) === RUN TestIntegration_ConstraintError func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_ConstraintError (2.12s) === RUN TestIntegration_ExecBindError func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_ExecBindError (0.08s) === RUN TestIntegration_QueryBindError func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_QueryBindError (0.04s) === RUN TestIntegration_ConfigMultiThread --- PASS: TestIntegration_ConfigMultiThread (0.05s) === RUN TestIntegration_LargeQuery func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_LargeQuery (2.15s) === RUN TestIntegration_Recover func.go:15: DEBUG: attempt 0: server @1: connected func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_Recover (1.18s) === RUN TestIntegration_PingOnlyWorksOnceLeaderElected func.go:15: WARN: attempt 0: server @1: dial: dial unix @1: connect: connection refused func.go:15: DEBUG: attempt 0: server @2: connect to reported leader @1 func.go:15: WARN: attempt 0: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1 func.go:15: WARN: attempt 1: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1 func.go:15: WARN: attempt 2: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 0: server @1: no known leader func.go:15: DEBUG: attempt 0: server @2: connect to reported leader @1 func.go:15: WARN: attempt 0: server @2: reported leader server is not the leader func.go:15: WARN: attempt 1: server @1: no known leader func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1 func.go:15: WARN: attempt 1: server @2: reported leader server is not the leader func.go:15: WARN: attempt 2: server @1: no known leader func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1 func.go:15: WARN: attempt 2: server @2: reported leader server is not the leader func.go:15: WARN: attempt 3: server @1: no known leader func.go:15: DEBUG: attempt 3: server @2: connect to reported leader @1 func.go:15: WARN: attempt 3: server @2: reported leader server is not the leader func.go:15: WARN: attempt 4: server @1: no known leader func.go:15: DEBUG: attempt 4: server @2: connect to reported leader @1 func.go:15: WARN: attempt 4: server @2: reported leader server is not the leader func.go:15: WARN: attempt 5: server @1: no known leader func.go:15: DEBUG: attempt 5: server @2: connect to reported leader @1 func.go:15: WARN: attempt 5: server @2: reported leader server is not the leader func.go:15: WARN: attempt 6: server @1: no known leader func.go:15: WARN: attempt 6: server @2: no known leader func.go:15: WARN: attempt 7: server @1: no known leader func.go:15: WARN: attempt 7: server @2: no known leader func.go:15: DEBUG: attempt 8: server @1: connected --- PASS: TestIntegration_PingOnlyWorksOnceLeaderElected (8.93s) === RUN TestIntegration_HighAvailability func.go:15: DEBUG: attempt 0: server @1: connected func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe func.go:15: WARN: attempt 0: server @1: dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 0: server @2: no known leader func.go:15: WARN: attempt 0: server @3: no known leader func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 1: server @2: no known leader func.go:15: WARN: attempt 1: server @3: no known leader func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 2: server @2: no known leader func.go:15: WARN: attempt 2: server @3: no known leader func.go:15: WARN: attempt 3: server @1: dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 3: server @2: no known leader func.go:15: WARN: attempt 3: server @3: no known leader func.go:15: WARN: attempt 4: server @1: dial: dial unix @1: connect: connection refused func.go:15: WARN: attempt 4: server @2: no known leader func.go:15: WARN: attempt 4: server @3: no known leader func.go:15: WARN: attempt 5: server @1: dial: dial unix @1: connect: connection refused func.go:15: DEBUG: attempt 5: server @2: connect to reported leader @3 func.go:15: DEBUG: attempt 5: server @2: connected --- PASS: TestIntegration_HighAvailability (7.70s) === RUN TestIntegration_LeadershipTransfer func.go:15: DEBUG: attempt 0: server @1: connected func.go:15: DEBUG: leadership lost (10250 - not leader) func.go:15: DEBUG: attempt 0: server @1: connect to reported leader @2 func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_LeadershipTransfer (2.13s) === RUN TestIntegration_LeadershipTransfer_Tx func.go:15: DEBUG: attempt 0: server @1: connected func.go:15: DEBUG: leadership lost (10250 - not leader) func.go:15: DEBUG: attempt 0: server @1: connect to reported leader @2 func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_LeadershipTransfer_Tx (2.12s) === RUN TestOptions --- PASS: TestOptions (0.00s) === RUN TestIntegration_ColumnTypeName func.go:15: DEBUG: attempt 0: server @1: connected --- PASS: TestIntegration_ColumnTypeName (0.10s) PASS ok github.com/canonical/go-dqlite/driver 29.286s === RUN TestNode_Create --- PASS: TestNode_Create (0.05s) === RUN TestNode_Start --- PASS: TestNode_Start (0.05s) === RUN TestNode_Restart --- PASS: TestNode_Restart (0.07s) === RUN TestNode_Start_Inet --- PASS: TestNode_Start_Inet (0.04s) === RUN TestNode_Leader --- PASS: TestNode_Leader (0.04s) PASS ok github.com/canonical/go-dqlite/internal/bindings 0.256s === RUN Test_TestFunc func.go:15: INFO: hello --- PASS: Test_TestFunc (0.00s) === RUN TestLevel_String --- PASS: TestLevel_String (0.00s) PASS ok github.com/canonical/go-dqlite/internal/logging 0.004s === RUN TestMessage_StaticBytesAlignment --- PASS: TestMessage_StaticBytesAlignment (0.00s) === RUN TestMessage_putBlob === RUN TestMessage_putBlob/16 === RUN TestMessage_putBlob/16#01 === RUN TestMessage_putBlob/24 --- PASS: TestMessage_putBlob (0.00s) --- PASS: TestMessage_putBlob/16 (0.00s) --- PASS: TestMessage_putBlob/16#01 (0.00s) --- PASS: TestMessage_putBlob/24 (0.00s) === RUN TestMessage_putString === RUN TestMessage_putString/hello === RUN TestMessage_putString/hello!! === RUN TestMessage_putString/hello_world --- PASS: TestMessage_putString (0.00s) --- PASS: TestMessage_putString/hello (0.00s) --- PASS: TestMessage_putString/hello!! (0.00s) --- PASS: TestMessage_putString/hello_world (0.00s) === RUN TestMessage_putUint8 --- PASS: TestMessage_putUint8 (0.00s) === RUN TestMessage_putUint16 --- PASS: TestMessage_putUint16 (0.00s) === RUN TestMessage_putUint32 --- PASS: TestMessage_putUint32 (0.00s) === RUN TestMessage_putUint64 --- PASS: TestMessage_putUint64 (0.00s) === RUN TestMessage_putNamedValues --- PASS: TestMessage_putNamedValues (0.00s) === RUN TestMessage_putHeader --- PASS: TestMessage_putHeader (0.00s) === RUN TestMessage_getString === RUN TestMessage_getString/hello === RUN TestMessage_getString/hello!! === RUN TestMessage_getString/hello!!! === RUN TestMessage_getString/hello_world --- PASS: TestMessage_getString (0.00s) --- PASS: TestMessage_getString/hello (0.00s) --- PASS: TestMessage_getString/hello!! (0.00s) --- PASS: TestMessage_getString/hello!!! (0.00s) --- PASS: TestMessage_getString/hello_world (0.00s) === RUN TestMessage_getBlob === RUN TestMessage_getBlob/16 === RUN TestMessage_getBlob/16#01 === RUN TestMessage_getBlob/24 --- PASS: TestMessage_getBlob (0.00s) --- PASS: TestMessage_getBlob/16 (0.00s) --- PASS: TestMessage_getBlob/16#01 (0.00s) --- PASS: TestMessage_getBlob/24 (0.00s) === RUN TestMessage_getString_Overflow_WordBoundary --- PASS: TestMessage_getString_Overflow_WordBoundary (0.00s) === RUN TestConnector_Success connector_test.go:302: DEBUG: attempt 0: server @test-0: connected --- PASS: TestConnector_Success (0.04s) === RUN TestConnector_LimitRetries connector_test.go:302: WARN: attempt 0: server @test-123: dial: dial unix @test-123: connect: connection refused connector_test.go:302: WARN: attempt 1: server @test-123: dial: dial unix @test-123: connect: connection refused connector_test.go:302: WARN: attempt 2: server @test-123: dial: dial unix @test-123: connect: connection refused --- PASS: TestConnector_LimitRetries (0.60s) === RUN TestConnector_DialTimeout connector_test.go:302: WARN: attempt 0: server 8.8.8.8:9000: dial: dial tcp 8.8.8.8:9000: i/o timeout connector_test.go:302: WARN: attempt 1: server 8.8.8.8:9000: dial: dial tcp 8.8.8.8:9000: i/o timeout --- PASS: TestConnector_DialTimeout (0.30s) === RUN TestConnector_EmptyNodeStore --- PASS: TestConnector_EmptyNodeStore (0.20s) === RUN TestConnector_ContextCanceled connector_test.go:302: WARN: attempt 0: server 1.2.3.4:666: dial: dial tcp 1.2.3.4:666: i/o timeout --- PASS: TestConnector_ContextCanceled (0.23s) === RUN TestConnector_AttemptTimeout func.go:15: WARN: attempt 0: server @1234: call leader (budget 99.871288ms): receive: header: read unix @->@1234: i/o timeout func.go:15: WARN: attempt 1: server @1234: call leader (budget 99.871029ms): receive: header: read unix @->@1234: i/o timeout --- PASS: TestConnector_AttemptTimeout (0.40s) === RUN TestProtocol_RequestWithDynamicBuffer func.go:15: DEBUG: attempt 0: server @test-0: connected --- PASS: TestProtocol_RequestWithDynamicBuffer (0.08s) === RUN TestProtocol_Prepare func.go:15: DEBUG: attempt 0: server @test-0: connected --- PASS: TestProtocol_Prepare (0.04s) PASS ok github.com/canonical/go-dqlite/internal/protocol 1.901s ? github.com/canonical/go-dqlite/internal/shell [no test files] FAIL dh_auto_test: error: cd _build && go test -vet=off -v -p 4 github.com/canonical/go-dqlite github.com/canonical/go-dqlite/app github.com/canonical/go-dqlite/client github.com/canonical/go-dqlite/cmd/dqlite 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/logging github.com/canonical/go-dqlite/internal/protocol github.com/canonical/go-dqlite/internal/shell returned exit code 1 make: *** [debian/rules:4: binary] Error 25 dpkg-buildpackage: error: debian/rules binary subprocess returned exit status 2 -------------------------------------------------------------------------------- Build finished at 2022-01-11T01:48:46Z Finished -------- +------------------------------------------------------------------------------+ | Cleanup | +------------------------------------------------------------------------------+ Purging /<> Not removing build depends: as requested E: Build failure (dpkg-buildpackage died) +------------------------------------------------------------------------------+ | Summary | +------------------------------------------------------------------------------+ Build Architecture: amd64 Build Type: binary Build-Space: n/a Build-Time: 97 Distribution: jammy Fail-Stage: build Host Architecture: amd64 Install-Time: 43 Job: golang-github-canonical-go-dqlite_1.8.0-1.dsc Machine Architecture: amd64 Package: golang-github-canonical-go-dqlite Package-Time: 142 Source-Version: 1.8.0-1 Space: n/a Status: attempted Version: 1.8.0-1 -------------------------------------------------------------------------------- Finished at 2022-01-11T01:48:46Z Build needed 00:02:22, no disk space E: Build failure (dpkg-buildpackage died) Adding user buildd to group lxd RUN: /usr/share/launchpad-buildd/bin/in-target scan-for-processes --backend=chroot --series=jammy --arch=amd64 PACKAGEBUILD-22879446 Scanning for processes to kill in build PACKAGEBUILD-22879446