0s autopkgtest [06:40:40]: starting date and time: 2025-02-22 06:40:40+0000 0s autopkgtest [06:40:40]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [06:40:40]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /var/tmp/autopkgtest-work.y9w2v1wr/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:postgresql-17 --apt-upgrade pgcopydb --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=postgresql-17/17.4-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-28.secgroup --name adt-plucky-s390x-pgcopydb-20250222-064040-juju-7f2275-prod-proposed-migration-environment-15-c6adbfd5-ece4-4f93-9593-f3606d19a96f --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-s390x -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,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 67s autopkgtest [06:41:46]: testbed dpkg architecture: s390x 67s autopkgtest [06:41:47]: testbed apt version: 2.9.30ubuntu1 67s autopkgtest [06:41:47]: @@@@@@@@@@@@@@@@@@@@ test bed setup 67s autopkgtest [06:41:47]: testbed release detected to be: None 68s autopkgtest [06:41:48]: updating testbed package index (apt update) 68s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 68s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 69s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 69s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 69s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 69s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 69s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [504 kB] 69s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.9 kB] 69s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [125 kB] 69s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 69s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [424 kB] 69s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [2816 B] 69s Fetched 1264 kB in 1s (1504 kB/s) 70s Reading package lists... 70s Reading package lists...+ lsb_release --codename --short 70s + RELEASE=plucky 70s + cat 70s + [ plucky != trusty ] 70s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 70s 70s Building dependency tree... 70s Reading state information... 70s Calculating upgrade... 70s Calculating upgrade... 71s The following packages were automatically installed and are no longer required: 71s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 71s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 71s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 71s linux-tools-6.11.0-8-generic 71s Use 'sudo apt autoremove' to remove them. 71s The following packages will be upgraded: 71s curl libcurl3t64-gnutls libcurl4t64 71s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 71s Need to get 1041 kB of archives. 71s After this operation, 7168 B disk space will be freed. 71s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x curl s390x 8.12.1-2ubuntu1 [251 kB] 71s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl4t64 s390x 8.12.1-2ubuntu1 [397 kB] 71s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl3t64-gnutls s390x 8.12.1-2ubuntu1 [393 kB] 71s Fetched 1041 kB in 1s (1868 kB/s) 71s (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 ... 81030 files and directories currently installed.) 71s Preparing to unpack .../curl_8.12.1-2ubuntu1_s390x.deb ... 71s Unpacking curl (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 71s Preparing to unpack .../libcurl4t64_8.12.1-2ubuntu1_s390x.deb ... 71s Unpacking libcurl4t64:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 71s Preparing to unpack .../libcurl3t64-gnutls_8.12.1-2ubuntu1_s390x.deb ... 71s Unpacking libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 72s Setting up libcurl4t64:s390x (8.12.1-2ubuntu1) ... 72s Setting up libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) ... 72s Setting up curl (8.12.1-2ubuntu1) ... 72s Processing triggers for man-db (2.13.0-1) ... 72s Processing triggers for libc-bin (2.40-4ubuntu1) ... 72s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 72s + /usr/lib/apt/apt-helper analyze-pattern ?true 72s + uname+ sed s/\./\\./g 72s -r 72s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 72s + apt list ?obsolete 72s + tail -n+2 72s + + cut -d/ -f1 72s grep -v ^linux-.*6\.12\.0-15-generic.* 72s + true 72s + obsolete_pkgs= 72s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 72s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s Solving dependencies... 73s The following packages will be REMOVED: 73s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 73s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 73s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 73s linux-tools-6.11.0-8-generic* 73s 0 upgraded, 0 newly installed, 9 to remove and 0 not upgraded. 73s After this operation, 167 MB disk space will be freed. 73s (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 ... 81030 files and directories currently installed.) 73s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 73s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 73s Removing libpython3.12t64:s390x (3.12.9-1) ... 73s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 73s Removing libnsl2:s390x (1.3.0-3build3) ... 73s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 73s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 73s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 74s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 74s Processing triggers for libc-bin (2.40-4ubuntu1) ... 74s (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 ... 55930 files and directories currently installed.) 74s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 74s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 74s + grep -q trusty /etc/lsb-release 74s + [ ! -d /usr/share/doc/unattended-upgrades ] 74s + [ ! -d /usr/share/doc/lxd ] 74s + [ ! -d /usr/share/doc/lxd-client ] 74s + [ ! -d /usr/share/doc/snapd ] 74s + type iptables 74s + cat 74s + chmod 755 /etc/rc.local 74s + . /etc/rc.local 74s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 74s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 74s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 74s + uname -m 74s + [ s390x = ppc64le ] 74s + [ -d /run/systemd/system ] 74s + systemd-detect-virt --quiet --vm 74s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 74s + cat 74s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 74s + echo COMPRESS=lz4 74s autopkgtest [06:41:54]: upgrading testbed (apt dist-upgrade and autopurge) 74s Reading package lists... 74s Building dependency tree... 74s Reading state information... 74s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 74s Starting 2 pkgProblemResolver with broken count: 0 74s Done 75s Entering ResolveByKeep 75s 75s Calculating upgrade... 75s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 75s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Starting pkgProblemResolver with broken count: 0 75s Starting 2 pkgProblemResolver with broken count: 0 75s Done 75s Solving dependencies... 76s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 76s autopkgtest [06:41:56]: rebooting testbed after setup commands that affected boot 96s autopkgtest [06:42:16]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 98s autopkgtest [06:42:18]: @@@@@@@@@@@@@@@@@@@@ apt-source pgcopydb 100s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pgcopydb 0.17-1 (dsc) [2145 B] 100s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pgcopydb 0.17-1 (tar) [19.1 MB] 100s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pgcopydb 0.17-1 (diff) [4148 B] 101s gpgv: Signature made Wed Aug 7 13:46:44 2024 UTC 101s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 101s gpgv: Can't check signature: No public key 101s dpkg-source: warning: cannot verify inline signature for ./pgcopydb_0.17-1.dsc: no acceptable signature found 101s autopkgtest [06:42:21]: testing package pgcopydb version 0.17-1 101s autopkgtest [06:42:21]: build not needed 103s autopkgtest [06:42:23]: test copydb: preparing testbed 103s Reading package lists... 103s Building dependency tree... 103s Reading state information... 103s Starting pkgProblemResolver with broken count: 0 103s Starting 2 pkgProblemResolver with broken count: 0 103s Done 104s The following NEW packages will be installed: 104s libgc1 libio-pty-perl libipc-run-perl libjson-perl libllvm20 libpq5 104s libxslt1.1 pgcopydb postgresql postgresql-17 postgresql-client 104s postgresql-client-17 postgresql-client-common postgresql-common 104s postgresql-common-dev ssl-cert 104s 0 upgraded, 16 newly installed, 0 to remove and 0 not upgraded. 104s Need to get 50.7 MB of archives. 104s After this operation, 215 MB of additional disk space will be used. 104s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-perl all 4.10000-1 [81.9 kB] 104s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-client-common all 273 [47.5 kB] 104s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libio-pty-perl s390x 1:1.20-1build3 [31.6 kB] 104s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libipc-run-perl all 20231003.0-2 [91.5 kB] 104s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-common-dev all 273 [72.9 kB] 104s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.3ubuntu1 [18.7 kB] 104s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-common all 273 [101 kB] 104s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libgc1 s390x 1:8.2.8-1 [93.7 kB] 104s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libllvm20 s390x 1:20.1.0~+rc2-1~exp2ubuntu0.4 [31.3 MB] 105s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpq5 s390x 17.4-1 [147 kB] 105s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu2 [169 kB] 105s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB] 105s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-client all 17+273 [13.2 kB] 105s Get:14 http://ftpmaster.internal/ubuntu plucky/universe s390x pgcopydb s390x 0.17-1 [825 kB] 105s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-17 s390x 17.4-1 [16.3 MB] 106s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql all 17+273 [14.3 kB] 106s Preconfiguring packages ... 106s /var/cache/debconf/tmp.ci/postgresql.config.96WFAe: 12: pg_lsclusters: not found 106s Fetched 50.7 MB in 2s (25.8 MB/s) 106s Selecting previously unselected package libjson-perl. 106s (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 ... 55928 files and directories currently installed.) 106s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 106s Unpacking libjson-perl (4.10000-1) ... 106s Selecting previously unselected package postgresql-client-common. 106s Preparing to unpack .../01-postgresql-client-common_273_all.deb ... 106s Unpacking postgresql-client-common (273) ... 106s Selecting previously unselected package libio-pty-perl. 106s Preparing to unpack .../02-libio-pty-perl_1%3a1.20-1build3_s390x.deb ... 106s Unpacking libio-pty-perl (1:1.20-1build3) ... 106s Selecting previously unselected package libipc-run-perl. 106s Preparing to unpack .../03-libipc-run-perl_20231003.0-2_all.deb ... 106s Unpacking libipc-run-perl (20231003.0-2) ... 106s Selecting previously unselected package postgresql-common-dev. 106s Preparing to unpack .../04-postgresql-common-dev_273_all.deb ... 106s Unpacking postgresql-common-dev (273) ... 106s Selecting previously unselected package ssl-cert. 106s Preparing to unpack .../05-ssl-cert_1.1.3ubuntu1_all.deb ... 106s Unpacking ssl-cert (1.1.3ubuntu1) ... 106s Selecting previously unselected package postgresql-common. 106s Preparing to unpack .../06-postgresql-common_273_all.deb ... 106s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 106s Unpacking postgresql-common (273) ... 106s Selecting previously unselected package libgc1:s390x. 106s Preparing to unpack .../07-libgc1_1%3a8.2.8-1_s390x.deb ... 106s Unpacking libgc1:s390x (1:8.2.8-1) ... 106s Selecting previously unselected package libllvm20:s390x. 106s Preparing to unpack .../08-libllvm20_1%3a20.1.0~+rc2-1~exp2ubuntu0.4_s390x.deb ... 106s Unpacking libllvm20:s390x (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 107s Selecting previously unselected package libpq5:s390x. 107s Preparing to unpack .../09-libpq5_17.4-1_s390x.deb ... 107s Unpacking libpq5:s390x (17.4-1) ... 107s Selecting previously unselected package libxslt1.1:s390x. 107s Preparing to unpack .../10-libxslt1.1_1.1.39-0exp1ubuntu2_s390x.deb ... 107s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu2) ... 107s Selecting previously unselected package postgresql-client-17. 107s Preparing to unpack .../11-postgresql-client-17_17.4-1_s390x.deb ... 107s Unpacking postgresql-client-17 (17.4-1) ... 107s Selecting previously unselected package postgresql-client. 107s Preparing to unpack .../12-postgresql-client_17+273_all.deb ... 107s Unpacking postgresql-client (17+273) ... 107s Selecting previously unselected package pgcopydb. 107s Preparing to unpack .../13-pgcopydb_0.17-1_s390x.deb ... 107s Unpacking pgcopydb (0.17-1) ... 107s Selecting previously unselected package postgresql-17. 107s Preparing to unpack .../14-postgresql-17_17.4-1_s390x.deb ... 107s Unpacking postgresql-17 (17.4-1) ... 107s Selecting previously unselected package postgresql. 107s Preparing to unpack .../15-postgresql_17+273_all.deb ... 107s Unpacking postgresql (17+273) ... 107s Setting up postgresql-client-common (273) ... 107s Setting up libio-pty-perl (1:1.20-1build3) ... 107s Setting up libpq5:s390x (17.4-1) ... 107s Setting up ssl-cert (1.1.3ubuntu1) ... 107s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 108s Setting up libllvm20:s390x (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 108s Setting up libipc-run-perl (20231003.0-2) ... 108s Setting up libgc1:s390x (1:8.2.8-1) ... 108s Setting up libjson-perl (4.10000-1) ... 108s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu2) ... 108s Setting up postgresql-common-dev (273) ... 108s Setting up postgresql-client-17 (17.4-1) ... 108s update-alternatives: using /usr/share/postgresql/17/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode 108s Setting up postgresql-common (273) ... 108s Creating config file /etc/postgresql-common/createcluster.conf with new version 108s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 108s Removing obsolete dictionary files: 109s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 109s Setting up pgcopydb (0.17-1) ... 109s Setting up postgresql-17 (17.4-1) ... 109s Creating new PostgreSQL cluster 17/main ... 109s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 109s The files belonging to this database system will be owned by user "postgres". 109s This user must also own the server process. 109s 109s The database cluster will be initialized with locale "C.UTF-8". 109s The default database encoding has accordingly been set to "UTF8". 109s The default text search configuration will be set to "english". 109s 109s Data page checksums are disabled. 109s 109s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 109s creating subdirectories ... ok 109s selecting dynamic shared memory implementation ... posix 109s selecting default "max_connections" ... 100 109s selecting default "shared_buffers" ... 128MB 109s selecting default time zone ... Etc/UTC 109s creating configuration files ... ok 109s running bootstrap script ... ok 110s performing post-bootstrap initialization ... ok 110s syncing data to disk ... ok 112s Setting up postgresql-client (17+273) ... 112s Setting up postgresql (17+273) ... 113s Processing triggers for man-db (2.13.0-1) ... 113s Processing triggers for libc-bin (2.40-4ubuntu1) ... 114s autopkgtest [06:42:34]: test copydb: [----------------------- 115s + WORKDIR=/tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home 115s + pg_virtualenv 115s Creating new PostgreSQL cluster 17/regress ... 117s + createdb src 117s + createdb dst 117s + psql -c 'create table foo as select 123+456' src 117s SELECT 1 117s + rm -rf /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home 117s + HOME=/tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home 117s + pgcopydb clone --source dbname=src --target dbname=dst --dir /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home 117s 2025-02-22 06:44:03.495 3550 INFO main.c:136 Running pgcopydb version 0.17-1 from "/usr/bin/pgcopydb" 117s 2025-02-22 06:44:03.496 3550 INFO cli_common.c:1225 [SOURCE] Copying database from "postgres:///src?keepalives=1&keepalives_idle=10&keepalives_interval=10&keepalives_count=60" 117s 2025-02-22 06:44:03.496 3550 INFO cli_common.c:1226 [TARGET] Copying database into "postgres:///dst?keepalives=1&keepalives_idle=10&keepalives_interval=10&keepalives_count=60" 117s 2025-02-22 06:44:03.498 3550 INFO copydb.c:105 Using work dir "/tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home" 117s 2025-02-22 06:44:03.521 3550 INFO snapshot.c:107 Exported snapshot "00000007-00000002-1" from the source database 117s 2025-02-22 06:44:03.521 3555 INFO cli_clone_follow.c:543 STEP 1: fetch source database tables, indexes, and sequences 117s 2025-02-22 06:44:03.599 3555 INFO copydb_schema.c:761 Fetched information for 1 tables (including 0 tables split in 0 partitions total), with an estimated total of 18 quintillion tuples and 8192 B on-disk 117s 2025-02-22 06:44:03.601 3555 INFO copydb_schema.c:968 Fetched information for 0 indexes (supporting 0 constraints) 117s 2025-02-22 06:44:03.601 3555 INFO sequences.c:78 Fetching information for 0 sequences 117s 2025-02-22 06:44:03.604 3555 INFO copydb_schema.c:1122 Fetched information for 1 extensions 118s 2025-02-22 06:44:03.635 3555 INFO copydb_schema.c:1538 Found 0 indexes (supporting 0 constraints) in the target database 118s 2025-02-22 06:44:03.636 3555 INFO cli_clone_follow.c:584 STEP 2: dump the source database schema (pre/post data) 118s 2025-02-22 06:44:03.637 3555 INFO pgcmd.c:475 /usr/lib/postgresql/17/bin/pg_dump -Fc --snapshot 00000007-00000002-1 --section=pre-data --section=post-data --file /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home/schema/schema.dump 'postgres:///src?keepalives=1&keepalives_idle=10&keepalives_interval=10&keepalives_count=60' 118s 2025-02-22 06:44:03.685 3555 INFO cli_clone_follow.c:592 STEP 3: restore the pre-data section to the target database 118s 2025-02-22 06:44:03.698 3555 INFO pgcmd.c:1008 /usr/lib/postgresql/17/bin/pg_restore --dbname 'postgres:///dst?keepalives=1&keepalives_idle=10&keepalives_interval=10&keepalives_count=60' --section pre-data --jobs 4 --use-list /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home/schema/pre-filtered.list /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home/schema/schema.dump 118s 2025-02-22 06:44:03.756 3574 INFO table-data.c:656 STEP 4: starting 4 table-data COPY processes 118s 2025-02-22 06:44:03.769 3580 INFO vacuum.c:143 STEP 8: starting 4 VACUUM processes 118s 2025-02-22 06:44:03.770 3575 INFO indexes.c:182 STEP 6: starting 4 CREATE INDEX processes 118s 2025-02-22 06:44:03.770 3575 INFO indexes.c:183 STEP 7: constraints are built by the CREATE INDEX processes 118s 2025-02-22 06:44:03.798 3555 INFO blobs.c:74 Skipping large objects: none found. 118s 2025-02-22 06:44:03.804 3555 INFO sequences.c:194 STEP 9: reset sequences values 118s 2025-02-22 06:44:03.811 3602 INFO sequences.c:290 Set sequences values on the target database 118s 2025-02-22 06:44:04.106 3555 INFO cli_clone_follow.c:608 STEP 10: restore the post-data section to the target database 118s 2025-02-22 06:44:04.110 3555 INFO pgcmd.c:1008 /usr/lib/postgresql/17/bin/pg_restore --dbname 'postgres:///dst?keepalives=1&keepalives_idle=10&keepalives_interval=10&keepalives_count=60' --section post-data --jobs 4 --use-list /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home/schema/post-filtered.list /tmp/autopkgtest.KJQyGz/build.1oB/src/debian/home/schema/schema.dump 118s 2025-02-22 06:44:04.164 3555 INFO cli_clone_follow.c:639 All step are now done, 528ms elapsed 118s 2025-02-22 06:44:04.164 3555 INFO summary.c:3173 Printing summary for 1 tables and 0 indexes 118s 118s OID | Schema | Name | Parts | copy duration | transmitted bytes | indexes | create index duration 118s ------+--------+------+-------+---------------+-------------------+---------+---------------------- 118s 16386 | public | foo | 1 | 2ms | 4 B | 0 | 0ms 118s 118s 118s Step Connection Duration Transfer Concurrency 118s -------------------------------------------------- ---------- ---------- ---------- ------------ 118s Catalog Queries (table ordering, filtering, etc) source 57ms 1 118s Dump Schema source 48ms 1 118s Prepare Schema target 64ms 1 118s COPY, INDEX, CONSTRAINTS, VACUUM (wall clock) both 354ms 12 118s COPY (cumulative) both 2ms 8192 B 4 118s CREATE INDEX (cumulative) target 0ms 4 118s CONSTRAINTS (cumulative) target 0ms 4 118s VACUUM (cumulative) target 21ms 4 118s Reset Sequences both 29ms 1 118s Large Objects (cumulative) (null) 0ms 0 118s Finalize Schema both 55ms 4 118s -------------------------------------------------- ---------- ---------- ---------- ------------ 118s Total Wall Clock Duration both 528ms 20 118s 118s + pg_dump -t foo dst 118s -- 118s -- PostgreSQL database dump 118s -- 118s 118s -- Dumped from database version 17.4 (Ubuntu 17.4-1) 118s -- Dumped by pg_dump version 17.4 (Ubuntu 17.4-1) 118s 118s SET statement_timeout = 0; 118s SET lock_timeout = 0; 118s SET idle_in_transaction_session_timeout = 0; 118s SET transaction_timeout = 0; 118s SET client_encoding = 'UTF8'; 118s SET standard_conforming_strings = on; 118s SELECT pg_catalog.set_config('search_path', '', false); 118s SET check_function_bodies = false; 118s SET xmloption = content; 118s SET client_min_messages = warning; 118s SET row_security = off; 118s 118s SET default_tablespace = ''; 118s 118s SET default_table_access_method = heap; 118s 118s -- 118s -- Name: foo; Type: TABLE; Schema: public; Owner: ubuntu 118s -- 118s 118s CREATE TABLE public.foo ( 118s "?column?" integer 118s ); 118s 118s 118s ALTER TABLE public.foo OWNER TO ubuntu; 118s 118s -- 118s -- Data for Name: foo; Type: TABLE DATA; Schema: public; Owner: ubuntu 118s -- 118s 118s COPY public.foo ("?column?") FROM stdin; 118s 579 118s \. 118s 118s 118s -- 118s -- PostgreSQL database dump complete 118s -- 118s 118s + pg_dump -t foo dst 118s + grep 579 118s 579 118s Dropping cluster 17/regress ... 119s autopkgtest [06:42:39]: test copydb: -----------------------] 119s autopkgtest [06:42:39]: test copydb: - - - - - - - - - - results - - - - - - - - - - 119s copydb PASS 120s autopkgtest [06:42:40]: @@@@@@@@@@@@@@@@@@@@ summary 120s copydb PASS 125s nova [W] Using flock in prodstack6-s390x 125s Creating nova instance adt-plucky-s390x-pgcopydb-20250222-064040-juju-7f2275-prod-proposed-migration-environment-15-c6adbfd5-ece4-4f93-9593-f3606d19a96f from image adt/ubuntu-plucky-s390x-server-20250222.img (UUID ae633cda-0dee-481c-9805-d0ef3f3b5166)... 125s nova [W] Timed out waiting for 681c5d9f-ed40-46c8-8c8c-ca8030f972ea to get deleted.