0s autopkgtest [15:53:50]: starting date: 2024-03-13 0s autopkgtest [15:53:50]: git checkout: d9c0295 adt_testbed.py: supress warnings from apt using a shell pipeline 0s autopkgtest [15:53:50]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8xzrd8zz/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:sqlite3,src:readline --apt-upgrade golang-github-cowsql-go-cowsql --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=sqlite3/3.45.1-1ubuntu1 readline/8.2-3.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-ppc64el-5.secgroup --name adt-noble-ppc64el-golang-github-cowsql-go-cowsql-20240313-155349-juju-7f2275-prod-proposed-migration-environment-2 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://us.ports.ubuntu.com/ubuntu-ports/ 99s autopkgtest [15:55:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup 99s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 100s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [2790 kB] 101s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [448 kB] 101s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [4812 B] 101s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [40.4 kB] 101s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [595 kB] 101s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3116 B] 101s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1372 B] 101s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 101s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [3109 kB] 102s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [8652 B] 102s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el Packages [39.1 kB] 102s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 104s Fetched 7157 kB in 3s (2328 kB/s) 105s Reading package lists... 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Calculating upgrade... 110s The following packages will be upgraded: 110s libsqlite3-0 readline-common 110s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Need to get 861 kB of archives. 110s After this operation, 0 B of additional disk space will be used. 110s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libsqlite3-0 ppc64el 3.45.1-1ubuntu1 [804 kB] 111s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el readline-common all 8.2-3.1 [56.4 kB] 111s Fetched 861 kB in 1s (991 kB/s) 112s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 70112 files and directories currently installed.) 112s Preparing to unpack .../libsqlite3-0_3.45.1-1ubuntu1_ppc64el.deb ... 112s Unpacking libsqlite3-0:ppc64el (3.45.1-1ubuntu1) over (3.45.1-1) ... 112s Preparing to unpack .../readline-common_8.2-3.1_all.deb ... 112s Unpacking readline-common (8.2-3.1) over (8.2-3) ... 112s Setting up libsqlite3-0:ppc64el (3.45.1-1ubuntu1) ... 112s Setting up readline-common (8.2-3.1) ... 112s Processing triggers for man-db (2.12.0-3) ... 112s Processing triggers for install-info (7.1-3) ... 112s Processing triggers for libc-bin (2.39-0ubuntu2) ... 112s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 112s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s sh: Attempting to set up Debian/Ubuntu apt sources automatically 113s sh: Distribution appears to be Ubuntu 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s eatmydata is already the newest version (131-1). 117s dbus is already the newest version (1.14.10-4ubuntu1). 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 117s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 117s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s rng-tools-debian is already the newest version (2.4). 118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s haveged is already the newest version (1.9.14-1ubuntu1). 118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 118s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s The following packages will be REMOVED: 119s cloud-init* python3-configobj* python3-debconf* 119s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 119s After this operation, 3252 kB disk space will be freed. 119s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 70112 files and directories currently installed.) 119s Removing cloud-init (24.1.1-0ubuntu1) ... 120s Removing python3-configobj (5.0.8-3) ... 120s Removing python3-debconf (1.5.86) ... 120s Processing triggers for man-db (2.12.0-3) ... 120s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 69723 files and directories currently installed.) 120s Purging configuration files for cloud-init (24.1.1-0ubuntu1) ... 121s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 121s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s linux-generic is already the newest version (6.8.0-11.11+1). 122s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 123s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 123s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 123s Hit:4 http://ftpmaster.internal/ubuntu noble-proposed InRelease 123s Hit:5 http://ftpmaster.internal/ubuntu noble-backports InRelease 127s Reading package lists... 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 127s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 127s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s Calculating upgrade... 128s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 128s Reading package lists... 128s Building dependency tree... 128s Reading state information... 128s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 128s autopkgtest [15:55:58]: rebooting testbed after setup commands that affected boot 285s autopkgtest [15:58:35]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP Wed Feb 14 00:33:03 UTC 2024 285s autopkgtest [15:58:35]: testbed dpkg architecture: ppc64el 287s autopkgtest [15:58:37]: @@@@@@@@@@@@@@@@@@@@ apt-source golang-github-cowsql-go-cowsql 288s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:1 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:2 and /etc/apt/sources.list.d/ubuntu.sources:1 288s W: Target Packages (main/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (main/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (main/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (universe/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (universe/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (universe/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (universe/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (restricted/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (restricted/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (restricted/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (restricted/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (multiverse/binary-ppc64el/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target Packages (multiverse/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (multiverse/cnf/Commands-ppc64el) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 288s W: Target CNF (multiverse/cnf/Commands-all) is configured multiple times in /etc/apt/sources.list:3 and /etc/apt/sources.list.d/ubuntu.sources:2 289s Get:1 http://ftpmaster.internal/ubuntu noble/universe golang-github-cowsql-go-cowsql 1.22.0-2 (dsc) [2726 B] 289s Get:2 http://ftpmaster.internal/ubuntu noble/universe golang-github-cowsql-go-cowsql 1.22.0-2 (tar) [107 kB] 289s Get:3 http://ftpmaster.internal/ubuntu noble/universe golang-github-cowsql-go-cowsql 1.22.0-2 (diff) [3800 B] 289s gpgv: Signature made Thu Dec 28 01:43:17 2023 UTC 289s gpgv: using RSA key D41A7AD07DF6C5FCA7489F1C29EEE2D6ECF442F9 289s gpgv: issuer "gibmat@debian.org" 289s gpgv: Can't check signature: No public key 289s dpkg-source: warning: cannot verify inline signature for ./golang-github-cowsql-go-cowsql_1.22.0-2.dsc: no acceptable signature found 289s autopkgtest [15:58:39]: testing package golang-github-cowsql-go-cowsql version 1.22.0-2 289s autopkgtest [15:58:39]: build not needed 290s autopkgtest [15:58:40]: test dh-golang-autopkgtest: preparing testbed 296s Reading package lists... 296s Building dependency tree... 296s Reading state information... 296s Correcting dependencies...Starting pkgProblemResolver with broken count: 0 297s Starting 2 pkgProblemResolver with broken count: 0 297s Done 297s Done 297s Starting pkgProblemResolver with broken count: 0 297s Starting 2 pkgProblemResolver with broken count: 0 297s Done 297s The following additional packages will be installed: 297s autoconf automake autopoint autotools-dev build-essential cpp cpp-13 297s cpp-13-powerpc64le-linux-gnu cpp-powerpc64le-linux-gnu debhelper debugedit 297s dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13 297s g++-13-powerpc64le-linux-gnu g++-powerpc64le-linux-gnu gcc gcc-13 297s gcc-13-powerpc64le-linux-gnu gcc-powerpc64le-linux-gnu gettext go-cowsql 297s golang-1.22-go golang-1.22-src golang-any golang-github-burntsushi-toml-dev 297s golang-github-cowsql-go-cowsql-dev golang-github-cpuguy83-go-md2man-v2-dev 297s golang-github-davecgh-go-spew-dev golang-github-fsnotify-fsnotify-dev 297s golang-github-ghodss-yaml-dev golang-github-google-renameio-dev 297s golang-github-hashicorp-hcl-dev golang-github-kr-fs-dev 297s golang-github-magiconair-properties-dev golang-github-mattn-go-runewidth-dev 297s golang-github-mattn-go-sqlite3-dev golang-github-mitchellh-mapstructure-dev 297s golang-github-pelletier-go-toml-dev golang-github-pelletier-go-toml.v2-dev 297s golang-github-peterh-liner-dev golang-github-pkg-errors-dev 297s golang-github-pkg-sftp-dev golang-github-pmezard-go-difflib-dev 297s golang-github-rican7-retry-dev golang-github-rivo-uniseg-dev 297s golang-github-russross-blackfriday-v2-dev 297s golang-github-shurcool-sanitized-anchor-name-dev 297s golang-github-spf13-afero-dev golang-github-spf13-cast-dev 297s golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev 297s golang-github-spf13-pflag-dev golang-github-spf13-viper-dev 297s golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev 297s golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev 297s golang-golang-x-sync-dev golang-golang-x-sys-dev golang-golang-x-term-dev 297s golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev 297s golang-gopkg-yaml.v3-dev golang-src intltool-debian libarchive-zip-perl 297s libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 libcowsql-dev libcowsql0 297s libcrypt-dev libdebhelper-perl libdw1 libfile-stripnondeterminism-perl 297s libgcc-13-dev libgomp1 libisl23 libitm1 liblsan0 libmpc3 libnsl-dev 297s libquadmath0 libraft-dev libraft0 libsqlite3-dev libstdc++-13-dev 297s libsub-override-perl libtirpc-dev libtool libtsan2 libubsan1 linux-libc-dev 297s m4 po-debconf rpcsvc-proto 297s Suggested packages: 297s autoconf-archive gnu-standards autoconf-doc cpp-doc gcc-13-locales 297s cpp-13-doc dh-make gcc-13-doc gcc-multilib manpages-dev flex bison gdb 297s gcc-doc gdb-powerpc64le-linux-gnu gettext-doc libasprintf-dev 297s libgettextpo-dev bzr | brz git mercurial subversion glibc-doc sqlite3-doc 297s libstdc++-13-doc libtool-doc gfortran | fortran95-compiler gcj-jdk m4-doc 297s libmail-box-perl 297s Recommended packages: 297s pkg-config manpages manpages-dev libc-devtools libarchive-cpio-perl 297s libltdl-dev libmail-sendmail-perl 297s The following NEW packages will be installed: 297s autoconf automake autopoint autotools-dev build-essential cpp cpp-13 297s cpp-13-powerpc64le-linux-gnu cpp-powerpc64le-linux-gnu debhelper debugedit 297s dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13 297s g++-13-powerpc64le-linux-gnu g++-powerpc64le-linux-gnu gcc gcc-13 297s gcc-13-powerpc64le-linux-gnu gcc-powerpc64le-linux-gnu gettext go-cowsql 297s golang-1.22-go golang-1.22-src golang-any golang-github-burntsushi-toml-dev 297s golang-github-cowsql-go-cowsql-dev golang-github-cpuguy83-go-md2man-v2-dev 297s golang-github-davecgh-go-spew-dev golang-github-fsnotify-fsnotify-dev 297s golang-github-ghodss-yaml-dev golang-github-google-renameio-dev 297s golang-github-hashicorp-hcl-dev golang-github-kr-fs-dev 297s golang-github-magiconair-properties-dev golang-github-mattn-go-runewidth-dev 297s golang-github-mattn-go-sqlite3-dev golang-github-mitchellh-mapstructure-dev 297s golang-github-pelletier-go-toml-dev golang-github-pelletier-go-toml.v2-dev 297s golang-github-peterh-liner-dev golang-github-pkg-errors-dev 297s golang-github-pkg-sftp-dev golang-github-pmezard-go-difflib-dev 297s golang-github-rican7-retry-dev golang-github-rivo-uniseg-dev 297s golang-github-russross-blackfriday-v2-dev 297s golang-github-shurcool-sanitized-anchor-name-dev 297s golang-github-spf13-afero-dev golang-github-spf13-cast-dev 297s golang-github-spf13-cobra-dev golang-github-spf13-jwalterweatherman-dev 297s golang-github-spf13-pflag-dev golang-github-spf13-viper-dev 297s golang-github-stretchr-objx-dev golang-github-stretchr-testify-dev 297s golang-github-subosito-gotenv-dev golang-go golang-golang-x-crypto-dev 297s golang-golang-x-sync-dev golang-golang-x-sys-dev golang-golang-x-term-dev 297s golang-golang-x-text-dev golang-gopkg-ini.v1-dev golang-gopkg-yaml.v2-dev 297s golang-gopkg-yaml.v3-dev golang-src intltool-debian libarchive-zip-perl 297s libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 libcowsql-dev libcowsql0 297s libcrypt-dev libdebhelper-perl libdw1 libfile-stripnondeterminism-perl 297s libgcc-13-dev libgomp1 libisl23 libitm1 liblsan0 libmpc3 libnsl-dev 297s libquadmath0 libraft-dev libraft0 libsqlite3-dev libstdc++-13-dev 297s libsub-override-perl libtirpc-dev libtool libtsan2 libubsan1 linux-libc-dev 297s m4 po-debconf rpcsvc-proto 297s 0 upgraded, 104 newly installed, 0 to remove and 0 not upgraded. 297s 1 not fully installed or removed. 297s Need to get 129 MB of archives. 297s After this operation, 581 MB of additional disk space will be used. 297s Get:1 http://ftpmaster.internal/ubuntu noble/universe ppc64el libraft0 ppc64el 0.22.0-1 [116 kB] 298s Get:2 http://ftpmaster.internal/ubuntu noble/universe ppc64el libcowsql0 ppc64el 1.15.4-1 [88.2 kB] 298s Get:3 http://ftpmaster.internal/ubuntu noble/main ppc64el libc-dev-bin ppc64el 2.39-0ubuntu2 [21.3 kB] 298s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el linux-libc-dev ppc64el 6.8.0-11.11 [1585 kB] 298s Get:5 http://ftpmaster.internal/ubuntu noble/main ppc64el libcrypt-dev ppc64el 1:4.4.36-4 [167 kB] 298s Get:6 http://ftpmaster.internal/ubuntu noble/main ppc64el libtirpc-dev ppc64el 1.3.4+ds-1build1 [262 kB] 298s Get:7 http://ftpmaster.internal/ubuntu noble/main ppc64el libnsl-dev ppc64el 1.3.0-3 [79.2 kB] 298s Get:8 http://ftpmaster.internal/ubuntu noble/main ppc64el rpcsvc-proto ppc64el 1.4.2-0ubuntu6 [82.3 kB] 298s Get:9 http://ftpmaster.internal/ubuntu noble/main ppc64el libc6-dev ppc64el 2.39-0ubuntu2 [2102 kB] 298s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libsqlite3-dev ppc64el 3.45.1-1ubuntu1 [1036 kB] 298s Get:11 http://ftpmaster.internal/ubuntu noble/universe ppc64el libcowsql-dev ppc64el 1.15.4-1 [126 kB] 298s Get:12 http://ftpmaster.internal/ubuntu noble/universe ppc64el libraft-dev ppc64el 0.22.0-1 [177 kB] 298s Get:13 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-gopkg-yaml.v2-dev all 2.4.0-4 [62.6 kB] 298s Get:14 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-ghodss-yaml-dev all 1.0.0+git20220118.d8423dc-2 [16.6 kB] 298s Get:15 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-google-renameio-dev all 2.0.0-2 [10.3 kB] 298s Get:16 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-mattn-go-sqlite3-dev ppc64el 1.14.19~ds1-1 [85.5 kB] 298s Get:17 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-rivo-uniseg-dev all 0.4.4-1 [256 kB] 298s Get:18 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-mattn-go-runewidth-dev all 0.0.15-2 [17.2 kB] 298s Get:19 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-peterh-liner-dev all 1.2.2-1 [21.3 kB] 298s Get:20 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-pkg-errors-dev all 0.9.1-3 [13.2 kB] 298s Get:21 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-rican7-retry-dev all 0.3.1-2 [7740 B] 298s Get:22 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-pmezard-go-difflib-dev all 1.0.0-3 [12.4 kB] 298s Get:23 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-shurcool-sanitized-anchor-name-dev all 1.0.0-3 [3590 B] 298s Get:24 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-russross-blackfriday-v2-dev all 2.1.0-1 [79.6 kB] 298s Get:25 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-cpuguy83-go-md2man-v2-dev all 2.0.3+ds1-1 [10.4 kB] 298s Get:26 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-pflag-dev all 1.0.6~git20210604-d5e0c0615ace-1 [43.6 kB] 298s Get:27 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-golang-x-sys-dev all 0.17.0-1 [424 kB] 298s Get:28 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-fsnotify-fsnotify-dev all 1.7.0-1 [39.1 kB] 298s Get:29 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-davecgh-go-spew-dev all 1.1.1-3 [31.1 kB] 298s Get:30 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-hashicorp-hcl-dev all 1.0.0-1.1 [58.9 kB] 298s Get:31 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-magiconair-properties-dev all 1.8.7-1 [27.3 kB] 298s Get:32 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-mitchellh-mapstructure-dev all 1.5.0+git20231216.8508981-1 [28.3 kB] 298s Get:33 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-burntsushi-toml-dev all 1.3.2-2 [115 kB] 298s Get:34 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-pelletier-go-toml-dev all 1.9.5-1build1 [79.6 kB] 298s Get:35 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-pelletier-go-toml.v2-dev all 2.1.1-1 [876 kB] 298s Get:36 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-kr-fs-dev all 0.1.0-2 [6344 B] 298s Get:37 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-golang-x-term-dev all 0.17.0-1 [14.7 kB] 298s Get:38 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-golang-x-text-dev all 0.14.0-1 [4646 kB] 299s Get:39 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-golang-x-crypto-dev all 1:0.19.0-1 [1712 kB] 299s Get:40 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-pkg-sftp-dev all 1.13.6-1 [104 kB] 299s Get:41 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-afero-dev all 1.11.0-1 [59.6 kB] 299s Get:42 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-cast-dev all 1.6.0-1 [14.3 kB] 299s Get:43 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-stretchr-objx-dev all 0.5.0-1 [26.5 kB] 299s Get:44 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-gopkg-yaml.v3-dev all 3.0.1-3 [76.1 kB] 299s Get:45 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-stretchr-testify-dev all 1.8.4-1 [72.8 kB] 299s Get:46 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-jwalterweatherman-dev all 1.1.0+really1.1.0-2 [6828 B] 299s Get:47 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-subosito-gotenv-dev all 1.3.0-1 [8808 B] 299s Get:48 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-gopkg-ini.v1-dev all 1.67.0-1 [40.8 kB] 299s Get:49 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-viper-dev all 1.12.0-1 [71.0 kB] 299s Get:50 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-spf13-cobra-dev all 1.8.0-1 [74.5 kB] 299s Get:51 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-golang-x-sync-dev all 0.6.0-1 [18.9 kB] 299s Get:52 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-github-cowsql-go-cowsql-dev all 1.22.0-2 [97.2 kB] 299s Get:53 http://ftpmaster.internal/ubuntu noble/universe ppc64el go-cowsql ppc64el 1.22.0-2 [8125 kB] 299s Get:54 http://ftpmaster.internal/ubuntu noble/main ppc64el autotools-dev all 20220109.1 [44.9 kB] 299s Get:55 http://ftpmaster.internal/ubuntu noble/main ppc64el m4 ppc64el 1.4.19-4 [275 kB] 299s Get:56 http://ftpmaster.internal/ubuntu noble/main ppc64el autoconf all 2.71-3 [339 kB] 299s Get:57 http://ftpmaster.internal/ubuntu noble/main ppc64el automake all 1:1.16.5-1.3ubuntu1 [558 kB] 299s Get:58 http://ftpmaster.internal/ubuntu noble/main ppc64el autopoint all 0.21-14ubuntu1 [422 kB] 299s Get:59 http://ftpmaster.internal/ubuntu noble/main ppc64el libdebhelper-perl all 13.14.1ubuntu1 [89.5 kB] 299s Get:60 http://ftpmaster.internal/ubuntu noble/main ppc64el libisl23 ppc64el 0.26-3 [864 kB] 299s Get:61 http://ftpmaster.internal/ubuntu noble/main ppc64el libmpc3 ppc64el 1.3.1-1 [61.2 kB] 299s Get:62 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [10.7 MB] 300s Get:63 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-13 ppc64el 13.2.0-17ubuntu2 [1038 B] 300s Get:64 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [5330 B] 300s Get:65 http://ftpmaster.internal/ubuntu noble/main ppc64el cpp ppc64el 4:13.2.0-7ubuntu1 [22.5 kB] 300s Get:66 http://ftpmaster.internal/ubuntu noble/main ppc64el libcc1-0 ppc64el 14-20240303-1ubuntu1 [48.1 kB] 300s Get:67 http://ftpmaster.internal/ubuntu noble/main ppc64el libgomp1 ppc64el 14-20240303-1ubuntu1 [161 kB] 300s Get:68 http://ftpmaster.internal/ubuntu noble/main ppc64el libitm1 ppc64el 14-20240303-1ubuntu1 [32.4 kB] 300s Get:69 http://ftpmaster.internal/ubuntu noble/main ppc64el libatomic1 ppc64el 14-20240303-1ubuntu1 [10.7 kB] 300s Get:70 http://ftpmaster.internal/ubuntu noble/main ppc64el libasan8 ppc64el 14-20240303-1ubuntu1 [2973 kB] 300s Get:71 http://ftpmaster.internal/ubuntu noble/main ppc64el liblsan0 ppc64el 14-20240303-1ubuntu1 [1325 kB] 300s Get:72 http://ftpmaster.internal/ubuntu noble/main ppc64el libtsan2 ppc64el 14-20240303-1ubuntu1 [2734 kB] 300s Get:73 http://ftpmaster.internal/ubuntu noble/main ppc64el libubsan1 ppc64el 14-20240303-1ubuntu1 [1194 kB] 300s Get:74 http://ftpmaster.internal/ubuntu noble/main ppc64el libquadmath0 ppc64el 14-20240303-1ubuntu1 [158 kB] 300s Get:75 http://ftpmaster.internal/ubuntu noble/main ppc64el libgcc-13-dev ppc64el 13.2.0-17ubuntu2 [1581 kB] 300s Get:76 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [20.6 MB] 300s Get:77 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-13 ppc64el 13.2.0-17ubuntu2 [477 kB] 300s Get:78 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [1224 B] 300s Get:79 http://ftpmaster.internal/ubuntu noble/main ppc64el gcc ppc64el 4:13.2.0-7ubuntu1 [5022 B] 300s Get:80 http://ftpmaster.internal/ubuntu noble/main ppc64el libtool all 2.4.7-7 [166 kB] 301s Get:81 http://ftpmaster.internal/ubuntu noble/main ppc64el dh-autoreconf all 20 [16.1 kB] 301s Get:82 http://ftpmaster.internal/ubuntu noble/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 301s Get:83 http://ftpmaster.internal/ubuntu noble/main ppc64el libsub-override-perl all 0.10-1 [10.0 kB] 301s Get:84 http://ftpmaster.internal/ubuntu noble/main ppc64el libfile-stripnondeterminism-perl all 1.13.1-1 [18.1 kB] 301s Get:85 http://ftpmaster.internal/ubuntu noble/main ppc64el dh-strip-nondeterminism all 1.13.1-1 [5362 B] 301s Get:86 http://ftpmaster.internal/ubuntu noble/main ppc64el libdw1 ppc64el 0.190-1 [294 kB] 301s Get:87 http://ftpmaster.internal/ubuntu noble/main ppc64el debugedit ppc64el 1:5.0-5 [51.1 kB] 301s Get:88 http://ftpmaster.internal/ubuntu noble/main ppc64el dwz ppc64el 0.15-1 [139 kB] 301s Get:89 http://ftpmaster.internal/ubuntu noble/main ppc64el gettext ppc64el 0.21-14ubuntu1 [979 kB] 301s Get:90 http://ftpmaster.internal/ubuntu noble/main ppc64el intltool-debian all 0.35.0+20060710.6 [23.2 kB] 301s Get:91 http://ftpmaster.internal/ubuntu noble/main ppc64el po-debconf all 1.0.21+nmu1 [233 kB] 301s Get:92 http://ftpmaster.internal/ubuntu noble/main ppc64el debhelper all 13.14.1ubuntu1 [869 kB] 301s Get:93 http://ftpmaster.internal/ubuntu noble/main ppc64el dh-golang all 1.62 [25.2 kB] 301s Get:94 http://ftpmaster.internal/ubuntu noble/main ppc64el golang-1.22-src all 1.22.1-1 [19.7 MB] 301s Get:95 http://ftpmaster.internal/ubuntu noble/main ppc64el golang-1.22-go ppc64el 1.22.1-1 [23.5 MB] 302s Get:96 http://ftpmaster.internal/ubuntu noble/main ppc64el golang-src all 2:1.22~2 [4992 B] 302s Get:97 http://ftpmaster.internal/ubuntu noble/main ppc64el golang-go ppc64el 2:1.22~2 [43.9 kB] 302s Get:98 http://ftpmaster.internal/ubuntu noble/universe ppc64el golang-any ppc64el 2:1.22~2 [2840 B] 302s Get:99 http://ftpmaster.internal/ubuntu noble/main ppc64el libstdc++-13-dev ppc64el 13.2.0-17ubuntu2 [2445 kB] 302s Get:100 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-13-powerpc64le-linux-gnu ppc64el 13.2.0-17ubuntu2 [12.2 MB] 302s Get:101 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-13 ppc64el 13.2.0-17ubuntu2 [14.5 kB] 302s Get:102 http://ftpmaster.internal/ubuntu noble/main ppc64el g++-powerpc64le-linux-gnu ppc64el 4:13.2.0-7ubuntu1 [968 B] 302s Get:103 http://ftpmaster.internal/ubuntu noble/main ppc64el g++ ppc64el 4:13.2.0-7ubuntu1 [1086 B] 302s Get:104 http://ftpmaster.internal/ubuntu noble/main ppc64el build-essential ppc64el 12.10ubuntu1 [4936 B] 303s Fetched 129 MB in 5s (25.2 MB/s) 303s Selecting previously unselected package libraft0:ppc64el. 303s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 69668 files and directories currently installed.) 303s Preparing to unpack .../000-libraft0_0.22.0-1_ppc64el.deb ... 303s Unpacking libraft0:ppc64el (0.22.0-1) ... 303s Selecting previously unselected package libcowsql0:ppc64el. 303s Preparing to unpack .../001-libcowsql0_1.15.4-1_ppc64el.deb ... 303s Unpacking libcowsql0:ppc64el (1.15.4-1) ... 303s Selecting previously unselected package libc-dev-bin. 303s Preparing to unpack .../002-libc-dev-bin_2.39-0ubuntu2_ppc64el.deb ... 303s Unpacking libc-dev-bin (2.39-0ubuntu2) ... 303s Selecting previously unselected package linux-libc-dev:ppc64el. 303s Preparing to unpack .../003-linux-libc-dev_6.8.0-11.11_ppc64el.deb ... 303s Unpacking linux-libc-dev:ppc64el (6.8.0-11.11) ... 303s Selecting previously unselected package libcrypt-dev:ppc64el. 303s Preparing to unpack .../004-libcrypt-dev_1%3a4.4.36-4_ppc64el.deb ... 303s Unpacking libcrypt-dev:ppc64el (1:4.4.36-4) ... 303s Selecting previously unselected package libtirpc-dev:ppc64el. 303s Preparing to unpack .../005-libtirpc-dev_1.3.4+ds-1build1_ppc64el.deb ... 303s Unpacking libtirpc-dev:ppc64el (1.3.4+ds-1build1) ... 303s Selecting previously unselected package libnsl-dev:ppc64el. 303s Preparing to unpack .../006-libnsl-dev_1.3.0-3_ppc64el.deb ... 303s Unpacking libnsl-dev:ppc64el (1.3.0-3) ... 303s Selecting previously unselected package rpcsvc-proto. 303s Preparing to unpack .../007-rpcsvc-proto_1.4.2-0ubuntu6_ppc64el.deb ... 303s Unpacking rpcsvc-proto (1.4.2-0ubuntu6) ... 303s Selecting previously unselected package libc6-dev:ppc64el. 303s Preparing to unpack .../008-libc6-dev_2.39-0ubuntu2_ppc64el.deb ... 303s Unpacking libc6-dev:ppc64el (2.39-0ubuntu2) ... 303s Selecting previously unselected package libsqlite3-dev:ppc64el. 303s Preparing to unpack .../009-libsqlite3-dev_3.45.1-1ubuntu1_ppc64el.deb ... 303s Unpacking libsqlite3-dev:ppc64el (3.45.1-1ubuntu1) ... 304s Selecting previously unselected package libcowsql-dev:ppc64el. 304s Preparing to unpack .../010-libcowsql-dev_1.15.4-1_ppc64el.deb ... 304s Unpacking libcowsql-dev:ppc64el (1.15.4-1) ... 304s Selecting previously unselected package libraft-dev:ppc64el. 304s Preparing to unpack .../011-libraft-dev_0.22.0-1_ppc64el.deb ... 304s Unpacking libraft-dev:ppc64el (0.22.0-1) ... 304s Selecting previously unselected package golang-gopkg-yaml.v2-dev. 304s Preparing to unpack .../012-golang-gopkg-yaml.v2-dev_2.4.0-4_all.deb ... 304s Unpacking golang-gopkg-yaml.v2-dev (2.4.0-4) ... 304s Selecting previously unselected package golang-github-ghodss-yaml-dev. 304s Preparing to unpack .../013-golang-github-ghodss-yaml-dev_1.0.0+git20220118.d8423dc-2_all.deb ... 304s Unpacking golang-github-ghodss-yaml-dev (1.0.0+git20220118.d8423dc-2) ... 304s Selecting previously unselected package golang-github-google-renameio-dev. 304s Preparing to unpack .../014-golang-github-google-renameio-dev_2.0.0-2_all.deb ... 304s Unpacking golang-github-google-renameio-dev (2.0.0-2) ... 304s Selecting previously unselected package golang-github-mattn-go-sqlite3-dev:ppc64el. 304s Preparing to unpack .../015-golang-github-mattn-go-sqlite3-dev_1.14.19~ds1-1_ppc64el.deb ... 304s Unpacking golang-github-mattn-go-sqlite3-dev:ppc64el (1.14.19~ds1-1) ... 304s Selecting previously unselected package golang-github-rivo-uniseg-dev. 304s Preparing to unpack .../016-golang-github-rivo-uniseg-dev_0.4.4-1_all.deb ... 304s Unpacking golang-github-rivo-uniseg-dev (0.4.4-1) ... 304s Selecting previously unselected package golang-github-mattn-go-runewidth-dev. 304s Preparing to unpack .../017-golang-github-mattn-go-runewidth-dev_0.0.15-2_all.deb ... 304s Unpacking golang-github-mattn-go-runewidth-dev (0.0.15-2) ... 304s Selecting previously unselected package golang-github-peterh-liner-dev. 304s Preparing to unpack .../018-golang-github-peterh-liner-dev_1.2.2-1_all.deb ... 304s Unpacking golang-github-peterh-liner-dev (1.2.2-1) ... 304s Selecting previously unselected package golang-github-pkg-errors-dev. 304s Preparing to unpack .../019-golang-github-pkg-errors-dev_0.9.1-3_all.deb ... 304s Unpacking golang-github-pkg-errors-dev (0.9.1-3) ... 304s Selecting previously unselected package golang-github-rican7-retry-dev. 304s Preparing to unpack .../020-golang-github-rican7-retry-dev_0.3.1-2_all.deb ... 304s Unpacking golang-github-rican7-retry-dev (0.3.1-2) ... 304s Selecting previously unselected package golang-github-pmezard-go-difflib-dev. 304s Preparing to unpack .../021-golang-github-pmezard-go-difflib-dev_1.0.0-3_all.deb ... 304s Unpacking golang-github-pmezard-go-difflib-dev (1.0.0-3) ... 304s Selecting previously unselected package golang-github-shurcool-sanitized-anchor-name-dev. 304s Preparing to unpack .../022-golang-github-shurcool-sanitized-anchor-name-dev_1.0.0-3_all.deb ... 304s Unpacking golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-3) ... 304s Selecting previously unselected package golang-github-russross-blackfriday-v2-dev. 304s Preparing to unpack .../023-golang-github-russross-blackfriday-v2-dev_2.1.0-1_all.deb ... 304s Unpacking golang-github-russross-blackfriday-v2-dev (2.1.0-1) ... 304s Selecting previously unselected package golang-github-cpuguy83-go-md2man-v2-dev. 304s Preparing to unpack .../024-golang-github-cpuguy83-go-md2man-v2-dev_2.0.3+ds1-1_all.deb ... 304s Unpacking golang-github-cpuguy83-go-md2man-v2-dev (2.0.3+ds1-1) ... 304s Selecting previously unselected package golang-github-spf13-pflag-dev. 304s Preparing to unpack .../025-golang-github-spf13-pflag-dev_1.0.6~git20210604-d5e0c0615ace-1_all.deb ... 304s Unpacking golang-github-spf13-pflag-dev (1.0.6~git20210604-d5e0c0615ace-1) ... 304s Selecting previously unselected package golang-golang-x-sys-dev. 304s Preparing to unpack .../026-golang-golang-x-sys-dev_0.17.0-1_all.deb ... 304s Unpacking golang-golang-x-sys-dev (0.17.0-1) ... 304s Selecting previously unselected package golang-github-fsnotify-fsnotify-dev. 304s Preparing to unpack .../027-golang-github-fsnotify-fsnotify-dev_1.7.0-1_all.deb ... 304s Unpacking golang-github-fsnotify-fsnotify-dev (1.7.0-1) ... 304s Selecting previously unselected package golang-github-davecgh-go-spew-dev. 304s Preparing to unpack .../028-golang-github-davecgh-go-spew-dev_1.1.1-3_all.deb ... 304s Unpacking golang-github-davecgh-go-spew-dev (1.1.1-3) ... 304s Selecting previously unselected package golang-github-hashicorp-hcl-dev. 304s Preparing to unpack .../029-golang-github-hashicorp-hcl-dev_1.0.0-1.1_all.deb ... 304s Unpacking golang-github-hashicorp-hcl-dev (1.0.0-1.1) ... 304s Selecting previously unselected package golang-github-magiconair-properties-dev. 304s Preparing to unpack .../030-golang-github-magiconair-properties-dev_1.8.7-1_all.deb ... 304s Unpacking golang-github-magiconair-properties-dev (1.8.7-1) ... 304s Selecting previously unselected package golang-github-mitchellh-mapstructure-dev. 304s Preparing to unpack .../031-golang-github-mitchellh-mapstructure-dev_1.5.0+git20231216.8508981-1_all.deb ... 304s Unpacking golang-github-mitchellh-mapstructure-dev (1.5.0+git20231216.8508981-1) ... 304s Selecting previously unselected package golang-github-burntsushi-toml-dev. 304s Preparing to unpack .../032-golang-github-burntsushi-toml-dev_1.3.2-2_all.deb ... 304s Unpacking golang-github-burntsushi-toml-dev (1.3.2-2) ... 304s Selecting previously unselected package golang-github-pelletier-go-toml-dev. 304s Preparing to unpack .../033-golang-github-pelletier-go-toml-dev_1.9.5-1build1_all.deb ... 304s Unpacking golang-github-pelletier-go-toml-dev (1.9.5-1build1) ... 304s Selecting previously unselected package golang-github-pelletier-go-toml.v2-dev. 304s Preparing to unpack .../034-golang-github-pelletier-go-toml.v2-dev_2.1.1-1_all.deb ... 304s Unpacking golang-github-pelletier-go-toml.v2-dev (2.1.1-1) ... 304s Selecting previously unselected package golang-github-kr-fs-dev. 304s Preparing to unpack .../035-golang-github-kr-fs-dev_0.1.0-2_all.deb ... 304s Unpacking golang-github-kr-fs-dev (0.1.0-2) ... 304s Selecting previously unselected package golang-golang-x-term-dev. 304s Preparing to unpack .../036-golang-golang-x-term-dev_0.17.0-1_all.deb ... 304s Unpacking golang-golang-x-term-dev (0.17.0-1) ... 304s Selecting previously unselected package golang-golang-x-text-dev. 304s Preparing to unpack .../037-golang-golang-x-text-dev_0.14.0-1_all.deb ... 304s Unpacking golang-golang-x-text-dev (0.14.0-1) ... 305s Selecting previously unselected package golang-golang-x-crypto-dev. 305s Preparing to unpack .../038-golang-golang-x-crypto-dev_1%3a0.19.0-1_all.deb ... 305s Unpacking golang-golang-x-crypto-dev (1:0.19.0-1) ... 305s Selecting previously unselected package golang-github-pkg-sftp-dev. 305s Preparing to unpack .../039-golang-github-pkg-sftp-dev_1.13.6-1_all.deb ... 305s Unpacking golang-github-pkg-sftp-dev (1.13.6-1) ... 305s Selecting previously unselected package golang-github-spf13-afero-dev. 305s Preparing to unpack .../040-golang-github-spf13-afero-dev_1.11.0-1_all.deb ... 305s Unpacking golang-github-spf13-afero-dev (1.11.0-1) ... 305s Selecting previously unselected package golang-github-spf13-cast-dev. 305s Preparing to unpack .../041-golang-github-spf13-cast-dev_1.6.0-1_all.deb ... 305s Unpacking golang-github-spf13-cast-dev (1.6.0-1) ... 305s Selecting previously unselected package golang-github-stretchr-objx-dev. 305s Preparing to unpack .../042-golang-github-stretchr-objx-dev_0.5.0-1_all.deb ... 305s Unpacking golang-github-stretchr-objx-dev (0.5.0-1) ... 305s Selecting previously unselected package golang-gopkg-yaml.v3-dev. 305s Preparing to unpack .../043-golang-gopkg-yaml.v3-dev_3.0.1-3_all.deb ... 305s Unpacking golang-gopkg-yaml.v3-dev (3.0.1-3) ... 305s Selecting previously unselected package golang-github-stretchr-testify-dev. 305s Preparing to unpack .../044-golang-github-stretchr-testify-dev_1.8.4-1_all.deb ... 305s Unpacking golang-github-stretchr-testify-dev (1.8.4-1) ... 305s Selecting previously unselected package golang-github-spf13-jwalterweatherman-dev. 305s Preparing to unpack .../045-golang-github-spf13-jwalterweatherman-dev_1.1.0+really1.1.0-2_all.deb ... 305s Unpacking golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-2) ... 305s Selecting previously unselected package golang-github-subosito-gotenv-dev. 305s Preparing to unpack .../046-golang-github-subosito-gotenv-dev_1.3.0-1_all.deb ... 305s Unpacking golang-github-subosito-gotenv-dev (1.3.0-1) ... 305s Selecting previously unselected package golang-gopkg-ini.v1-dev. 305s Preparing to unpack .../047-golang-gopkg-ini.v1-dev_1.67.0-1_all.deb ... 305s Unpacking golang-gopkg-ini.v1-dev (1.67.0-1) ... 305s Selecting previously unselected package golang-github-spf13-viper-dev. 305s Preparing to unpack .../048-golang-github-spf13-viper-dev_1.12.0-1_all.deb ... 305s Unpacking golang-github-spf13-viper-dev (1.12.0-1) ... 305s Selecting previously unselected package golang-github-spf13-cobra-dev. 305s Preparing to unpack .../049-golang-github-spf13-cobra-dev_1.8.0-1_all.deb ... 305s Unpacking golang-github-spf13-cobra-dev (1.8.0-1) ... 305s Selecting previously unselected package golang-golang-x-sync-dev. 305s Preparing to unpack .../050-golang-golang-x-sync-dev_0.6.0-1_all.deb ... 305s Unpacking golang-golang-x-sync-dev (0.6.0-1) ... 305s Selecting previously unselected package golang-github-cowsql-go-cowsql-dev. 305s Preparing to unpack .../051-golang-github-cowsql-go-cowsql-dev_1.22.0-2_all.deb ... 305s Unpacking golang-github-cowsql-go-cowsql-dev (1.22.0-2) ... 305s Selecting previously unselected package go-cowsql. 305s Preparing to unpack .../052-go-cowsql_1.22.0-2_ppc64el.deb ... 305s Unpacking go-cowsql (1.22.0-2) ... 305s Selecting previously unselected package autotools-dev. 305s Preparing to unpack .../053-autotools-dev_20220109.1_all.deb ... 305s Unpacking autotools-dev (20220109.1) ... 305s Selecting previously unselected package m4. 305s Preparing to unpack .../054-m4_1.4.19-4_ppc64el.deb ... 305s Unpacking m4 (1.4.19-4) ... 305s Selecting previously unselected package autoconf. 305s Preparing to unpack .../055-autoconf_2.71-3_all.deb ... 305s Unpacking autoconf (2.71-3) ... 305s Selecting previously unselected package automake. 305s Preparing to unpack .../056-automake_1%3a1.16.5-1.3ubuntu1_all.deb ... 305s Unpacking automake (1:1.16.5-1.3ubuntu1) ... 305s Selecting previously unselected package autopoint. 305s Preparing to unpack .../057-autopoint_0.21-14ubuntu1_all.deb ... 305s Unpacking autopoint (0.21-14ubuntu1) ... 305s Selecting previously unselected package libdebhelper-perl. 305s Preparing to unpack .../058-libdebhelper-perl_13.14.1ubuntu1_all.deb ... 305s Unpacking libdebhelper-perl (13.14.1ubuntu1) ... 305s Selecting previously unselected package libisl23:ppc64el. 305s Preparing to unpack .../059-libisl23_0.26-3_ppc64el.deb ... 305s Unpacking libisl23:ppc64el (0.26-3) ... 305s Selecting previously unselected package libmpc3:ppc64el. 305s Preparing to unpack .../060-libmpc3_1.3.1-1_ppc64el.deb ... 305s Unpacking libmpc3:ppc64el (1.3.1-1) ... 305s Selecting previously unselected package cpp-13-powerpc64le-linux-gnu. 305s Preparing to unpack .../061-cpp-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 305s Unpacking cpp-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 306s Selecting previously unselected package cpp-13. 306s Preparing to unpack .../062-cpp-13_13.2.0-17ubuntu2_ppc64el.deb ... 306s Unpacking cpp-13 (13.2.0-17ubuntu2) ... 306s Selecting previously unselected package cpp-powerpc64le-linux-gnu. 306s Preparing to unpack .../063-cpp-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 306s Unpacking cpp-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 306s Selecting previously unselected package cpp. 306s Preparing to unpack .../064-cpp_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 306s Unpacking cpp (4:13.2.0-7ubuntu1) ... 306s Selecting previously unselected package libcc1-0:ppc64el. 306s Preparing to unpack .../065-libcc1-0_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libcc1-0:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libgomp1:ppc64el. 306s Preparing to unpack .../066-libgomp1_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libgomp1:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libitm1:ppc64el. 306s Preparing to unpack .../067-libitm1_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libitm1:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libatomic1:ppc64el. 306s Preparing to unpack .../068-libatomic1_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libatomic1:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libasan8:ppc64el. 306s Preparing to unpack .../069-libasan8_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libasan8:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package liblsan0:ppc64el. 306s Preparing to unpack .../070-liblsan0_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking liblsan0:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libtsan2:ppc64el. 306s Preparing to unpack .../071-libtsan2_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libtsan2:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libubsan1:ppc64el. 306s Preparing to unpack .../072-libubsan1_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libubsan1:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libquadmath0:ppc64el. 306s Preparing to unpack .../073-libquadmath0_14-20240303-1ubuntu1_ppc64el.deb ... 306s Unpacking libquadmath0:ppc64el (14-20240303-1ubuntu1) ... 306s Selecting previously unselected package libgcc-13-dev:ppc64el. 306s Preparing to unpack .../074-libgcc-13-dev_13.2.0-17ubuntu2_ppc64el.deb ... 306s Unpacking libgcc-13-dev:ppc64el (13.2.0-17ubuntu2) ... 306s Selecting previously unselected package gcc-13-powerpc64le-linux-gnu. 306s Preparing to unpack .../075-gcc-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 306s Unpacking gcc-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 306s Selecting previously unselected package gcc-13. 306s Preparing to unpack .../076-gcc-13_13.2.0-17ubuntu2_ppc64el.deb ... 306s Unpacking gcc-13 (13.2.0-17ubuntu2) ... 307s Selecting previously unselected package gcc-powerpc64le-linux-gnu. 307s Preparing to unpack .../077-gcc-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 307s Unpacking gcc-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 307s Selecting previously unselected package gcc. 307s Preparing to unpack .../078-gcc_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 307s Unpacking gcc (4:13.2.0-7ubuntu1) ... 307s Selecting previously unselected package libtool. 307s Preparing to unpack .../079-libtool_2.4.7-7_all.deb ... 307s Unpacking libtool (2.4.7-7) ... 307s Selecting previously unselected package dh-autoreconf. 307s Preparing to unpack .../080-dh-autoreconf_20_all.deb ... 307s Unpacking dh-autoreconf (20) ... 307s Selecting previously unselected package libarchive-zip-perl. 307s Preparing to unpack .../081-libarchive-zip-perl_1.68-1_all.deb ... 307s Unpacking libarchive-zip-perl (1.68-1) ... 307s Selecting previously unselected package libsub-override-perl. 307s Preparing to unpack .../082-libsub-override-perl_0.10-1_all.deb ... 307s Unpacking libsub-override-perl (0.10-1) ... 307s Selecting previously unselected package libfile-stripnondeterminism-perl. 307s Preparing to unpack .../083-libfile-stripnondeterminism-perl_1.13.1-1_all.deb ... 307s Unpacking libfile-stripnondeterminism-perl (1.13.1-1) ... 307s Selecting previously unselected package dh-strip-nondeterminism. 307s Preparing to unpack .../084-dh-strip-nondeterminism_1.13.1-1_all.deb ... 307s Unpacking dh-strip-nondeterminism (1.13.1-1) ... 307s Selecting previously unselected package libdw1:ppc64el. 307s Preparing to unpack .../085-libdw1_0.190-1_ppc64el.deb ... 307s Unpacking libdw1:ppc64el (0.190-1) ... 307s Selecting previously unselected package debugedit. 307s Preparing to unpack .../086-debugedit_1%3a5.0-5_ppc64el.deb ... 307s Unpacking debugedit (1:5.0-5) ... 307s Selecting previously unselected package dwz. 307s Preparing to unpack .../087-dwz_0.15-1_ppc64el.deb ... 307s Unpacking dwz (0.15-1) ... 307s Selecting previously unselected package gettext. 307s Preparing to unpack .../088-gettext_0.21-14ubuntu1_ppc64el.deb ... 307s Unpacking gettext (0.21-14ubuntu1) ... 307s Selecting previously unselected package intltool-debian. 307s Preparing to unpack .../089-intltool-debian_0.35.0+20060710.6_all.deb ... 307s Unpacking intltool-debian (0.35.0+20060710.6) ... 307s Selecting previously unselected package po-debconf. 307s Preparing to unpack .../090-po-debconf_1.0.21+nmu1_all.deb ... 307s Unpacking po-debconf (1.0.21+nmu1) ... 307s Selecting previously unselected package debhelper. 307s Preparing to unpack .../091-debhelper_13.14.1ubuntu1_all.deb ... 307s Unpacking debhelper (13.14.1ubuntu1) ... 307s Selecting previously unselected package dh-golang. 307s Preparing to unpack .../092-dh-golang_1.62_all.deb ... 307s Unpacking dh-golang (1.62) ... 307s Selecting previously unselected package golang-1.22-src. 307s Preparing to unpack .../093-golang-1.22-src_1.22.1-1_all.deb ... 307s Unpacking golang-1.22-src (1.22.1-1) ... 310s Selecting previously unselected package golang-1.22-go. 310s Preparing to unpack .../094-golang-1.22-go_1.22.1-1_ppc64el.deb ... 310s Unpacking golang-1.22-go (1.22.1-1) ... 310s Selecting previously unselected package golang-src. 310s Preparing to unpack .../095-golang-src_2%3a1.22~2_all.deb ... 310s Unpacking golang-src (2:1.22~2) ... 310s Selecting previously unselected package golang-go:ppc64el. 310s Preparing to unpack .../096-golang-go_2%3a1.22~2_ppc64el.deb ... 310s Unpacking golang-go:ppc64el (2:1.22~2) ... 310s Selecting previously unselected package golang-any:ppc64el. 310s Preparing to unpack .../097-golang-any_2%3a1.22~2_ppc64el.deb ... 310s Unpacking golang-any:ppc64el (2:1.22~2) ... 310s Selecting previously unselected package libstdc++-13-dev:ppc64el. 310s Preparing to unpack .../098-libstdc++-13-dev_13.2.0-17ubuntu2_ppc64el.deb ... 310s Unpacking libstdc++-13-dev:ppc64el (13.2.0-17ubuntu2) ... 311s Selecting previously unselected package g++-13-powerpc64le-linux-gnu. 311s Preparing to unpack .../099-g++-13-powerpc64le-linux-gnu_13.2.0-17ubuntu2_ppc64el.deb ... 311s Unpacking g++-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 311s Selecting previously unselected package g++-13. 311s Preparing to unpack .../100-g++-13_13.2.0-17ubuntu2_ppc64el.deb ... 311s Unpacking g++-13 (13.2.0-17ubuntu2) ... 311s Selecting previously unselected package g++-powerpc64le-linux-gnu. 311s Preparing to unpack .../101-g++-powerpc64le-linux-gnu_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 311s Unpacking g++-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 311s Selecting previously unselected package g++. 311s Preparing to unpack .../102-g++_4%3a13.2.0-7ubuntu1_ppc64el.deb ... 311s Unpacking g++ (4:13.2.0-7ubuntu1) ... 311s Selecting previously unselected package build-essential. 311s Preparing to unpack .../103-build-essential_12.10ubuntu1_ppc64el.deb ... 311s Unpacking build-essential (12.10ubuntu1) ... 311s Setting up golang-github-pelletier-go-toml.v2-dev (2.1.1-1) ... 311s Setting up golang-gopkg-yaml.v2-dev (2.4.0-4) ... 311s Setting up libdw1:ppc64el (0.190-1) ... 311s Setting up golang-github-mitchellh-mapstructure-dev (1.5.0+git20231216.8508981-1) ... 311s Setting up golang-github-shurcool-sanitized-anchor-name-dev (1.0.0-3) ... 311s Setting up golang-github-stretchr-objx-dev (0.5.0-1) ... 311s Setting up golang-github-pkg-errors-dev (0.9.1-3) ... 311s Setting up libarchive-zip-perl (1.68-1) ... 311s Setting up golang-gopkg-yaml.v3-dev (3.0.1-3) ... 311s Setting up libdebhelper-perl (13.14.1ubuntu1) ... 311s Setting up golang-github-burntsushi-toml-dev (1.3.2-2) ... 311s Setting up golang-golang-x-sys-dev (0.17.0-1) ... 311s Setting up golang-github-kr-fs-dev (0.1.0-2) ... 311s Setting up golang-github-subosito-gotenv-dev (1.3.0-1) ... 311s Setting up linux-libc-dev:ppc64el (6.8.0-11.11) ... 311s Setting up golang-github-pmezard-go-difflib-dev (1.0.0-3) ... 311s Setting up m4 (1.4.19-4) ... 311s Setting up golang-golang-x-term-dev (0.17.0-1) ... 311s Setting up libgomp1:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up golang-github-google-renameio-dev (2.0.0-2) ... 311s Setting up golang-github-spf13-pflag-dev (1.0.6~git20210604-d5e0c0615ace-1) ... 311s Setting up golang-github-davecgh-go-spew-dev (1.1.1-3) ... 311s Setting up autotools-dev (20220109.1) ... 311s Setting up libtirpc-dev:ppc64el (1.3.4+ds-1build1) ... 311s Setting up rpcsvc-proto (1.4.2-0ubuntu6) ... 311s Setting up libraft0:ppc64el (0.22.0-1) ... 311s Setting up golang-github-stretchr-testify-dev (1.8.4-1) ... 311s Setting up golang-1.22-src (1.22.1-1) ... 311s Setting up libquadmath0:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up libraft-dev:ppc64el (0.22.0-1) ... 311s Setting up golang-gopkg-ini.v1-dev (1.67.0-1) ... 311s Setting up libmpc3:ppc64el (1.3.1-1) ... 311s Setting up libatomic1:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up golang-golang-x-sync-dev (0.6.0-1) ... 311s Setting up autopoint (0.21-14ubuntu1) ... 311s Setting up golang-github-magiconair-properties-dev (1.8.7-1) ... 311s Setting up golang-github-hashicorp-hcl-dev (1.0.0-1.1) ... 311s Setting up golang-github-rican7-retry-dev (0.3.1-2) ... 311s Setting up autoconf (2.71-3) ... 311s Setting up golang-github-rivo-uniseg-dev (0.4.4-1) ... 311s Setting up libubsan1:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up dwz (0.15-1) ... 311s Setting up libnsl-dev:ppc64el (1.3.0-3) ... 311s Setting up golang-golang-x-text-dev (0.14.0-1) ... 311s Setting up libcrypt-dev:ppc64el (1:4.4.36-4) ... 311s Setting up libasan8:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up golang-github-spf13-cast-dev (1.6.0-1) ... 311s Setting up golang-github-fsnotify-fsnotify-dev (1.7.0-1) ... 311s Setting up debugedit (1:5.0-5) ... 311s Setting up libsub-override-perl (0.10-1) ... 311s Setting up golang-golang-x-crypto-dev (1:0.19.0-1) ... 311s Setting up golang-github-pelletier-go-toml-dev (1.9.5-1build1) ... 311s Setting up golang-github-spf13-jwalterweatherman-dev (1.1.0+really1.1.0-2) ... 311s Setting up libtsan2:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up libisl23:ppc64el (0.26-3) ... 311s Setting up golang-github-ghodss-yaml-dev (1.0.0+git20220118.d8423dc-2) ... 311s Setting up libc-dev-bin (2.39-0ubuntu2) ... 311s Setting up cpp-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 311s Setting up golang-src (2:1.22~2) ... 311s Setting up libcc1-0:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up liblsan0:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up libitm1:ppc64el (14-20240303-1ubuntu1) ... 311s Setting up cpp-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 311s Setting up automake (1:1.16.5-1.3ubuntu1) ... 311s update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode 311s Setting up libfile-stripnondeterminism-perl (1.13.1-1) ... 311s Setting up golang-github-mattn-go-runewidth-dev (0.0.15-2) ... 311s Setting up gettext (0.21-14ubuntu1) ... 311s Setting up golang-github-russross-blackfriday-v2-dev (2.1.0-1) ... 311s Setting up cpp-13 (13.2.0-17ubuntu2) ... 311s Setting up golang-github-pkg-sftp-dev (1.13.6-1) ... 311s Setting up libcowsql0:ppc64el (1.15.4-1) ... 311s Setting up golang-1.22-go (1.22.1-1) ... 311s Setting up intltool-debian (0.35.0+20060710.6) ... 311s Setting up golang-github-peterh-liner-dev (1.2.2-1) ... 311s Setting up dh-strip-nondeterminism (1.13.1-1) ... 311s Setting up libgcc-13-dev:ppc64el (13.2.0-17ubuntu2) ... 311s Setting up cpp (4:13.2.0-7ubuntu1) ... 311s Setting up libc6-dev:ppc64el (2.39-0ubuntu2) ... 311s Setting up golang-github-spf13-afero-dev (1.11.0-1) ... 311s Setting up libstdc++-13-dev:ppc64el (13.2.0-17ubuntu2) ... 311s Setting up golang-github-cpuguy83-go-md2man-v2-dev (2.0.3+ds1-1) ... 311s Setting up golang-go:ppc64el (2:1.22~2) ... 311s Setting up po-debconf (1.0.21+nmu1) ... 311s Setting up go-cowsql (1.22.0-2) ... 311s Setting up golang-any:ppc64el (2:1.22~2) ... 311s Setting up libsqlite3-dev:ppc64el (3.45.1-1ubuntu1) ... 311s Setting up gcc-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 311s Setting up gcc-13 (13.2.0-17ubuntu2) ... 311s Setting up golang-github-spf13-viper-dev (1.12.0-1) ... 311s Setting up libtool (2.4.7-7) ... 311s Setting up libcowsql-dev:ppc64el (1.15.4-1) ... 311s Setting up g++-13-powerpc64le-linux-gnu (13.2.0-17ubuntu2) ... 311s Setting up dh-autoreconf (20) ... 311s Setting up golang-github-mattn-go-sqlite3-dev:ppc64el (1.14.19~ds1-1) ... 311s Setting up gcc-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 311s Setting up golang-github-spf13-cobra-dev (1.8.0-1) ... 311s Setting up golang-github-cowsql-go-cowsql-dev (1.22.0-2) ... 311s Setting up g++-powerpc64le-linux-gnu (4:13.2.0-7ubuntu1) ... 311s Setting up g++-13 (13.2.0-17ubuntu2) ... 311s Setting up debhelper (13.14.1ubuntu1) ... 311s Setting up gcc (4:13.2.0-7ubuntu1) ... 311s Setting up g++ (4:13.2.0-7ubuntu1) ... 311s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 311s Setting up build-essential (12.10ubuntu1) ... 311s Setting up dh-golang (1.62) ... 311s Setting up autopkgtest-satdep (0) ... 311s Processing triggers for man-db (2.12.0-3) ... 312s Processing triggers for install-info (7.1-3) ... 312s Processing triggers for libc-bin (2.39-0ubuntu2) ... 317s (Reading database ... 91675 files and directories currently installed.) 317s Removing autopkgtest-satdep (0) ... 318s autopkgtest [15:59:08]: test dh-golang-autopkgtest: /usr/bin/dh_golang_autopkgtest 318s autopkgtest [15:59:08]: test dh-golang-autopkgtest: [----------------------- 318s [info] Testing github.com/cowsql/go-cowsql... 318s [info] Source code installed by binary package, overriding dh_auto_configure... 318s -e: warning: LTO optimize is enable in buildflags. But cgo doesn't support it. LTO flags will be stripped in cgo. 318s dh build --builddirectory=_build --buildsystem=golang --with=golang 319s dh_update_autotools_config -O--builddirectory=_build -O--buildsystem=golang 319s dh_autoreconf -O--builddirectory=_build -O--buildsystem=golang 319s debian/rules override_dh_auto_configure 319s make[1]: Entering directory '/tmp/autopkgtest.r0V8qU/autopkgtest_tmp' 319s -e: warning: LTO optimize is enable in buildflags. But cgo doesn't support it. LTO flags will be stripped in cgo. 319s mkdir -p "_build" 319s # remove existing symlinks, since "cp -a" won't convert them 319s find "_build" -type l -exec rm "{}" \; 319s cp -a /usr/share/gocode/src "_build" 322s make[1]: Leaving directory '/tmp/autopkgtest.r0V8qU/autopkgtest_tmp' 322s dh_auto_build: warning: LTO optimize is enable in buildflags. But cgo doesn't support it. LTO flags will be stripped in cgo. 322s internal/goarch 322s internal/abi 322s internal/unsafeheader 322s internal/cpu 322s dh_auto_build -O--builddirectory=_build -O--buildsystem=golang 322s cd _build && go install -trimpath -v -p 1 github.com/cowsql/go-cowsql github.com/cowsql/go-cowsql/app github.com/cowsql/go-cowsql/benchmark github.com/cowsql/go-cowsql/client github.com/cowsql/go-cowsql/cmd/cowsql github.com/cowsql/go-cowsql/cmd/cowsql-benchmark github.com/cowsql/go-cowsql/cmd/cowsql-demo github.com/cowsql/go-cowsql/driver github.com/cowsql/go-cowsql/internal/bindings github.com/cowsql/go-cowsql/internal/protocol github.com/cowsql/go-cowsql/internal/shell github.com/cowsql/go-cowsql/logging 322s internal/bytealg 322s internal/chacha8rand 322s internal/coverage/rtcov 322s internal/godebugs 322s internal/goexperiment 322s internal/goos 322s runtime/internal/atomic 322s runtime/internal/math 322s runtime/internal/sys 322s runtime/internal/syscall 322s runtime 328s internal/reflectlite 328s errors 328s internal/race 328s sync/atomic 328s sync 328s internal/itoa 328s internal/oserror 328s syscall 328s time 329s context 329s math/bits 329s math 329s unicode/utf8 329s strconv 330s unicode 330s reflect 331s cmp 331s slices 331s sort 331s internal/fmtsort 331s io 331s internal/syscall/unix 331s internal/poll 331s internal/safefilepath 331s internal/syscall/execenv 332s internal/testlog 332s path 332s io/fs 332s os 332s fmt 332s bytes 332s container/list 333s hash 333s crypto 333s crypto/internal/alias 333s crypto/subtle 333s encoding/binary 333s crypto/cipher 333s crypto/internal/boring/sig 333s crypto/internal/boring 333s crypto/aes 333s crypto/des 333s crypto/internal/edwards25519/field 333s crypto/internal/nistec/fiat 334s embed 334s crypto/internal/nistec 334s crypto/internal/randutil 334s crypto/ecdh 334s internal/bisect 334s internal/godebug 334s math/rand 334s strings 334s math/big 335s crypto/elliptic 335s crypto/internal/bigmod 335s crypto/internal/boring/bbig 335s crypto/sha512 335s unicode/utf16 335s encoding/asn1 336s vendor/golang.org/x/crypto/cryptobyte/asn1 336s vendor/golang.org/x/crypto/cryptobyte 336s crypto/ecdsa 336s crypto/internal/edwards25519 336s crypto/rand 336s crypto/ed25519 336s crypto/hmac 336s crypto/md5 336s crypto/rc4 336s crypto/rsa 336s crypto/sha1 336s crypto/sha256 337s crypto/dsa 337s encoding/hex 337s crypto/x509/pkix 337s encoding/base64 337s encoding/pem 337s vendor/golang.org/x/net/dns/dnsmessage 337s internal/nettrace 337s internal/singleflight 337s internal/intern 337s net/netip 337s runtime/cgo 338s net 341s net/url 341s path/filepath 341s crypto/x509 342s vendor/golang.org/x/crypto/internal/alias 342s vendor/golang.org/x/crypto/chacha20 342s vendor/golang.org/x/crypto/internal/poly1305 342s vendor/golang.org/x/crypto/chacha20poly1305 342s vendor/golang.org/x/crypto/hkdf 342s crypto/tls 344s database/sql/driver 344s database/sql 344s github.com/Rican7/retry/backoff 344s github.com/Rican7/retry/jitter 344s github.com/Rican7/retry/strategy 344s github.com/Rican7/retry 344s encoding 344s flag 344s bufio 345s internal/sysinfo 345s runtime/debug 345s runtime/trace 345s testing 345s github.com/cowsql/go-cowsql/logging 345s github.com/pkg/errors 345s github.com/cowsql/go-cowsql/internal/protocol 345s io/ioutil 345s github.com/google/renameio 345s github.com/mattn/go-sqlite3 349s regexp/syntax 350s regexp 350s gopkg.in/yaml.v2 351s github.com/cowsql/go-cowsql/client 351s github.com/cowsql/go-cowsql/internal/bindings 352s github.com/cowsql/go-cowsql 352s github.com/cowsql/go-cowsql/driver 352s golang.org/x/sync/semaphore 352s golang.org/x/sys/unix 354s log/internal 354s log 354s github.com/cowsql/go-cowsql/app 354s github.com/cowsql/go-cowsql/benchmark 354s encoding/json 354s github.com/cowsql/go-cowsql/internal/shell 355s container/ring 355s github.com/rivo/uniseg 355s github.com/mattn/go-runewidth 355s os/signal 355s github.com/peterh/liner 355s encoding/csv 355s github.com/spf13/pflag 356s text/template/parse 356s text/template 357s github.com/spf13/cobra 357s github.com/cowsql/go-cowsql/cmd/cowsql 359s github.com/cowsql/go-cowsql/cmd/cowsql-benchmark 360s compress/flate 360s hash/crc32 360s compress/gzip 360s vendor/golang.org/x/text/transform 360s vendor/golang.org/x/text/unicode/bidi 360s vendor/golang.org/x/text/secure/bidirule 360s vendor/golang.org/x/text/unicode/norm 361s vendor/golang.org/x/net/idna 361s net/textproto 361s vendor/golang.org/x/net/http/httpguts 361s vendor/golang.org/x/net/http/httpproxy 361s vendor/golang.org/x/net/http2/hpack 361s mime 361s mime/quotedprintable 361s mime/multipart 362s net/http/httptrace 362s net/http/internal 362s net/http/internal/ascii 362s net/http 365s github.com/cowsql/go-cowsql/cmd/cowsql-demo 367s create-stamp debian/debhelper-build-stamp 367s -e: warning: LTO optimize is enable in buildflags. But cgo doesn't support it. LTO flags will be stripped in cgo. 367s dh_auto_test -O--builddirectory=_build -O--buildsystem=golang 367s dh_auto_test: warning: LTO optimize is enable in buildflags. But cgo doesn't support it. LTO flags will be stripped in cgo. 367s cd _build && go test -vet=off -v -p 1 github.com/cowsql/go-cowsql github.com/cowsql/go-cowsql/app github.com/cowsql/go-cowsql/benchmark github.com/cowsql/go-cowsql/client github.com/cowsql/go-cowsql/cmd/cowsql github.com/cowsql/go-cowsql/cmd/cowsql-benchmark github.com/cowsql/go-cowsql/cmd/cowsql-demo github.com/cowsql/go-cowsql/driver github.com/cowsql/go-cowsql/internal/bindings github.com/cowsql/go-cowsql/internal/protocol github.com/cowsql/go-cowsql/internal/shell github.com/cowsql/go-cowsql/logging 398s ? github.com/cowsql/go-cowsql [no test files] 411s === RUN TestNew_PristineDefault 411s --- PASS: TestNew_PristineDefault (0.04s) 411s === RUN TestNew_PristineJoiner 411s app_test.go:1117: 16:00:03.093 - 2: DEBUG: new connection from 127.0.0.1:33160 411s app_test.go:1117: 16:00:03.096 - 2: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.099 - 2: DEBUG: new connection from 127.0.0.1:33174 411s app_test.go:1117: 16:00:03.128 - 2: DEBUG: new connection from 127.0.0.1:33188 411s app_test.go:1117: 16:00:03.130 - 3: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.133 - 2: DEBUG: new connection from 127.0.0.1:33196 411s app_test.go:1117: 16:00:03.136 - 3: DEBUG: new connection from 127.0.0.1:54300 411s app_test.go:1117: 16:00:03.139 - 2: DEBUG: new connection from 127.0.0.1:33202 411s app_test.go:1117: 16:00:03.143 - 2: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s --- PASS: TestNew_PristineJoiner (0.10s) 411s === RUN TestNew_JoinerRestart 411s app_test.go:1117: 16:00:03.185 - 4: DEBUG: new connection from 127.0.0.1:33214 411s app_test.go:1117: 16:00:03.187 - 4: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.188 - 4: DEBUG: new connection from 127.0.0.1:33216 411s app_test.go:1117: 16:00:03.211 - 4: DEBUG: new connection from 127.0.0.1:33220 411s app_test.go:1117: 16:00:03.213 - 5: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.223 - 4: DEBUG: new connection from 127.0.0.1:33226 411s app_test.go:1117: 16:00:03.226 - 5: DEBUG: new connection from 127.0.0.1:54304 411s app_test.go:1117: 16:00:03.251 - 4: DEBUG: new connection from 127.0.0.1:33228 411s app_test.go:1117: 16:00:03.253 - 6: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.255 - 4: DEBUG: new connection from 127.0.0.1:33238 411s app_test.go:1117: 16:00:03.257 - 6: DEBUG: new connection from 127.0.0.1:54310 411s --- PASS: TestNew_JoinerRestart (0.12s) 411s === RUN TestNew_SecondJoiner 411s app_test.go:1117: 16:00:03.314 - 7: DEBUG: new connection from 127.0.0.1:33254 411s app_test.go:1117: 16:00:03.317 - 7: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.320 - 7: DEBUG: new connection from 127.0.0.1:33256 411s app_test.go:1117: 16:00:03.336 - 7: DEBUG: new connection from 127.0.0.1:33264 411s app_test.go:1117: 16:00:03.338 - 8: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.341 - 7: DEBUG: new connection from 127.0.0.1:33280 411s app_test.go:1117: 16:00:03.346 - 8: DEBUG: new connection from 127.0.0.1:54314 411s app_test.go:1117: 16:00:03.375 - 7: DEBUG: new connection from 127.0.0.1:33292 411s app_test.go:1117: 16:00:03.377 - 9: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.380 - 7: DEBUG: new connection from 127.0.0.1:33300 411s app_test.go:1117: 16:00:03.382 - 8: DEBUG: new connection from 127.0.0.1:54326 411s app_test.go:1117: 16:00:03.384 - 9: DEBUG: new connection from 127.0.0.1:46544 411s app_test.go:1117: 16:00:03.389 - 9: DEBUG: new connection from 127.0.0.1:46546 411s app_test.go:1117: 16:00:03.394 - 7: DEBUG: new connection from 127.0.0.1:33304 411s app_test.go:1117: 16:00:03.409 - 8: DEBUG: new connection from 127.0.0.1:54338 411s app_test.go:1117: 16:00:03.413 - 7: DEBUG: new connection from 127.0.0.1:33308 411s app_test.go:1117: 16:00:03.416 - 7: DEBUG: new connection from 127.0.0.1:33324 411s app_test.go:1117: 16:00:03.418 - 7: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s --- PASS: TestNew_SecondJoiner (0.20s) 411s === RUN TestNew_ThirdJoiner 411s app_test.go:1117: 16:00:03.513 - 10: DEBUG: new connection from 127.0.0.1:33330 411s app_test.go:1117: 16:00:03.515 - 10: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.516 - 10: DEBUG: new connection from 127.0.0.1:33342 411s app_test.go:1117: 16:00:03.543 - 10: DEBUG: new connection from 127.0.0.1:33346 411s app_test.go:1117: 16:00:03.545 - 11: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.549 - 10: DEBUG: new connection from 127.0.0.1:33362 411s app_test.go:1117: 16:00:03.551 - 11: DEBUG: new connection from 127.0.0.1:54348 411s app_test.go:1117: 16:00:03.579 - 10: DEBUG: new connection from 127.0.0.1:33364 411s app_test.go:1117: 16:00:03.581 - 12: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.584 - 10: DEBUG: new connection from 127.0.0.1:33370 411s app_test.go:1117: 16:00:03.586 - 11: DEBUG: new connection from 127.0.0.1:54362 411s app_test.go:1117: 16:00:03.590 - 12: DEBUG: new connection from 127.0.0.1:46558 411s app_test.go:1117: 16:00:03.592 - 12: DEBUG: new connection from 127.0.0.1:46572 411s app_test.go:1117: 16:00:03.597 - 10: DEBUG: new connection from 127.0.0.1:33386 411s app_test.go:1117: 16:00:03.601 - 11: DEBUG: new connection from 127.0.0.1:54376 411s app_test.go:1117: 16:00:03.605 - 10: DEBUG: new connection from 127.0.0.1:33390 411s app_test.go:1117: 16:00:03.635 - 10: DEBUG: new connection from 127.0.0.1:33398 411s app_test.go:1117: 16:00:03.637 - 13: DEBUG: attempt 1: server 127.0.0.1:9001: connected 411s app_test.go:1117: 16:00:03.640 - 10: DEBUG: new connection from 127.0.0.1:33410 411s app_test.go:1117: 16:00:03.642 - 11: DEBUG: new connection from 127.0.0.1:54392 411s app_test.go:1117: 16:00:03.644 - 12: DEBUG: new connection from 127.0.0.1:46574 411s app_test.go:1117: 16:00:03.646 - 13: DEBUG: new connection from 127.0.0.1:35688 411s app_test.go:1117: 16:00:03.654 - 13: DEBUG: new connection from 127.0.0.1:35696 411s app_test.go:1117: 16:00:03.658 - 10: DEBUG: new connection from 127.0.0.1:33416 411s app_test.go:1117: 16:00:03.659 - 10: DEBUG: new connection from 127.0.0.1:33422 411s app_test.go:1117: 16:00:03.663 - 10: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s --- PASS: TestNew_ThirdJoiner (0.26s) 412s === RUN TestNew_FourthJoiner 412s app_test.go:1117: 16:00:03.772 - 14: DEBUG: new connection from 127.0.0.1:33436 412s app_test.go:1117: 16:00:03.775 - 14: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.776 - 14: DEBUG: new connection from 127.0.0.1:33438 412s app_test.go:1117: 16:00:03.799 - 14: DEBUG: new connection from 127.0.0.1:33448 412s app_test.go:1117: 16:00:03.801 - 15: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.805 - 14: DEBUG: new connection from 127.0.0.1:33450 412s app_test.go:1117: 16:00:03.808 - 15: DEBUG: new connection from 127.0.0.1:54404 412s app_test.go:1117: 16:00:03.835 - 14: DEBUG: new connection from 127.0.0.1:33456 412s app_test.go:1117: 16:00:03.837 - 16: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.840 - 14: DEBUG: new connection from 127.0.0.1:33460 412s app_test.go:1117: 16:00:03.842 - 15: DEBUG: new connection from 127.0.0.1:54418 412s app_test.go:1117: 16:00:03.845 - 16: DEBUG: new connection from 127.0.0.1:46588 412s app_test.go:1117: 16:00:03.850 - 16: DEBUG: new connection from 127.0.0.1:46600 412s app_test.go:1117: 16:00:03.856 - 14: DEBUG: new connection from 127.0.0.1:33472 412s app_test.go:1117: 16:00:03.860 - 15: DEBUG: new connection from 127.0.0.1:54420 412s app_test.go:1117: 16:00:03.864 - 14: DEBUG: new connection from 127.0.0.1:33480 412s app_test.go:1117: 16:00:03.895 - 14: DEBUG: new connection from 127.0.0.1:33484 412s app_test.go:1117: 16:00:03.897 - 17: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.901 - 14: DEBUG: new connection from 127.0.0.1:33496 412s app_test.go:1117: 16:00:03.904 - 15: DEBUG: new connection from 127.0.0.1:54424 412s app_test.go:1117: 16:00:03.906 - 16: DEBUG: new connection from 127.0.0.1:46614 412s app_test.go:1117: 16:00:03.908 - 17: DEBUG: new connection from 127.0.0.1:35708 412s app_test.go:1117: 16:00:03.917 - 17: DEBUG: new connection from 127.0.0.1:35710 412s app_test.go:1117: 16:00:03.924 - 14: DEBUG: new connection from 127.0.0.1:33504 412s app_test.go:1117: 16:00:03.943 - 14: DEBUG: new connection from 127.0.0.1:33520 412s app_test.go:1117: 16:00:03.945 - 18: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.948 - 14: DEBUG: new connection from 127.0.0.1:33522 412s app_test.go:1117: 16:00:03.952 - 15: DEBUG: new connection from 127.0.0.1:54430 412s app_test.go:1117: 16:00:03.954 - 16: DEBUG: new connection from 127.0.0.1:46626 412s app_test.go:1117: 16:00:03.956 - 17: DEBUG: new connection from 127.0.0.1:35714 412s app_test.go:1117: 16:00:03.958 - 18: DEBUG: new connection from 127.0.0.1:49096 412s app_test.go:1117: 16:00:03.973 - 18: DEBUG: new connection from 127.0.0.1:49102 412s app_test.go:1117: 16:00:03.976 - 14: DEBUG: new connection from 127.0.0.1:33538 412s app_test.go:1117: 16:00:03.983 - 14: DEBUG: new connection from 127.0.0.1:33550 412s app_test.go:1117: 16:00:03.985 - 14: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s --- PASS: TestNew_FourthJoiner (0.35s) 412s === RUN TestNew_FifthJoiner 412s app_test.go:1117: 16:00:03.121 - 19: DEBUG: new connection from 127.0.0.1:33556 412s app_test.go:1117: 16:00:03.123 - 19: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.125 - 19: DEBUG: new connection from 127.0.0.1:33560 412s app_test.go:1117: 16:00:03.147 - 19: DEBUG: new connection from 127.0.0.1:33576 412s app_test.go:1117: 16:00:03.149 - 20: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.152 - 19: DEBUG: new connection from 127.0.0.1:33588 412s app_test.go:1117: 16:00:03.155 - 20: DEBUG: new connection from 127.0.0.1:54438 412s app_test.go:1117: 16:00:03.175 - 19: DEBUG: new connection from 127.0.0.1:33602 412s app_test.go:1117: 16:00:03.177 - 21: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.180 - 19: DEBUG: new connection from 127.0.0.1:33616 412s app_test.go:1117: 16:00:03.183 - 20: DEBUG: new connection from 127.0.0.1:54448 412s app_test.go:1117: 16:00:03.185 - 21: DEBUG: new connection from 127.0.0.1:46632 412s app_test.go:1117: 16:00:03.188 - 21: DEBUG: new connection from 127.0.0.1:46638 412s app_test.go:1117: 16:00:03.192 - 19: DEBUG: new connection from 127.0.0.1:33620 412s app_test.go:1117: 16:00:03.197 - 20: DEBUG: new connection from 127.0.0.1:54450 412s app_test.go:1117: 16:00:03.200 - 19: DEBUG: new connection from 127.0.0.1:33630 412s app_test.go:1117: 16:00:03.231 - 19: DEBUG: new connection from 127.0.0.1:33636 412s app_test.go:1117: 16:00:03.233 - 22: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.237 - 19: DEBUG: new connection from 127.0.0.1:33646 412s app_test.go:1117: 16:00:03.239 - 20: DEBUG: new connection from 127.0.0.1:54452 412s app_test.go:1117: 16:00:03.242 - 21: DEBUG: new connection from 127.0.0.1:46652 412s app_test.go:1117: 16:00:03.244 - 22: DEBUG: new connection from 127.0.0.1:35728 412s app_test.go:1117: 16:00:03.246 - 22: DEBUG: new connection from 127.0.0.1:35732 412s app_test.go:1117: 16:00:03.262 - 19: DEBUG: new connection from 127.0.0.1:33660 412s app_test.go:1117: 16:00:03.271 - 19: DEBUG: new connection from 127.0.0.1:33670 412s app_test.go:1117: 16:00:03.273 - 23: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.275 - 19: DEBUG: new connection from 127.0.0.1:33674 412s app_test.go:1117: 16:00:03.277 - 20: DEBUG: new connection from 127.0.0.1:54454 412s app_test.go:1117: 16:00:03.279 - 21: DEBUG: new connection from 127.0.0.1:46660 412s app_test.go:1117: 16:00:03.281 - 22: DEBUG: new connection from 127.0.0.1:35740 412s app_test.go:1117: 16:00:03.285 - 23: DEBUG: new connection from 127.0.0.1:49116 412s app_test.go:1117: 16:00:03.301 - 23: DEBUG: new connection from 127.0.0.1:49122 412s app_test.go:1117: 16:00:03.308 - 19: DEBUG: new connection from 127.0.0.1:33688 412s app_test.go:1117: 16:00:03.335 - 19: DEBUG: new connection from 127.0.0.1:33690 412s app_test.go:1117: 16:00:03.345 - 24: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.348 - 19: DEBUG: new connection from 127.0.0.1:33696 412s app_test.go:1117: 16:00:03.350 - 20: DEBUG: new connection from 127.0.0.1:54464 412s app_test.go:1117: 16:00:03.353 - 21: DEBUG: new connection from 127.0.0.1:46668 412s app_test.go:1117: 16:00:03.355 - 22: DEBUG: new connection from 127.0.0.1:35742 412s app_test.go:1117: 16:00:03.357 - 23: DEBUG: new connection from 127.0.0.1:49128 412s app_test.go:1117: 16:00:03.359 - 24: DEBUG: new connection from 127.0.0.1:60750 412s app_test.go:1117: 16:00:03.361 - 24: DEBUG: new connection from 127.0.0.1:60752 412s app_test.go:1117: 16:00:03.364 - 19: DEBUG: new connection from 127.0.0.1:33706 412s app_test.go:1117: 16:00:03.367 - 19: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s --- PASS: TestNew_FifthJoiner (0.38s) 412s === RUN TestNew_SixthJoiner 412s app_test.go:1117: 16:00:03.509 - 25: DEBUG: new connection from 127.0.0.1:33718 412s app_test.go:1117: 16:00:03.512 - 25: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.514 - 25: DEBUG: new connection from 127.0.0.1:33726 412s app_test.go:1117: 16:00:03.535 - 25: DEBUG: new connection from 127.0.0.1:33740 412s app_test.go:1117: 16:00:03.537 - 26: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.540 - 25: DEBUG: new connection from 127.0.0.1:33750 412s app_test.go:1117: 16:00:03.542 - 26: DEBUG: new connection from 127.0.0.1:54478 412s app_test.go:1117: 16:00:03.571 - 25: DEBUG: new connection from 127.0.0.1:33752 412s app_test.go:1117: 16:00:03.573 - 27: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.575 - 25: DEBUG: new connection from 127.0.0.1:33754 412s app_test.go:1117: 16:00:03.578 - 26: DEBUG: new connection from 127.0.0.1:54488 412s app_test.go:1117: 16:00:03.580 - 27: DEBUG: new connection from 127.0.0.1:46678 412s app_test.go:1117: 16:00:03.582 - 27: DEBUG: new connection from 127.0.0.1:46692 412s app_test.go:1117: 16:00:03.586 - 25: DEBUG: new connection from 127.0.0.1:33766 412s app_test.go:1117: 16:00:03.590 - 26: DEBUG: new connection from 127.0.0.1:54494 412s app_test.go:1117: 16:00:03.594 - 25: DEBUG: new connection from 127.0.0.1:33772 412s app_test.go:1117: 16:00:03.627 - 25: DEBUG: new connection from 127.0.0.1:33788 412s app_test.go:1117: 16:00:03.629 - 28: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.632 - 25: DEBUG: new connection from 127.0.0.1:33792 412s app_test.go:1117: 16:00:03.634 - 26: DEBUG: new connection from 127.0.0.1:54500 412s app_test.go:1117: 16:00:03.636 - 27: DEBUG: new connection from 127.0.0.1:46704 412s app_test.go:1117: 16:00:03.638 - 28: DEBUG: new connection from 127.0.0.1:35746 412s app_test.go:1117: 16:00:03.641 - 28: DEBUG: new connection from 127.0.0.1:35754 412s app_test.go:1117: 16:00:03.667 - 25: DEBUG: new connection from 127.0.0.1:33794 412s app_test.go:1117: 16:00:03.672 - 25: DEBUG: new connection from 127.0.0.1:33810 412s app_test.go:1117: 16:00:03.674 - 29: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.679 - 25: DEBUG: new connection from 127.0.0.1:33816 412s app_test.go:1117: 16:00:03.681 - 26: DEBUG: new connection from 127.0.0.1:54504 412s app_test.go:1117: 16:00:03.683 - 27: DEBUG: new connection from 127.0.0.1:46710 412s app_test.go:1117: 16:00:03.685 - 28: DEBUG: new connection from 127.0.0.1:35756 412s app_test.go:1117: 16:00:03.688 - 29: DEBUG: new connection from 127.0.0.1:49134 412s app_test.go:1117: 16:00:03.690 - 29: DEBUG: new connection from 127.0.0.1:49144 412s app_test.go:1117: 16:00:03.701 - 25: DEBUG: new connection from 127.0.0.1:33820 412s app_test.go:1117: 16:00:03.731 - 25: DEBUG: new connection from 127.0.0.1:33834 412s app_test.go:1117: 16:00:03.733 - 30: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.738 - 25: DEBUG: new connection from 127.0.0.1:33850 412s app_test.go:1117: 16:00:03.740 - 26: DEBUG: new connection from 127.0.0.1:54518 412s app_test.go:1117: 16:00:03.742 - 27: DEBUG: new connection from 127.0.0.1:46722 412s app_test.go:1117: 16:00:03.744 - 28: DEBUG: new connection from 127.0.0.1:35772 412s app_test.go:1117: 16:00:03.746 - 29: DEBUG: new connection from 127.0.0.1:49158 412s app_test.go:1117: 16:00:03.749 - 30: DEBUG: new connection from 127.0.0.1:60764 412s app_test.go:1117: 16:00:03.762 - 30: DEBUG: new connection from 127.0.0.1:60776 412s app_test.go:1117: 16:00:03.771 - 25: DEBUG: new connection from 127.0.0.1:33860 412s app_test.go:1117: 16:00:03.799 - 25: DEBUG: new connection from 127.0.0.1:33874 412s app_test.go:1117: 16:00:03.801 - 31: DEBUG: attempt 1: server 127.0.0.1:9001: connected 412s app_test.go:1117: 16:00:03.805 - 25: DEBUG: new connection from 127.0.0.1:33884 412s app_test.go:1117: 16:00:03.808 - 26: DEBUG: new connection from 127.0.0.1:54530 412s app_test.go:1117: 16:00:03.810 - 27: DEBUG: new connection from 127.0.0.1:46724 412s app_test.go:1117: 16:00:03.812 - 28: DEBUG: new connection from 127.0.0.1:35776 412s app_test.go:1117: 16:00:03.815 - 29: DEBUG: new connection from 127.0.0.1:49172 412s app_test.go:1117: 16:00:03.817 - 30: DEBUG: new connection from 127.0.0.1:60778 412s app_test.go:1117: 16:00:03.819 - 31: DEBUG: new connection from 127.0.0.1:46930 412s app_test.go:1117: 16:00:03.821 - 25: DEBUG: new connection from 127.0.0.1:33888 412s app_test.go:1117: 16:00:03.824 - 25: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s --- PASS: TestNew_SixthJoiner (0.50s) 413s === RUN TestHandover_Voter 413s app_test.go:1117: 16:00:03.008 - 32: DEBUG: new connection from 127.0.0.1:33892 413s app_test.go:1117: 16:00:03.011 - 32: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.012 - 32: DEBUG: new connection from 127.0.0.1:33902 413s app_test.go:1117: 16:00:03.043 - 32: DEBUG: new connection from 127.0.0.1:33910 413s app_test.go:1117: 16:00:03.045 - 33: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.048 - 32: DEBUG: new connection from 127.0.0.1:33916 413s app_test.go:1117: 16:00:03.050 - 33: DEBUG: new connection from 127.0.0.1:54540 413s app_test.go:1117: 16:00:03.081 - 32: DEBUG: new connection from 127.0.0.1:33920 413s app_test.go:1117: 16:00:03.083 - 34: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.085 - 32: DEBUG: new connection from 127.0.0.1:33922 413s app_test.go:1117: 16:00:03.087 - 33: DEBUG: new connection from 127.0.0.1:54554 413s app_test.go:1117: 16:00:03.090 - 34: DEBUG: new connection from 127.0.0.1:46738 413s app_test.go:1117: 16:00:03.092 - 34: DEBUG: new connection from 127.0.0.1:46752 413s app_test.go:1117: 16:00:03.096 - 32: DEBUG: new connection from 127.0.0.1:33934 413s app_test.go:1117: 16:00:03.106 - 33: DEBUG: new connection from 127.0.0.1:54556 413s app_test.go:1117: 16:00:03.116 - 32: DEBUG: new connection from 127.0.0.1:33950 413s app_test.go:1117: 16:00:03.155 - 32: DEBUG: new connection from 127.0.0.1:33956 413s app_test.go:1117: 16:00:03.157 - 35: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.160 - 32: DEBUG: new connection from 127.0.0.1:33972 413s app_test.go:1117: 16:00:03.162 - 33: DEBUG: new connection from 127.0.0.1:54570 413s app_test.go:1117: 16:00:03.164 - 34: DEBUG: new connection from 127.0.0.1:46760 413s app_test.go:1117: 16:00:03.166 - 35: DEBUG: new connection from 127.0.0.1:35780 413s app_test.go:1117: 16:00:03.175 - 35: DEBUG: new connection from 127.0.0.1:35792 413s app_test.go:1117: 16:00:03.181 - 32: DEBUG: new connection from 127.0.0.1:33980 413s app_test.go:1117: 16:00:03.184 - 32: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.184 - 32: DEBUG: new connection from 127.0.0.1:33986 413s app_test.go:1117: 16:00:03.186 - 32: DEBUG: new connection from 127.0.0.1:33988 413s app_test.go:1117: 16:00:03.189 - 34: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.190 - 32: DEBUG: new connection from 127.0.0.1:33990 413s app_test.go:1117: 16:00:03.192 - 33: DEBUG: new connection from 127.0.0.1:54572 413s app_test.go:1117: 16:00:03.195 - 34: DEBUG: new connection from 127.0.0.1:46770 413s app_test.go:1117: 16:00:03.197 - 35: DEBUG: new connection from 127.0.0.1:35802 413s app_test.go:1117: 16:00:03.200 - 34: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter 413s --- PASS: TestHandover_Voter (0.31s) 413s === RUN TestHandover_TwoNodes 413s app_test.go:1117: 16:00:03.312 - 36: DEBUG: new connection from 127.0.0.1:33998 413s app_test.go:1117: 16:00:03.315 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.318 - 36: DEBUG: new connection from 127.0.0.1:34010 413s app_test.go:1117: 16:00:03.351 - 36: DEBUG: new connection from 127.0.0.1:34016 413s app_test.go:1117: 16:00:03.353 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.357 - 36: DEBUG: new connection from 127.0.0.1:34020 413s app_test.go:1117: 16:00:03.359 - 37: DEBUG: new connection from 127.0.0.1:54582 413s app_test.go:1117: 16:00:03.362 - 36: DEBUG: new connection from 127.0.0.1:34024 413s app_test.go:1117: 16:00:03.364 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.364 - 36: DEBUG: new connection from 127.0.0.1:34032 413s app_test.go:1117: 16:00:03.367 - 37: DEBUG: new connection from 127.0.0.1:54592 413s app_test.go:1117: 16:00:03.383 - 37: DEBUG: new connection from 127.0.0.1:54608 413s app_test.go:1117: 16:00:03.387 - 36: DEBUG: new connection from 127.0.0.1:34044 413s app_test.go:1117: 16:00:03.392 - 36: DEBUG: promoted 127.0.0.1:9002 from spare to voter 413s app_test.go:1117: 16:00:03.393 - 36: DEBUG: new connection from 127.0.0.1:34054 413s app_test.go:1117: 16:00:03.395 - 37: DEBUG: new connection from 127.0.0.1:54620 413s app_test.go:1117: 16:00:03.399 - 36: DEBUG: new connection from 127.0.0.1:34068 413s app_test.go:1117: 16:00:03.401 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002 413s app_test.go:1117: 16:00:03.402 - 37: DEBUG: new connection from 127.0.0.1:54622 413s app_test.go:1117: 16:00:03.404 - 36: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s app_test.go:1117: 16:00:03.405 - 36: DEBUG: new connection from 127.0.0.1:34084 413s app_test.go:1117: 16:00:03.407 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002 413s app_test.go:1117: 16:00:03.408 - 37: DEBUG: new connection from 127.0.0.1:54634 413s app_test.go:1117: 16:00:03.410 - 37: DEBUG: attempt 1: server 127.0.0.1:9001: connected 413s --- PASS: TestHandover_TwoNodes (0.18s) 413s === RUN TestHandover_VoterHonorFailureDomain 414s app_test.go:1117: 16:00:03.502 - 38: DEBUG: new connection from 127.0.0.1:34094 414s app_test.go:1117: 16:00:03.505 - 38: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.506 - 38: DEBUG: new connection from 127.0.0.1:34096 414s app_test.go:1117: 16:00:03.554 - 38: DEBUG: new connection from 127.0.0.1:34108 414s app_test.go:1117: 16:00:03.556 - 39: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.560 - 38: DEBUG: new connection from 127.0.0.1:34120 414s app_test.go:1117: 16:00:03.562 - 39: DEBUG: new connection from 127.0.0.1:54642 414s app_test.go:1117: 16:00:03.588 - 38: DEBUG: new connection from 127.0.0.1:34130 414s app_test.go:1117: 16:00:03.591 - 40: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.593 - 38: DEBUG: new connection from 127.0.0.1:34142 414s app_test.go:1117: 16:00:03.595 - 39: DEBUG: new connection from 127.0.0.1:54646 414s app_test.go:1117: 16:00:03.598 - 40: DEBUG: new connection from 127.0.0.1:46780 414s app_test.go:1117: 16:00:03.603 - 40: DEBUG: new connection from 127.0.0.1:46784 414s app_test.go:1117: 16:00:03.610 - 38: DEBUG: new connection from 127.0.0.1:34158 414s app_test.go:1117: 16:00:03.614 - 39: DEBUG: new connection from 127.0.0.1:54652 414s app_test.go:1117: 16:00:03.618 - 38: DEBUG: new connection from 127.0.0.1:34166 414s app_test.go:1117: 16:00:03.651 - 38: DEBUG: new connection from 127.0.0.1:34174 414s app_test.go:1117: 16:00:03.653 - 41: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.656 - 38: DEBUG: new connection from 127.0.0.1:34180 414s app_test.go:1117: 16:00:03.658 - 39: DEBUG: new connection from 127.0.0.1:54658 414s app_test.go:1117: 16:00:03.661 - 40: DEBUG: new connection from 127.0.0.1:46800 414s app_test.go:1117: 16:00:03.663 - 41: DEBUG: new connection from 127.0.0.1:35810 414s app_test.go:1117: 16:00:03.668 - 41: DEBUG: new connection from 127.0.0.1:35814 414s app_test.go:1117: 16:00:03.674 - 38: DEBUG: new connection from 127.0.0.1:34194 414s app_test.go:1117: 16:00:03.703 - 38: DEBUG: new connection from 127.0.0.1:34200 414s app_test.go:1117: 16:00:03.705 - 42: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.710 - 38: DEBUG: new connection from 127.0.0.1:34206 414s app_test.go:1117: 16:00:03.712 - 39: DEBUG: new connection from 127.0.0.1:54660 414s app_test.go:1117: 16:00:03.715 - 40: DEBUG: new connection from 127.0.0.1:46804 414s app_test.go:1117: 16:00:03.717 - 41: DEBUG: new connection from 127.0.0.1:35828 414s app_test.go:1117: 16:00:03.719 - 42: DEBUG: new connection from 127.0.0.1:49186 414s app_test.go:1117: 16:00:03.730 - 42: DEBUG: new connection from 127.0.0.1:49200 414s app_test.go:1117: 16:00:03.736 - 38: DEBUG: new connection from 127.0.0.1:34210 414s app_test.go:1117: 16:00:03.768 - 38: DEBUG: new connection from 127.0.0.1:34214 414s app_test.go:1117: 16:00:03.770 - 43: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.778 - 38: DEBUG: new connection from 127.0.0.1:34230 414s app_test.go:1117: 16:00:03.780 - 39: DEBUG: new connection from 127.0.0.1:54676 414s app_test.go:1117: 16:00:03.783 - 40: DEBUG: new connection from 127.0.0.1:46806 414s app_test.go:1117: 16:00:03.785 - 41: DEBUG: new connection from 127.0.0.1:35840 414s app_test.go:1117: 16:00:03.787 - 42: DEBUG: new connection from 127.0.0.1:49202 414s app_test.go:1117: 16:00:03.789 - 43: DEBUG: new connection from 127.0.0.1:60780 414s app_test.go:1117: 16:00:03.805 - 43: DEBUG: new connection from 127.0.0.1:60782 414s app_test.go:1117: 16:00:03.811 - 38: DEBUG: new connection from 127.0.0.1:34244 414s app_test.go:1117: 16:00:03.816 - 38: DEBUG: new connection from 127.0.0.1:34258 414s app_test.go:1117: 16:00:03.819 - 38: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.820 - 38: DEBUG: new connection from 127.0.0.1:34262 414s app_test.go:1117: 16:00:03.822 - 40: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.822 - 38: DEBUG: new connection from 127.0.0.1:34272 414s app_test.go:1117: 16:00:03.824 - 39: DEBUG: new connection from 127.0.0.1:54688 414s app_test.go:1117: 16:00:03.827 - 40: DEBUG: new connection from 127.0.0.1:46822 414s app_test.go:1117: 16:00:03.828 - 41: DEBUG: new connection from 127.0.0.1:35854 414s app_test.go:1117: 16:00:03.830 - 42: DEBUG: new connection from 127.0.0.1:49206 414s app_test.go:1117: 16:00:03.832 - 43: DEBUG: new connection from 127.0.0.1:60794 414s app_test.go:1117: 16:00:03.836 - 40: DEBUG: promoted 127.0.0.1:9006 from stand-by to voter 414s --- PASS: TestHandover_VoterHonorFailureDomain (0.52s) 414s === RUN TestHandover_SingleNode 414s --- PASS: TestHandover_SingleNode (0.03s) 414s === RUN TestHandover_GracefulShutdown 414s --- PASS: TestHandover_GracefulShutdown (0.17s) 414s === RUN TestHandover_StandBy 414s app_test.go:1117: 16:00:03.201 - 44: DEBUG: new connection from 127.0.0.1:34528 414s app_test.go:1117: 16:00:03.204 - 44: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.206 - 44: DEBUG: new connection from 127.0.0.1:34540 414s app_test.go:1117: 16:00:03.227 - 44: DEBUG: new connection from 127.0.0.1:34550 414s app_test.go:1117: 16:00:03.229 - 45: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.234 - 44: DEBUG: new connection from 127.0.0.1:34556 414s app_test.go:1117: 16:00:03.236 - 45: DEBUG: new connection from 127.0.0.1:54792 414s app_test.go:1117: 16:00:03.259 - 44: DEBUG: new connection from 127.0.0.1:34562 414s app_test.go:1117: 16:00:03.261 - 46: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.265 - 44: DEBUG: new connection from 127.0.0.1:34566 414s app_test.go:1117: 16:00:03.267 - 45: DEBUG: new connection from 127.0.0.1:54800 414s app_test.go:1117: 16:00:03.269 - 46: DEBUG: new connection from 127.0.0.1:46944 414s app_test.go:1117: 16:00:03.280 - 46: DEBUG: new connection from 127.0.0.1:46948 414s app_test.go:1117: 16:00:03.285 - 44: DEBUG: new connection from 127.0.0.1:34574 414s app_test.go:1117: 16:00:03.291 - 45: DEBUG: new connection from 127.0.0.1:54812 414s app_test.go:1117: 16:00:03.295 - 44: DEBUG: new connection from 127.0.0.1:34586 414s app_test.go:1117: 16:00:03.324 - 44: DEBUG: new connection from 127.0.0.1:34598 414s app_test.go:1117: 16:00:03.326 - 47: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.329 - 44: DEBUG: new connection from 127.0.0.1:34612 414s app_test.go:1117: 16:00:03.331 - 45: DEBUG: new connection from 127.0.0.1:54822 414s app_test.go:1117: 16:00:03.334 - 46: DEBUG: new connection from 127.0.0.1:46952 414s app_test.go:1117: 16:00:03.337 - 47: DEBUG: new connection from 127.0.0.1:35862 414s app_test.go:1117: 16:00:03.340 - 47: DEBUG: new connection from 127.0.0.1:35876 414s app_test.go:1117: 16:00:03.360 - 44: DEBUG: new connection from 127.0.0.1:34626 414s app_test.go:1117: 16:00:03.383 - 44: DEBUG: new connection from 127.0.0.1:34638 414s app_test.go:1117: 16:00:03.385 - 48: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.387 - 44: DEBUG: new connection from 127.0.0.1:34642 414s app_test.go:1117: 16:00:03.389 - 45: DEBUG: new connection from 127.0.0.1:54834 414s app_test.go:1117: 16:00:03.392 - 46: DEBUG: new connection from 127.0.0.1:46964 414s app_test.go:1117: 16:00:03.394 - 47: DEBUG: new connection from 127.0.0.1:35890 414s app_test.go:1117: 16:00:03.396 - 48: DEBUG: new connection from 127.0.0.1:49208 414s app_test.go:1117: 16:00:03.398 - 48: DEBUG: new connection from 127.0.0.1:49212 414s app_test.go:1117: 16:00:03.416 - 44: DEBUG: new connection from 127.0.0.1:34652 414s app_test.go:1117: 16:00:03.431 - 44: DEBUG: new connection from 127.0.0.1:34664 414s app_test.go:1117: 16:00:03.433 - 49: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.437 - 44: DEBUG: new connection from 127.0.0.1:34666 414s app_test.go:1117: 16:00:03.439 - 45: DEBUG: new connection from 127.0.0.1:54848 414s app_test.go:1117: 16:00:03.443 - 46: DEBUG: new connection from 127.0.0.1:46980 414s app_test.go:1117: 16:00:03.445 - 47: DEBUG: new connection from 127.0.0.1:35896 414s app_test.go:1117: 16:00:03.447 - 48: DEBUG: new connection from 127.0.0.1:49222 414s app_test.go:1117: 16:00:03.449 - 49: DEBUG: new connection from 127.0.0.1:60798 414s app_test.go:1117: 16:00:03.464 - 49: DEBUG: new connection from 127.0.0.1:60810 414s app_test.go:1117: 16:00:03.472 - 44: DEBUG: new connection from 127.0.0.1:34668 414s app_test.go:1117: 16:00:03.499 - 44: DEBUG: new connection from 127.0.0.1:34684 414s app_test.go:1117: 16:00:03.501 - 50: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.506 - 44: DEBUG: new connection from 127.0.0.1:34700 414s app_test.go:1117: 16:00:03.508 - 45: DEBUG: new connection from 127.0.0.1:54856 414s app_test.go:1117: 16:00:03.510 - 46: DEBUG: new connection from 127.0.0.1:46994 414s app_test.go:1117: 16:00:03.512 - 47: DEBUG: new connection from 127.0.0.1:35904 414s app_test.go:1117: 16:00:03.514 - 48: DEBUG: new connection from 127.0.0.1:49238 414s app_test.go:1117: 16:00:03.517 - 49: DEBUG: new connection from 127.0.0.1:60816 414s app_test.go:1117: 16:00:03.520 - 50: DEBUG: new connection from 127.0.0.1:46936 414s app_test.go:1117: 16:00:03.522 - 44: DEBUG: new connection from 127.0.0.1:34710 414s app_test.go:1117: 16:00:03.524 - 44: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.524 - 44: DEBUG: new connection from 127.0.0.1:34722 414s app_test.go:1117: 16:00:03.526 - 48: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.526 - 44: DEBUG: new connection from 127.0.0.1:34734 414s app_test.go:1117: 16:00:03.528 - 45: DEBUG: new connection from 127.0.0.1:54868 414s app_test.go:1117: 16:00:03.530 - 46: DEBUG: new connection from 127.0.0.1:47000 414s app_test.go:1117: 16:00:03.532 - 47: DEBUG: new connection from 127.0.0.1:35916 414s app_test.go:1117: 16:00:03.534 - 48: DEBUG: new connection from 127.0.0.1:49240 414s app_test.go:1117: 16:00:03.536 - 49: DEBUG: new connection from 127.0.0.1:60822 414s app_test.go:1117: 16:00:03.538 - 50: DEBUG: new connection from 127.0.0.1:46948 414s app_test.go:1117: 16:00:03.551 - 50: DEBUG: new connection from 127.0.0.1:46954 414s app_test.go:1117: 16:00:03.555 - 48: DEBUG: promoted 127.0.0.1:9007 from spare to stand-by 414s app_test.go:1117: 16:00:03.558 - 44: DEBUG: new connection from 127.0.0.1:34744 414s --- PASS: TestHandover_StandBy (0.52s) 414s === RUN TestHandover_TransferLeadership 414s app_test.go:1117: 16:00:03.720 - 51: DEBUG: new connection from 127.0.0.1:34750 414s app_test.go:1117: 16:00:03.723 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.730 - 51: DEBUG: new connection from 127.0.0.1:34758 414s app_test.go:1117: 16:00:03.763 - 51: DEBUG: new connection from 127.0.0.1:34766 414s app_test.go:1117: 16:00:03.766 - 52: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.770 - 51: DEBUG: new connection from 127.0.0.1:34772 414s app_test.go:1117: 16:00:03.773 - 52: DEBUG: new connection from 127.0.0.1:54872 414s app_test.go:1117: 16:00:03.799 - 51: DEBUG: new connection from 127.0.0.1:34784 414s app_test.go:1117: 16:00:03.801 - 53: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.803 - 51: DEBUG: new connection from 127.0.0.1:34790 414s app_test.go:1117: 16:00:03.805 - 52: DEBUG: new connection from 127.0.0.1:54884 414s app_test.go:1117: 16:00:03.807 - 53: DEBUG: new connection from 127.0.0.1:47012 414s app_test.go:1117: 16:00:03.810 - 53: DEBUG: new connection from 127.0.0.1:47014 414s app_test.go:1117: 16:00:03.814 - 51: DEBUG: new connection from 127.0.0.1:34806 414s app_test.go:1117: 16:00:03.818 - 52: DEBUG: new connection from 127.0.0.1:54896 414s app_test.go:1117: 16:00:03.822 - 51: DEBUG: new connection from 127.0.0.1:34820 414s app_test.go:1117: 16:00:03.855 - 51: DEBUG: new connection from 127.0.0.1:34828 414s app_test.go:1117: 16:00:03.857 - 54: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.862 - 51: DEBUG: new connection from 127.0.0.1:34844 414s app_test.go:1117: 16:00:03.865 - 52: DEBUG: new connection from 127.0.0.1:54910 414s app_test.go:1117: 16:00:03.867 - 53: DEBUG: new connection from 127.0.0.1:47028 414s app_test.go:1117: 16:00:03.869 - 54: DEBUG: new connection from 127.0.0.1:35926 414s app_test.go:1117: 16:00:03.872 - 54: DEBUG: new connection from 127.0.0.1:35934 414s app_test.go:1117: 16:00:03.876 - 51: DEBUG: new connection from 127.0.0.1:34850 414s app_test.go:1117: 16:00:03.879 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.879 - 51: DEBUG: new connection from 127.0.0.1:34854 414s app_test.go:1117: 16:00:03.898 - 51: DEBUG: new connection from 127.0.0.1:34868 414s app_test.go:1117: 16:00:03.900 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.901 - 51: DEBUG: new connection from 127.0.0.1:34872 414s app_test.go:1117: 16:00:03.904 - 52: DEBUG: new connection from 127.0.0.1:54922 414s app_test.go:1117: 16:00:03.907 - 53: DEBUG: new connection from 127.0.0.1:47042 414s app_test.go:1117: 16:00:03.909 - 54: DEBUG: new connection from 127.0.0.1:35950 414s app_test.go:1117: 16:00:03.912 - 51: DEBUG: promoted 127.0.0.1:9004 from stand-by to voter 414s app_test.go:1117: 16:00:03.912 - 51: DEBUG: new connection from 127.0.0.1:34874 414s app_test.go:1117: 16:00:03.914 - 52: DEBUG: new connection from 127.0.0.1:54934 414s app_test.go:1117: 16:00:03.916 - 53: DEBUG: new connection from 127.0.0.1:47048 414s app_test.go:1117: 16:00:03.918 - 54: DEBUG: new connection from 127.0.0.1:35962 414s app_test.go:1117: 16:00:03.922 - 53: DEBUG: new connection from 127.0.0.1:47058 414s app_test.go:1117: 16:00:03.940 - 54: DEBUG: new connection from 127.0.0.1:35968 414s app_test.go:1117: 16:00:03.944 - 52: DEBUG: new connection from 127.0.0.1:54948 414s app_test.go:1117: 16:00:03.946 - 52: DEBUG: new connection from 127.0.0.1:54954 414s app_test.go:1117: 16:00:03.951 - 51: DEBUG: new connection from 127.0.0.1:34876 414s app_test.go:1117: 16:00:03.953 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002 414s app_test.go:1117: 16:00:03.953 - 52: DEBUG: new connection from 127.0.0.1:54958 414s app_test.go:1117: 16:00:03.955 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected 414s app_test.go:1117: 16:00:03.957 - 51: DEBUG: new connection from 127.0.0.1:34886 414s app_test.go:1117: 16:00:03.959 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connect to reported leader 127.0.0.1:9002 414s app_test.go:1117: 16:00:03.959 - 52: DEBUG: new connection from 127.0.0.1:54974 414s app_test.go:1117: 16:00:03.961 - 51: DEBUG: attempt 1: server 127.0.0.1:9001: connected 415s --- PASS: TestHandover_TransferLeadership (0.36s) 415s === RUN TestRolesAdjustment_ReplaceVoter 415s app_test.go:1117: 16:00:03.072 - 55: DEBUG: new connection from 127.0.0.1:34902 415s app_test.go:1117: 16:00:03.075 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected 415s app_test.go:1117: 16:00:03.077 - 55: DEBUG: new connection from 127.0.0.1:34906 415s app_test.go:1117: 16:00:03.099 - 55: DEBUG: new connection from 127.0.0.1:34910 415s app_test.go:1117: 16:00:03.101 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected 415s app_test.go:1117: 16:00:03.107 - 55: DEBUG: new connection from 127.0.0.1:34918 415s app_test.go:1117: 16:00:03.109 - 56: DEBUG: new connection from 127.0.0.1:54976 415s app_test.go:1117: 16:00:03.135 - 55: DEBUG: new connection from 127.0.0.1:34930 415s app_test.go:1117: 16:00:03.137 - 57: DEBUG: attempt 1: server 127.0.0.1:9001: connected 415s app_test.go:1117: 16:00:03.139 - 55: DEBUG: new connection from 127.0.0.1:34946 415s app_test.go:1117: 16:00:03.141 - 56: DEBUG: new connection from 127.0.0.1:54990 415s app_test.go:1117: 16:00:03.146 - 57: DEBUG: new connection from 127.0.0.1:47062 415s app_test.go:1117: 16:00:03.148 - 57: DEBUG: new connection from 127.0.0.1:47064 415s app_test.go:1117: 16:00:03.155 - 55: DEBUG: new connection from 127.0.0.1:34950 415s app_test.go:1117: 16:00:03.160 - 56: DEBUG: new connection from 127.0.0.1:54996 415s app_test.go:1117: 16:00:03.164 - 55: DEBUG: new connection from 127.0.0.1:34956 415s app_test.go:1117: 16:00:03.199 - 55: DEBUG: new connection from 127.0.0.1:34966 415s app_test.go:1117: 16:00:03.201 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected 415s app_test.go:1117: 16:00:03.204 - 55: DEBUG: new connection from 127.0.0.1:34980 415s app_test.go:1117: 16:00:03.206 - 56: DEBUG: new connection from 127.0.0.1:55002 415s app_test.go:1117: 16:00:03.208 - 57: DEBUG: new connection from 127.0.0.1:47066 415s app_test.go:1117: 16:00:03.210 - 58: DEBUG: new connection from 127.0.0.1:35970 415s app_test.go:1117: 16:00:03.213 - 58: DEBUG: new connection from 127.0.0.1:35974 415s app_test.go:1117: 16:00:03.219 - 55: DEBUG: new connection from 127.0.0.1:34990 417s app_test.go:1117: 16:00:03.080 - 55: DEBUG: new connection from 127.0.0.1:34994 417s app_test.go:1117: 16:00:03.083 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected 417s app_test.go:1117: 16:00:03.086 - 55: DEBUG: new connection from 127.0.0.1:35002 417s app_test.go:1117: 16:00:03.089 - 56: DEBUG: new connection from 127.0.0.1:55018 417s app_test.go:1117: 16:00:03.096 - 58: DEBUG: new connection from 127.0.0.1:35988 417s app_test.go:1117: 16:00:03.111 - 55: DEBUG: new connection from 127.0.0.1:35008 417s app_test.go:1117: 16:00:03.114 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected 417s app_test.go:1117: 16:00:03.216 - 55: DEBUG: new connection from 127.0.0.1:35024 417s app_test.go:1117: 16:00:03.219 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected 417s app_test.go:1117: 16:00:03.551 - 55: DEBUG: new connection from 127.0.0.1:35040 417s app_test.go:1117: 16:00:03.554 - 56: DEBUG: new connection from 127.0.0.1:55030 417s app_test.go:1117: 16:00:03.556 - 58: DEBUG: new connection from 127.0.0.1:35990 417s app_test.go:1117: 16:00:03.559 - 55: DEBUG: new connection from 127.0.0.1:35054 417s app_test.go:1117: 16:00:03.561 - 56: DEBUG: new connection from 127.0.0.1:55038 417s app_test.go:1117: 16:00:03.563 - 58: DEBUG: new connection from 127.0.0.1:35994 419s app_test.go:1117: 16:00:03.116 - 55: DEBUG: new connection from 127.0.0.1:32776 419s app_test.go:1117: 16:00:03.118 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected 419s app_test.go:1117: 16:00:03.221 - 55: DEBUG: new connection from 127.0.0.1:32790 419s app_test.go:1117: 16:00:03.223 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected 419s app_test.go:1117: 16:00:03.566 - 55: DEBUG: new connection from 127.0.0.1:32798 419s app_test.go:1117: 16:00:03.569 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected 419s app_test.go:1117: 16:00:03.572 - 55: DEBUG: new connection from 127.0.0.1:32812 419s app_test.go:1117: 16:00:03.576 - 56: DEBUG: new connection from 127.0.0.1:52372 419s app_test.go:1117: 16:00:03.579 - 58: DEBUG: new connection from 127.0.0.1:55456 421s app_test.go:1117: 16:00:03.122 - 55: DEBUG: new connection from 127.0.0.1:32822 422s app_test.go:1117: 16:00:03.124 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected 422s app_test.go:1117: 16:00:03.228 - 55: DEBUG: new connection from 127.0.0.1:32836 422s app_test.go:1117: 16:00:03.230 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected 422s app_test.go:1117: 16:00:03.583 - 55: DEBUG: new connection from 127.0.0.1:32848 422s app_test.go:1117: 16:00:03.585 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected 422s app_test.go:1117: 16:00:03.587 - 55: DEBUG: new connection from 127.0.0.1:32856 422s app_test.go:1117: 16:00:03.589 - 56: DEBUG: new connection from 127.0.0.1:52384 422s app_test.go:1117: 16:00:03.592 - 58: DEBUG: new connection from 127.0.0.1:55466 423s app_test.go:1117: 16:00:03.127 - 55: DEBUG: new connection from 127.0.0.1:32872 423s app_test.go:1117: 16:00:03.130 - 56: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.233 - 55: DEBUG: new connection from 127.0.0.1:32876 423s app_test.go:1117: 16:00:03.234 - 55: DEBUG: new connection from 127.0.0.1:32884 423s app_test.go:1117: 16:00:03.238 - 55: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.238 - 58: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s --- PASS: TestRolesAdjustment_ReplaceVoter (8.27s) 423s === RUN TestRolesAdjustment_ReplaceVoterHonorFailureDomain 423s app_test.go:1117: 16:00:03.345 - 59: DEBUG: new connection from 127.0.0.1:32898 423s app_test.go:1117: 16:00:03.348 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.349 - 59: DEBUG: new connection from 127.0.0.1:32914 423s app_test.go:1117: 16:00:03.379 - 59: DEBUG: new connection from 127.0.0.1:32918 423s app_test.go:1117: 16:00:03.382 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.387 - 59: DEBUG: new connection from 127.0.0.1:32924 423s app_test.go:1117: 16:00:03.391 - 60: DEBUG: new connection from 127.0.0.1:52400 423s app_test.go:1117: 16:00:03.423 - 59: DEBUG: new connection from 127.0.0.1:32932 423s app_test.go:1117: 16:00:03.425 - 61: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.428 - 59: DEBUG: new connection from 127.0.0.1:32940 423s app_test.go:1117: 16:00:03.431 - 60: DEBUG: new connection from 127.0.0.1:52410 423s app_test.go:1117: 16:00:03.434 - 61: DEBUG: new connection from 127.0.0.1:50760 423s app_test.go:1117: 16:00:03.443 - 61: DEBUG: new connection from 127.0.0.1:50768 423s app_test.go:1117: 16:00:03.448 - 59: DEBUG: new connection from 127.0.0.1:32952 423s app_test.go:1117: 16:00:03.453 - 60: DEBUG: new connection from 127.0.0.1:52416 423s app_test.go:1117: 16:00:03.456 - 59: DEBUG: new connection from 127.0.0.1:32958 423s app_test.go:1117: 16:00:03.492 - 59: DEBUG: new connection from 127.0.0.1:32972 423s app_test.go:1117: 16:00:03.494 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.498 - 59: DEBUG: new connection from 127.0.0.1:32980 423s app_test.go:1117: 16:00:03.501 - 60: DEBUG: new connection from 127.0.0.1:52432 423s app_test.go:1117: 16:00:03.505 - 61: DEBUG: new connection from 127.0.0.1:50780 423s app_test.go:1117: 16:00:03.509 - 62: DEBUG: new connection from 127.0.0.1:55482 423s app_test.go:1117: 16:00:03.515 - 62: DEBUG: new connection from 127.0.0.1:55494 423s app_test.go:1117: 16:00:03.523 - 59: DEBUG: new connection from 127.0.0.1:32986 423s app_test.go:1117: 16:00:03.552 - 59: DEBUG: new connection from 127.0.0.1:32992 423s app_test.go:1117: 16:00:03.555 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.558 - 59: DEBUG: new connection from 127.0.0.1:33000 423s app_test.go:1117: 16:00:03.561 - 60: DEBUG: new connection from 127.0.0.1:52434 423s app_test.go:1117: 16:00:03.563 - 61: DEBUG: new connection from 127.0.0.1:50794 423s app_test.go:1117: 16:00:03.565 - 62: DEBUG: new connection from 127.0.0.1:55500 423s app_test.go:1117: 16:00:03.567 - 63: DEBUG: new connection from 127.0.0.1:58466 423s app_test.go:1117: 16:00:03.569 - 63: DEBUG: new connection from 127.0.0.1:58478 423s app_test.go:1117: 16:00:03.585 - 59: DEBUG: new connection from 127.0.0.1:33004 423s app_test.go:1117: 16:00:03.600 - 59: DEBUG: new connection from 127.0.0.1:33014 423s app_test.go:1117: 16:00:03.602 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected 423s app_test.go:1117: 16:00:03.605 - 59: DEBUG: new connection from 127.0.0.1:33026 423s app_test.go:1117: 16:00:03.607 - 60: DEBUG: new connection from 127.0.0.1:52444 423s app_test.go:1117: 16:00:03.609 - 61: DEBUG: new connection from 127.0.0.1:50808 423s app_test.go:1117: 16:00:03.611 - 62: DEBUG: new connection from 127.0.0.1:55508 423s app_test.go:1117: 16:00:03.615 - 63: DEBUG: new connection from 127.0.0.1:58480 423s app_test.go:1117: 16:00:03.618 - 64: DEBUG: new connection from 127.0.0.1:39456 423s app_test.go:1117: 16:00:03.620 - 64: DEBUG: new connection from 127.0.0.1:39468 423s app_test.go:1117: 16:00:03.631 - 59: DEBUG: new connection from 127.0.0.1:33042 427s app_test.go:1117: 16:00:03.352 - 59: DEBUG: new connection from 127.0.0.1:33058 427s app_test.go:1117: 16:00:03.357 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 427s app_test.go:1117: 16:00:03.359 - 59: DEBUG: new connection from 127.0.0.1:33066 427s app_test.go:1117: 16:00:03.362 - 60: DEBUG: new connection from 127.0.0.1:52448 427s app_test.go:1117: 16:00:03.365 - 62: DEBUG: new connection from 127.0.0.1:55524 427s app_test.go:1117: 16:00:03.367 - 63: DEBUG: new connection from 127.0.0.1:58490 427s app_test.go:1117: 16:00:03.369 - 64: DEBUG: new connection from 127.0.0.1:39482 427s app_test.go:1117: 16:00:03.395 - 59: DEBUG: new connection from 127.0.0.1:33072 427s app_test.go:1117: 16:00:03.397 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected 427s app_test.go:1117: 16:00:03.519 - 59: DEBUG: new connection from 127.0.0.1:33086 427s app_test.go:1117: 16:00:03.522 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected 427s app_test.go:1117: 16:00:03.572 - 59: DEBUG: new connection from 127.0.0.1:33102 427s app_test.go:1117: 16:00:03.574 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected 427s app_test.go:1117: 16:00:03.624 - 59: DEBUG: new connection from 127.0.0.1:33106 427s app_test.go:1117: 16:00:03.626 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected 427s app_test.go:1117: 16:00:03.823 - 59: DEBUG: new connection from 127.0.0.1:33110 427s app_test.go:1117: 16:00:03.825 - 60: DEBUG: new connection from 127.0.0.1:52462 427s app_test.go:1117: 16:00:03.828 - 62: DEBUG: new connection from 127.0.0.1:55534 427s app_test.go:1117: 16:00:03.830 - 63: DEBUG: new connection from 127.0.0.1:58498 427s app_test.go:1117: 16:00:03.832 - 64: DEBUG: new connection from 127.0.0.1:39486 427s app_test.go:1117: 16:00:03.835 - 59: DEBUG: new connection from 127.0.0.1:33114 427s app_test.go:1117: 16:00:03.837 - 60: DEBUG: new connection from 127.0.0.1:52478 427s app_test.go:1117: 16:00:03.840 - 62: DEBUG: new connection from 127.0.0.1:55548 427s app_test.go:1117: 16:00:03.842 - 63: DEBUG: new connection from 127.0.0.1:58510 427s app_test.go:1117: 16:00:03.844 - 64: DEBUG: new connection from 127.0.0.1:39498 431s app_test.go:1117: 16:01:03.399 - 59: DEBUG: new connection from 127.0.0.1:39148 431s app_test.go:1117: 16:01:03.401 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected 431s app_test.go:1117: 16:01:03.526 - 59: DEBUG: new connection from 127.0.0.1:39156 431s app_test.go:1117: 16:01:03.529 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected 431s app_test.go:1117: 16:01:03.578 - 59: DEBUG: new connection from 127.0.0.1:39162 431s app_test.go:1117: 16:01:03.580 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected 431s app_test.go:1117: 16:01:03.628 - 59: DEBUG: new connection from 127.0.0.1:39176 431s app_test.go:1117: 16:01:03.630 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected 431s app_test.go:1117: 16:01:03.846 - 59: DEBUG: new connection from 127.0.0.1:39190 431s app_test.go:1117: 16:01:03.848 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 431s app_test.go:1117: 16:01:03.850 - 59: DEBUG: new connection from 127.0.0.1:39202 431s app_test.go:1117: 16:01:03.852 - 60: DEBUG: new connection from 127.0.0.1:35990 431s app_test.go:1117: 16:01:03.855 - 62: DEBUG: new connection from 127.0.0.1:55832 431s app_test.go:1117: 16:01:03.857 - 63: DEBUG: new connection from 127.0.0.1:59964 431s app_test.go:1117: 16:01:03.859 - 64: DEBUG: new connection from 127.0.0.1:42684 435s app_test.go:1117: 16:01:03.404 - 59: DEBUG: new connection from 127.0.0.1:39208 435s app_test.go:1117: 16:01:03.406 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected 435s app_test.go:1117: 16:01:03.532 - 59: DEBUG: new connection from 127.0.0.1:39216 435s app_test.go:1117: 16:01:03.535 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected 435s app_test.go:1117: 16:01:03.583 - 59: DEBUG: new connection from 127.0.0.1:39226 435s app_test.go:1117: 16:01:03.585 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected 435s app_test.go:1117: 16:01:03.633 - 59: DEBUG: new connection from 127.0.0.1:39240 435s app_test.go:1117: 16:01:03.635 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected 435s app_test.go:1117: 16:01:03.861 - 59: DEBUG: new connection from 127.0.0.1:39252 435s app_test.go:1117: 16:01:03.863 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 435s app_test.go:1117: 16:01:03.868 - 59: DEBUG: new connection from 127.0.0.1:39260 435s app_test.go:1117: 16:01:03.870 - 60: DEBUG: new connection from 127.0.0.1:36002 435s app_test.go:1117: 16:01:03.873 - 62: DEBUG: new connection from 127.0.0.1:55846 435s app_test.go:1117: 16:01:03.876 - 63: DEBUG: new connection from 127.0.0.1:59976 435s app_test.go:1117: 16:01:03.878 - 64: DEBUG: new connection from 127.0.0.1:42696 439s app_test.go:1117: 16:01:03.410 - 59: DEBUG: new connection from 127.0.0.1:38678 439s app_test.go:1117: 16:01:03.412 - 60: DEBUG: attempt 1: server 127.0.0.1:9001: connected 439s app_test.go:1117: 16:01:03.539 - 59: DEBUG: new connection from 127.0.0.1:38694 439s app_test.go:1117: 16:01:03.541 - 62: DEBUG: attempt 1: server 127.0.0.1:9001: connected 439s app_test.go:1117: 16:01:03.588 - 59: DEBUG: new connection from 127.0.0.1:38710 439s app_test.go:1117: 16:01:03.591 - 63: DEBUG: attempt 1: server 127.0.0.1:9001: connected 439s app_test.go:1117: 16:01:03.639 - 59: DEBUG: new connection from 127.0.0.1:38722 439s app_test.go:1117: 16:01:03.642 - 64: DEBUG: attempt 1: server 127.0.0.1:9001: connected 439s app_test.go:1117: 16:01:03.882 - 59: DEBUG: new connection from 127.0.0.1:38732 439s app_test.go:1117: 16:01:03.884 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 439s app_test.go:1117: 16:01:03.886 - 59: DEBUG: new connection from 127.0.0.1:38736 439s app_test.go:1117: 16:01:03.889 - 60: DEBUG: new connection from 127.0.0.1:51040 439s app_test.go:1117: 16:01:03.892 - 62: DEBUG: new connection from 127.0.0.1:46644 439s app_test.go:1117: 16:01:03.894 - 63: DEBUG: new connection from 127.0.0.1:46742 439s app_test.go:1117: 16:01:03.897 - 64: DEBUG: new connection from 127.0.0.1:40144 441s app_test.go:1117: 16:01:03.642 - 59: DEBUG: new connection from 127.0.0.1:38738 441s app_test.go:1117: 16:01:03.644 - 59: DEBUG: attempt 1: server 127.0.0.1:9001: connected 441s --- PASS: TestRolesAdjustment_ReplaceVoterHonorFailureDomain (18.44s) 441s === RUN TestRolesAdjustment_ReplaceVoterHonorWeight 441s app_test.go:1117: 16:01:03.795 - 65: DEBUG: new connection from 127.0.0.1:38740 441s app_test.go:1117: 16:01:03.798 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 441s app_test.go:1117: 16:01:03.800 - 65: DEBUG: new connection from 127.0.0.1:38742 441s app_test.go:1117: 16:01:03.834 - 65: DEBUG: new connection from 127.0.0.1:38748 441s app_test.go:1117: 16:01:03.837 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected 441s app_test.go:1117: 16:01:03.843 - 65: DEBUG: new connection from 127.0.0.1:38756 441s app_test.go:1117: 16:01:03.845 - 66: DEBUG: new connection from 127.0.0.1:51046 441s app_test.go:1117: 16:01:03.872 - 65: DEBUG: new connection from 127.0.0.1:38762 441s app_test.go:1117: 16:01:03.874 - 67: DEBUG: attempt 1: server 127.0.0.1:9001: connected 441s app_test.go:1117: 16:01:03.876 - 65: DEBUG: new connection from 127.0.0.1:38776 441s app_test.go:1117: 16:01:03.878 - 66: DEBUG: new connection from 127.0.0.1:51058 441s app_test.go:1117: 16:01:03.880 - 67: DEBUG: new connection from 127.0.0.1:57018 441s app_test.go:1117: 16:01:03.891 - 67: DEBUG: new connection from 127.0.0.1:57032 441s app_test.go:1117: 16:01:03.912 - 65: DEBUG: new connection from 127.0.0.1:38778 441s app_test.go:1117: 16:01:03.916 - 66: DEBUG: new connection from 127.0.0.1:51072 441s app_test.go:1117: 16:01:03.924 - 65: DEBUG: new connection from 127.0.0.1:38780 441s app_test.go:1117: 16:01:03.959 - 65: DEBUG: new connection from 127.0.0.1:38790 441s app_test.go:1117: 16:01:03.962 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected 441s app_test.go:1117: 16:01:03.965 - 65: DEBUG: new connection from 127.0.0.1:38800 441s app_test.go:1117: 16:01:03.967 - 66: DEBUG: new connection from 127.0.0.1:51084 442s app_test.go:1117: 16:01:03.970 - 67: DEBUG: new connection from 127.0.0.1:57048 442s app_test.go:1117: 16:01:03.973 - 68: DEBUG: new connection from 127.0.0.1:46652 442s app_test.go:1117: 16:01:03.976 - 68: DEBUG: new connection from 127.0.0.1:46660 442s app_test.go:1117: 16:01:03.985 - 65: DEBUG: new connection from 127.0.0.1:38812 442s app_test.go:1117: 16:01:03.020 - 65: DEBUG: new connection from 127.0.0.1:38818 442s app_test.go:1117: 16:01:03.023 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected 442s app_test.go:1117: 16:01:03.026 - 65: DEBUG: new connection from 127.0.0.1:38830 442s app_test.go:1117: 16:01:03.028 - 66: DEBUG: new connection from 127.0.0.1:51086 442s app_test.go:1117: 16:01:03.031 - 67: DEBUG: new connection from 127.0.0.1:57052 442s app_test.go:1117: 16:01:03.033 - 68: DEBUG: new connection from 127.0.0.1:46666 442s app_test.go:1117: 16:01:03.038 - 69: DEBUG: new connection from 127.0.0.1:46750 442s app_test.go:1117: 16:01:03.042 - 69: DEBUG: new connection from 127.0.0.1:46752 442s app_test.go:1117: 16:01:03.069 - 65: DEBUG: new connection from 127.0.0.1:38838 442s app_test.go:1117: 16:01:03.101 - 65: DEBUG: new connection from 127.0.0.1:38840 442s app_test.go:1117: 16:01:03.104 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected 442s app_test.go:1117: 16:01:03.111 - 65: DEBUG: new connection from 127.0.0.1:38852 442s app_test.go:1117: 16:01:03.113 - 66: DEBUG: new connection from 127.0.0.1:51102 442s app_test.go:1117: 16:01:03.115 - 67: DEBUG: new connection from 127.0.0.1:57060 442s app_test.go:1117: 16:01:03.119 - 68: DEBUG: new connection from 127.0.0.1:46670 442s app_test.go:1117: 16:01:03.121 - 69: DEBUG: new connection from 127.0.0.1:46758 442s app_test.go:1117: 16:01:03.123 - 70: DEBUG: new connection from 127.0.0.1:40160 442s app_test.go:1117: 16:01:03.126 - 70: DEBUG: new connection from 127.0.0.1:40172 442s app_test.go:1117: 16:01:03.140 - 65: DEBUG: new connection from 127.0.0.1:38864 445s app_test.go:1117: 16:01:03.802 - 65: DEBUG: new connection from 127.0.0.1:38870 445s app_test.go:1117: 16:01:03.805 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 445s app_test.go:1117: 16:01:03.807 - 65: DEBUG: new connection from 127.0.0.1:38882 445s app_test.go:1117: 16:01:03.810 - 66: DEBUG: new connection from 127.0.0.1:51104 445s app_test.go:1117: 16:01:03.813 - 68: DEBUG: new connection from 127.0.0.1:46684 445s app_test.go:1117: 16:01:03.815 - 69: DEBUG: new connection from 127.0.0.1:46770 445s app_test.go:1117: 16:01:03.817 - 70: DEBUG: new connection from 127.0.0.1:40174 445s app_test.go:1117: 16:01:03.848 - 65: DEBUG: new connection from 127.0.0.1:38892 445s app_test.go:1117: 16:01:03.850 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected 446s app_test.go:1117: 16:01:03.982 - 65: DEBUG: new connection from 127.0.0.1:38900 446s app_test.go:1117: 16:01:03.984 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected 446s app_test.go:1117: 16:01:03.046 - 65: DEBUG: new connection from 127.0.0.1:38908 446s app_test.go:1117: 16:01:03.050 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected 446s app_test.go:1117: 16:01:03.137 - 65: DEBUG: new connection from 127.0.0.1:38914 446s app_test.go:1117: 16:01:03.140 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected 446s app_test.go:1117: 16:01:03.270 - 65: DEBUG: new connection from 127.0.0.1:38920 446s app_test.go:1117: 16:01:03.273 - 66: DEBUG: new connection from 127.0.0.1:51106 446s app_test.go:1117: 16:01:03.276 - 68: DEBUG: new connection from 127.0.0.1:46700 446s app_test.go:1117: 16:01:03.279 - 69: DEBUG: new connection from 127.0.0.1:46778 446s app_test.go:1117: 16:01:03.281 - 70: DEBUG: new connection from 127.0.0.1:40186 446s app_test.go:1117: 16:01:03.285 - 65: DEBUG: new connection from 127.0.0.1:38926 446s app_test.go:1117: 16:01:03.287 - 66: DEBUG: new connection from 127.0.0.1:51120 446s app_test.go:1117: 16:01:03.290 - 68: DEBUG: new connection from 127.0.0.1:46714 446s app_test.go:1117: 16:01:03.292 - 69: DEBUG: new connection from 127.0.0.1:46794 446s app_test.go:1117: 16:01:03.294 - 70: DEBUG: new connection from 127.0.0.1:40192 449s app_test.go:1117: 16:01:03.855 - 65: DEBUG: new connection from 127.0.0.1:36358 449s app_test.go:1117: 16:01:03.858 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected 450s app_test.go:1117: 16:01:03.988 - 65: DEBUG: new connection from 127.0.0.1:36364 450s app_test.go:1117: 16:01:03.990 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected 450s app_test.go:1117: 16:01:03.053 - 65: DEBUG: new connection from 127.0.0.1:36372 450s app_test.go:1117: 16:01:03.056 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected 450s app_test.go:1117: 16:01:03.145 - 65: DEBUG: new connection from 127.0.0.1:36380 450s app_test.go:1117: 16:01:03.147 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected 450s app_test.go:1117: 16:01:03.297 - 65: DEBUG: new connection from 127.0.0.1:36382 450s app_test.go:1117: 16:01:03.299 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 450s app_test.go:1117: 16:01:03.302 - 65: DEBUG: new connection from 127.0.0.1:36388 450s app_test.go:1117: 16:01:03.304 - 66: DEBUG: new connection from 127.0.0.1:50958 450s app_test.go:1117: 16:01:03.306 - 68: DEBUG: new connection from 127.0.0.1:39554 450s app_test.go:1117: 16:01:03.308 - 69: DEBUG: new connection from 127.0.0.1:37778 450s app_test.go:1117: 16:01:03.311 - 70: DEBUG: new connection from 127.0.0.1:39486 453s app_test.go:1117: 16:01:03.861 - 65: DEBUG: new connection from 127.0.0.1:36396 453s app_test.go:1117: 16:01:03.863 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected 454s app_test.go:1117: 16:01:03.993 - 65: DEBUG: new connection from 127.0.0.1:36398 454s app_test.go:1117: 16:01:03.996 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected 454s app_test.go:1117: 16:01:03.060 - 65: DEBUG: new connection from 127.0.0.1:36400 454s app_test.go:1117: 16:01:03.063 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected 454s app_test.go:1117: 16:01:03.150 - 65: DEBUG: new connection from 127.0.0.1:36408 454s app_test.go:1117: 16:01:03.153 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected 454s app_test.go:1117: 16:01:03.313 - 65: DEBUG: new connection from 127.0.0.1:36412 454s app_test.go:1117: 16:01:03.318 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 454s app_test.go:1117: 16:01:03.320 - 65: DEBUG: new connection from 127.0.0.1:36420 454s app_test.go:1117: 16:01:03.323 - 66: DEBUG: new connection from 127.0.0.1:50960 454s app_test.go:1117: 16:01:03.326 - 68: DEBUG: new connection from 127.0.0.1:39570 454s app_test.go:1117: 16:01:03.328 - 69: DEBUG: new connection from 127.0.0.1:37790 454s app_test.go:1117: 16:01:03.331 - 70: DEBUG: new connection from 127.0.0.1:39494 457s app_test.go:1117: 16:01:03.866 - 65: DEBUG: new connection from 127.0.0.1:36430 457s app_test.go:1117: 16:01:03.868 - 66: DEBUG: attempt 1: server 127.0.0.1:9001: connected 458s app_test.go:1117: 16:01:03.000 - 65: DEBUG: new connection from 127.0.0.1:36432 458s app_test.go:1117: 16:01:03.002 - 68: DEBUG: attempt 1: server 127.0.0.1:9001: connected 458s app_test.go:1117: 16:01:03.068 - 65: DEBUG: new connection from 127.0.0.1:36440 458s app_test.go:1117: 16:01:03.071 - 69: DEBUG: attempt 1: server 127.0.0.1:9001: connected 458s app_test.go:1117: 16:01:03.156 - 65: DEBUG: new connection from 127.0.0.1:36448 458s app_test.go:1117: 16:01:03.158 - 70: DEBUG: attempt 1: server 127.0.0.1:9001: connected 458s app_test.go:1117: 16:01:03.335 - 65: DEBUG: new connection from 127.0.0.1:36462 458s app_test.go:1117: 16:01:03.337 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 458s app_test.go:1117: 16:01:03.339 - 65: DEBUG: new connection from 127.0.0.1:36464 458s app_test.go:1117: 16:01:03.341 - 66: DEBUG: new connection from 127.0.0.1:50970 458s app_test.go:1117: 16:01:03.345 - 68: DEBUG: new connection from 127.0.0.1:39584 458s app_test.go:1117: 16:01:03.347 - 69: DEBUG: new connection from 127.0.0.1:37800 458s app_test.go:1117: 16:01:03.350 - 70: DEBUG: new connection from 127.0.0.1:39508 460s app_test.go:1117: 16:01:03.155 - 65: DEBUG: new connection from 127.0.0.1:44990 460s app_test.go:1117: 16:01:03.157 - 65: DEBUG: attempt 1: server 127.0.0.1:9001: connected 460s --- PASS: TestRolesAdjustment_ReplaceVoterHonorWeight (18.52s) 460s === RUN TestRolesAdjustment_CantReplaceVoter 460s app_test.go:1117: 16:01:03.300 - 71: DEBUG: new connection from 127.0.0.1:45002 460s app_test.go:1117: 16:01:03.303 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected 460s app_test.go:1117: 16:01:03.304 - 71: DEBUG: new connection from 127.0.0.1:45010 460s app_test.go:1117: 16:01:03.336 - 71: DEBUG: new connection from 127.0.0.1:45016 460s app_test.go:1117: 16:01:03.339 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected 460s app_test.go:1117: 16:01:03.344 - 71: DEBUG: new connection from 127.0.0.1:45028 460s app_test.go:1117: 16:01:03.347 - 72: DEBUG: new connection from 127.0.0.1:53674 460s app_test.go:1117: 16:01:03.384 - 71: DEBUG: new connection from 127.0.0.1:45034 460s app_test.go:1117: 16:01:03.386 - 73: DEBUG: attempt 1: server 127.0.0.1:9001: connected 460s app_test.go:1117: 16:01:03.389 - 71: DEBUG: new connection from 127.0.0.1:45050 460s app_test.go:1117: 16:01:03.391 - 72: DEBUG: new connection from 127.0.0.1:53680 460s app_test.go:1117: 16:01:03.394 - 73: DEBUG: new connection from 127.0.0.1:45974 460s app_test.go:1117: 16:01:03.402 - 73: DEBUG: new connection from 127.0.0.1:45978 460s app_test.go:1117: 16:01:03.406 - 71: DEBUG: new connection from 127.0.0.1:45060 460s app_test.go:1117: 16:01:03.411 - 72: DEBUG: new connection from 127.0.0.1:53694 460s app_test.go:1117: 16:01:03.416 - 71: DEBUG: new connection from 127.0.0.1:45062 460s app_test.go:1117: 16:01:03.453 - 71: DEBUG: new connection from 127.0.0.1:45076 460s app_test.go:1117: 16:01:03.456 - 74: DEBUG: attempt 1: server 127.0.0.1:9001: connected 460s app_test.go:1117: 16:01:03.459 - 71: DEBUG: new connection from 127.0.0.1:45082 460s app_test.go:1117: 16:01:03.461 - 72: DEBUG: new connection from 127.0.0.1:53704 460s app_test.go:1117: 16:01:03.464 - 73: DEBUG: new connection from 127.0.0.1:45980 460s app_test.go:1117: 16:01:03.466 - 74: DEBUG: new connection from 127.0.0.1:49356 460s app_test.go:1117: 16:01:03.477 - 74: DEBUG: new connection from 127.0.0.1:49358 464s app_test.go:1117: 16:01:03.308 - 71: DEBUG: new connection from 127.0.0.1:45084 464s app_test.go:1117: 16:01:03.310 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected 464s app_test.go:1117: 16:01:03.313 - 71: DEBUG: new connection from 127.0.0.1:45100 464s app_test.go:1117: 16:01:03.315 - 72: DEBUG: new connection from 127.0.0.1:53706 464s app_test.go:1117: 16:01:03.351 - 71: DEBUG: new connection from 127.0.0.1:45104 464s app_test.go:1117: 16:01:03.353 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected 468s app_test.go:1117: 16:01:03.318 - 71: DEBUG: new connection from 127.0.0.1:45114 468s app_test.go:1117: 16:01:03.320 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected 468s app_test.go:1117: 16:01:03.322 - 71: DEBUG: new connection from 127.0.0.1:45130 468s app_test.go:1117: 16:01:03.326 - 72: DEBUG: new connection from 127.0.0.1:53720 468s app_test.go:1117: 16:01:03.355 - 71: DEBUG: new connection from 127.0.0.1:45140 468s app_test.go:1117: 16:01:03.357 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.329 - 71: DEBUG: new connection from 127.0.0.1:46746 472s app_test.go:1117: 16:01:03.332 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.335 - 71: DEBUG: new connection from 127.0.0.1:46758 472s app_test.go:1117: 16:01:03.338 - 72: DEBUG: new connection from 127.0.0.1:47922 472s app_test.go:1117: 16:01:03.360 - 71: DEBUG: new connection from 127.0.0.1:46760 472s app_test.go:1117: 16:01:03.362 - 72: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.524 - 71: DEBUG: new connection from 127.0.0.1:46772 472s app_test.go:1117: 16:01:03.526 - 71: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s --- PASS: TestRolesAdjustment_CantReplaceVoter (12.30s) 472s === RUN TestRolesAdjustment_ReplaceStandBy 472s app_test.go:1117: 16:01:03.598 - 75: DEBUG: new connection from 127.0.0.1:46784 472s app_test.go:1117: 16:01:03.601 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.602 - 75: DEBUG: new connection from 127.0.0.1:46788 472s app_test.go:1117: 16:01:03.635 - 75: DEBUG: new connection from 127.0.0.1:46792 472s app_test.go:1117: 16:01:03.637 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.641 - 75: DEBUG: new connection from 127.0.0.1:46808 472s app_test.go:1117: 16:01:03.643 - 76: DEBUG: new connection from 127.0.0.1:47934 472s app_test.go:1117: 16:01:03.675 - 75: DEBUG: new connection from 127.0.0.1:46818 472s app_test.go:1117: 16:01:03.677 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.680 - 75: DEBUG: new connection from 127.0.0.1:46822 472s app_test.go:1117: 16:01:03.682 - 76: DEBUG: new connection from 127.0.0.1:47944 472s app_test.go:1117: 16:01:03.684 - 77: DEBUG: new connection from 127.0.0.1:54994 472s app_test.go:1117: 16:01:03.688 - 77: DEBUG: new connection from 127.0.0.1:55004 472s app_test.go:1117: 16:01:03.691 - 75: DEBUG: new connection from 127.0.0.1:46834 472s app_test.go:1117: 16:01:03.695 - 76: DEBUG: new connection from 127.0.0.1:47948 472s app_test.go:1117: 16:01:03.700 - 75: DEBUG: new connection from 127.0.0.1:46844 472s app_test.go:1117: 16:01:03.731 - 75: DEBUG: new connection from 127.0.0.1:46852 472s app_test.go:1117: 16:01:03.733 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.736 - 75: DEBUG: new connection from 127.0.0.1:46856 472s app_test.go:1117: 16:01:03.738 - 76: DEBUG: new connection from 127.0.0.1:47960 472s app_test.go:1117: 16:01:03.740 - 77: DEBUG: new connection from 127.0.0.1:55020 472s app_test.go:1117: 16:01:03.742 - 78: DEBUG: new connection from 127.0.0.1:39736 472s app_test.go:1117: 16:01:03.751 - 78: DEBUG: new connection from 127.0.0.1:39738 472s app_test.go:1117: 16:01:03.756 - 75: DEBUG: new connection from 127.0.0.1:46860 472s app_test.go:1117: 16:01:03.783 - 75: DEBUG: new connection from 127.0.0.1:46874 472s app_test.go:1117: 16:01:03.785 - 79: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.791 - 75: DEBUG: new connection from 127.0.0.1:46876 472s app_test.go:1117: 16:01:03.793 - 76: DEBUG: new connection from 127.0.0.1:47970 472s app_test.go:1117: 16:01:03.795 - 77: DEBUG: new connection from 127.0.0.1:55036 472s app_test.go:1117: 16:01:03.797 - 78: DEBUG: new connection from 127.0.0.1:39746 472s app_test.go:1117: 16:01:03.801 - 79: DEBUG: new connection from 127.0.0.1:52420 472s app_test.go:1117: 16:01:03.806 - 79: DEBUG: new connection from 127.0.0.1:52434 472s app_test.go:1117: 16:01:03.811 - 75: DEBUG: new connection from 127.0.0.1:46892 472s app_test.go:1117: 16:01:03.843 - 75: DEBUG: new connection from 127.0.0.1:46904 472s app_test.go:1117: 16:01:03.845 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.847 - 75: DEBUG: new connection from 127.0.0.1:46912 472s app_test.go:1117: 16:01:03.849 - 76: DEBUG: new connection from 127.0.0.1:47982 472s app_test.go:1117: 16:01:03.852 - 77: DEBUG: new connection from 127.0.0.1:55040 472s app_test.go:1117: 16:01:03.854 - 78: DEBUG: new connection from 127.0.0.1:39762 472s app_test.go:1117: 16:01:03.856 - 79: DEBUG: new connection from 127.0.0.1:52440 472s app_test.go:1117: 16:01:03.858 - 80: DEBUG: new connection from 127.0.0.1:56832 472s app_test.go:1117: 16:01:03.860 - 80: DEBUG: new connection from 127.0.0.1:56838 472s app_test.go:1117: 16:01:03.885 - 75: DEBUG: new connection from 127.0.0.1:46916 472s app_test.go:1117: 16:01:03.888 - 75: DEBUG: new connection from 127.0.0.1:46930 472s app_test.go:1117: 16:01:03.891 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected 472s app_test.go:1117: 16:01:03.894 - 75: DEBUG: new connection from 127.0.0.1:46946 472s app_test.go:1117: 16:01:03.896 - 76: DEBUG: new connection from 127.0.0.1:47988 472s app_test.go:1117: 16:01:03.898 - 77: DEBUG: new connection from 127.0.0.1:55054 472s app_test.go:1117: 16:01:03.900 - 78: DEBUG: new connection from 127.0.0.1:39772 472s app_test.go:1117: 16:01:03.902 - 79: DEBUG: new connection from 127.0.0.1:52452 472s app_test.go:1117: 16:01:03.904 - 80: DEBUG: new connection from 127.0.0.1:56846 472s app_test.go:1117: 16:01:03.905 - 81: DEBUG: new connection from 127.0.0.1:47360 477s app_test.go:1117: 16:01:03.605 - 75: DEBUG: new connection from 127.0.0.1:46962 477s app_test.go:1117: 16:01:03.607 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected 477s app_test.go:1117: 16:01:03.609 - 75: DEBUG: new connection from 127.0.0.1:46968 477s app_test.go:1117: 16:01:03.612 - 76: DEBUG: new connection from 127.0.0.1:47998 477s app_test.go:1117: 16:01:03.614 - 77: DEBUG: new connection from 127.0.0.1:55068 477s app_test.go:1117: 16:01:03.617 - 78: DEBUG: new connection from 127.0.0.1:39778 477s app_test.go:1117: 16:01:03.621 - 80: DEBUG: new connection from 127.0.0.1:56862 477s app_test.go:1117: 16:01:03.623 - 81: DEBUG: new connection from 127.0.0.1:47376 477s app_test.go:1117: 16:01:03.625 - 81: DEBUG: new connection from 127.0.0.1:47382 477s app_test.go:1117: 16:01:03.631 - 75: DEBUG: new connection from 127.0.0.1:46974 477s app_test.go:1117: 16:01:03.647 - 75: DEBUG: new connection from 127.0.0.1:46984 477s app_test.go:1117: 16:01:03.650 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected 477s app_test.go:1117: 16:01:03.705 - 75: DEBUG: new connection from 127.0.0.1:46986 477s app_test.go:1117: 16:01:03.707 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected 477s app_test.go:1117: 16:01:03.755 - 75: DEBUG: new connection from 127.0.0.1:46992 477s app_test.go:1117: 16:01:03.757 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected 477s app_test.go:1117: 16:01:03.864 - 75: DEBUG: new connection from 127.0.0.1:47006 477s app_test.go:1117: 16:01:03.866 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected 477s app_test.go:1117: 16:01:03.908 - 75: DEBUG: new connection from 127.0.0.1:47012 477s app_test.go:1117: 16:01:03.910 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected 478s app_test.go:1117: 16:01:03.085 - 75: DEBUG: new connection from 127.0.0.1:47026 478s app_test.go:1117: 16:01:03.088 - 76: DEBUG: new connection from 127.0.0.1:48014 478s app_test.go:1117: 16:01:03.090 - 77: DEBUG: new connection from 127.0.0.1:55084 478s app_test.go:1117: 16:01:03.092 - 78: DEBUG: new connection from 127.0.0.1:39782 478s app_test.go:1117: 16:01:03.096 - 80: DEBUG: new connection from 127.0.0.1:56870 478s app_test.go:1117: 16:01:03.099 - 81: DEBUG: new connection from 127.0.0.1:47398 478s app_test.go:1117: 16:01:03.104 - 75: DEBUG: new connection from 127.0.0.1:47032 478s app_test.go:1117: 16:01:03.106 - 76: DEBUG: new connection from 127.0.0.1:48020 478s app_test.go:1117: 16:01:03.109 - 77: DEBUG: new connection from 127.0.0.1:55090 478s app_test.go:1117: 16:01:03.111 - 78: DEBUG: new connection from 127.0.0.1:39786 478s app_test.go:1117: 16:01:03.113 - 80: DEBUG: new connection from 127.0.0.1:56884 478s app_test.go:1117: 16:01:03.115 - 81: DEBUG: new connection from 127.0.0.1:47414 482s app_test.go:1117: 16:01:03.654 - 75: DEBUG: new connection from 127.0.0.1:50252 482s app_test.go:1117: 16:01:03.657 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected 482s app_test.go:1117: 16:01:03.710 - 75: DEBUG: new connection from 127.0.0.1:50254 482s app_test.go:1117: 16:01:03.712 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected 482s app_test.go:1117: 16:01:03.760 - 75: DEBUG: new connection from 127.0.0.1:50258 482s app_test.go:1117: 16:01:03.762 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected 482s app_test.go:1117: 16:01:03.870 - 75: DEBUG: new connection from 127.0.0.1:50266 482s app_test.go:1117: 16:01:03.873 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected 482s app_test.go:1117: 16:01:03.921 - 75: DEBUG: new connection from 127.0.0.1:50276 482s app_test.go:1117: 16:01:03.923 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected 483s app_test.go:1117: 16:01:03.118 - 75: DEBUG: new connection from 127.0.0.1:50288 483s app_test.go:1117: 16:01:03.120 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected 483s app_test.go:1117: 16:01:03.123 - 75: DEBUG: new connection from 127.0.0.1:50296 483s app_test.go:1117: 16:01:03.127 - 76: DEBUG: new connection from 127.0.0.1:41864 483s app_test.go:1117: 16:01:03.130 - 77: DEBUG: new connection from 127.0.0.1:56948 483s app_test.go:1117: 16:01:03.132 - 78: DEBUG: new connection from 127.0.0.1:33294 483s app_test.go:1117: 16:01:03.134 - 80: DEBUG: new connection from 127.0.0.1:38678 483s app_test.go:1117: 16:01:03.136 - 81: DEBUG: new connection from 127.0.0.1:56800 487s app_test.go:1117: 16:01:03.660 - 75: DEBUG: new connection from 127.0.0.1:50302 487s app_test.go:1117: 16:01:03.663 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected 487s app_test.go:1117: 16:01:03.715 - 75: DEBUG: new connection from 127.0.0.1:50310 487s app_test.go:1117: 16:01:03.718 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected 487s app_test.go:1117: 16:01:03.765 - 75: DEBUG: new connection from 127.0.0.1:50324 487s app_test.go:1117: 16:01:03.769 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected 487s app_test.go:1117: 16:01:03.878 - 75: DEBUG: new connection from 127.0.0.1:50334 487s app_test.go:1117: 16:01:03.881 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected 487s app_test.go:1117: 16:01:03.926 - 75: DEBUG: new connection from 127.0.0.1:50336 487s app_test.go:1117: 16:01:03.929 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected 488s app_test.go:1117: 16:01:03.139 - 75: DEBUG: new connection from 127.0.0.1:50348 488s app_test.go:1117: 16:01:03.142 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected 488s app_test.go:1117: 16:01:03.145 - 75: DEBUG: new connection from 127.0.0.1:50352 488s app_test.go:1117: 16:01:03.148 - 76: DEBUG: new connection from 127.0.0.1:41880 488s app_test.go:1117: 16:01:03.151 - 77: DEBUG: new connection from 127.0.0.1:56956 488s app_test.go:1117: 16:01:03.153 - 78: DEBUG: new connection from 127.0.0.1:33310 488s app_test.go:1117: 16:01:03.156 - 80: DEBUG: new connection from 127.0.0.1:38684 488s app_test.go:1117: 16:01:03.159 - 81: DEBUG: new connection from 127.0.0.1:56804 492s app_test.go:1117: 16:02:03.666 - 75: DEBUG: new connection from 127.0.0.1:38508 492s app_test.go:1117: 16:02:03.669 - 76: DEBUG: attempt 1: server 127.0.0.1:9001: connected 492s app_test.go:1117: 16:02:03.725 - 75: DEBUG: new connection from 127.0.0.1:38512 492s app_test.go:1117: 16:02:03.728 - 77: DEBUG: attempt 1: server 127.0.0.1:9001: connected 492s app_test.go:1117: 16:02:03.772 - 75: DEBUG: new connection from 127.0.0.1:38516 492s app_test.go:1117: 16:02:03.775 - 78: DEBUG: attempt 1: server 127.0.0.1:9001: connected 492s app_test.go:1117: 16:02:03.892 - 75: DEBUG: new connection from 127.0.0.1:38530 492s app_test.go:1117: 16:02:03.895 - 80: DEBUG: attempt 1: server 127.0.0.1:9001: connected 492s app_test.go:1117: 16:02:03.931 - 75: DEBUG: new connection from 127.0.0.1:38544 492s app_test.go:1117: 16:02:03.933 - 75: DEBUG: new connection from 127.0.0.1:38560 492s app_test.go:1117: 16:02:03.936 - 75: DEBUG: attempt 1: server 127.0.0.1:9001: connected 492s app_test.go:1117: 16:02:03.936 - 81: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s --- PASS: TestRolesAdjustment_ReplaceStandBy (20.51s) 493s === RUN TestRolesAdjustment_ReplaceStandByHonorFailureDomains 493s app_test.go:1117: 16:02:03.107 - 82: DEBUG: new connection from 127.0.0.1:38572 493s app_test.go:1117: 16:02:03.110 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.112 - 82: DEBUG: new connection from 127.0.0.1:38584 493s app_test.go:1117: 16:02:03.140 - 82: DEBUG: new connection from 127.0.0.1:38594 493s app_test.go:1117: 16:02:03.143 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.147 - 82: DEBUG: new connection from 127.0.0.1:38604 493s app_test.go:1117: 16:02:03.150 - 83: DEBUG: new connection from 127.0.0.1:53856 493s app_test.go:1117: 16:02:03.184 - 82: DEBUG: new connection from 127.0.0.1:38620 493s app_test.go:1117: 16:02:03.188 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.196 - 82: DEBUG: new connection from 127.0.0.1:38624 493s app_test.go:1117: 16:02:03.198 - 83: DEBUG: new connection from 127.0.0.1:53858 493s app_test.go:1117: 16:02:03.203 - 84: DEBUG: new connection from 127.0.0.1:49564 493s app_test.go:1117: 16:02:03.205 - 84: DEBUG: new connection from 127.0.0.1:49574 493s app_test.go:1117: 16:02:03.210 - 82: DEBUG: new connection from 127.0.0.1:38632 493s app_test.go:1117: 16:02:03.215 - 83: DEBUG: new connection from 127.0.0.1:53870 493s app_test.go:1117: 16:02:03.221 - 82: DEBUG: new connection from 127.0.0.1:38634 493s app_test.go:1117: 16:02:03.259 - 82: DEBUG: new connection from 127.0.0.1:38642 493s app_test.go:1117: 16:02:03.262 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.264 - 82: DEBUG: new connection from 127.0.0.1:38648 493s app_test.go:1117: 16:02:03.267 - 83: DEBUG: new connection from 127.0.0.1:53872 493s app_test.go:1117: 16:02:03.269 - 84: DEBUG: new connection from 127.0.0.1:49586 493s app_test.go:1117: 16:02:03.271 - 85: DEBUG: new connection from 127.0.0.1:52484 493s app_test.go:1117: 16:02:03.283 - 85: DEBUG: new connection from 127.0.0.1:52488 493s app_test.go:1117: 16:02:03.291 - 82: DEBUG: new connection from 127.0.0.1:38658 493s app_test.go:1117: 16:02:03.323 - 82: DEBUG: new connection from 127.0.0.1:38668 493s app_test.go:1117: 16:02:03.325 - 86: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.329 - 82: DEBUG: new connection from 127.0.0.1:38684 493s app_test.go:1117: 16:02:03.331 - 83: DEBUG: new connection from 127.0.0.1:53880 493s app_test.go:1117: 16:02:03.334 - 84: DEBUG: new connection from 127.0.0.1:49590 493s app_test.go:1117: 16:02:03.337 - 85: DEBUG: new connection from 127.0.0.1:52504 493s app_test.go:1117: 16:02:03.339 - 86: DEBUG: new connection from 127.0.0.1:33592 493s app_test.go:1117: 16:02:03.354 - 86: DEBUG: new connection from 127.0.0.1:33594 493s app_test.go:1117: 16:02:03.359 - 82: DEBUG: new connection from 127.0.0.1:38688 493s app_test.go:1117: 16:02:03.392 - 82: DEBUG: new connection from 127.0.0.1:38704 493s app_test.go:1117: 16:02:03.394 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.398 - 82: DEBUG: new connection from 127.0.0.1:38714 493s app_test.go:1117: 16:02:03.400 - 83: DEBUG: new connection from 127.0.0.1:53886 493s app_test.go:1117: 16:02:03.402 - 84: DEBUG: new connection from 127.0.0.1:49606 493s app_test.go:1117: 16:02:03.405 - 85: DEBUG: new connection from 127.0.0.1:52512 493s app_test.go:1117: 16:02:03.407 - 86: DEBUG: new connection from 127.0.0.1:33608 493s app_test.go:1117: 16:02:03.409 - 87: DEBUG: new connection from 127.0.0.1:54250 493s app_test.go:1117: 16:02:03.418 - 87: DEBUG: new connection from 127.0.0.1:54254 493s app_test.go:1117: 16:02:03.426 - 82: DEBUG: new connection from 127.0.0.1:38718 493s app_test.go:1117: 16:02:03.455 - 82: DEBUG: new connection from 127.0.0.1:38730 493s app_test.go:1117: 16:02:03.458 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.461 - 82: DEBUG: new connection from 127.0.0.1:38738 493s app_test.go:1117: 16:02:03.464 - 83: DEBUG: new connection from 127.0.0.1:53896 493s app_test.go:1117: 16:02:03.466 - 84: DEBUG: new connection from 127.0.0.1:49620 493s app_test.go:1117: 16:02:03.469 - 85: DEBUG: new connection from 127.0.0.1:52528 493s app_test.go:1117: 16:02:03.471 - 86: DEBUG: new connection from 127.0.0.1:33614 493s app_test.go:1117: 16:02:03.473 - 87: DEBUG: new connection from 127.0.0.1:54266 493s app_test.go:1117: 16:02:03.475 - 88: DEBUG: new connection from 127.0.0.1:50564 493s app_test.go:1117: 16:02:03.509 - 82: DEBUG: new connection from 127.0.0.1:38740 493s app_test.go:1117: 16:02:03.511 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.519 - 82: DEBUG: new connection from 127.0.0.1:38742 493s app_test.go:1117: 16:02:03.522 - 83: DEBUG: new connection from 127.0.0.1:53900 493s app_test.go:1117: 16:02:03.524 - 84: DEBUG: new connection from 127.0.0.1:49630 493s app_test.go:1117: 16:02:03.529 - 85: DEBUG: new connection from 127.0.0.1:52532 493s app_test.go:1117: 16:02:03.532 - 86: DEBUG: new connection from 127.0.0.1:33624 493s app_test.go:1117: 16:02:03.535 - 87: DEBUG: new connection from 127.0.0.1:54270 493s app_test.go:1117: 16:02:03.537 - 88: DEBUG: new connection from 127.0.0.1:50572 493s app_test.go:1117: 16:02:03.539 - 89: DEBUG: new connection from 127.0.0.1:35768 493s app_test.go:1117: 16:02:03.568 - 82: DEBUG: new connection from 127.0.0.1:38750 493s app_test.go:1117: 16:02:03.571 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected 493s app_test.go:1117: 16:02:03.577 - 82: DEBUG: new connection from 127.0.0.1:38756 493s app_test.go:1117: 16:02:03.580 - 83: DEBUG: new connection from 127.0.0.1:53916 493s app_test.go:1117: 16:02:03.582 - 84: DEBUG: new connection from 127.0.0.1:49646 493s app_test.go:1117: 16:02:03.585 - 85: DEBUG: new connection from 127.0.0.1:52538 493s app_test.go:1117: 16:02:03.587 - 86: DEBUG: new connection from 127.0.0.1:33632 493s app_test.go:1117: 16:02:03.589 - 87: DEBUG: new connection from 127.0.0.1:54286 493s app_test.go:1117: 16:02:03.592 - 88: DEBUG: new connection from 127.0.0.1:50576 493s app_test.go:1117: 16:02:03.594 - 89: DEBUG: new connection from 127.0.0.1:35774 493s app_test.go:1117: 16:02:03.596 - 90: DEBUG: new connection from 127.0.0.1:39950 498s app_test.go:1117: 16:02:03.116 - 82: DEBUG: new connection from 127.0.0.1:38770 498s app_test.go:1117: 16:02:03.118 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.122 - 82: DEBUG: new connection from 127.0.0.1:38776 498s app_test.go:1117: 16:02:03.126 - 83: DEBUG: new connection from 127.0.0.1:53918 498s app_test.go:1117: 16:02:03.129 - 84: DEBUG: new connection from 127.0.0.1:49652 498s app_test.go:1117: 16:02:03.131 - 85: DEBUG: new connection from 127.0.0.1:52554 498s app_test.go:1117: 16:02:03.133 - 87: DEBUG: new connection from 127.0.0.1:54290 498s app_test.go:1117: 16:02:03.135 - 88: DEBUG: new connection from 127.0.0.1:50578 498s app_test.go:1117: 16:02:03.137 - 89: DEBUG: new connection from 127.0.0.1:35782 498s app_test.go:1117: 16:02:03.139 - 90: DEBUG: new connection from 127.0.0.1:39952 498s app_test.go:1117: 16:02:03.142 - 89: DEBUG: new connection from 127.0.0.1:35790 498s app_test.go:1117: 16:02:03.157 - 82: DEBUG: new connection from 127.0.0.1:38780 498s app_test.go:1117: 16:02:03.157 - 82: DEBUG: new connection from 127.0.0.1:38788 498s app_test.go:1117: 16:02:03.162 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.232 - 82: DEBUG: new connection from 127.0.0.1:38790 498s app_test.go:1117: 16:02:03.234 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.288 - 82: DEBUG: new connection from 127.0.0.1:38796 498s app_test.go:1117: 16:02:03.290 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.424 - 82: DEBUG: new connection from 127.0.0.1:38810 498s app_test.go:1117: 16:02:03.429 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.481 - 82: DEBUG: new connection from 127.0.0.1:38816 498s app_test.go:1117: 16:02:03.485 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.542 - 82: DEBUG: new connection from 127.0.0.1:38832 498s app_test.go:1117: 16:02:03.545 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.592 - 82: DEBUG: new connection from 127.0.0.1:38846 498s app_test.go:1117: 16:02:03.594 - 83: DEBUG: new connection from 127.0.0.1:53930 498s app_test.go:1117: 16:02:03.596 - 84: DEBUG: new connection from 127.0.0.1:49662 498s app_test.go:1117: 16:02:03.598 - 85: DEBUG: new connection from 127.0.0.1:52560 498s app_test.go:1117: 16:02:03.600 - 82: DEBUG: new connection from 127.0.0.1:38852 498s app_test.go:1117: 16:02:03.602 - 87: DEBUG: new connection from 127.0.0.1:54300 498s app_test.go:1117: 16:02:03.604 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected 498s app_test.go:1117: 16:02:03.606 - 88: DEBUG: new connection from 127.0.0.1:50582 498s app_test.go:1117: 16:02:03.609 - 89: DEBUG: new connection from 127.0.0.1:35804 498s app_test.go:1117: 16:02:03.611 - 90: DEBUG: new connection from 127.0.0.1:39958 498s app_test.go:1117: 16:02:03.615 - 82: DEBUG: new connection from 127.0.0.1:38858 498s app_test.go:1117: 16:02:03.619 - 83: DEBUG: new connection from 127.0.0.1:53942 498s app_test.go:1117: 16:02:03.622 - 84: DEBUG: new connection from 127.0.0.1:49670 498s app_test.go:1117: 16:02:03.624 - 85: DEBUG: new connection from 127.0.0.1:52576 498s app_test.go:1117: 16:02:03.627 - 87: DEBUG: new connection from 127.0.0.1:54306 498s app_test.go:1117: 16:02:03.629 - 88: DEBUG: new connection from 127.0.0.1:50598 498s app_test.go:1117: 16:02:03.631 - 89: DEBUG: new connection from 127.0.0.1:35812 498s app_test.go:1117: 16:02:03.633 - 90: DEBUG: new connection from 127.0.0.1:39968 503s app_test.go:1117: 16:02:03.165 - 82: DEBUG: new connection from 127.0.0.1:49608 503s app_test.go:1117: 16:02:03.169 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected 503s app_test.go:1117: 16:02:03.238 - 82: DEBUG: new connection from 127.0.0.1:49610 503s app_test.go:1117: 16:02:03.240 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected 503s app_test.go:1117: 16:02:03.296 - 82: DEBUG: new connection from 127.0.0.1:49626 503s app_test.go:1117: 16:02:03.298 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected 503s app_test.go:1117: 16:02:03.434 - 82: DEBUG: new connection from 127.0.0.1:49638 503s app_test.go:1117: 16:02:03.437 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected 504s app_test.go:1117: 16:02:03.489 - 82: DEBUG: new connection from 127.0.0.1:49646 504s app_test.go:1117: 16:02:03.491 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected 504s app_test.go:1117: 16:02:03.548 - 82: DEBUG: new connection from 127.0.0.1:49656 504s app_test.go:1117: 16:02:03.550 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected 504s app_test.go:1117: 16:02:03.607 - 82: DEBUG: new connection from 127.0.0.1:49664 504s app_test.go:1117: 16:02:03.611 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected 504s app_test.go:1117: 16:02:03.635 - 82: DEBUG: new connection from 127.0.0.1:49680 504s app_test.go:1117: 16:02:03.638 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 504s app_test.go:1117: 16:02:03.640 - 82: DEBUG: new connection from 127.0.0.1:49694 504s app_test.go:1117: 16:02:03.642 - 83: DEBUG: new connection from 127.0.0.1:58008 504s app_test.go:1117: 16:02:03.644 - 84: DEBUG: new connection from 127.0.0.1:58692 504s app_test.go:1117: 16:02:03.646 - 85: DEBUG: new connection from 127.0.0.1:50704 504s app_test.go:1117: 16:02:03.649 - 87: DEBUG: new connection from 127.0.0.1:40562 504s app_test.go:1117: 16:02:03.651 - 88: DEBUG: new connection from 127.0.0.1:52270 504s app_test.go:1117: 16:02:03.653 - 89: DEBUG: new connection from 127.0.0.1:56770 504s app_test.go:1117: 16:02:03.655 - 90: DEBUG: new connection from 127.0.0.1:53328 508s app_test.go:1117: 16:02:03.172 - 82: DEBUG: new connection from 127.0.0.1:49710 508s app_test.go:1117: 16:02:03.174 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected 508s app_test.go:1117: 16:02:03.243 - 82: DEBUG: new connection from 127.0.0.1:49714 508s app_test.go:1117: 16:02:03.246 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected 508s app_test.go:1117: 16:02:03.301 - 82: DEBUG: new connection from 127.0.0.1:49718 508s app_test.go:1117: 16:02:03.303 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected 508s app_test.go:1117: 16:02:03.440 - 82: DEBUG: new connection from 127.0.0.1:49724 508s app_test.go:1117: 16:02:03.442 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected 509s app_test.go:1117: 16:02:03.494 - 82: DEBUG: new connection from 127.0.0.1:49728 509s app_test.go:1117: 16:02:03.497 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected 509s app_test.go:1117: 16:02:03.555 - 82: DEBUG: new connection from 127.0.0.1:49740 509s app_test.go:1117: 16:02:03.557 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected 509s app_test.go:1117: 16:02:03.614 - 82: DEBUG: new connection from 127.0.0.1:49748 509s app_test.go:1117: 16:02:03.617 - 90: DEBUG: attempt 1: server 127.0.0.1:9001: connected 509s app_test.go:1117: 16:02:03.658 - 82: DEBUG: new connection from 127.0.0.1:49758 509s app_test.go:1117: 16:02:03.660 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 509s app_test.go:1117: 16:02:03.665 - 82: DEBUG: new connection from 127.0.0.1:49760 509s app_test.go:1117: 16:02:03.667 - 83: DEBUG: new connection from 127.0.0.1:58020 509s app_test.go:1117: 16:02:03.669 - 84: DEBUG: new connection from 127.0.0.1:58700 509s app_test.go:1117: 16:02:03.672 - 85: DEBUG: new connection from 127.0.0.1:50706 509s app_test.go:1117: 16:02:03.674 - 87: DEBUG: new connection from 127.0.0.1:40566 509s app_test.go:1117: 16:02:03.675 - 88: DEBUG: new connection from 127.0.0.1:52286 509s app_test.go:1117: 16:02:03.677 - 89: DEBUG: new connection from 127.0.0.1:56778 509s app_test.go:1117: 16:02:03.680 - 90: DEBUG: new connection from 127.0.0.1:53332 513s app_test.go:1117: 16:02:03.181 - 82: DEBUG: new connection from 127.0.0.1:35956 513s app_test.go:1117: 16:02:03.183 - 83: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.254 - 82: DEBUG: new connection from 127.0.0.1:35962 513s app_test.go:1117: 16:02:03.256 - 84: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.311 - 82: DEBUG: new connection from 127.0.0.1:35966 513s app_test.go:1117: 16:02:03.313 - 85: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.444 - 82: DEBUG: new connection from 127.0.0.1:35974 513s app_test.go:1117: 16:02:03.446 - 87: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.500 - 82: DEBUG: new connection from 127.0.0.1:35986 513s app_test.go:1117: 16:02:03.502 - 88: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.560 - 82: DEBUG: new connection from 127.0.0.1:36000 513s app_test.go:1117: 16:02:03.563 - 89: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.614 - 82: DEBUG: new connection from 127.0.0.1:36004 513s app_test.go:1117: 16:02:03.616 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.685 - 82: DEBUG: new connection from 127.0.0.1:36016 513s app_test.go:1117: 16:02:03.688 - 82: DEBUG: attempt 1: server 127.0.0.1:9001: connected 513s app_test.go:1117: 16:02:03.692 - 82: DEBUG: new connection from 127.0.0.1:36022 513s app_test.go:1117: 16:02:03.694 - 83: DEBUG: new connection from 127.0.0.1:43958 513s --- PASS: TestRolesAdjustment_ReplaceStandByHonorFailureDomains (20.67s) 513s === RUN TestOpen 513s app_test.go:1117: 16:02:03.781 - 91: DEBUG: new connection from 127.0.0.1:56306 513s app_test.go:1117: 16:02:03.782 - 91: DEBUG: new connection from 127.0.0.1:56312 513s app_test.go:1117: 16:02:03.786 - 91: DEBUG: attempt 1: server 127.0.0.1:9000: connected 513s app_test.go:1117: 16:02:03.787 - 91: DEBUG: attempt 1: server 127.0.0.1:9000: connected 513s app_test.go:1117: 16:02:03.790 - 91: DEBUG: new connection from 127.0.0.1:56316 513s --- PASS: TestOpen (0.06s) 513s === RUN TestOptions 513s --- PASS: TestOptions (0.03s) 513s === RUN TestProxy_Error 513s app_test.go:1117: 16:02:03.868 - 93: DEBUG: new connection from 127.0.0.1:56328 513s app_test.go:1117: 16:02:03.869 - 93: DEBUG: new connection from 127.0.0.1:56334 513s app_test.go:1117: 16:02:03.873 - 93: DEBUG: attempt 1: server 127.0.0.1:9000: connected 513s app_test.go:1117: 16:02:03.874 - 93: DEBUG: new connection from 127.0.0.1:56338 514s --- PASS: TestProxy_Error (0.38s) 514s === RUN TestReady_Cancel 514s app_test.go:1117: 16:02:03.251 - 94: WARN: attempt 1: server 127.0.0.1:9001: dial: dial tcp 127.0.0.1:9001: connect: connection refused 514s --- PASS: TestReady_Cancel (0.23s) 514s === RUN TestExternalConnWithTCP 514s app_test.go:1142: 16:02:03.478 - 95: DEBUG: attempt 1: server 127.0.0.1:9191: connected 514s app_test.go:1142: 16:02:03.504 - 96: DEBUG: attempt 1: server 127.0.0.1:9191: connected 514s app_test.go:1142: 16:02:03.531 - 97: DEBUG: attempt 1: server 127.0.0.1:9191: connected 514s app_test.go:1142: 16:02:03.543 - 95: DEBUG: attempt 1: server 127.0.0.1:9191: connected 514s --- PASS: TestExternalConnWithTCP (0.15s) 514s === RUN TestExternalConnWithPipe 514s app_test.go:1142: 16:02:03.629 - 98: DEBUG: attempt 1: server first: connected 514s app_test.go:1142: 16:02:03.655 - 99: DEBUG: attempt 1: server first: connected 514s app_test.go:1142: 16:02:03.683 - 100: DEBUG: attempt 1: server first: connected 514s app_test.go:1142: 16:02:03.694 - 98: DEBUG: attempt 1: server first: connected 514s --- PASS: TestExternalConnWithPipe (0.16s) 514s === RUN TestParallelNewApp 514s === PAUSE TestParallelNewApp 514s === RUN Test_TxRowsAffected 514s app_test.go:1142: 16:02:03.789 - 101: DEBUG: attempt 1: server 127.0.0.1:9001: connected 514s app_test.go:1142: 16:02:03.790 - 101: DEBUG: attempt 1: server 127.0.0.1:9001: connected 514s --- PASS: Test_TxRowsAffected (0.05s) 514s === CONT TestParallelNewApp 514s === RUN TestParallelNewApp/run-0 514s === PAUSE TestParallelNewApp/run-0 514s === RUN TestParallelNewApp/run-1 514s === PAUSE TestParallelNewApp/run-1 514s === RUN TestParallelNewApp/run-2 514s === PAUSE TestParallelNewApp/run-2 514s === RUN TestParallelNewApp/run-3 514s === PAUSE TestParallelNewApp/run-3 514s === RUN TestParallelNewApp/run-4 514s === PAUSE TestParallelNewApp/run-4 514s === RUN TestParallelNewApp/run-5 514s === PAUSE TestParallelNewApp/run-5 514s === RUN TestParallelNewApp/run-6 514s === PAUSE TestParallelNewApp/run-6 514s === RUN TestParallelNewApp/run-7 514s === PAUSE TestParallelNewApp/run-7 514s === RUN TestParallelNewApp/run-8 514s === PAUSE TestParallelNewApp/run-8 514s === RUN TestParallelNewApp/run-9 514s === PAUSE TestParallelNewApp/run-9 514s === RUN TestParallelNewApp/run-10 514s === PAUSE TestParallelNewApp/run-10 514s === RUN TestParallelNewApp/run-11 514s === PAUSE TestParallelNewApp/run-11 514s === RUN TestParallelNewApp/run-12 514s === PAUSE TestParallelNewApp/run-12 514s === RUN TestParallelNewApp/run-13 514s === PAUSE TestParallelNewApp/run-13 514s === RUN TestParallelNewApp/run-14 514s === PAUSE TestParallelNewApp/run-14 514s === RUN TestParallelNewApp/run-15 514s === PAUSE TestParallelNewApp/run-15 514s === RUN TestParallelNewApp/run-16 514s === PAUSE TestParallelNewApp/run-16 514s === RUN TestParallelNewApp/run-17 514s === PAUSE TestParallelNewApp/run-17 514s === RUN TestParallelNewApp/run-18 514s === PAUSE TestParallelNewApp/run-18 514s === RUN TestParallelNewApp/run-19 514s === PAUSE TestParallelNewApp/run-19 514s === RUN TestParallelNewApp/run-20 514s === PAUSE TestParallelNewApp/run-20 514s === RUN TestParallelNewApp/run-21 514s === PAUSE TestParallelNewApp/run-21 514s === RUN TestParallelNewApp/run-22 514s === PAUSE TestParallelNewApp/run-22 514s === RUN TestParallelNewApp/run-23 514s === PAUSE TestParallelNewApp/run-23 514s === RUN TestParallelNewApp/run-24 514s === PAUSE TestParallelNewApp/run-24 514s === RUN TestParallelNewApp/run-25 514s === PAUSE TestParallelNewApp/run-25 514s === RUN TestParallelNewApp/run-26 514s === PAUSE TestParallelNewApp/run-26 514s === RUN TestParallelNewApp/run-27 514s === PAUSE TestParallelNewApp/run-27 514s === RUN TestParallelNewApp/run-28 514s === PAUSE TestParallelNewApp/run-28 514s === RUN TestParallelNewApp/run-29 514s === PAUSE TestParallelNewApp/run-29 514s === RUN TestParallelNewApp/run-30 514s === PAUSE TestParallelNewApp/run-30 514s === RUN TestParallelNewApp/run-31 514s === PAUSE TestParallelNewApp/run-31 514s === RUN TestParallelNewApp/run-32 514s === PAUSE TestParallelNewApp/run-32 514s === RUN TestParallelNewApp/run-33 514s === PAUSE TestParallelNewApp/run-33 514s === RUN TestParallelNewApp/run-34 514s === PAUSE TestParallelNewApp/run-34 514s === RUN TestParallelNewApp/run-35 514s === PAUSE TestParallelNewApp/run-35 514s === RUN TestParallelNewApp/run-36 514s === PAUSE TestParallelNewApp/run-36 514s === RUN TestParallelNewApp/run-37 514s === PAUSE TestParallelNewApp/run-37 514s === RUN TestParallelNewApp/run-38 514s === PAUSE TestParallelNewApp/run-38 514s === RUN TestParallelNewApp/run-39 514s === PAUSE TestParallelNewApp/run-39 514s === RUN TestParallelNewApp/run-40 514s === PAUSE TestParallelNewApp/run-40 514s === RUN TestParallelNewApp/run-41 514s === PAUSE TestParallelNewApp/run-41 514s === RUN TestParallelNewApp/run-42 514s === PAUSE TestParallelNewApp/run-42 514s === RUN TestParallelNewApp/run-43 514s === PAUSE TestParallelNewApp/run-43 514s === RUN TestParallelNewApp/run-44 514s === PAUSE TestParallelNewApp/run-44 514s === RUN TestParallelNewApp/run-45 514s === PAUSE TestParallelNewApp/run-45 514s === RUN TestParallelNewApp/run-46 514s === PAUSE TestParallelNewApp/run-46 514s === RUN TestParallelNewApp/run-47 514s === PAUSE TestParallelNewApp/run-47 514s === RUN TestParallelNewApp/run-48 514s === PAUSE TestParallelNewApp/run-48 514s === RUN TestParallelNewApp/run-49 514s === PAUSE TestParallelNewApp/run-49 514s === RUN TestParallelNewApp/run-50 514s === PAUSE TestParallelNewApp/run-50 514s === RUN TestParallelNewApp/run-51 514s === PAUSE TestParallelNewApp/run-51 514s === RUN TestParallelNewApp/run-52 514s === PAUSE TestParallelNewApp/run-52 514s === RUN TestParallelNewApp/run-53 514s === PAUSE TestParallelNewApp/run-53 514s === RUN TestParallelNewApp/run-54 514s === PAUSE TestParallelNewApp/run-54 514s === RUN TestParallelNewApp/run-55 514s === PAUSE TestParallelNewApp/run-55 514s === RUN TestParallelNewApp/run-56 514s === PAUSE TestParallelNewApp/run-56 514s === RUN TestParallelNewApp/run-57 514s === PAUSE TestParallelNewApp/run-57 514s === RUN TestParallelNewApp/run-58 514s === PAUSE TestParallelNewApp/run-58 514s === RUN TestParallelNewApp/run-59 514s === PAUSE TestParallelNewApp/run-59 514s === RUN TestParallelNewApp/run-60 514s === PAUSE TestParallelNewApp/run-60 514s === RUN TestParallelNewApp/run-61 514s === PAUSE TestParallelNewApp/run-61 514s === RUN TestParallelNewApp/run-62 514s === PAUSE TestParallelNewApp/run-62 514s === RUN TestParallelNewApp/run-63 514s === PAUSE TestParallelNewApp/run-63 514s === RUN TestParallelNewApp/run-64 514s === PAUSE TestParallelNewApp/run-64 514s === RUN TestParallelNewApp/run-65 514s === PAUSE TestParallelNewApp/run-65 514s === RUN TestParallelNewApp/run-66 514s === PAUSE TestParallelNewApp/run-66 514s === RUN TestParallelNewApp/run-67 514s === PAUSE TestParallelNewApp/run-67 514s === RUN TestParallelNewApp/run-68 514s === PAUSE TestParallelNewApp/run-68 514s === RUN TestParallelNewApp/run-69 514s === PAUSE TestParallelNewApp/run-69 514s === RUN TestParallelNewApp/run-70 514s === PAUSE TestParallelNewApp/run-70 514s === RUN TestParallelNewApp/run-71 514s === PAUSE TestParallelNewApp/run-71 514s === RUN TestParallelNewApp/run-72 514s === PAUSE TestParallelNewApp/run-72 514s === RUN TestParallelNewApp/run-73 514s === PAUSE TestParallelNewApp/run-73 514s === RUN TestParallelNewApp/run-74 514s === PAUSE TestParallelNewApp/run-74 514s === RUN TestParallelNewApp/run-75 514s === PAUSE TestParallelNewApp/run-75 514s === RUN TestParallelNewApp/run-76 514s === PAUSE TestParallelNewApp/run-76 514s === RUN TestParallelNewApp/run-77 514s === PAUSE TestParallelNewApp/run-77 514s === RUN TestParallelNewApp/run-78 514s === PAUSE TestParallelNewApp/run-78 514s === RUN TestParallelNewApp/run-79 514s === PAUSE TestParallelNewApp/run-79 514s === RUN TestParallelNewApp/run-80 514s === PAUSE TestParallelNewApp/run-80 514s === RUN TestParallelNewApp/run-81 514s === PAUSE TestParallelNewApp/run-81 514s === RUN TestParallelNewApp/run-82 514s === PAUSE TestParallelNewApp/run-82 514s === RUN TestParallelNewApp/run-83 514s === PAUSE TestParallelNewApp/run-83 514s === RUN TestParallelNewApp/run-84 514s === PAUSE TestParallelNewApp/run-84 514s === RUN TestParallelNewApp/run-85 514s === PAUSE TestParallelNewApp/run-85 514s === RUN TestParallelNewApp/run-86 514s === PAUSE TestParallelNewApp/run-86 514s === RUN TestParallelNewApp/run-87 514s === PAUSE TestParallelNewApp/run-87 514s === RUN TestParallelNewApp/run-88 514s === PAUSE TestParallelNewApp/run-88 514s === RUN TestParallelNewApp/run-89 514s === PAUSE TestParallelNewApp/run-89 514s === RUN TestParallelNewApp/run-90 514s === PAUSE TestParallelNewApp/run-90 514s === RUN TestParallelNewApp/run-91 514s === PAUSE TestParallelNewApp/run-91 514s === RUN TestParallelNewApp/run-92 514s === PAUSE TestParallelNewApp/run-92 514s === RUN TestParallelNewApp/run-93 514s === PAUSE TestParallelNewApp/run-93 514s === RUN TestParallelNewApp/run-94 514s === PAUSE TestParallelNewApp/run-94 514s === RUN TestParallelNewApp/run-95 514s === PAUSE TestParallelNewApp/run-95 514s === RUN TestParallelNewApp/run-96 514s === PAUSE TestParallelNewApp/run-96 514s === RUN TestParallelNewApp/run-97 514s === PAUSE TestParallelNewApp/run-97 514s === RUN TestParallelNewApp/run-98 514s === PAUSE TestParallelNewApp/run-98 514s === RUN TestParallelNewApp/run-99 514s === PAUSE TestParallelNewApp/run-99 514s === CONT TestParallelNewApp/run-0 514s === CONT TestParallelNewApp/run-99 514s === CONT TestParallelNewApp/run-98 514s === CONT TestParallelNewApp/run-97 514s === CONT TestParallelNewApp/run-96 514s === CONT TestParallelNewApp/run-95 514s === CONT TestParallelNewApp/run-94 515s === CONT TestParallelNewApp/run-93 515s === CONT TestParallelNewApp/run-92 515s === CONT TestParallelNewApp/run-91 515s === CONT TestParallelNewApp/run-90 515s === CONT TestParallelNewApp/run-89 515s === CONT TestParallelNewApp/run-88 515s === CONT TestParallelNewApp/run-87 515s === CONT TestParallelNewApp/run-86 515s === CONT TestParallelNewApp/run-85 515s === CONT TestParallelNewApp/run-84 515s === CONT TestParallelNewApp/run-83 515s === CONT TestParallelNewApp/run-82 515s === CONT TestParallelNewApp/run-81 515s === CONT TestParallelNewApp/run-80 515s === CONT TestParallelNewApp/run-79 515s === CONT TestParallelNewApp/run-78 515s === CONT TestParallelNewApp/run-77 515s === CONT TestParallelNewApp/run-76 515s === CONT TestParallelNewApp/run-75 515s === CONT TestParallelNewApp/run-74 515s === CONT TestParallelNewApp/run-73 515s === CONT TestParallelNewApp/run-72 515s === CONT TestParallelNewApp/run-71 515s === CONT TestParallelNewApp/run-70 515s === CONT TestParallelNewApp/run-69 515s === CONT TestParallelNewApp/run-68 515s === CONT TestParallelNewApp/run-67 515s === CONT TestParallelNewApp/run-66 515s === CONT TestParallelNewApp/run-65 515s === CONT TestParallelNewApp/run-64 515s === CONT TestParallelNewApp/run-63 515s === CONT TestParallelNewApp/run-62 515s === CONT TestParallelNewApp/run-61 515s === CONT TestParallelNewApp/run-60 515s === CONT TestParallelNewApp/run-59 515s === CONT TestParallelNewApp/run-58 515s === CONT TestParallelNewApp/run-57 515s === CONT TestParallelNewApp/run-56 515s === CONT TestParallelNewApp/run-55 516s === CONT TestParallelNewApp/run-54 516s === CONT TestParallelNewApp/run-53 516s === CONT TestParallelNewApp/run-52 516s === CONT TestParallelNewApp/run-51 516s === CONT TestParallelNewApp/run-50 516s === CONT TestParallelNewApp/run-49 516s === CONT TestParallelNewApp/run-48 516s === CONT TestParallelNewApp/run-47 516s === CONT TestParallelNewApp/run-46 516s === CONT TestParallelNewApp/run-45 516s === CONT TestParallelNewApp/run-44 516s === CONT TestParallelNewApp/run-43 516s === CONT TestParallelNewApp/run-42 516s === CONT TestParallelNewApp/run-41 516s === CONT TestParallelNewApp/run-40 516s === CONT TestParallelNewApp/run-39 516s === CONT TestParallelNewApp/run-38 516s === CONT TestParallelNewApp/run-37 516s === CONT TestParallelNewApp/run-36 516s === CONT TestParallelNewApp/run-35 516s === CONT TestParallelNewApp/run-34 516s === CONT TestParallelNewApp/run-33 516s === CONT TestParallelNewApp/run-32 516s === CONT TestParallelNewApp/run-31 516s === CONT TestParallelNewApp/run-30 516s === CONT TestParallelNewApp/run-29 516s === CONT TestParallelNewApp/run-28 516s === CONT TestParallelNewApp/run-27 516s === CONT TestParallelNewApp/run-26 516s === CONT TestParallelNewApp/run-25 516s === CONT TestParallelNewApp/run-24 516s === CONT TestParallelNewApp/run-23 516s === CONT TestParallelNewApp/run-22 516s === CONT TestParallelNewApp/run-21 516s === CONT TestParallelNewApp/run-20 516s === CONT TestParallelNewApp/run-19 516s === CONT TestParallelNewApp/run-18 516s === CONT TestParallelNewApp/run-17 516s === CONT TestParallelNewApp/run-16 517s === CONT TestParallelNewApp/run-15 517s === CONT TestParallelNewApp/run-14 517s === CONT TestParallelNewApp/run-13 517s === CONT TestParallelNewApp/run-12 517s === CONT TestParallelNewApp/run-11 517s === CONT TestParallelNewApp/run-10 517s === CONT TestParallelNewApp/run-9 517s === CONT TestParallelNewApp/run-8 517s === CONT TestParallelNewApp/run-7 517s === CONT TestParallelNewApp/run-6 517s === CONT TestParallelNewApp/run-5 517s === CONT TestParallelNewApp/run-4 517s === CONT TestParallelNewApp/run-3 517s === CONT TestParallelNewApp/run-2 517s === CONT TestParallelNewApp/run-1 517s --- PASS: TestParallelNewApp (0.01s) 517s --- PASS: TestParallelNewApp/run-0 (0.03s) 517s --- PASS: TestParallelNewApp/run-99 (0.02s) 517s --- PASS: TestParallelNewApp/run-98 (0.02s) 517s --- PASS: TestParallelNewApp/run-97 (0.02s) 517s --- PASS: TestParallelNewApp/run-96 (0.03s) 517s --- PASS: TestParallelNewApp/run-95 (0.02s) 517s --- PASS: TestParallelNewApp/run-94 (0.02s) 517s --- PASS: TestParallelNewApp/run-93 (0.03s) 517s --- PASS: TestParallelNewApp/run-92 (0.02s) 517s --- PASS: TestParallelNewApp/run-91 (0.03s) 517s --- PASS: TestParallelNewApp/run-90 (0.02s) 517s --- PASS: TestParallelNewApp/run-89 (0.03s) 517s --- PASS: TestParallelNewApp/run-88 (0.02s) 517s --- PASS: TestParallelNewApp/run-87 (0.03s) 517s --- PASS: TestParallelNewApp/run-86 (0.02s) 517s --- PASS: TestParallelNewApp/run-85 (0.03s) 517s --- PASS: TestParallelNewApp/run-84 (0.03s) 517s --- PASS: TestParallelNewApp/run-83 (0.03s) 517s --- PASS: TestParallelNewApp/run-82 (0.03s) 517s --- PASS: TestParallelNewApp/run-81 (0.03s) 517s --- PASS: TestParallelNewApp/run-80 (0.03s) 517s --- PASS: TestParallelNewApp/run-79 (0.02s) 517s --- PASS: TestParallelNewApp/run-78 (0.02s) 517s --- PASS: TestParallelNewApp/run-77 (0.03s) 517s --- PASS: TestParallelNewApp/run-76 (0.03s) 517s --- PASS: TestParallelNewApp/run-75 (0.02s) 517s --- PASS: TestParallelNewApp/run-74 (0.02s) 517s --- PASS: TestParallelNewApp/run-73 (0.03s) 517s --- PASS: TestParallelNewApp/run-72 (0.02s) 517s --- PASS: TestParallelNewApp/run-71 (0.03s) 517s --- PASS: TestParallelNewApp/run-70 (0.02s) 517s --- PASS: TestParallelNewApp/run-69 (0.02s) 517s --- PASS: TestParallelNewApp/run-68 (0.02s) 517s --- PASS: TestParallelNewApp/run-67 (0.02s) 517s --- PASS: TestParallelNewApp/run-66 (0.02s) 517s --- PASS: TestParallelNewApp/run-65 (0.02s) 517s --- PASS: TestParallelNewApp/run-64 (0.02s) 517s --- PASS: TestParallelNewApp/run-63 (0.02s) 517s --- PASS: TestParallelNewApp/run-62 (0.02s) 517s --- PASS: TestParallelNewApp/run-61 (0.02s) 517s --- PASS: TestParallelNewApp/run-60 (0.02s) 517s --- PASS: TestParallelNewApp/run-59 (0.02s) 517s --- PASS: TestParallelNewApp/run-58 (0.02s) 517s --- PASS: TestParallelNewApp/run-57 (0.02s) 517s --- PASS: TestParallelNewApp/run-56 (0.02s) 517s --- PASS: TestParallelNewApp/run-55 (0.02s) 517s --- PASS: TestParallelNewApp/run-54 (0.03s) 517s --- PASS: TestParallelNewApp/run-53 (0.03s) 517s --- PASS: TestParallelNewApp/run-52 (0.02s) 517s --- PASS: TestParallelNewApp/run-51 (0.02s) 517s --- PASS: TestParallelNewApp/run-50 (0.02s) 517s --- PASS: TestParallelNewApp/run-49 (0.02s) 517s --- PASS: TestParallelNewApp/run-48 (0.03s) 517s --- PASS: TestParallelNewApp/run-47 (0.02s) 517s --- PASS: TestParallelNewApp/run-46 (0.03s) 517s --- PASS: TestParallelNewApp/run-45 (0.03s) 517s --- PASS: TestParallelNewApp/run-44 (0.02s) 517s --- PASS: TestParallelNewApp/run-43 (0.03s) 517s --- PASS: TestParallelNewApp/run-42 (0.02s) 517s --- PASS: TestParallelNewApp/run-41 (0.03s) 517s --- PASS: TestParallelNewApp/run-40 (0.02s) 517s --- PASS: TestParallelNewApp/run-39 (0.03s) 517s --- PASS: TestParallelNewApp/run-38 (0.02s) 517s --- PASS: TestParallelNewApp/run-37 (0.02s) 517s --- PASS: TestParallelNewApp/run-36 (0.03s) 517s --- PASS: TestParallelNewApp/run-35 (0.03s) 517s --- PASS: TestParallelNewApp/run-34 (0.03s) 517s --- PASS: TestParallelNewApp/run-33 (0.03s) 517s --- PASS: TestParallelNewApp/run-32 (0.03s) 517s --- PASS: TestParallelNewApp/run-31 (0.03s) 517s --- PASS: TestParallelNewApp/run-30 (0.03s) 517s --- PASS: TestParallelNewApp/run-29 (0.03s) 517s --- PASS: TestParallelNewApp/run-28 (0.03s) 517s --- PASS: TestParallelNewApp/run-27 (0.03s) 517s --- PASS: TestParallelNewApp/run-26 (0.02s) 517s --- PASS: TestParallelNewApp/run-25 (0.02s) 517s --- PASS: TestParallelNewApp/run-24 (0.02s) 517s --- PASS: TestParallelNewApp/run-23 (0.02s) 517s --- PASS: TestParallelNewApp/run-22 (0.02s) 517s --- PASS: TestParallelNewApp/run-21 (0.02s) 517s --- PASS: TestParallelNewApp/run-20 (0.02s) 517s --- PASS: TestParallelNewApp/run-19 (0.02s) 517s --- PASS: TestParallelNewApp/run-18 (0.02s) 517s --- PASS: TestParallelNewApp/run-17 (0.02s) 517s --- PASS: TestParallelNewApp/run-16 (0.03s) 517s --- PASS: TestParallelNewApp/run-15 (0.03s) 517s --- PASS: TestParallelNewApp/run-14 (0.02s) 517s --- PASS: TestParallelNewApp/run-13 (0.02s) 517s --- PASS: TestParallelNewApp/run-12 (0.02s) 517s --- PASS: TestParallelNewApp/run-11 (0.02s) 517s --- PASS: TestParallelNewApp/run-10 (0.03s) 517s --- PASS: TestParallelNewApp/run-9 (0.02s) 517s --- PASS: TestParallelNewApp/run-8 (0.03s) 517s --- PASS: TestParallelNewApp/run-7 (0.02s) 517s --- PASS: TestParallelNewApp/run-6 (0.02s) 517s --- PASS: TestParallelNewApp/run-5 (0.02s) 517s --- PASS: TestParallelNewApp/run-4 (0.02s) 517s --- PASS: TestParallelNewApp/run-3 (0.02s) 517s --- PASS: TestParallelNewApp/run-2 (0.02s) 517s --- PASS: TestParallelNewApp/run-1 (0.02s) 517s === RUN Example 517s --- PASS: Example (0.05s) 517s PASS 517s ok github.com/cowsql/go-cowsql/app 106.406s 518s === RUN TestNew_Default 519s Benchmark done. Results available here: 519s /tmp/cowsql-app-test-2394633286/results 519s --- PASS: TestNew_Default (1.06s) 519s === RUN TestNew_KvReadWrite 520s Benchmark done. Results available here: 520s /tmp/cowsql-app-test-2712949043/results 520s --- PASS: TestNew_KvReadWrite (1.07s) 520s === RUN TestNew_ClusteredKvReadWrite 522s Benchmark done. Results available here: 522s /tmp/cowsql-app-test-3980695002/results 522s --- PASS: TestNew_ClusteredKvReadWrite (2.14s) 522s === RUN TestNew_ClusteredTimeout 524s --- PASS: TestNew_ClusteredTimeout (2.07s) 524s PASS 524s ok github.com/cowsql/go-cowsql/benchmark 6.372s 525s === RUN TestClient_Leader 525s --- PASS: TestClient_Leader (0.04s) 525s === RUN TestClient_Dump 525s --- PASS: TestClient_Dump (0.05s) 525s === RUN TestClient_Cluster 525s --- PASS: TestClient_Cluster (0.03s) 525s === RUN TestClient_Transfer 525s --- PASS: TestClient_Transfer (0.10s) 525s === RUN TestClient_Describe 525s --- PASS: TestClient_Describe (0.03s) 525s === RUN TestMembership 525s --- PASS: TestMembership (0.12s) 525s === RUN TestDefaultNodeStore 525s --- PASS: TestDefaultNodeStore (0.00s) 525s === RUN TestConfigMultiThread 525s --- PASS: TestConfigMultiThread (0.00s) 525s PASS 525s ok github.com/cowsql/go-cowsql/client 0.379s 528s ? github.com/cowsql/go-cowsql/cmd/cowsql [no test files] 528s ? github.com/cowsql/go-cowsql/cmd/cowsql-benchmark [no test files] 528s ? github.com/cowsql/go-cowsql/cmd/cowsql-demo [no test files] 529s === RUN TestDriver_Open 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestDriver_Open (0.04s) 529s === RUN TestDriver_Prepare 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestDriver_Prepare (0.03s) 529s === RUN TestConn_Exec 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_Exec (0.03s) 529s === RUN TestConn_Query 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_Query (0.03s) 529s === RUN TestConn_QueryRow 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_QueryRow (0.03s) 529s === RUN TestConn_QueryBlob 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_QueryBlob (0.03s) 529s === RUN TestStmt_Exec 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestStmt_Exec (0.03s) 529s === RUN TestStmt_ExecManyParams 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestStmt_ExecManyParams (0.03s) 529s === RUN TestStmt_Query 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestStmt_Query (0.03s) 529s === RUN TestStmt_QueryManyParams 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestStmt_QueryManyParams (0.03s) 529s === RUN TestConn_QueryParams 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_QueryParams (0.03s) 529s === RUN TestConn_QueryManyParams 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_QueryManyParams (0.03s) 529s === RUN TestConn_ExecManyParams 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestConn_ExecManyParams (0.03s) 529s === RUN Test_ColumnTypesEmpty 529s driver_test.go:439: this currently fails if the result set is empty, is cowsql skipping the header if empty set? 529s --- SKIP: Test_ColumnTypesEmpty (0.00s) 529s === RUN Test_ColumnTypesExists 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: Test_ColumnTypesExists (0.03s) 529s === RUN Test_ColumnTypesEnd 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: Test_ColumnTypesEnd (0.03s) 529s === RUN Test_ZeroColumns 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: Test_ZeroColumns (0.05s) 529s === RUN TestIntegration_DatabaseSQL 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestIntegration_DatabaseSQL (0.16s) 529s === RUN TestIntegration_ConstraintError 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestIntegration_ConstraintError (0.16s) 529s === RUN TestIntegration_ExecBindError 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestIntegration_ExecBindError (0.06s) 529s === RUN TestIntegration_QueryBindError 529s func.go:15: DEBUG: attempt 1: server @1: connected 529s --- PASS: TestIntegration_QueryBindError (0.03s) 529s === RUN TestIntegration_LargeQuery 530s func.go:15: DEBUG: attempt 1: server @1: connected 530s --- PASS: TestIntegration_LargeQuery (0.21s) 530s === RUN TestIntegration_Recover 530s func.go:15: DEBUG: attempt 1: server @1: connected 530s func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe 530s func.go:15: DEBUG: attempt 1: server @1: connected 530s --- PASS: TestIntegration_Recover (0.17s) 530s === RUN TestIntegration_PingOnlyWorksOnceLeaderElected 530s func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused 530s func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1 530s func.go:15: WARN: attempt 1: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused 530s func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused 530s func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1 530s func.go:15: WARN: attempt 2: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused 531s func.go:15: WARN: attempt 3: server @1: dial: dial unix @1: connect: connection refused 531s func.go:15: DEBUG: attempt 3: server @2: connect to reported leader @1 531s func.go:15: WARN: attempt 3: server @2: reported leader unavailable err=dial: dial unix @1: connect: connection refused 531s func.go:15: WARN: attempt 1: server @1: no known leader 531s func.go:15: DEBUG: attempt 1: server @2: connect to reported leader @1 531s func.go:15: WARN: attempt 1: server @2: reported leader server is not the leader 532s func.go:15: WARN: attempt 2: server @1: no known leader 532s func.go:15: DEBUG: attempt 2: server @2: connect to reported leader @1 532s func.go:15: WARN: attempt 2: server @2: reported leader server is not the leader 532s func.go:15: WARN: attempt 3: server @1: no known leader 532s func.go:15: DEBUG: attempt 3: server @2: connect to reported leader @1 532s func.go:15: WARN: attempt 3: server @2: reported leader server is not the leader 533s func.go:15: WARN: attempt 4: server @1: no known leader 533s func.go:15: DEBUG: attempt 4: server @2: connect to reported leader @1 533s func.go:15: WARN: attempt 4: server @2: reported leader server is not the leader 534s func.go:15: WARN: attempt 5: server @1: no known leader 534s func.go:15: DEBUG: attempt 5: server @2: connect to reported leader @1 534s func.go:15: WARN: attempt 5: server @2: reported leader server is not the leader 535s func.go:15: WARN: attempt 6: server @1: no known leader 535s func.go:15: WARN: attempt 6: server @2: no known leader 536s func.go:15: WARN: attempt 7: server @1: no known leader 536s func.go:15: WARN: attempt 7: server @2: no known leader 537s func.go:15: WARN: attempt 8: server @1: no known leader 537s func.go:15: WARN: attempt 8: server @2: no known leader 538s func.go:15: DEBUG: attempt 9: server @1: connected 538s --- PASS: TestIntegration_PingOnlyWorksOnceLeaderElected (7.98s) 538s === RUN TestIntegration_HighAvailability 538s func.go:15: DEBUG: attempt 1: server @1: connected 540s func.go:15: DEBUG: network connection lost: write unix @->@1: write: broken pipe 540s func.go:15: WARN: attempt 1: server @1: dial: dial unix @1: connect: connection refused 540s func.go:15: WARN: attempt 1: server @2: no known leader 540s func.go:15: WARN: attempt 1: server @3: no known leader 540s func.go:15: WARN: attempt 2: server @1: dial: dial unix @1: connect: connection refused 540s func.go:15: WARN: attempt 2: server @2: no known leader 540s func.go:15: WARN: attempt 2: server @3: no known leader 541s func.go:15: WARN: attempt 3: server @1: dial: dial unix @1: connect: connection refused 541s func.go:15: WARN: attempt 3: server @2: no known leader 541s func.go:15: WARN: attempt 3: server @3: no known leader 541s func.go:15: WARN: attempt 4: server @1: dial: dial unix @1: connect: connection refused 541s func.go:15: WARN: attempt 4: server @2: no known leader 541s func.go:15: WARN: attempt 4: server @3: no known leader 542s func.go:15: WARN: attempt 5: server @1: dial: dial unix @1: connect: connection refused 542s func.go:15: DEBUG: attempt 5: server @2: connected 542s --- PASS: TestIntegration_HighAvailability (4.66s) 542s === RUN TestIntegration_LeadershipTransfer 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s func.go:15: DEBUG: leadership lost (10250 - not leader) 543s func.go:15: DEBUG: attempt 1: server @1: connect to reported leader @2 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s --- PASS: TestIntegration_LeadershipTransfer (0.16s) 543s === RUN TestIntegration_LeadershipTransfer_Tx 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s func.go:15: DEBUG: leadership lost (10250 - not leader) 543s func.go:15: DEBUG: attempt 1: server @1: connect to reported leader @2 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s --- PASS: TestIntegration_LeadershipTransfer_Tx (0.16s) 543s === RUN TestOptions 543s --- PASS: TestOptions (0.00s) 543s === RUN TestIntegration_ColumnTypeName 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s --- PASS: TestIntegration_ColumnTypeName (0.05s) 543s === RUN TestIntegration_SqlNullTime 543s func.go:15: DEBUG: attempt 1: server @1: connected 543s --- PASS: TestIntegration_SqlNullTime (0.06s) 543s PASS 543s ok github.com/cowsql/go-cowsql/driver 14.332s 543s === RUN TestNode_Create 543s --- PASS: TestNode_Create (0.03s) 543s === RUN TestNode_Start 543s --- PASS: TestNode_Start (0.03s) 543s === RUN TestNode_Restart 543s --- PASS: TestNode_Restart (0.05s) 543s === RUN TestNode_Start_Inet 543s --- PASS: TestNode_Start_Inet (0.03s) 543s === RUN TestNode_Leader 543s --- PASS: TestNode_Leader (0.02s) 543s PASS 543s ok github.com/cowsql/go-cowsql/internal/bindings 0.169s 545s === RUN TestMessage_StaticBytesAlignment 545s --- PASS: TestMessage_StaticBytesAlignment (0.00s) 545s === RUN TestMessage_putBlob 545s === RUN TestMessage_putBlob/16 545s === RUN TestMessage_putBlob/16#01 545s === RUN TestMessage_putBlob/24 545s --- PASS: TestMessage_putBlob (0.00s) 545s --- PASS: TestMessage_putBlob/16 (0.00s) 545s --- PASS: TestMessage_putBlob/16#01 (0.00s) 545s --- PASS: TestMessage_putBlob/24 (0.00s) 545s === RUN TestMessage_putString 545s === RUN TestMessage_putString/hello 545s === RUN TestMessage_putString/hello!! 545s === RUN TestMessage_putString/hello_world 545s --- PASS: TestMessage_putString (0.00s) 545s --- PASS: TestMessage_putString/hello (0.00s) 545s --- PASS: TestMessage_putString/hello!! (0.00s) 545s --- PASS: TestMessage_putString/hello_world (0.00s) 545s === RUN TestMessage_putUint8 545s --- PASS: TestMessage_putUint8 (0.00s) 545s === RUN TestMessage_putUint16 545s --- PASS: TestMessage_putUint16 (0.00s) 545s === RUN TestMessage_putUint32 545s --- PASS: TestMessage_putUint32 (0.00s) 545s === RUN TestMessage_putUint64 545s --- PASS: TestMessage_putUint64 (0.00s) 545s === RUN TestMessage_putNamedValues 545s --- PASS: TestMessage_putNamedValues (0.00s) 545s === RUN TestMessage_putNamedValues32 545s --- PASS: TestMessage_putNamedValues32 (0.00s) 545s === RUN TestMessage_putHeader 545s --- PASS: TestMessage_putHeader (0.00s) 545s === RUN TestMessage_getString 545s === RUN TestMessage_getString/hello 545s === RUN TestMessage_getString/hello!! 545s === RUN TestMessage_getString/hello!!! 545s === RUN TestMessage_getString/hello_world 545s --- PASS: TestMessage_getString (0.00s) 545s --- PASS: TestMessage_getString/hello (0.00s) 545s --- PASS: TestMessage_getString/hello!! (0.00s) 545s --- PASS: TestMessage_getString/hello!!! (0.00s) 545s --- PASS: TestMessage_getString/hello_world (0.00s) 545s === RUN TestMessage_getBlob 545s === RUN TestMessage_getBlob/16 545s === RUN TestMessage_getBlob/16#01 545s === RUN TestMessage_getBlob/24 545s --- PASS: TestMessage_getBlob (0.00s) 545s --- PASS: TestMessage_getBlob/16 (0.00s) 545s --- PASS: TestMessage_getBlob/16#01 (0.00s) 545s --- PASS: TestMessage_getBlob/24 (0.00s) 545s === RUN TestMessage_getString_Overflow_WordBoundary 545s --- PASS: TestMessage_getString_Overflow_WordBoundary (0.00s) 545s === RUN TestConnector_Success 545s connector_test.go:304: DEBUG: attempt 1: server @test-0: connected 545s --- PASS: TestConnector_Success (0.03s) 545s === RUN TestConnector_LimitRetries 545s connector_test.go:304: WARN: attempt 1: server @test-123: dial: dial unix @test-123: connect: connection refused 545s connector_test.go:304: WARN: attempt 2: server @test-123: dial: dial unix @test-123: connect: connection refused 546s connector_test.go:304: WARN: attempt 3: server @test-123: dial: dial unix @test-123: connect: connection refused 546s --- PASS: TestConnector_LimitRetries (0.60s) 546s === RUN TestConnector_DialTimeout 546s connector_test.go:64: Skipping network test 546s --- SKIP: TestConnector_DialTimeout (0.00s) 546s === RUN TestConnector_EmptyNodeStore 546s --- PASS: TestConnector_EmptyNodeStore (0.20s) 546s === RUN TestConnector_ContextCanceled 546s connector_test.go:99: Skipping network test 546s --- SKIP: TestConnector_ContextCanceled (0.00s) 546s === RUN TestConnector_AttemptTimeout 546s func.go:15: WARN: attempt 1: server @1234: call leader (budget 99.826395ms): receive: header: read unix @->@1234: i/o timeout 546s func.go:15: WARN: attempt 2: server @1234: call leader (budget 99.921178ms): receive: header: read unix @->@1234: i/o timeout 546s --- PASS: TestConnector_AttemptTimeout (0.40s) 546s === RUN TestProtocol_RequestWithDynamicBuffer 546s func.go:15: DEBUG: attempt 1: server @test-0: connected 546s --- PASS: TestProtocol_RequestWithDynamicBuffer (0.06s) 546s === RUN TestProtocol_Prepare 547s func.go:15: DEBUG: attempt 1: server @test-0: connected 547s --- PASS: TestProtocol_Prepare (0.03s) 547s PASS 547s ok github.com/cowsql/go-cowsql/internal/protocol 1.324s 547s ? github.com/cowsql/go-cowsql/internal/shell [no test files] 547s === RUN Test_TestFunc 547s func.go:15: INFO: hello 547s --- PASS: Test_TestFunc (0.00s) 547s === RUN TestLevel_String 547s --- PASS: TestLevel_String (0.00s) 547s PASS 547s ok github.com/cowsql/go-cowsql/logging 0.004s 547s autopkgtest [16:02:57]: test dh-golang-autopkgtest: -----------------------] 548s autopkgtest [16:02:58]: test dh-golang-autopkgtest: - - - - - - - - - - results - - - - - - - - - - 548s dh-golang-autopkgtest PASS 548s autopkgtest [16:02:58]: @@@@@@@@@@@@@@@@@@@@ summary 548s dh-golang-autopkgtest PASS 563s Creating nova instance adt-noble-ppc64el-golang-github-cowsql-go-cowsql-20240313-155349-juju-7f2275-prod-proposed-migration-environment-2 from image adt/ubuntu-noble-ppc64el-server-20240313.img (UUID 49ee2e43-6e8c-4030-9847-9ce502cac677)...