0s autopkgtest [07:00:40]: starting date and time: 2025-02-22 07:00:40+0000 0s autopkgtest [07:00:40]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [07:00:40]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.6bbleonc/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:postgresql-17 --apt-upgrade pgbackrest --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-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-ppc64el-16.secgroup --name adt-plucky-ppc64el-pgbackrest-20250222-070040-juju-7f2275-prod-proposed-migration-environment-20-215b6cb1-fd14-41a7-b0d1-9f45a923fee4 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-ppc64el -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/ 99s autopkgtest [07:02:19]: testbed dpkg architecture: ppc64el 100s autopkgtest [07:02:20]: testbed apt version: 2.9.30ubuntu1 100s autopkgtest [07:02:20]: @@@@@@@@@@@@@@@@@@@@ test bed setup 100s autopkgtest [07:02:20]: testbed release detected to be: None 101s autopkgtest [07:02:21]: updating testbed package index (apt update) 101s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 102s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 102s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 102s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 102s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 102s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 102s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.9 kB] 102s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [504 kB] 102s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [127 kB] 102s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el Packages [760 B] 102s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [432 kB] 102s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [3292 B] 102s Fetched 1276 kB in 1s (1333 kB/s) 104s Reading package lists... 104s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade... 105s Calculating upgrade... 105s The following packages will be upgraded: 105s curl libcurl3t64-gnutls libcurl4t64 105s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s Need to get 1221 kB of archives. 105s After this operation, 3072 B disk space will be freed. 105s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el curl ppc64el 8.12.1-2ubuntu1 [258 kB] 106s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el libcurl4t64 ppc64el 8.12.1-2ubuntu1 [482 kB] 106s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libcurl3t64-gnutls ppc64el 8.12.1-2ubuntu1 [481 kB] 106s Fetched 1221 kB in 1s (2035 kB/s) 107s (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 ... 106371 files and directories currently installed.) 107s Preparing to unpack .../curl_8.12.1-2ubuntu1_ppc64el.deb ... 107s Unpacking curl (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 107s Preparing to unpack .../libcurl4t64_8.12.1-2ubuntu1_ppc64el.deb ... 107s Unpacking libcurl4t64:ppc64el (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 107s Preparing to unpack .../libcurl3t64-gnutls_8.12.1-2ubuntu1_ppc64el.deb ... 107s Unpacking libcurl3t64-gnutls:ppc64el (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 107s Setting up libcurl4t64:ppc64el (8.12.1-2ubuntu1) ... 107s Setting up libcurl3t64-gnutls:ppc64el (8.12.1-2ubuntu1) ... 107s Setting up curl (8.12.1-2ubuntu1) ... 107s Processing triggers for man-db (2.13.0-1) ... 107s Processing triggers for libc-bin (2.40-4ubuntu1) ... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Solving dependencies... 108s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 108s autopkgtest [07:02:28]: upgrading testbed (apt dist-upgrade and autopurge) 109s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 109s Starting 2 pkgProblemResolver with broken count: 0 109s Done 110s Entering ResolveByKeep 110s 110s Calculating upgrade... 110s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Starting pkgProblemResolver with broken count: 0 111s Starting 2 pkgProblemResolver with broken count: 0 111s Done 111s Solving dependencies... 111s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s autopkgtest [07:02:34]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 16:32:08 UTC 2025 114s autopkgtest [07:02:34]: @@@@@@@@@@@@@@@@@@@@ apt-source pgbackrest 117s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pgbackrest 2.54.2-1 (dsc) [2361 B] 117s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pgbackrest 2.54.2-1 (tar) [2732 kB] 117s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pgbackrest 2.54.2-1 (diff) [21.7 kB] 117s gpgv: Signature made Tue Jan 21 10:48:00 2025 UTC 117s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 117s gpgv: Can't check signature: No public key 117s dpkg-source: warning: cannot verify inline signature for ./pgbackrest_2.54.2-1.dsc: no acceptable signature found 118s autopkgtest [07:02:38]: testing package pgbackrest version 2.54.2-1 118s autopkgtest [07:02:38]: build not needed 119s autopkgtest [07:02:39]: test version: preparing testbed 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 120s Starting pkgProblemResolver with broken count: 0 120s Starting 2 pkgProblemResolver with broken count: 0 120s Done 120s The following NEW packages will be installed: 120s libio-pty-perl libipc-run-perl libjson-perl libllvm20 libpq5 libxslt1.1 120s pgbackrest pgbackrest-doc postgresql postgresql-17 postgresql-client-17 120s postgresql-client-common postgresql-common postgresql-common-dev ssl-cert 120s 0 upgraded, 15 newly installed, 0 to remove and 0 not upgraded. 120s Need to get 52.2 MB of archives. 120s After this operation, 225 MB of additional disk space will be used. 120s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el libjson-perl all 4.10000-1 [81.9 kB] 120s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el postgresql-client-common all 273 [47.5 kB] 120s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el libio-pty-perl ppc64el 1:1.20-1build3 [32.0 kB] 120s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el libipc-run-perl all 20231003.0-2 [91.5 kB] 120s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el postgresql-common-dev all 273 [72.9 kB] 121s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el ssl-cert all 1.1.3ubuntu1 [18.7 kB] 121s Get:7 http://ftpmaster.internal/ubuntu plucky/main ppc64el postgresql-common all 273 [101 kB] 121s Get:8 http://ftpmaster.internal/ubuntu plucky/main ppc64el libllvm20 ppc64el 1:20.1.0~+rc2-1~exp2ubuntu0.4 [31.9 MB] 122s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libpq5 ppc64el 17.4-1 [174 kB] 122s Get:10 http://ftpmaster.internal/ubuntu plucky/main ppc64el libxslt1.1 ppc64el 1.1.39-0exp1ubuntu2 [191 kB] 122s Get:11 http://ftpmaster.internal/ubuntu plucky/universe ppc64el pgbackrest ppc64el 2.54.2-1 [634 kB] 122s Get:12 http://ftpmaster.internal/ubuntu plucky/universe ppc64el pgbackrest-doc all 2.54.2-1 [129 kB] 122s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el postgresql-client-17 ppc64el 17.4-1 [1482 kB] 122s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el postgresql-17 ppc64el 17.4-1 [17.2 MB] 122s Get:15 http://ftpmaster.internal/ubuntu plucky/main ppc64el postgresql all 17+273 [14.3 kB] 122s Preconfiguring packages ... 122s /var/cache/debconf/tmp.ci/postgresql.config.D2uM5G: 12: pg_lsclusters: not found 123s Fetched 52.2 MB in 2s (25.5 MB/s) 123s Selecting previously unselected package libjson-perl. 123s (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 ... 106371 files and directories currently installed.) 123s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 123s Unpacking libjson-perl (4.10000-1) ... 123s Selecting previously unselected package postgresql-client-common. 123s Preparing to unpack .../01-postgresql-client-common_273_all.deb ... 123s Unpacking postgresql-client-common (273) ... 123s Selecting previously unselected package libio-pty-perl. 123s Preparing to unpack .../02-libio-pty-perl_1%3a1.20-1build3_ppc64el.deb ... 123s Unpacking libio-pty-perl (1:1.20-1build3) ... 123s Selecting previously unselected package libipc-run-perl. 123s Preparing to unpack .../03-libipc-run-perl_20231003.0-2_all.deb ... 123s Unpacking libipc-run-perl (20231003.0-2) ... 123s Selecting previously unselected package postgresql-common-dev. 123s Preparing to unpack .../04-postgresql-common-dev_273_all.deb ... 123s Unpacking postgresql-common-dev (273) ... 123s Selecting previously unselected package ssl-cert. 123s Preparing to unpack .../05-ssl-cert_1.1.3ubuntu1_all.deb ... 123s Unpacking ssl-cert (1.1.3ubuntu1) ... 123s Selecting previously unselected package postgresql-common. 123s Preparing to unpack .../06-postgresql-common_273_all.deb ... 123s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 123s Unpacking postgresql-common (273) ... 123s Selecting previously unselected package libllvm20:ppc64el. 123s Preparing to unpack .../07-libllvm20_1%3a20.1.0~+rc2-1~exp2ubuntu0.4_ppc64el.deb ... 123s Unpacking libllvm20:ppc64el (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 124s Selecting previously unselected package libpq5:ppc64el. 124s Preparing to unpack .../08-libpq5_17.4-1_ppc64el.deb ... 124s Unpacking libpq5:ppc64el (17.4-1) ... 124s Selecting previously unselected package libxslt1.1:ppc64el. 124s Preparing to unpack .../09-libxslt1.1_1.1.39-0exp1ubuntu2_ppc64el.deb ... 124s Unpacking libxslt1.1:ppc64el (1.1.39-0exp1ubuntu2) ... 124s Selecting previously unselected package pgbackrest. 124s Preparing to unpack .../10-pgbackrest_2.54.2-1_ppc64el.deb ... 124s Unpacking pgbackrest (2.54.2-1) ... 124s Selecting previously unselected package pgbackrest-doc. 124s Preparing to unpack .../11-pgbackrest-doc_2.54.2-1_all.deb ... 124s Unpacking pgbackrest-doc (2.54.2-1) ... 124s Selecting previously unselected package postgresql-client-17. 124s Preparing to unpack .../12-postgresql-client-17_17.4-1_ppc64el.deb ... 124s Unpacking postgresql-client-17 (17.4-1) ... 124s Selecting previously unselected package postgresql-17. 124s Preparing to unpack .../13-postgresql-17_17.4-1_ppc64el.deb ... 124s Unpacking postgresql-17 (17.4-1) ... 124s Selecting previously unselected package postgresql. 124s Preparing to unpack .../14-postgresql_17+273_all.deb ... 124s Unpacking postgresql (17+273) ... 124s Setting up postgresql-client-common (273) ... 124s Setting up libio-pty-perl (1:1.20-1build3) ... 124s Setting up libpq5:ppc64el (17.4-1) ... 124s Setting up ssl-cert (1.1.3ubuntu1) ... 125s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 125s Setting up libllvm20:ppc64el (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 125s Setting up libipc-run-perl (20231003.0-2) ... 125s Setting up pgbackrest-doc (2.54.2-1) ... 125s Setting up libjson-perl (4.10000-1) ... 125s Setting up libxslt1.1:ppc64el (1.1.39-0exp1ubuntu2) ... 125s Setting up postgresql-common-dev (273) ... 125s Setting up postgresql-client-17 (17.4-1) ... 126s 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 126s Setting up postgresql-common (273) ... 126s Creating config file /etc/postgresql-common/createcluster.conf with new version 126s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 126s Removing obsolete dictionary files: 127s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 128s Setting up postgresql-17 (17.4-1) ... 129s Creating new PostgreSQL cluster 17/main ... 129s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 129s The files belonging to this database system will be owned by user "postgres". 129s This user must also own the server process. 129s 129s The database cluster will be initialized with locale "C.UTF-8". 129s The default database encoding has accordingly been set to "UTF8". 129s The default text search configuration will be set to "english". 129s 129s Data page checksums are disabled. 129s 129s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 129s creating subdirectories ... ok 129s selecting dynamic shared memory implementation ... posix 129s selecting default "max_connections" ... 100 129s selecting default "shared_buffers" ... 128MB 129s selecting default time zone ... Etc/UTC 129s creating configuration files ... ok 129s running bootstrap script ... ok 130s performing post-bootstrap initialization ... ok 130s syncing data to disk ... ok 133s Setting up pgbackrest (2.54.2-1) ... 134s Setting up postgresql (17+273) ... 134s Processing triggers for man-db (2.13.0-1) ... 136s Processing triggers for libc-bin (2.40-4ubuntu1) ... 137s autopkgtest [07:02:57]: test version: [----------------------- 137s pgBackRest 2.54.2 137s autopkgtest [07:02:57]: test version: -----------------------] 138s version PASS 138s autopkgtest [07:02:58]: test version: - - - - - - - - - - results - - - - - - - - - - 138s autopkgtest [07:02:58]: test suite: preparing testbed 138s Reading package lists... 139s Building dependency tree... 139s Reading state information... 139s Starting pkgProblemResolver with broken count: 0 139s Starting 2 pkgProblemResolver with broken count: 0 139s Done 139s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 140s autopkgtest [07:03:00]: test suite: [----------------------- 140s Creating new PostgreSQL cluster 17/regress ... 143s 2025-02-22 07:03:03.867 P00 INFO: stanza-create command begin 2.54.2: --config=/tmp/tmp.vsr7mZnLJA --exec-id=4339-eb615beb --lock-path=/tmp/tmp.VEtAueeIIw --log-level-console=info --log-path=/tmp/tmp.moTJHhisQd --pg1-path=/tmp/pg_virtualenv.ujWkX4/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.bwlxoDCLBZ --stanza=demo 143s 2025-02-22 07:03:03.876 P00 INFO: stanza-create for stanza 'demo' on repo1 143s 2025-02-22 07:03:03.901 P00 INFO: stanza-create command end: completed successfully (37ms) 143s 2025-02-22 07:03:03.907 P00 INFO: check command begin 2.54.2: --config=/tmp/tmp.vsr7mZnLJA --exec-id=4341-9c4ed7bf --log-level-console=info --log-path=/tmp/tmp.moTJHhisQd --pg1-path=/tmp/pg_virtualenv.ujWkX4/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.bwlxoDCLBZ --stanza=demo 143s 2025-02-22 07:03:03.916 P00 INFO: check repo1 configuration (primary) 143s 2025-02-22 07:03:03.920 P00 INFO: check repo1 archive for WAL (primary) 144s 2025-02-22 07:03:04.522 P00 INFO: WAL segment 000000010000000000000001 successfully archived to '/tmp/tmp.bwlxoDCLBZ/archive/demo/17-1/0000000100000000/000000010000000000000001-ce0665a85ddb65894b8db519a8263163568bff59.gz' on repo1 144s 2025-02-22 07:03:04.522 P00 INFO: check command end: completed successfully (617ms) 144s 2025-02-22 07:03:04.528 P00 INFO: backup command begin 2.54.2: --config=/tmp/tmp.vsr7mZnLJA --exec-id=4345-4346d29b --lock-path=/tmp/tmp.VEtAueeIIw --log-level-console=info --log-path=/tmp/tmp.moTJHhisQd --pg1-path=/tmp/pg_virtualenv.ujWkX4/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.bwlxoDCLBZ --repo1-retention-full=2 --stanza=demo 144s 2025-02-22 07:03:04.538 P00 WARN: no prior backup exists, incr backup has been changed to full 144s 2025-02-22 07:03:04.538 P00 INFO: execute non-exclusive backup start: backup begins after the next regular checkpoint completes 144s 2025-02-22 07:03:04.555 P00 INFO: backup start archive = 000000010000000000000002, lsn = 0/2000028 144s 2025-02-22 07:03:04.555 P00 INFO: check archive for segment 000000010000000000000002 148s 2025-02-22 07:03:08.169 P00 INFO: execute non-exclusive backup stop and wait for all WAL segments to archive 148s 2025-02-22 07:03:08.177 P00 INFO: backup stop archive = 000000010000000000000003, lsn = 0/3000050 148s 2025-02-22 07:03:08.184 P00 INFO: check archive for segment(s) 000000010000000000000002:000000010000000000000003 148s 2025-02-22 07:03:08.496 P00 INFO: new backup label = 20250222-070304F 148s 2025-02-22 07:03:08.552 P00 INFO: full backup size = 22MB, file total = 963 148s 2025-02-22 07:03:08.552 P00 INFO: backup command end: completed successfully (4026ms) 148s 2025-02-22 07:03:08.553 P00 INFO: expire command begin 2.54.2: --config=/tmp/tmp.vsr7mZnLJA --exec-id=4345-4346d29b --lock-path=/tmp/tmp.VEtAueeIIw --log-level-console=info --log-path=/tmp/tmp.moTJHhisQd --repo1-path=/tmp/tmp.bwlxoDCLBZ --repo1-retention-full=2 --stanza=demo 148s 2025-02-22 07:03:08.554 P00 INFO: expire command end: completed successfully (1ms) 148s stanza: demo 148s status: ok 148s cipher: none 148s 148s db (current) 148s wal archive min/max (17): 000000010000000000000001/000000010000000000000003 148s 148s full backup: 20250222-070304F 148s timestamp start/stop: 2025-02-22 07:03:04+00 / 2025-02-22 07:03:08+00 148s wal start/stop: 000000010000000000000002 / 000000010000000000000003 148s database size: 22MB, database backup size: 22MB 148s repo1: backup set size: 2.9MB, backup size: 2.9MB 148s Cleaning files... 148s Dropping cluster 17/regress ... 149s autopkgtest [07:03:09]: test suite: -----------------------] 149s suite PASS 149s autopkgtest [07:03:09]: test suite: - - - - - - - - - - results - - - - - - - - - - 149s autopkgtest [07:03:09]: @@@@@@@@@@@@@@@@@@@@ summary 149s version PASS 149s suite PASS 154s nova [W] Using flock in prodstack6-ppc64el 154s Creating nova instance adt-plucky-ppc64el-pgbackrest-20250222-070040-juju-7f2275-prod-proposed-migration-environment-20-215b6cb1-fd14-41a7-b0d1-9f45a923fee4 from image adt/ubuntu-plucky-ppc64el-server-20250222.img (UUID fe93544b-49e9-47e0-b80a-745acc8cd85b)... 154s nova [W] Timed out waiting for 43431d5d-3f6b-4d63-aaa3-3dfc75357a4e to get deleted.