0s autopkgtest [14:33:57]: starting date and time: 2024-11-15 14:33:57+0000 0s autopkgtest [14:33:57]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [14:33:57]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8me9uro8/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:postgresql-common --apt-upgrade postgresql-filedump --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=postgresql-common/266 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-8.secgroup --name adt-plucky-amd64-postgresql-filedump-20241115-143357-juju-7f2275-prod-proposed-migration-environment-15-5eedb90f-81b8-472d-8f50-8a8db2d65abb --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-amd64 -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/ 46s autopkgtest [14:34:43]: testbed dpkg architecture: amd64 46s autopkgtest [14:34:43]: testbed apt version: 2.9.8 46s autopkgtest [14:34:43]: @@@@@@@@@@@@@@@@@@@@ test bed setup 47s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 47s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [1062 kB] 47s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [94.2 kB] 47s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 47s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.5 kB] 47s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [108 kB] 47s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [174 kB] 47s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [32.6 kB] 47s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [840 kB] 47s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [300 kB] 47s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [9416 B] 47s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [740 B] 48s Fetched 2718 kB in 1s (3317 kB/s) 48s Reading package lists... 50s Reading package lists... 50s Building dependency tree... 50s Reading state information... 50s Calculating upgrade... 50s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 50s Reading package lists... 51s Building dependency tree... 51s Reading state information... 51s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 51s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 51s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 51s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 51s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 52s Reading package lists... 52s Reading package lists... 52s Building dependency tree... 52s Reading state information... 53s Calculating upgrade... 53s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 53s Reading package lists... 53s Building dependency tree... 53s Reading state information... 53s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 56s autopkgtest [14:34:53]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 13:41:20 UTC 2024 56s autopkgtest [14:34:53]: @@@@@@@@@@@@@@@@@@@@ apt-source postgresql-filedump 57s Get:1 http://ftpmaster.internal/ubuntu plucky/universe postgresql-filedump 16.0-1 (dsc) [2180 B] 57s Get:2 http://ftpmaster.internal/ubuntu plucky/universe postgresql-filedump 16.0-1 (tar) [40.5 kB] 57s Get:3 http://ftpmaster.internal/ubuntu plucky/universe postgresql-filedump 16.0-1 (diff) [3672 B] 58s gpgv: Signature made Thu Sep 14 14:08:31 2023 UTC 58s gpgv: using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE 58s gpgv: Can't check signature: No public key 58s dpkg-source: warning: cannot verify inline signature for ./postgresql-filedump_16.0-1.dsc: no acceptable signature found 58s autopkgtest [14:34:55]: testing package postgresql-filedump version 16.0-1 58s autopkgtest [14:34:55]: build not needed 58s autopkgtest [14:34:55]: test installcheck: preparing testbed 62s Reading package lists... 62s Building dependency tree... 62s Reading state information... 62s Starting pkgProblemResolver with broken count: 0 62s Starting 2 pkgProblemResolver with broken count: 0 62s Done 62s The following additional packages will be installed: 62s libio-pty-perl libipc-run-perl libjson-perl libpq5 libxslt1.1 postgresql 62s postgresql-17 postgresql-client-17 postgresql-client-common 62s postgresql-common postgresql-filedump ssl-cert 62s Suggested packages: 62s postgresql-doc postgresql-doc-17 62s Recommended packages: 62s libjson-xs-perl 62s The following NEW packages will be installed: 62s autopkgtest-satdep libio-pty-perl libipc-run-perl libjson-perl libpq5 62s libxslt1.1 postgresql postgresql-17 postgresql-client-17 62s postgresql-client-common postgresql-common postgresql-filedump ssl-cert 62s 0 upgraded, 13 newly installed, 0 to remove and 0 not upgraded. 62s Need to get 20.9 MB/20.9 MB of archives. 62s After this operation, 71.9 MB of additional disk space will be used. 62s Get:1 /tmp/autopkgtest.Q2PGEV/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [720 B] 62s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 libjson-perl all 4.10000-1 [81.9 kB] 63s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 libio-pty-perl amd64 1:1.20-1build3 [31.4 kB] 63s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 libipc-run-perl all 20231003.0-2 [91.5 kB] 63s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 postgresql-client-common all 266 [37.0 kB] 63s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 ssl-cert all 1.1.2ubuntu2 [18.0 kB] 63s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 postgresql-common all 266 [162 kB] 63s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 libpq5 amd64 17.0-1 [249 kB] 63s Get:9 http://ftpmaster.internal/ubuntu plucky/main amd64 libxslt1.1 amd64 1.1.39-0exp1ubuntu1 [169 kB] 63s Get:10 http://ftpmaster.internal/ubuntu plucky/main amd64 postgresql-client-17 amd64 17.0-1 [2111 kB] 63s Get:11 http://ftpmaster.internal/ubuntu plucky/main amd64 postgresql-17 amd64 17.0-1 [17.9 MB] 63s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 postgresql all 17+266 [12.1 kB] 63s Get:13 http://ftpmaster.internal/ubuntu plucky/universe amd64 postgresql-filedump amd64 16.0-1 [42.4 kB] 64s Preconfiguring packages ... 64s Fetched 20.9 MB in 1s (19.2 MB/s) 64s Selecting previously unselected package libjson-perl. 64s (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 ... 75576 files and directories currently installed.) 64s Preparing to unpack .../00-libjson-perl_4.10000-1_all.deb ... 64s Unpacking libjson-perl (4.10000-1) ... 64s Selecting previously unselected package libio-pty-perl. 64s Preparing to unpack .../01-libio-pty-perl_1%3a1.20-1build3_amd64.deb ... 64s Unpacking libio-pty-perl (1:1.20-1build3) ... 64s Selecting previously unselected package libipc-run-perl. 64s Preparing to unpack .../02-libipc-run-perl_20231003.0-2_all.deb ... 64s Unpacking libipc-run-perl (20231003.0-2) ... 64s Selecting previously unselected package postgresql-client-common. 64s Preparing to unpack .../03-postgresql-client-common_266_all.deb ... 64s Unpacking postgresql-client-common (266) ... 64s Selecting previously unselected package ssl-cert. 64s Preparing to unpack .../04-ssl-cert_1.1.2ubuntu2_all.deb ... 64s Unpacking ssl-cert (1.1.2ubuntu2) ... 64s Selecting previously unselected package postgresql-common. 64s Preparing to unpack .../05-postgresql-common_266_all.deb ... 64s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 64s Unpacking postgresql-common (266) ... 64s Selecting previously unselected package libpq5:amd64. 64s Preparing to unpack .../06-libpq5_17.0-1_amd64.deb ... 64s Unpacking libpq5:amd64 (17.0-1) ... 64s Selecting previously unselected package libxslt1.1:amd64. 64s Preparing to unpack .../07-libxslt1.1_1.1.39-0exp1ubuntu1_amd64.deb ... 64s Unpacking libxslt1.1:amd64 (1.1.39-0exp1ubuntu1) ... 64s Selecting previously unselected package postgresql-client-17. 64s Preparing to unpack .../08-postgresql-client-17_17.0-1_amd64.deb ... 64s Unpacking postgresql-client-17 (17.0-1) ... 64s Selecting previously unselected package postgresql-17. 64s Preparing to unpack .../09-postgresql-17_17.0-1_amd64.deb ... 64s Unpacking postgresql-17 (17.0-1) ... 65s Selecting previously unselected package postgresql. 65s Preparing to unpack .../10-postgresql_17+266_all.deb ... 65s Unpacking postgresql (17+266) ... 65s Selecting previously unselected package postgresql-filedump. 65s Preparing to unpack .../11-postgresql-filedump_16.0-1_amd64.deb ... 65s Unpacking postgresql-filedump (16.0-1) ... 65s Selecting previously unselected package autopkgtest-satdep. 65s Preparing to unpack .../12-1-autopkgtest-satdep.deb ... 65s Unpacking autopkgtest-satdep (0) ... 65s Setting up libio-pty-perl (1:1.20-1build3) ... 65s Setting up libpq5:amd64 (17.0-1) ... 65s Setting up ssl-cert (1.1.2ubuntu2) ... 65s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 65s Setting up postgresql-filedump (16.0-1) ... 65s Setting up libipc-run-perl (20231003.0-2) ... 65s Setting up libjson-perl (4.10000-1) ... 65s Setting up libxslt1.1:amd64 (1.1.39-0exp1ubuntu1) ... 65s Setting up postgresql-client-common (266) ... 65s Setting up postgresql-client-17 (17.0-1) ... 66s 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 66s Setting up postgresql-common (266) ... 66s 66s Creating config file /etc/postgresql-common/createcluster.conf with new version 66s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 66s Removing obsolete dictionary files: 67s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 67s Setting up postgresql-17 (17.0-1) ... 67s Creating new PostgreSQL cluster 17/main ... 67s /usr/lib/postgresql/17/bin/initdb -D /var/lib/postgresql/17/main --auth-local peer --auth-host scram-sha-256 --no-instructions 67s The files belonging to this database system will be owned by user "postgres". 67s This user must also own the server process. 67s 67s The database cluster will be initialized with locale "C.UTF-8". 67s The default database encoding has accordingly been set to "UTF8". 67s The default text search configuration will be set to "english". 67s 67s Data page checksums are disabled. 67s 67s fixing permissions on existing directory /var/lib/postgresql/17/main ... ok 67s creating subdirectories ... ok 67s selecting dynamic shared memory implementation ... posix 67s selecting default "max_connections" ... 100 67s selecting default "shared_buffers" ... 128MB 67s selecting default time zone ... Etc/UTC 67s creating configuration files ... ok 67s running bootstrap script ... ok 68s performing post-bootstrap initialization ... ok 68s syncing data to disk ... ok 71s Setting up postgresql (17+266) ... 71s Setting up autopkgtest-satdep (0) ... 71s Processing triggers for man-db (2.13.0-1) ... 72s Processing triggers for libc-bin (2.40-1ubuntu3) ... 74s (Reading database ... 77945 files and directories currently installed.) 74s Removing autopkgtest-satdep (0) ... 75s autopkgtest [14:35:12]: test installcheck: [----------------------- 75s Creating new PostgreSQL cluster 17/regress ... 78s 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 datatypes float numeric xml 78s # +++ regress install-check in +++ 78s # using postmaster on localhost, port 5433 78s not ok 1 - datatypes 134 ms 78s ok 2 - float 28 ms 78s ok 3 - numeric 24 ms 78s ok 4 - xml 25 ms 78s 1..4 78s # 1 of 4 tests failed. 78s # The differences that caused some tests to fail can be viewed in the file "/tmp/autopkgtest.Q2PGEV/build.K96/src/regression.diffs". 78s # A copy of the test summary that you see above is saved in the file "/tmp/autopkgtest.Q2PGEV/build.K96/src/regression.out". 78s make: *** [/usr/lib/postgresql/17/lib/pgxs/src/makefiles/pgxs.mk:436: installcheck] Error 1 78s *** /tmp/pg_virtualenv.7dxitx/log/postgresql-17-regress.log (last 100 lines) *** 78s 2024-11-15 14:35:13.293 UTC [4189] LOG: starting PostgreSQL 17.0 (Ubuntu 17.0-1) on x86_64-pc-linux-gnu, compiled by gcc (Ubuntu 14.2.0-7ubuntu1) 14.2.0, 64-bit 78s 2024-11-15 14:35:13.294 UTC [4189] LOG: listening on IPv6 address "::1", port 5433 78s 2024-11-15 14:35:13.294 UTC [4189] LOG: listening on IPv4 address "127.0.0.1", port 5433 78s 2024-11-15 14:35:13.294 UTC [4189] LOG: listening on Unix socket "/tmp/.s.PGSQL.5433" 78s 2024-11-15 14:35:13.296 UTC [4192] LOG: database system was shut down at 2024-11-15 14:35:13 UTC 78s 2024-11-15 14:35:13.300 UTC [4189] LOG: database system is ready to accept connections 78s 2024-11-15 14:35:15.603 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.611 UTC [4190] LOG: checkpoint complete: wrote 934 buffers (5.7%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.009 s, sync=0.001 s, total=0.009 s; sync files=0, longest=0.000 s, average=0.000 s; distance=4276 kB, estimate=4276 kB; lsn=0/19183C8, redo lsn=0/1918370 78s 2024-11-15 14:35:15.620 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.621 UTC [4190] LOG: checkpoint complete: wrote 28 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=85 kB, estimate=3857 kB; lsn=0/192D870, redo lsn=0/192D818 78s 2024-11-15 14:35:15.625 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.626 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=87 kB, estimate=3480 kB; lsn=0/1943830, redo lsn=0/19437D8 78s 2024-11-15 14:35:15.630 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.630 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=90 kB, estimate=3141 kB; lsn=0/195A318, redo lsn=0/195A2C0 78s 2024-11-15 14:35:15.634 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.635 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=93 kB, estimate=2836 kB; lsn=0/1971948, redo lsn=0/19718F0 78s 2024-11-15 14:35:15.639 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.640 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=96 kB, estimate=2562 kB; lsn=0/1989BE0, redo lsn=0/1989B88 78s 2024-11-15 14:35:15.644 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.644 UTC [4190] LOG: checkpoint complete: wrote 33 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=105 kB, estimate=2316 kB; lsn=0/19A4118, redo lsn=0/19A40C0 78s 2024-11-15 14:35:15.649 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.649 UTC [4190] LOG: checkpoint complete: wrote 30 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=117 kB, estimate=2097 kB; lsn=0/19C1628, redo lsn=0/19C15D0 78s 2024-11-15 14:35:15.653 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.654 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=97 kB, estimate=1897 kB; lsn=0/19D9D30, redo lsn=0/19D9CD8 78s 2024-11-15 14:35:15.659 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.659 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=100 kB, estimate=1717 kB; lsn=0/19F3040, redo lsn=0/19F2FE8 78s 2024-11-15 14:35:15.663 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.664 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=103 kB, estimate=1556 kB; lsn=0/1A0CE60, redo lsn=0/1A0CE08 78s 2024-11-15 14:35:15.668 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.668 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=107 kB, estimate=1411 kB; lsn=0/1A27B48, redo lsn=0/1A27AF0 78s 2024-11-15 14:35:15.673 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.674 UTC [4190] LOG: checkpoint complete: wrote 33 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=130 kB, estimate=1283 kB; lsn=0/1A484C8, redo lsn=0/1A48470 78s 2024-11-15 14:35:15.678 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.678 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=107 kB, estimate=1165 kB; lsn=0/1A634B0, redo lsn=0/1A63458 78s 2024-11-15 14:35:15.682 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.683 UTC [4190] LOG: checkpoint complete: wrote 29 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=102 kB, estimate=1059 kB; lsn=0/1A7D050, redo lsn=0/1A7CFF8 78s 2024-11-15 14:35:15.687 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.687 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=105 kB, estimate=963 kB; lsn=0/1A977A0, redo lsn=0/1A97748 78s 2024-11-15 14:35:15.692 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.692 UTC [4190] LOG: checkpoint complete: wrote 30 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=108 kB, estimate=878 kB; lsn=0/1AB2A80, redo lsn=0/1AB2A28 78s 2024-11-15 14:35:15.697 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.697 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=103 kB, estimate=800 kB; lsn=0/1ACC850, redo lsn=0/1ACC7F8 78s 2024-11-15 14:35:15.702 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.702 UTC [4190] LOG: checkpoint complete: wrote 31 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=126 kB, estimate=733 kB; lsn=0/1AEC418, redo lsn=0/1AEC3C0 78s 2024-11-15 14:35:15.707 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.707 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=104 kB, estimate=670 kB; lsn=0/1B064D0, redo lsn=0/1B06478 78s 2024-11-15 14:35:15.711 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.712 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=107 kB, estimate=614 kB; lsn=0/1B21100, redo lsn=0/1B210A8 78s 2024-11-15 14:35:15.741 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.742 UTC [4190] LOG: checkpoint complete: wrote 29 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=107 kB, estimate=563 kB; lsn=0/1B3BD20, redo lsn=0/1B3BCC8 78s 2024-11-15 14:35:15.747 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.748 UTC [4190] LOG: checkpoint complete: wrote 26 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=101 kB, estimate=517 kB; lsn=0/1B55500, redo lsn=0/1B554A8 78s 2024-11-15 14:35:15.772 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.773 UTC [4190] LOG: checkpoint complete: wrote 34 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=133 kB, estimate=478 kB; lsn=0/1B769B8, redo lsn=0/1B76960 78s 2024-11-15 14:35:15.800 UTC [4190] LOG: checkpoint starting: immediate force wait 78s 2024-11-15 14:35:15.800 UTC [4190] LOG: checkpoint complete: wrote 36 buffers (0.2%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.001 s, total=0.001 s; sync files=0, longest=0.000 s, average=0.000 s; distance=126 kB, estimate=443 kB; lsn=0/1B965B0, redo lsn=0/1B96558 78s Dropping cluster 17/regress ... 79s diff -U3 /tmp/autopkgtest.Q2PGEV/build.K96/src/expected/datatypes.out /tmp/autopkgtest.Q2PGEV/build.K96/src/results/datatypes.out 79s --- /tmp/autopkgtest.Q2PGEV/build.K96/src/expected/datatypes.out 2023-09-14 13:37:45.000000000 +0000 79s +++ /tmp/autopkgtest.Q2PGEV/build.K96/src/results/datatypes.out 2024-11-15 14:35:15.714209606 +0000 79s @@ -746,7 +746,7 @@ 79s Item 1 -- Length: 32 Offset: 8160 (0x1fe0) Flags: NORMAL 79s COPY: 2000-01-01 08:00:00.000000+00 79s Item 2 -- Length: 32 Offset: 8128 (0x1fc0) Flags: NORMAL 79s -COPY: 0100-01-01 10:22:00.000000+00 BC 79s +COPY: 0100-01-01 10:14:58.000000+00 BC 79s Item 3 -- Length: 32 Offset: 8096 (0x1fa0) Flags: NORMAL 79s COPY: infinity 79s Item 4 -- Length: 32 Offset: 8064 (0x1f80) Flags: NORMAL 79s autopkgtest [14:35:16]: test installcheck: -----------------------] 79s autopkgtest [14:35:16]: test installcheck: - - - - - - - - - - results - - - - - - - - - - 79s installcheck FAIL non-zero exit status 1 80s autopkgtest [14:35:17]: @@@@@@@@@@@@@@@@@@@@ summary 80s installcheck FAIL non-zero exit status 1 92s nova [W] Skipping flock for amd64 92s Creating nova instance adt-plucky-amd64-postgresql-filedump-20241115-143357-juju-7f2275-prod-proposed-migration-environment-15-5eedb90f-81b8-472d-8f50-8a8db2d65abb from image adt/ubuntu-plucky-amd64-server-20241115.img (UUID 9bb4dd9c-454f-45da-a125-77b9d27ed145)...