0s autopkgtest [06:40:22]: starting date and time: 2025-02-22 06:40:22+0000 0s autopkgtest [06:40:22]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [06:40:22]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3mqbymsj/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:postgresql-17 --apt-upgrade pgauditlogtofile --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-2@bos03-s390x-23.secgroup --name adt-plucky-s390x-pgauditlogtofile-20250222-064022-juju-7f2275-prod-proposed-migration-environment-2-fff9d878-84bd-4fcc-bfd3-eb96307844b0 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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/ 105s autopkgtest [06:42:07]: testbed dpkg architecture: s390x 105s autopkgtest [06:42:07]: testbed apt version: 2.9.30ubuntu1 105s autopkgtest [06:42:07]: @@@@@@@@@@@@@@@@@@@@ test bed setup 105s autopkgtest [06:42:07]: testbed release detected to be: None 106s autopkgtest [06:42:08]: updating testbed package index (apt update) 106s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 106s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 107s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 107s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 107s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.9 kB] 107s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 107s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 107s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [504 kB] 107s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [125 kB] 107s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 107s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [424 kB] 107s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [2816 B] 107s Fetched 1264 kB in 1s (1486 kB/s) 108s Reading package lists... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 108s Calculating upgrade... 108s Calculating upgrade... 109s The following packages were automatically installed and are no longer required: 109s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 109s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 109s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 109s linux-tools-6.11.0-8-generic 109s Use 'sudo apt autoremove' to remove them. 109s The following packages will be upgraded: 109s curl libcurl3t64-gnutls libcurl4t64 109s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s Need to get 1041 kB of archives. 109s After this operation, 7168 B disk space will be freed. 109s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x curl s390x 8.12.1-2ubuntu1 [251 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl4t64 s390x 8.12.1-2ubuntu1 [397 kB] 109s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl3t64-gnutls s390x 8.12.1-2ubuntu1 [393 kB] 109s Fetched 1041 kB in 1s (1751 kB/s) 110s (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.) 110s Preparing to unpack .../curl_8.12.1-2ubuntu1_s390x.deb ... 110s Unpacking curl (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 110s Preparing to unpack .../libcurl4t64_8.12.1-2ubuntu1_s390x.deb ... 110s Unpacking libcurl4t64:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 110s Preparing to unpack .../libcurl3t64-gnutls_8.12.1-2ubuntu1_s390x.deb ... 110s Unpacking libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 110s Setting up libcurl4t64:s390x (8.12.1-2ubuntu1) ... 110s Setting up libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) ... 110s Setting up curl (8.12.1-2ubuntu1) ... 110s Processing triggers for man-db (2.13.0-1) ... 110s Processing triggers for libc-bin (2.40-4ubuntu1) ... 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Solving dependencies... 111s The following packages will be REMOVED: 111s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 111s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 111s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 111s linux-tools-6.11.0-8-generic* 111s 0 upgraded, 0 newly installed, 9 to remove and 0 not upgraded. 111s After this operation, 167 MB disk space will be freed. 111s (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.) 111s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 111s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 111s Removing libpython3.12t64:s390x (3.12.9-1) ... 111s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 111s Removing libnsl2:s390x (1.3.0-3build3) ... 111s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 111s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 111s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 112s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 112s Processing triggers for libc-bin (2.40-4ubuntu1) ... 112s (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.) 112s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 112s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 112s autopkgtest [06:42:14]: upgrading testbed (apt dist-upgrade and autopurge) 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 112s Starting 2 pkgProblemResolver with broken count: 0 112s Done 113s Entering ResolveByKeep 113s 113s Calculating upgrade... 113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 113s Starting pkgProblemResolver with broken count: 0 113s Starting 2 pkgProblemResolver with broken count: 0 113s Done 113s Solving dependencies... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s autopkgtest [06:42:16]: rebooting testbed after setup commands that affected boot 118s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 133s autopkgtest [06:42:35]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 135s autopkgtest [06:42:37]: @@@@@@@@@@@@@@@@@@@@ apt-source pgauditlogtofile 137s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pgauditlogtofile 1.6.4-1 (dsc) [2264 B] 137s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pgauditlogtofile 1.6.4-1 (tar) [14.8 kB] 137s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pgauditlogtofile 1.6.4-1 (diff) [3396 B] 137s gpgv: Signature made Sat Dec 21 19:59:10 2024 UTC 137s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 137s gpgv: Can't check signature: No public key 137s dpkg-source: warning: cannot verify inline signature for ./pgauditlogtofile_1.6.4-1.dsc: no acceptable signature found 137s autopkgtest [06:42:39]: testing package pgauditlogtofile version 1.6.4-1 137s autopkgtest [06:42:39]: build not needed 137s autopkgtest [06:42:39]: test logtofile: preparing testbed 138s Reading package lists... 138s Building dependency tree... 138s Reading state information... 138s Starting pkgProblemResolver with broken count: 0 138s Starting 2 pkgProblemResolver with broken count: 0 138s Done 138s The following NEW packages will be installed: 138s libio-pty-perl libipc-run-perl libjson-perl libllvm20 libpq5 libxslt1.1 138s postgresql-17 postgresql-17-pgaudit postgresql-17-pgauditlogtofile 138s postgresql-client-17 postgresql-client-common postgresql-common 138s postgresql-common-dev ssl-cert 138s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded. 138s Need to get 49.8 MB of archives. 138s After this operation, 213 MB of additional disk space will be used. 138s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-perl all 4.10000-1 [81.9 kB] 138s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-client-common all 273 [47.5 kB] 138s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libio-pty-perl s390x 1:1.20-1build3 [31.6 kB] 139s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libipc-run-perl all 20231003.0-2 [91.5 kB] 139s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-common-dev all 273 [72.9 kB] 139s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.3ubuntu1 [18.7 kB] 139s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-common all 273 [101 kB] 139s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libllvm20 s390x 1:20.1.0~+rc2-1~exp2ubuntu0.4 [31.3 MB] 139s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpq5 s390x 17.4-1 [147 kB] 139s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu2 [169 kB] 139s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-client-17 s390x 17.4-1 [1367 kB] 140s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x postgresql-17 s390x 17.4-1 [16.3 MB] 140s Get:13 http://ftpmaster.internal/ubuntu plucky/universe s390x postgresql-17-pgaudit s390x 17.0-2 [50.5 kB] 140s Get:14 http://ftpmaster.internal/ubuntu plucky/universe s390x postgresql-17-pgauditlogtofile s390x 1.6.4-1 [44.2 kB] 140s Preconfiguring packages ... 140s Fetched 49.8 MB in 2s (27.8 MB/s) 140s Selecting previously unselected package libjson-perl. 140s (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.) 140s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 140s Unpacking libjson-perl (4.10000-1) ... 140s Selecting previously unselected package postgresql-client-common. 140s Preparing to unpack .../01-postgresql-client-common_273_all.deb ... 140s Unpacking postgresql-client-common (273) ... 140s Selecting previously unselected package libio-pty-perl. 140s Preparing to unpack .../02-libio-pty-perl_1%3a1.20-1build3_s390x.deb ... 140s Unpacking libio-pty-perl (1:1.20-1build3) ... 140s Selecting previously unselected package libipc-run-perl. 140s Preparing to unpack .../03-libipc-run-perl_20231003.0-2_all.deb ... 140s Unpacking libipc-run-perl (20231003.0-2) ... 140s Selecting previously unselected package postgresql-common-dev. 140s Preparing to unpack .../04-postgresql-common-dev_273_all.deb ... 140s Unpacking postgresql-common-dev (273) ... 140s Selecting previously unselected package ssl-cert. 140s Preparing to unpack .../05-ssl-cert_1.1.3ubuntu1_all.deb ... 140s Unpacking ssl-cert (1.1.3ubuntu1) ... 140s Selecting previously unselected package postgresql-common. 140s Preparing to unpack .../06-postgresql-common_273_all.deb ... 140s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 140s Unpacking postgresql-common (273) ... 140s Selecting previously unselected package libllvm20:s390x. 140s Preparing to unpack .../07-libllvm20_1%3a20.1.0~+rc2-1~exp2ubuntu0.4_s390x.deb ... 140s Unpacking libllvm20:s390x (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 141s Selecting previously unselected package libpq5:s390x. 141s Preparing to unpack .../08-libpq5_17.4-1_s390x.deb ... 141s Unpacking libpq5:s390x (17.4-1) ... 141s Selecting previously unselected package libxslt1.1:s390x. 141s Preparing to unpack .../09-libxslt1.1_1.1.39-0exp1ubuntu2_s390x.deb ... 141s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu2) ... 141s Selecting previously unselected package postgresql-client-17. 141s Preparing to unpack .../10-postgresql-client-17_17.4-1_s390x.deb ... 141s Unpacking postgresql-client-17 (17.4-1) ... 141s Selecting previously unselected package postgresql-17. 141s Preparing to unpack .../11-postgresql-17_17.4-1_s390x.deb ... 141s Unpacking postgresql-17 (17.4-1) ... 141s Selecting previously unselected package postgresql-17-pgaudit. 141s Preparing to unpack .../12-postgresql-17-pgaudit_17.0-2_s390x.deb ... 141s Unpacking postgresql-17-pgaudit (17.0-2) ... 141s Selecting previously unselected package postgresql-17-pgauditlogtofile. 141s Preparing to unpack .../13-postgresql-17-pgauditlogtofile_1.6.4-1_s390x.deb ... 141s Unpacking postgresql-17-pgauditlogtofile (1.6.4-1) ... 141s Setting up postgresql-client-common (273) ... 141s Setting up libio-pty-perl (1:1.20-1build3) ... 141s Setting up libpq5:s390x (17.4-1) ... 141s Setting up ssl-cert (1.1.3ubuntu1) ... 142s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 142s Setting up libllvm20:s390x (1:20.1.0~+rc2-1~exp2ubuntu0.4) ... 142s Setting up libipc-run-perl (20231003.0-2) ... 142s Setting up libjson-perl (4.10000-1) ... 142s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu2) ... 142s Setting up postgresql-common-dev (273) ... 142s Setting up postgresql-client-17 (17.4-1) ... 142s 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 142s Setting up postgresql-common (273) ... 143s Creating config file /etc/postgresql-common/createcluster.conf with new version 143s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 143s Removing obsolete dictionary files: 143s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 143s Setting up postgresql-17 (17.4-1) ... 144s Creating new PostgreSQL cluster 17/main ... 144s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 144s The files belonging to this database system will be owned by user "postgres". 144s This user must also own the server process. 144s 144s The database cluster will be initialized with locale "C.UTF-8". 144s The default database encoding has accordingly been set to "UTF8". 144s The default text search configuration will be set to "english". 144s 144s Data page checksums are disabled. 144s 144s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 144s creating subdirectories ... ok 144s selecting dynamic shared memory implementation ... posix 144s selecting default "max_connections" ... 100 144s selecting default "shared_buffers" ... 128MB 144s selecting default time zone ... Etc/UTC 144s creating configuration files ... ok 144s running bootstrap script ... ok 144s performing post-bootstrap initialization ... ok 144s syncing data to disk ... ok 147s Setting up postgresql-17-pgaudit (17.0-2) ... 147s Setting up postgresql-17-pgauditlogtofile (1.6.4-1) ... 147s Processing triggers for man-db (2.13.0-1) ... 148s Processing triggers for libc-bin (2.40-4ubuntu1) ... 149s autopkgtest [06:42:51]: test logtofile: [----------------------- 149s ### PostgreSQL 17 installcheck ### 149s Creating new PostgreSQL cluster 17/regress ... 152s echo "# +++ regress install-check in +++" && /usr/lib/postgresql/17/lib/pgxs/src/makefiles/../../src/test/regress/pg_regress --inputdir=./ --bindir='/usr/lib/postgresql/17/bin' --dbname=contrib_regression logtofile 152s # +++ regress install-check in +++ 152s # using postmaster on localhost, port 5433 152s ok 1 - logtofile 18 ms 152s 1..1 152s # All 1 tests passed. 152s Dropping cluster 17/regress ... 152s rm -f pgauditlogtofile.so libpgauditlogtofile.a libpgauditlogtofile.pc 152s rm -f pgauditlogtofile.o logtofile.o logtofile_bgw.o logtofile_connect.o logtofile_guc.o logtofile_log.o logtofile_shmem.o logtofile_autoclose.o logtofile_vars.o logtofile_filename.o pgauditlogtofile.bc logtofile.bc logtofile_bgw.bc logtofile_connect.bc logtofile_guc.bc logtofile_log.bc logtofile_shmem.bc logtofile_autoclose.bc logtofile_vars.bc logtofile_filename.bc 152s rm -rf results/ regression.diffs regression.out tmp_check/ tmp_check_iso/ log/ output_iso/ 152s ### End 17 installcheck ### 152s autopkgtest [06:42:54]: test logtofile: -----------------------] 153s autopkgtest [06:42:55]: test logtofile: - - - - - - - - - - results - - - - - - - - - - 153s logtofile PASS 153s autopkgtest [06:42:55]: @@@@@@@@@@@@@@@@@@@@ summary 153s logtofile PASS 172s nova [W] Using flock in prodstack6-s390x 172s flock: timeout while waiting to get lock 172s Creating nova instance adt-plucky-s390x-pgauditlogtofile-20250222-064022-juju-7f2275-prod-proposed-migration-environment-2-fff9d878-84bd-4fcc-bfd3-eb96307844b0 from image adt/ubuntu-plucky-s390x-server-20250222.img (UUID ae633cda-0dee-481c-9805-d0ef3f3b5166)... 172s nova [W] Timed out waiting for ad69a3d1-403c-4158-b229-36c638836b1c to get deleted.