0s autopkgtest [13:11:05]: starting date and time: 2024-06-03 13:11:05+0000 0s autopkgtest [13:11:05]: git checkout: 930f72e5 setup-testbed: don't install 'Recommends' for 'linux-generic' 0s autopkgtest [13:11:05]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3nq4jfte/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:libxml2,src:libxml-libxml-perl --apt-upgrade pgbackrest --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=libxml2/2.12.7+dfsg-3 libxml-libxml-perl/2.0207+dfsg+really+2.0134-3' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@lcy02-105.secgroup --name adt-oracular-amd64-pgbackrest-20240603-131105-juju-7f2275-prod-proposed-migration-environment-3-49fcfab5-00a6-4255-9aa5-b01de4a9214d --image adt/ubuntu-oracular-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 161s autopkgtest [13:13:46]: testbed dpkg architecture: amd64 161s autopkgtest [13:13:46]: testbed apt version: 2.9.3 161s autopkgtest [13:13:46]: @@@@@@@@@@@@@@@@@@@@ test bed setup 162s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 162s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [1680 B] 162s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [384 kB] 162s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [4792 B] 162s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [43.4 kB] 162s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [81.4 kB] 162s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [58.4 kB] 162s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [4300 B] 162s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [7700 B] 162s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [355 kB] 162s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [187 kB] 162s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [1392 B] 162s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [1392 B] 162s Fetched 1241 kB in 0s (3155 kB/s) 162s Reading package lists... 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 166s Calculating upgrade... 166s The following packages will be upgraded: 166s libxml2 166s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 166s Need to get 642 kB of archives. 166s After this operation, 353 kB disk space will be freed. 166s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libxml2 amd64 2.12.7+dfsg-3 [642 kB] 166s Fetched 642 kB in 0s (22.9 MB/s) 167s (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 ... 74359 files and directories currently installed.) 167s Preparing to unpack .../libxml2_2.12.7+dfsg-3_amd64.deb ... 167s Unpacking libxml2:amd64 (2.12.7+dfsg-3) over (2.9.14+dfsg-1.3ubuntu3) ... 167s Setting up libxml2:amd64 (2.12.7+dfsg-3) ... 167s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 167s Reading package lists... 167s Building dependency tree... 167s Reading state information... 168s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 168s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 168s Get:2 http://ftpmaster.internal/ubuntu oracular InRelease [110 kB] 168s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 168s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 168s Get:5 http://ftpmaster.internal/ubuntu oracular/main Sources [1380 kB] 168s Get:6 http://ftpmaster.internal/ubuntu oracular/universe Sources [20.2 MB] 168s Get:7 http://ftpmaster.internal/ubuntu oracular/main i386 Packages [1047 kB] 168s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 Packages [1406 kB] 168s Get:9 http://ftpmaster.internal/ubuntu oracular/universe i386 Packages [8731 kB] 169s Get:10 http://ftpmaster.internal/ubuntu oracular/universe amd64 Packages [15.5 MB] 174s Fetched 48.4 MB in 6s (8776 kB/s) 175s Reading package lists... 175s Reading package lists... 175s Building dependency tree... 175s Reading state information... 176s Calculating upgrade... 176s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 176s Reading package lists... 176s Building dependency tree... 176s Reading state information... 177s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 179s autopkgtest [13:14:04]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 00:40:06 UTC 2024 179s autopkgtest [13:14:04]: @@@@@@@@@@@@@@@@@@@@ apt-source pgbackrest 181s Get:1 http://ftpmaster.internal/ubuntu oracular/universe pgbackrest 2.51-1 (dsc) [2311 B] 181s Get:2 http://ftpmaster.internal/ubuntu oracular/universe pgbackrest 2.51-1 (tar) [6120 kB] 181s Get:3 http://ftpmaster.internal/ubuntu oracular/universe pgbackrest 2.51-1 (diff) [21.2 kB] 181s gpgv: Signature made Tue Mar 26 14:14:21 2024 UTC 181s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 181s gpgv: Can't check signature: No public key 181s dpkg-source: warning: cannot verify inline signature for ./pgbackrest_2.51-1.dsc: no acceptable signature found 181s autopkgtest [13:14:06]: testing package pgbackrest version 2.51-1 182s autopkgtest [13:14:07]: build not needed 193s autopkgtest [13:14:18]: test version: preparing testbed 197s Reading package lists... 197s Building dependency tree... 197s Reading state information... 198s Starting pkgProblemResolver with broken count: 0 198s Starting 2 pkgProblemResolver with broken count: 0 198s Done 198s The following additional packages will be installed: 198s libjson-perl libpq5 libssh2-1t64 libxslt1.1 pgbackrest pgbackrest-doc 198s postgresql postgresql-16 postgresql-client-16 postgresql-client-common 198s postgresql-common ssl-cert 198s Suggested packages: 198s check-pgbackrest postgresql-doc postgresql-doc-16 198s Recommended packages: 198s libjson-xs-perl 198s The following NEW packages will be installed: 198s autopkgtest-satdep libjson-perl libpq5 libssh2-1t64 libxslt1.1 pgbackrest 198s pgbackrest-doc postgresql postgresql-16 postgresql-client-16 198s postgresql-client-common postgresql-common ssl-cert 198s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 198s Need to get 18.2 MB/18.2 MB of archives. 198s After this operation, 54.9 MB of additional disk space will be used. 198s Get:1 /tmp/autopkgtest.YoP16K/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [716 B] 198s Get:2 http://ftpmaster.internal/ubuntu oracular/main amd64 libjson-perl all 4.10000-1 [81.9 kB] 198s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-client-common all 260 [36.4 kB] 198s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 ssl-cert all 1.1.2ubuntu1 [17.8 kB] 198s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-common all 260 [162 kB] 198s Get:6 http://ftpmaster.internal/ubuntu oracular/main amd64 libpq5 amd64 16.3-1 [140 kB] 198s Get:7 http://ftpmaster.internal/ubuntu oracular/main amd64 libssh2-1t64 amd64 1.11.0-5 [120 kB] 198s Get:8 http://ftpmaster.internal/ubuntu oracular/main amd64 libxslt1.1 amd64 1.1.39-0exp1build1 [167 kB] 198s Get:9 http://ftpmaster.internal/ubuntu oracular/universe amd64 pgbackrest amd64 2.51-1 [567 kB] 198s Get:10 http://ftpmaster.internal/ubuntu oracular/universe amd64 pgbackrest-doc all 2.51-1 [125 kB] 198s Get:11 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-client-16 amd64 16.3-1 [1269 kB] 198s Get:12 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql-16 amd64 16.3-1 [15.5 MB] 199s Get:13 http://ftpmaster.internal/ubuntu oracular/main amd64 postgresql all 16+260 [11.6 kB] 199s Preconfiguring packages ... 199s Fetched 18.2 MB in 0s (51.9 MB/s) 199s Selecting previously unselected package libjson-perl. 199s (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 ... 74359 files and directories currently installed.) 199s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 199s Unpacking libjson-perl (4.10000-1) ... 199s Selecting previously unselected package postgresql-client-common. 199s Preparing to unpack .../01-postgresql-client-common_260_all.deb ... 199s Unpacking postgresql-client-common (260) ... 199s Selecting previously unselected package ssl-cert. 199s Preparing to unpack .../02-ssl-cert_1.1.2ubuntu1_all.deb ... 199s Unpacking ssl-cert (1.1.2ubuntu1) ... 199s Selecting previously unselected package postgresql-common. 199s Preparing to unpack .../03-postgresql-common_260_all.deb ... 199s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 199s Unpacking postgresql-common (260) ... 199s Selecting previously unselected package libpq5:amd64. 199s Preparing to unpack .../04-libpq5_16.3-1_amd64.deb ... 199s Unpacking libpq5:amd64 (16.3-1) ... 199s Selecting previously unselected package libssh2-1t64:amd64. 199s Preparing to unpack .../05-libssh2-1t64_1.11.0-5_amd64.deb ... 199s Unpacking libssh2-1t64:amd64 (1.11.0-5) ... 199s Selecting previously unselected package libxslt1.1:amd64. 199s Preparing to unpack .../06-libxslt1.1_1.1.39-0exp1build1_amd64.deb ... 199s Unpacking libxslt1.1:amd64 (1.1.39-0exp1build1) ... 199s Selecting previously unselected package pgbackrest. 199s Preparing to unpack .../07-pgbackrest_2.51-1_amd64.deb ... 199s Unpacking pgbackrest (2.51-1) ... 199s Selecting previously unselected package pgbackrest-doc. 199s Preparing to unpack .../08-pgbackrest-doc_2.51-1_all.deb ... 199s Unpacking pgbackrest-doc (2.51-1) ... 199s Selecting previously unselected package postgresql-client-16. 199s Preparing to unpack .../09-postgresql-client-16_16.3-1_amd64.deb ... 199s Unpacking postgresql-client-16 (16.3-1) ... 199s Selecting previously unselected package postgresql-16. 200s Preparing to unpack .../10-postgresql-16_16.3-1_amd64.deb ... 200s Unpacking postgresql-16 (16.3-1) ... 200s Selecting previously unselected package postgresql. 200s Preparing to unpack .../11-postgresql_16+260_all.deb ... 200s Unpacking postgresql (16+260) ... 200s Selecting previously unselected package autopkgtest-satdep. 200s Preparing to unpack .../12-1-autopkgtest-satdep.deb ... 200s Unpacking autopkgtest-satdep (0) ... 200s Setting up postgresql-client-common (260) ... 200s Setting up libpq5:amd64 (16.3-1) ... 200s Setting up ssl-cert (1.1.2ubuntu1) ... 200s Created symlink /etc/systemd/system/multi-user.target.wants/ssl-cert.service → /usr/lib/systemd/system/ssl-cert.service. 201s Setting up pgbackrest-doc (2.51-1) ... 201s Setting up libjson-perl (4.10000-1) ... 201s Setting up libxslt1.1:amd64 (1.1.39-0exp1build1) ... 201s Setting up libssh2-1t64:amd64 (1.11.0-5) ... 201s Setting up postgresql-client-16 (16.3-1) ... 201s update-alternatives: using /usr/share/postgresql/16/man/man1/psql.1.gz to provide /usr/share/man/man1/psql.1.gz (psql.1.gz) in auto mode 201s Setting up postgresql-common (260) ... 202s 202s Creating config file /etc/postgresql-common/createcluster.conf with new version 202s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 202s Removing obsolete dictionary files: 203s Created symlink /etc/systemd/system/multi-user.target.wants/postgresql.service → /usr/lib/systemd/system/postgresql.service. 203s Setting up postgresql-16 (16.3-1) ... 203s Creating new PostgreSQL cluster 16/main ... 203s /usr/lib/postgresql/16/bin/initdb -D /var/lib/postgresql/16/main --auth-local peer --auth-host scram-sha-256 --no-instructions 204s The files belonging to this database system will be owned by user "postgres". 204s This user must also own the server process. 204s 204s The database cluster will be initialized with locale "C.UTF-8". 204s The default database encoding has accordingly been set to "UTF8". 204s The default text search configuration will be set to "english". 204s 204s Data page checksums are disabled. 204s 204s fixing permissions on existing directory /var/lib/postgresql/16/main ... ok 204s creating subdirectories ... ok 204s selecting dynamic shared memory implementation ... posix 204s selecting default max_connections ... 100 204s selecting default shared_buffers ... 128MB 204s selecting default time zone ... Etc/UTC 204s creating configuration files ... ok 204s running bootstrap script ... ok 204s performing post-bootstrap initialization ... ok 204s syncing data to disk ... ok 208s Setting up pgbackrest (2.51-1) ... 209s Setting up postgresql (16+260) ... 209s Setting up autopkgtest-satdep (0) ... 209s Processing triggers for man-db (2.12.1-1) ... 210s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 214s (Reading database ... 76336 files and directories currently installed.) 214s Removing autopkgtest-satdep (0) ... 216s autopkgtest [13:14:41]: test version: [----------------------- 216s pgBackRest 2.51 217s autopkgtest [13:14:42]: test version: -----------------------] 218s autopkgtest [13:14:43]: test version: - - - - - - - - - - results - - - - - - - - - - 218s version PASS 218s autopkgtest [13:14:43]: test suite: preparing testbed 220s Reading package lists... 221s Building dependency tree... 221s Reading state information... 221s Starting pkgProblemResolver with broken count: 0 221s Starting 2 pkgProblemResolver with broken count: 0 221s Done 221s The following NEW packages will be installed: 221s autopkgtest-satdep 222s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 222s Need to get 0 B/720 B of archives. 222s After this operation, 0 B of additional disk space will be used. 222s Get:1 /tmp/autopkgtest.YoP16K/2-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [720 B] 222s Selecting previously unselected package autopkgtest-satdep. 222s (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 ... 76336 files and directories currently installed.) 222s Preparing to unpack .../2-autopkgtest-satdep.deb ... 222s Unpacking autopkgtest-satdep (0) ... 222s Setting up autopkgtest-satdep (0) ... 228s (Reading database ... 76336 files and directories currently installed.) 228s Removing autopkgtest-satdep (0) ... 230s autopkgtest [13:14:55]: test suite: [----------------------- 230s Creating new PostgreSQL cluster 16/regress ... 233s 2024-06-03 13:14:58.707 P00 INFO: stanza-create command begin 2.51: --config=/tmp/tmp.5rXl0TpVHm --exec-id=4363-3a36edcc --lock-path=/tmp/tmp.c1UGQTrxWJ --log-level-console=info --log-path=/tmp/tmp.aE5V2hlym2 --pg1-path=/tmp/pg_virtualenv.L8mI4d/data/16/regress --pg1-port=5433 --repo1-path=/tmp/tmp.8EOAySzwdq --stanza=demo 234s 2024-06-03 13:14:59.312 P00 INFO: stanza-create for stanza 'demo' on repo1 234s 2024-06-03 13:14:59.335 P00 INFO: stanza-create command end: completed successfully (631ms) 234s 2024-06-03 13:14:59.347 P00 INFO: check command begin 2.51: --config=/tmp/tmp.5rXl0TpVHm --exec-id=4365-f20b47e4 --log-level-console=info --log-path=/tmp/tmp.aE5V2hlym2 --pg1-path=/tmp/pg_virtualenv.L8mI4d/data/16/regress --pg1-port=5433 --repo1-path=/tmp/tmp.8EOAySzwdq --stanza=demo 234s 2024-06-03 13:14:59.952 P00 INFO: check repo1 configuration (primary) 235s 2024-06-03 13:15:00.154 P00 INFO: check repo1 archive for WAL (primary) 235s 2024-06-03 13:15:00.455 P00 INFO: WAL segment 000000010000000000000001 successfully archived to '/tmp/tmp.8EOAySzwdq/archive/demo/16-1/0000000100000000/000000010000000000000001-6a4486bc80922eae5a0a80f75bada7c6e2e5d55e.gz' on repo1 235s 2024-06-03 13:15:00.455 P00 INFO: check command end: completed successfully (1110ms) 235s 2024-06-03 13:15:00.469 P00 INFO: backup command begin 2.51: --config=/tmp/tmp.5rXl0TpVHm --exec-id=4369-718e822f --lock-path=/tmp/tmp.c1UGQTrxWJ --log-level-console=info --log-path=/tmp/tmp.aE5V2hlym2 --pg1-path=/tmp/pg_virtualenv.L8mI4d/data/16/regress --pg1-port=5433 --repo1-path=/tmp/tmp.8EOAySzwdq --repo1-retention-full=2 --stanza=demo 236s 2024-06-03 13:15:01.175 P00 INFO: execute non-exclusive backup start: backup begins after the next regular checkpoint completes 236s WARN: no prior backup exists, incr backup has been changed to full 236s 2024-06-03 13:15:01.877 P00 INFO: backup start archive = 000000010000000000000002, lsn = 0/2000028 236s 2024-06-03 13:15:01.877 P00 INFO: check archive for segment 000000010000000000000002 241s 2024-06-03 13:15:06.726 P00 INFO: execute non-exclusive backup stop and wait for all WAL segments to archive 241s 2024-06-03 13:15:06.926 P00 INFO: backup stop archive = 000000010000000000000003, lsn = 0/3000050 241s 2024-06-03 13:15:06.930 P00 INFO: check archive for segment(s) 000000010000000000000002:000000010000000000000003 241s 2024-06-03 13:15:06.943 P00 INFO: new backup label = 20240603-131501F 241s 2024-06-03 13:15:06.991 P00 INFO: full backup size = 22MB, file total = 963 241s 2024-06-03 13:15:06.991 P00 INFO: backup command end: completed successfully (6525ms) 241s 2024-06-03 13:15:06.991 P00 INFO: expire command begin 2.51: --config=/tmp/tmp.5rXl0TpVHm --exec-id=4369-718e822f --lock-path=/tmp/tmp.c1UGQTrxWJ --log-level-console=info --log-path=/tmp/tmp.aE5V2hlym2 --repo1-path=/tmp/tmp.8EOAySzwdq --repo1-retention-full=2 --stanza=demo 241s 2024-06-03 13:15:06.999 P00 INFO: expire command end: completed successfully (8ms) 242s stanza: demo 242s status: ok 242s cipher: none 242s 242s db (current) 242s wal archive min/max (16): 000000010000000000000001/000000010000000000000003 242s 242s full backup: 20240603-131501F 242s timestamp start/stop: 2024-06-03 13:15:01+00 / 2024-06-03 13:15:06+00 242s wal start/stop: 000000010000000000000002 / 000000010000000000000003 242s database size: 22MB, database backup size: 22MB 242s repo1: backup set size: 2.9MB, backup size: 2.9MB 242s Cleaning files... 242s Dropping cluster 16/regress ... 242s autopkgtest [13:15:07]: test suite: -----------------------] 243s autopkgtest [13:15:08]: test suite: - - - - - - - - - - results - - - - - - - - - - 243s suite PASS 243s autopkgtest [13:15:08]: @@@@@@@@@@@@@@@@@@@@ summary 243s version PASS 243s suite PASS 262s Creating nova instance adt-oracular-amd64-pgbackrest-20240603-131105-juju-7f2275-prod-proposed-migration-environment-3-49fcfab5-00a6-4255-9aa5-b01de4a9214d from image adt/ubuntu-oracular-amd64-server-20240603.img (UUID 2970e866-c7b7-4b51-b306-e135723f16bf)...