0s autopkgtest [03:09:53]: starting date and time: 2025-05-02 03:09:53+0000 0s autopkgtest [03:09:53]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production' 0s autopkgtest [03:09:53]: host juju-7f2275-prod-proposed-migration-environment-23; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.e3zk1aj5/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:postgresql-common --apt-upgrade pgbackrest --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=postgresql-common/277 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@sto01-arm64-4.secgroup --name adt-questing-arm64-pgbackrest-20250502-030952-juju-7f2275-prod-proposed-migration-environment-23-4463a0a5-cb8a-4936-80a9-3ae5240f6b59 --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-23 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 90s autopkgtest [03:11:23]: testbed dpkg architecture: arm64 90s autopkgtest [03:11:23]: testbed apt version: 3.0.0 90s autopkgtest [03:11:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 90s autopkgtest [03:11:23]: testbed release detected to be: None 91s autopkgtest [03:11:24]: updating testbed package index (apt update) 91s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB] 91s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease 91s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease 91s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease 91s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [190 kB] 92s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2281 kB] 92s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB] 92s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [227 kB] 92s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [1341 kB] 92s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [16.5 kB] 92s Fetched 4223 kB in 1s (3942 kB/s) 93s Reading package lists... 94s autopkgtest [03:11:27]: upgrading testbed (apt dist-upgrade and autopurge) 94s Reading package lists... 94s Building dependency tree... 94s Reading state information... 95s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 95s Starting 2 pkgProblemResolver with broken count: 0 95s Done 95s Entering ResolveByKeep 96s 96s Calculating upgrade... 96s The following packages will be upgraded: 96s libperl5.40 perl perl-base perl-modules-5.40 96s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 96s Need to get 10.0 MB of archives. 96s After this operation, 0 B of additional disk space will be used. 96s Get:1 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 libperl5.40 arm64 5.40.1-3 [4780 kB] 97s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl arm64 5.40.1-3 [262 kB] 97s Get:3 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl-base arm64 5.40.1-3 [1786 kB] 98s Get:4 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 perl-modules-5.40 all 5.40.1-3 [3217 kB] 99s Fetched 10.0 MB in 2s (4067 kB/s) 99s (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 ... 85224 files and directories currently installed.) 99s Preparing to unpack .../libperl5.40_5.40.1-3_arm64.deb ... 99s Unpacking libperl5.40:arm64 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 99s Preparing to unpack .../perl_5.40.1-3_arm64.deb ... 99s Unpacking perl (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 99s Preparing to unpack .../perl-base_5.40.1-3_arm64.deb ... 99s Unpacking perl-base (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 100s Setting up perl-base (5.40.1-3) ... 100s (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 ... 85224 files and directories currently installed.) 100s Preparing to unpack .../perl-modules-5.40_5.40.1-3_all.deb ... 100s Unpacking perl-modules-5.40 (5.40.1-3) over (5.40.1-2ubuntu0.1) ... 100s Setting up perl-modules-5.40 (5.40.1-3) ... 100s Setting up libperl5.40:arm64 (5.40.1-3) ... 100s Setting up perl (5.40.1-3) ... 100s Processing triggers for man-db (2.13.0-1) ... 100s Processing triggers for libc-bin (2.41-6ubuntu1) ... 101s Reading package lists... 101s Building dependency tree... 101s Reading state information... 101s Starting pkgProblemResolver with broken count: 0 101s Starting 2 pkgProblemResolver with broken count: 0 101s Done 102s Solving dependencies... 102s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 104s autopkgtest [03:11:37]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr 6 14:37:51 UTC 2025 104s autopkgtest [03:11:37]: @@@@@@@@@@@@@@@@@@@@ apt-source pgbackrest 109s Get:1 http://ftpmaster.internal/ubuntu questing/universe pgbackrest 2.54.2-1 (dsc) [2361 B] 109s Get:2 http://ftpmaster.internal/ubuntu questing/universe pgbackrest 2.54.2-1 (tar) [2732 kB] 109s Get:3 http://ftpmaster.internal/ubuntu questing/universe pgbackrest 2.54.2-1 (diff) [21.7 kB] 109s gpgv: Signature made Tue Jan 21 10:48:00 2025 UTC 109s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 109s gpgv: Can't check signature: No public key 109s dpkg-source: warning: cannot verify inline signature for ./pgbackrest_2.54.2-1.dsc: no acceptable signature found 109s autopkgtest [03:11:42]: testing package pgbackrest version 2.54.2-1 109s autopkgtest [03:11:42]: build not needed 110s autopkgtest [03:11:43]: test version: preparing testbed 111s 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 112s The following NEW packages will be installed: 112s libio-pty-perl libipc-run-perl libjson-perl libllvm20 libpq5 libxslt1.1 112s pgbackrest pgbackrest-doc postgresql postgresql-17 postgresql-client-17 112s postgresql-client-common postgresql-common postgresql-common-dev ssl-cert 112s 0 upgraded, 15 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 47.5 MB of archives. 112s After this operation, 201 MB of additional disk space will be used. 112s Get:1 http://ftpmaster.internal/ubuntu questing/main arm64 libjson-perl all 4.10000-1 [81.9 kB] 112s Get:2 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 postgresql-client-common all 277 [48.0 kB] 112s Get:3 http://ftpmaster.internal/ubuntu questing/main arm64 libio-pty-perl arm64 1:1.20-1build3 [31.3 kB] 112s Get:4 http://ftpmaster.internal/ubuntu questing/main arm64 libipc-run-perl all 20231003.0-2 [91.5 kB] 112s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 postgresql-common-dev all 277 [73.4 kB] 112s Get:6 http://ftpmaster.internal/ubuntu questing/main arm64 ssl-cert all 1.1.3ubuntu1 [18.7 kB] 112s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 postgresql-common all 277 [101 kB] 112s Get:8 http://ftpmaster.internal/ubuntu questing/main arm64 libllvm20 arm64 1:20.1.2-0ubuntu1 [29.1 MB] 117s Get:9 http://ftpmaster.internal/ubuntu questing/main arm64 libpq5 arm64 17.4-1 [142 kB] 117s Get:10 http://ftpmaster.internal/ubuntu questing/main arm64 libxslt1.1 arm64 1.1.39-0exp1ubuntu4 [168 kB] 117s Get:11 http://ftpmaster.internal/ubuntu questing/universe arm64 pgbackrest arm64 2.54.2-1 [571 kB] 117s Get:12 http://ftpmaster.internal/ubuntu questing/universe arm64 pgbackrest-doc all 2.54.2-1 [129 kB] 118s Get:13 http://ftpmaster.internal/ubuntu questing/main arm64 postgresql-client-17 arm64 17.4-1 [1342 kB] 118s Get:14 http://ftpmaster.internal/ubuntu questing/main arm64 postgresql-17 arm64 17.4-1 [15.6 MB] 121s Get:15 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 postgresql all 17+277 [16.5 kB] 121s Preconfiguring packages ... 121s /var/cache/debconf/tmp.ci/postgresql.config.fsmhPk: 12: pg_lsclusters: not found 121s Fetched 47.5 MB in 9s (5429 kB/s) 121s Selecting previously unselected package libjson-perl. 121s (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 ... 85224 files and directories currently installed.) 121s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 121s Unpacking libjson-perl (4.10000-1) ... 121s Selecting previously unselected package postgresql-client-common. 121s Preparing to unpack .../01-postgresql-client-common_277_all.deb ... 121s Unpacking postgresql-client-common (277) ... 121s Selecting previously unselected package libio-pty-perl. 121s Preparing to unpack .../02-libio-pty-perl_1%3a1.20-1build3_arm64.deb ... 121s Unpacking libio-pty-perl (1:1.20-1build3) ... 121s Selecting previously unselected package libipc-run-perl. 121s Preparing to unpack .../03-libipc-run-perl_20231003.0-2_all.deb ... 121s Unpacking libipc-run-perl (20231003.0-2) ... 121s Selecting previously unselected package postgresql-common-dev. 121s Preparing to unpack .../04-postgresql-common-dev_277_all.deb ... 121s Unpacking postgresql-common-dev (277) ... 121s Selecting previously unselected package ssl-cert. 121s Preparing to unpack .../05-ssl-cert_1.1.3ubuntu1_all.deb ... 121s Unpacking ssl-cert (1.1.3ubuntu1) ... 121s Selecting previously unselected package postgresql-common. 121s Preparing to unpack .../06-postgresql-common_277_all.deb ... 121s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 121s Unpacking postgresql-common (277) ... 121s Selecting previously unselected package libllvm20:arm64. 121s Preparing to unpack .../07-libllvm20_1%3a20.1.2-0ubuntu1_arm64.deb ... 121s Unpacking libllvm20:arm64 (1:20.1.2-0ubuntu1) ... 122s Selecting previously unselected package libpq5:arm64. 122s Preparing to unpack .../08-libpq5_17.4-1_arm64.deb ... 122s Unpacking libpq5:arm64 (17.4-1) ... 122s Selecting previously unselected package libxslt1.1:arm64. 122s Preparing to unpack .../09-libxslt1.1_1.1.39-0exp1ubuntu4_arm64.deb ... 122s Unpacking libxslt1.1:arm64 (1.1.39-0exp1ubuntu4) ... 122s Selecting previously unselected package pgbackrest. 122s Preparing to unpack .../10-pgbackrest_2.54.2-1_arm64.deb ... 122s Unpacking pgbackrest (2.54.2-1) ... 122s Selecting previously unselected package pgbackrest-doc. 122s Preparing to unpack .../11-pgbackrest-doc_2.54.2-1_all.deb ... 122s Unpacking pgbackrest-doc (2.54.2-1) ... 122s Selecting previously unselected package postgresql-client-17. 122s Preparing to unpack .../12-postgresql-client-17_17.4-1_arm64.deb ... 122s Unpacking postgresql-client-17 (17.4-1) ... 122s Selecting previously unselected package postgresql-17. 122s Preparing to unpack .../13-postgresql-17_17.4-1_arm64.deb ... 122s Unpacking postgresql-17 (17.4-1) ... 123s Selecting previously unselected package postgresql. 123s Preparing to unpack .../14-postgresql_17+277_all.deb ... 123s Unpacking postgresql (17+277) ... 123s Setting up postgresql-client-common (277) ... 123s Setting up libio-pty-perl (1:1.20-1build3) ... 123s Setting up libpq5:arm64 (17.4-1) ... 123s Setting up ssl-cert (1.1.3ubuntu1) ... 123s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 124s Setting up libllvm20:arm64 (1:20.1.2-0ubuntu1) ... 124s Setting up libipc-run-perl (20231003.0-2) ... 124s Setting up pgbackrest-doc (2.54.2-1) ... 124s Setting up libjson-perl (4.10000-1) ... 124s Setting up libxslt1.1:arm64 (1.1.39-0exp1ubuntu4) ... 124s Setting up postgresql-common-dev (277) ... 124s Setting up postgresql-client-17 (17.4-1) ... 124s 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 124s Setting up postgresql-common (277) ... 124s Creating config file /etc/postgresql-common/createcluster.conf with new version 124s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 124s Removing obsolete dictionary files: 125s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 125s Setting up postgresql-17 (17.4-1) ... 126s Creating new PostgreSQL cluster 17/main ... 126s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 126s The files belonging to this database system will be owned by user "postgres". 126s This user must also own the server process. 126s 126s The database cluster will be initialized with locale "C.UTF-8". 126s The default database encoding has accordingly been set to "UTF8". 126s The default text search configuration will be set to "english". 126s 126s Data page checksums are disabled. 126s 126s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 126s creating subdirectories ... ok 126s selecting dynamic shared memory implementation ... posix 126s selecting default "max_connections" ... 100 126s selecting default "shared_buffers" ... 128MB 126s selecting default time zone ... Etc/UTC 126s creating configuration files ... ok 126s running bootstrap script ... ok 127s performing post-bootstrap initialization ... ok 127s syncing data to disk ... ok 130s Setting up pgbackrest (2.54.2-1) ... 130s Setting up postgresql (17+277) ... 130s Processing triggers for man-db (2.13.0-1) ... 131s Processing triggers for libc-bin (2.41-6ubuntu1) ... 132s autopkgtest [03:12:05]: test version: [----------------------- 132s pgBackRest 2.54.2 132s autopkgtest [03:12:05]: test version: -----------------------] 133s version PASS 133s autopkgtest [03:12:06]: test version: - - - - - - - - - - results - - - - - - - - - - 133s autopkgtest [03:12:06]: test suite: preparing testbed 133s Reading package lists... 134s Building dependency tree... 134s Reading state information... 134s Starting pkgProblemResolver with broken count: 0 134s Starting 2 pkgProblemResolver with broken count: 0 134s Done 135s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 136s autopkgtest [03:12:09]: test suite: [----------------------- 136s Creating new PostgreSQL cluster 17/regress ... 139s 2025-05-02 03:12:11.673 P00 INFO: stanza-create command begin 2.54.2: --config=/tmp/tmp.ynM14z7VXH --exec-id=4326-4a357828 --lock-path=/tmp/tmp.z5R9LhqI99 --log-level-console=info --log-path=/tmp/tmp.hRMPtmwkF7 --pg1-path=/tmp/pg_virtualenv.w4xpZ5/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.g8ImUeOkZ5 --stanza=demo 139s 2025-05-02 03:12:11.683 P00 INFO: stanza-create for stanza 'demo' on repo1 139s 2025-05-02 03:12:11.706 P00 INFO: stanza-create command end: completed successfully (35ms) 139s 2025-05-02 03:12:11.713 P00 INFO: check command begin 2.54.2: --config=/tmp/tmp.ynM14z7VXH --exec-id=4328-67085219 --log-level-console=info --log-path=/tmp/tmp.hRMPtmwkF7 --pg1-path=/tmp/pg_virtualenv.w4xpZ5/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.g8ImUeOkZ5 --stanza=demo 139s 2025-05-02 03:12:11.722 P00 INFO: check repo1 configuration (primary) 139s 2025-05-02 03:12:11.727 P00 INFO: check repo1 archive for WAL (primary) 139s 2025-05-02 03:12:12.027 P00 INFO: WAL segment 000000010000000000000001 successfully archived to '/tmp/tmp.g8ImUeOkZ5/archive/demo/17-1/0000000100000000/000000010000000000000001-993bc74acce847e40113949e6f642466244344c6.gz' on repo1 139s 2025-05-02 03:12:12.028 P00 INFO: check command end: completed successfully (317ms) 139s 2025-05-02 03:12:12.036 P00 INFO: backup command begin 2.54.2: --config=/tmp/tmp.ynM14z7VXH --exec-id=4332-dc553abf --lock-path=/tmp/tmp.z5R9LhqI99 --log-level-console=info --log-path=/tmp/tmp.hRMPtmwkF7 --pg1-path=/tmp/pg_virtualenv.w4xpZ5/data/17/regress --pg1-port=5433 --repo1-path=/tmp/tmp.g8ImUeOkZ5 --repo1-retention-full=2 --stanza=demo 139s 2025-05-02 03:12:12.046 P00 WARN: no prior backup exists, incr backup has been changed to full 139s 2025-05-02 03:12:12.046 P00 INFO: execute non-exclusive backup start: backup begins after the next regular checkpoint completes 139s 2025-05-02 03:12:12.064 P00 INFO: backup start archive = 000000010000000000000002, lsn = 0/2000028 139s 2025-05-02 03:12:12.064 P00 INFO: check archive for segment 000000010000000000000002 143s 2025-05-02 03:12:15.729 P00 INFO: execute non-exclusive backup stop and wait for all WAL segments to archive 143s 2025-05-02 03:12:15.735 P00 INFO: backup stop archive = 000000010000000000000003, lsn = 0/3000050 143s 2025-05-02 03:12:15.742 P00 INFO: check archive for segment(s) 000000010000000000000002:000000010000000000000003 143s 2025-05-02 03:12:15.856 P00 INFO: new backup label = 20250502-031212F 143s 2025-05-02 03:12:15.900 P00 INFO: full backup size = 22MB, file total = 963 143s 2025-05-02 03:12:15.900 P00 INFO: backup command end: completed successfully (3866ms) 143s 2025-05-02 03:12:15.901 P00 INFO: expire command begin 2.54.2: --config=/tmp/tmp.ynM14z7VXH --exec-id=4332-dc553abf --lock-path=/tmp/tmp.z5R9LhqI99 --log-level-console=info --log-path=/tmp/tmp.hRMPtmwkF7 --repo1-path=/tmp/tmp.g8ImUeOkZ5 --repo1-retention-full=2 --stanza=demo 143s 2025-05-02 03:12:15.901 P00 INFO: expire command end: completed successfully (0ms) 143s stanza: demo 143s status: ok 143s cipher: none 143s 143s db (current) 143s wal archive min/max (17): 000000010000000000000001/000000010000000000000003 143s 143s full backup: 20250502-031212F 143s timestamp start/stop: 2025-05-02 03:12:12+00 / 2025-05-02 03:12:15+00 143s wal start/stop: 000000010000000000000002 / 000000010000000000000003 143s database size: 22MB, database backup size: 22MB 143s repo1: backup set size: 2.9MB, backup size: 2.9MB 143s Cleaning files... 143s Dropping cluster 17/regress ... 143s autopkgtest [03:12:16]: test suite: -----------------------] 144s autopkgtest [03:12:17]: test suite: - - - - - - - - - - results - - - - - - - - - - 144s suite PASS 144s autopkgtest [03:12:17]: @@@@@@@@@@@@@@@@@@@@ summary 144s version PASS 144s suite PASS 148s nova [W] Using flock in prodstack7-arm64 148s Creating nova instance adt-questing-arm64-pgbackrest-20250502-030952-juju-7f2275-prod-proposed-migration-environment-23-4463a0a5-cb8a-4936-80a9-3ae5240f6b59 from image adt/ubuntu-questing-arm64-server-20250501.img (UUID 137c3127-57d2-4bf2-a106-d904ad6e43f4)... 148s nova [W] Timed out waiting for 996597d5-9a4f-410b-9691-c9f0721cf885 to get deleted.