0s autopkgtest [03:33:28]: starting date and time: 2024-07-13 03:33:28+0000 0s autopkgtest [03:33:28]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [03:33:28]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8nze7rmk/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade pgauditlogtofile --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.39-3.1ubuntu3 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos03-arm64-46.secgroup --name adt-oracular-arm64-pgauditlogtofile-20240713-033328-juju-7f2275-prod-proposed-migration-environment-3-8441a0fd-de03-4c4a-89f3-1b639835dbed --image adt/ubuntu-oracular-arm64-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/ 100s autopkgtest [03:35:08]: testbed dpkg architecture: arm64 101s autopkgtest [03:35:09]: testbed apt version: 2.9.6 101s autopkgtest [03:35:09]: @@@@@@@@@@@@@@@@@@@@ test bed setup 102s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 103s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 103s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [364 kB] 103s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [3860 B] 103s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [48.2 kB] 103s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [109 kB] 103s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 c-n-f Metadata [2116 B] 103s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [43.9 kB] 103s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 c-n-f Metadata [364 B] 103s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [419 kB] 103s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 c-n-f Metadata [8752 B] 103s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [8216 B] 103s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 c-n-f Metadata [276 B] 106s Fetched 1144 kB in 2s (589 kB/s) 107s Reading package lists... 110s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Calculating upgrade... 112s The following packages will be upgraded: 112s inetutils-telnet libc-bin libc-dev-bin libc-devtools libc6 libc6-dev locales 112s openssh-client openssh-server openssh-sftp-server telnet 112s 11 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 10.7 MB of archives. 112s After this operation, 28.7 kB disk space will be freed. 112s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-devtools arm64 2.39-3.1ubuntu3 [27.7 kB] 112s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc6-dev arm64 2.39-3.1ubuntu3 [1591 kB] 113s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-dev-bin arm64 2.39-3.1ubuntu3 [19.7 kB] 113s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc6 arm64 2.39-3.1ubuntu3 [2770 kB] 113s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libc-bin arm64 2.39-3.1ubuntu3 [579 kB] 113s Get:6 http://ftpmaster.internal/ubuntu oracular/main arm64 openssh-sftp-server arm64 1:9.6p1-3ubuntu17 [36.7 kB] 113s Get:7 http://ftpmaster.internal/ubuntu oracular/main arm64 openssh-server arm64 1:9.6p1-3ubuntu17 [502 kB] 113s Get:8 http://ftpmaster.internal/ubuntu oracular/main arm64 openssh-client arm64 1:9.6p1-3ubuntu17 [888 kB] 113s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 locales all 2.39-3.1ubuntu3 [4220 kB] 113s Get:10 http://ftpmaster.internal/ubuntu oracular/main arm64 inetutils-telnet arm64 2:2.5-5ubuntu1 [103 kB] 113s Get:11 http://ftpmaster.internal/ubuntu oracular/main arm64 telnet all 0.17+2.5-5ubuntu1 [3688 B] 114s Preconfiguring packages ... 115s Fetched 10.7 MB in 1s (7533 kB/s) 115s (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 ... 78392 files and directories currently installed.) 115s Preparing to unpack .../libc-devtools_2.39-3.1ubuntu3_arm64.deb ... 115s Unpacking libc-devtools (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 115s Preparing to unpack .../libc6-dev_2.39-3.1ubuntu3_arm64.deb ... 115s Unpacking libc6-dev:arm64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 116s Preparing to unpack .../libc-dev-bin_2.39-3.1ubuntu3_arm64.deb ... 116s Unpacking libc-dev-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 116s Preparing to unpack .../libc6_2.39-3.1ubuntu3_arm64.deb ... 116s Unpacking libc6:arm64 (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 117s Setting up libc6:arm64 (2.39-3.1ubuntu3) ... 117s Error: Could not restart systemd, systemd binary not working 117s (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 ... 78392 files and directories currently installed.) 117s Preparing to unpack .../libc-bin_2.39-3.1ubuntu3_arm64.deb ... 117s Unpacking libc-bin (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 117s Setting up libc-bin (2.39-3.1ubuntu3) ... 118s (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 ... 78392 files and directories currently installed.) 118s Preparing to unpack .../0-openssh-sftp-server_1%3a9.6p1-3ubuntu17_arm64.deb ... 118s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu17) over (1:9.6p1-3ubuntu15) ... 118s Preparing to unpack .../1-openssh-server_1%3a9.6p1-3ubuntu17_arm64.deb ... 118s Unpacking openssh-server (1:9.6p1-3ubuntu17) over (1:9.6p1-3ubuntu15) ... 118s Preparing to unpack .../2-openssh-client_1%3a9.6p1-3ubuntu17_arm64.deb ... 118s Unpacking openssh-client (1:9.6p1-3ubuntu17) over (1:9.6p1-3ubuntu15) ... 118s Preparing to unpack .../3-locales_2.39-3.1ubuntu3_all.deb ... 118s Unpacking locales (2.39-3.1ubuntu3) over (2.39-0ubuntu9) ... 119s Preparing to unpack .../4-inetutils-telnet_2%3a2.5-5ubuntu1_arm64.deb ... 119s Unpacking inetutils-telnet (2:2.5-5ubuntu1) over (2:2.5-3ubuntu4) ... 119s Preparing to unpack .../5-telnet_0.17+2.5-5ubuntu1_all.deb ... 119s Unpacking telnet (0.17+2.5-5ubuntu1) over (0.17+2.5-3ubuntu4) ... 121s Setting up openssh-client (1:9.6p1-3ubuntu17) ... 122s Setting up inetutils-telnet (2:2.5-5ubuntu1) ... 122s Setting up locales (2.39-3.1ubuntu3) ... 126s Generating locales (this might take a while)... 130s en_US.UTF-8... done 130s Generation complete. 130s Setting up libc-dev-bin (2.39-3.1ubuntu3) ... 130s Setting up libc-devtools (2.39-3.1ubuntu3) ... 130s Setting up openssh-sftp-server (1:9.6p1-3ubuntu17) ... 130s Setting up telnet (0.17+2.5-5ubuntu1) ... 130s Setting up openssh-server (1:9.6p1-3ubuntu17) ... 130s Installing new version of config file /etc/pam.d/sshd ... 132s Setting up libc6-dev:arm64 (2.39-3.1ubuntu3) ... 132s Processing triggers for systemd (256-1ubuntu1) ... 133s Processing triggers for man-db (2.12.1-2) ... 134s Processing triggers for ufw (0.36.2-6) ... 134s Reading package lists... 134s Building dependency tree... 134s Reading state information... 135s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 135s Hit:1 http://ftpmaster.internal/ubuntu oracular InRelease 136s Hit:2 http://ftpmaster.internal/ubuntu oracular-updates InRelease 136s Hit:3 http://ftpmaster.internal/ubuntu oracular-security InRelease 136s Hit:4 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 137s Reading package lists... 137s Reading package lists... 137s Building dependency tree... 137s Reading state information... 138s Calculating upgrade... 138s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 138s Reading package lists... 139s Building dependency tree... 139s Reading state information... 139s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 140s autopkgtest [03:35:48]: rebooting testbed after setup commands that affected boot 145s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 178s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 186s autopkgtest [03:36:34]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 190s autopkgtest [03:36:38]: @@@@@@@@@@@@@@@@@@@@ apt-source pgauditlogtofile 193s Get:1 http://ftpmaster.internal/ubuntu oracular/universe pgauditlogtofile 1.5.12-2 (dsc) [2170 B] 193s Get:2 http://ftpmaster.internal/ubuntu oracular/universe pgauditlogtofile 1.5.12-2 (tar) [10.1 kB] 193s Get:3 http://ftpmaster.internal/ubuntu oracular/universe pgauditlogtofile 1.5.12-2 (diff) [3036 B] 194s gpgv: Signature made Mon Sep 18 13:08:21 2023 UTC 194s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 194s gpgv: Can't check signature: No public key 194s dpkg-source: warning: cannot verify inline signature for ./pgauditlogtofile_1.5.12-2.dsc: no acceptable signature found 194s autopkgtest [03:36:42]: testing package pgauditlogtofile version 1.5.12-2 194s autopkgtest [03:36:42]: build not needed 194s autopkgtest [03:36:42]: test logtofile: preparing testbed 197s Reading package lists... 197s Building dependency tree... 197s Reading state information... 197s Starting pkgProblemResolver with broken count: 0 197s Starting 2 pkgProblemResolver with broken count: 0 197s Done 198s The following additional packages will be installed: 198s libjson-perl libpq5 libxslt1.1 postgresql-16 postgresql-16-pgaudit 198s postgresql-16-pgauditlogtofile postgresql-client-16 postgresql-client-common 198s postgresql-common ssl-cert 198s Suggested packages: 198s postgresql-doc-16 198s Recommended packages: 198s libjson-xs-perl 198s The following NEW packages will be installed: 198s autopkgtest-satdep libjson-perl libpq5 libxslt1.1 postgresql-16 198s postgresql-16-pgaudit postgresql-16-pgauditlogtofile postgresql-client-16 198s postgresql-client-common postgresql-common ssl-cert 198s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 198s Need to get 17.2 MB/17.2 MB of archives. 198s After this operation, 55.5 MB of additional disk space will be used. 198s Get:1 /tmp/autopkgtest.vsGHaz/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [720 B] 198s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 libjson-perl all 4.10000-1 [81.9 kB] 199s Get:3 http://ftpmaster.internal/ubuntu oracular/main arm64 postgresql-client-common all 261 [36.6 kB] 199s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 ssl-cert all 1.1.2ubuntu2 [18.0 kB] 199s Get:5 http://ftpmaster.internal/ubuntu oracular/main arm64 postgresql-common all 261 [162 kB] 199s Get:6 http://ftpmaster.internal/ubuntu oracular/main arm64 libpq5 arm64 16.3-1 [138 kB] 199s Get:7 http://ftpmaster.internal/ubuntu oracular/main arm64 libxslt1.1 arm64 1.1.39-0exp1build1 [166 kB] 199s Get:8 http://ftpmaster.internal/ubuntu oracular/main arm64 postgresql-client-16 arm64 16.3-1 [1261 kB] 199s Get:9 http://ftpmaster.internal/ubuntu oracular/main arm64 postgresql-16 arm64 16.3-1 [15.3 MB] 199s Get:10 http://ftpmaster.internal/ubuntu oracular/universe arm64 postgresql-16-pgaudit arm64 16.0-1 [53.3 kB] 199s Get:11 http://ftpmaster.internal/ubuntu oracular/universe arm64 postgresql-16-pgauditlogtofile arm64 1.5.12-2 [31.1 kB] 200s Preconfiguring packages ... 201s Fetched 17.2 MB in 1s (13.7 MB/s) 201s Selecting previously unselected package libjson-perl. 201s (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 ... 78392 files and directories currently installed.) 201s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 201s Unpacking libjson-perl (4.10000-1) ... 201s Selecting previously unselected package postgresql-client-common. 201s Preparing to unpack .../01-postgresql-client-common_261_all.deb ... 201s Unpacking postgresql-client-common (261) ... 201s Selecting previously unselected package ssl-cert. 201s Preparing to unpack .../02-ssl-cert_1.1.2ubuntu2_all.deb ... 201s Unpacking ssl-cert (1.1.2ubuntu2) ... 201s Selecting previously unselected package postgresql-common. 201s Preparing to unpack .../03-postgresql-common_261_all.deb ... 201s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 201s Unpacking postgresql-common (261) ... 201s Selecting previously unselected package libpq5:arm64. 201s Preparing to unpack .../04-libpq5_16.3-1_arm64.deb ... 201s Unpacking libpq5:arm64 (16.3-1) ... 201s Selecting previously unselected package libxslt1.1:arm64. 201s Preparing to unpack .../05-libxslt1.1_1.1.39-0exp1build1_arm64.deb ... 201s Unpacking libxslt1.1:arm64 (1.1.39-0exp1build1) ... 201s Selecting previously unselected package postgresql-client-16. 201s Preparing to unpack .../06-postgresql-client-16_16.3-1_arm64.deb ... 201s Unpacking postgresql-client-16 (16.3-1) ... 201s Selecting previously unselected package postgresql-16. 201s Preparing to unpack .../07-postgresql-16_16.3-1_arm64.deb ... 201s Unpacking postgresql-16 (16.3-1) ... 202s Selecting previously unselected package postgresql-16-pgaudit. 202s Preparing to unpack .../08-postgresql-16-pgaudit_16.0-1_arm64.deb ... 202s Unpacking postgresql-16-pgaudit (16.0-1) ... 202s Selecting previously unselected package postgresql-16-pgauditlogtofile. 202s Preparing to unpack .../09-postgresql-16-pgauditlogtofile_1.5.12-2_arm64.deb ... 202s Unpacking postgresql-16-pgauditlogtofile (1.5.12-2) ... 202s Selecting previously unselected package autopkgtest-satdep. 202s Preparing to unpack .../10-1-autopkgtest-satdep.deb ... 202s Unpacking autopkgtest-satdep (0) ... 202s Setting up postgresql-client-common (261) ... 202s Setting up libpq5:arm64 (16.3-1) ... 202s Setting up ssl-cert (1.1.2ubuntu2) ... 203s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 203s Setting up libjson-perl (4.10000-1) ... 203s Setting up libxslt1.1:arm64 (1.1.39-0exp1build1) ... 203s Setting up postgresql-client-16 (16.3-1) ... 204s 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 204s Setting up postgresql-common (261) ... 204s 204s Creating config file /etc/postgresql-common/createcluster.conf with new version 205s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 205s Removing obsolete dictionary files: 205s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 206s Setting up postgresql-16 (16.3-1) ... 206s Creating new PostgreSQL cluster 16/main ... 206s /usr/lib/postgresql/16/bin/initdb -D /var/lib/postgresql/16/main --auth-local peer --auth-host scram-sha-256 --no-instructions 206s The files belonging to this database system will be owned by user "postgres". 206s This user must also own the server process. 206s 206s The database cluster will be initialized with locale "C.UTF-8". 206s The default database encoding has accordingly been set to "UTF8". 206s The default text search configuration will be set to "english". 206s 206s Data page checksums are disabled. 206s 206s fixing permissions on existing directory /var/lib/postgresql/16/main ... ok 206s creating subdirectories ... ok 206s selecting dynamic shared memory implementation ... posix 207s selecting default max_connections ... 100 207s selecting default shared_buffers ... 128MB 207s selecting default time zone ... Etc/UTC 207s creating configuration files ... ok 207s running bootstrap script ... ok 207s performing post-bootstrap initialization ... ok 207s syncing data to disk ... ok 211s Setting up postgresql-16-pgaudit (16.0-1) ... 211s Setting up postgresql-16-pgauditlogtofile (1.5.12-2) ... 211s Setting up autopkgtest-satdep (0) ... 211s Processing triggers for man-db (2.12.1-2) ... 213s Processing triggers for libc-bin (2.39-3.1ubuntu3) ... 216s (Reading database ... 80355 files and directories currently installed.) 216s Removing autopkgtest-satdep (0) ... 216s autopkgtest [03:37:04]: test logtofile: [----------------------- 217s ### PostgreSQL 16 installcheck ### 217s Creating new PostgreSQL cluster 16/regress ... 220s echo "# +++ regress install-check in +++" && /usr/lib/postgresql/16/lib/pgxs/src/makefiles/../../src/test/regress/pg_regress --inputdir=./ --bindir='/usr/lib/postgresql/16/bin' --dbname=contrib_regression logtofile 220s # +++ regress install-check in +++ 220s # using postmaster on localhost, port 5433 220s ok 1 - logtofile 55 ms 220s 1..1 220s # All 1 tests passed. 220s Dropping cluster 16/regress ... 221s rm -f pgauditlogtofile.so libpgauditlogtofile.a libpgauditlogtofile.pc 221s rm -f pgauditlogtofile.o logtofile.o pgauditlogtofile.bc logtofile.bc 221s rm -rf results/ regression.diffs regression.out tmp_check/ tmp_check_iso/ log/ output_iso/ 221s ### End 16 installcheck ### 221s autopkgtest [03:37:09]: test logtofile: -----------------------] 222s autopkgtest [03:37:10]: test logtofile: - - - - - - - - - - results - - - - - - - - - - 222s logtofile PASS 222s autopkgtest [03:37:10]: @@@@@@@@@@@@@@@@@@@@ summary 222s logtofile PASS 240s nova [W] Skipping flock in bos03-arm64 240s Creating nova instance adt-oracular-arm64-pgauditlogtofile-20240713-033328-juju-7f2275-prod-proposed-migration-environment-3-8441a0fd-de03-4c4a-89f3-1b639835dbed from image adt/ubuntu-oracular-arm64-server-20240712.img (UUID a9c53646-2a41-49d7-a14b-d40262a2cb6c)...