0s autopkgtest [10:29:32]: starting date and time: 2024-11-13 10:29:32+0000 0s autopkgtest [10:29:32]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky 0s autopkgtest [10:29:32]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.nz7rn2zu/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade powa-collector --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.7-1 python3-stdlib-extensions/3.12.7-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-16.secgroup --name adt-plucky-s390x-powa-collector-20241113-102932-juju-7f2275-prod-proposed-migration-environment-20-809c27b3-ce70-4370-8736-5d03762c1683 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 105s autopkgtest [10:31:17]: testbed dpkg architecture: s390x 105s autopkgtest [10:31:17]: testbed apt version: 2.9.8 105s autopkgtest [10:31:17]: @@@@@@@@@@@@@@@@@@@@ test bed setup 106s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB] 106s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.4 kB] 106s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.3 kB] 106s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B] 106s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [849 kB] 106s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [85.8 kB] 106s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [565 kB] 106s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [16.6 kB] 106s Fetched 1689 kB in 1s (2244 kB/s) 106s Reading package lists... 108s Reading package lists... 109s Building dependency tree... 109s Reading state information... 109s Calculating upgrade... 109s The following NEW packages will be installed: 109s python3.13-gdbm 109s The following packages will be upgraded: 109s libgpgme11t64 libpython3-stdlib python3 python3-gdbm python3-minimal 109s 5 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 109s Need to get 252 kB of archives. 109s After this operation, 98.3 kB of additional disk space will be used. 109s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-minimal s390x 3.12.7-1 [27.4 kB] 109s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3 s390x 3.12.7-1 [24.0 kB] 109s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libpython3-stdlib s390x 3.12.7-1 [10.0 kB] 109s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x python3.13-gdbm s390x 3.13.0-2 [31.0 kB] 109s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x python3-gdbm s390x 3.12.7-1 [8642 B] 109s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB] 110s Fetched 252 kB in 0s (571 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 ... 55510 files and directories currently installed.) 110s Preparing to unpack .../python3-minimal_3.12.7-1_s390x.deb ... 110s Unpacking python3-minimal (3.12.7-1) over (3.12.6-0ubuntu1) ... 110s Setting up python3-minimal (3.12.7-1) ... 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 ... 55510 files and directories currently installed.) 110s Preparing to unpack .../python3_3.12.7-1_s390x.deb ... 110s Unpacking python3 (3.12.7-1) over (3.12.6-0ubuntu1) ... 110s Preparing to unpack .../libpython3-stdlib_3.12.7-1_s390x.deb ... 110s Unpacking libpython3-stdlib:s390x (3.12.7-1) over (3.12.6-0ubuntu1) ... 110s Selecting previously unselected package python3.13-gdbm. 110s Preparing to unpack .../python3.13-gdbm_3.13.0-2_s390x.deb ... 110s Unpacking python3.13-gdbm (3.13.0-2) ... 110s Preparing to unpack .../python3-gdbm_3.12.7-1_s390x.deb ... 110s Unpacking python3-gdbm:s390x (3.12.7-1) over (3.12.6-1ubuntu1) ... 110s Preparing to unpack .../libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ... 110s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ... 110s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ... 110s Setting up python3.13-gdbm (3.13.0-2) ... 110s Setting up libpython3-stdlib:s390x (3.12.7-1) ... 110s Setting up python3 (3.12.7-1) ... 110s Setting up python3-gdbm:s390x (3.12.7-1) ... 110s Processing triggers for man-db (2.12.1-3) ... 110s Processing triggers for libc-bin (2.40-1ubuntu3) ... 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 111s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease 111s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 111s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 111s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 112s Reading package lists... 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Calculating upgrade... 112s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 112s Reading package lists... 113s Building dependency tree... 113s Reading state information... 113s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s autopkgtest [10:31:27]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024 116s autopkgtest [10:31:28]: @@@@@@@@@@@@@@@@@@@@ apt-source powa-collector 117s Get:1 http://ftpmaster.internal/ubuntu plucky/universe powa-collector 1.2.0-3 (dsc) [2111 B] 117s Get:2 http://ftpmaster.internal/ubuntu plucky/universe powa-collector 1.2.0-3 (tar) [14.2 kB] 117s Get:3 http://ftpmaster.internal/ubuntu plucky/universe powa-collector 1.2.0-3 (diff) [4076 B] 117s gpgv: Signature made Wed May 15 16:11:05 2024 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 ./powa-collector_1.2.0-3.dsc: no acceptable signature found 117s autopkgtest [10:31:29]: testing package powa-collector version 1.2.0-3 117s autopkgtest [10:31:29]: build not needed 118s autopkgtest [10:31:30]: test collector: preparing testbed 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Starting pkgProblemResolver with broken count: 0 119s Starting 2 pkgProblemResolver with broken count: 0 119s Done 119s The following additional packages will be installed: 119s libjson-perl libpq5 libxslt1.1 postgresql-16 postgresql-16-powa 119s postgresql-client-16 postgresql-client-common postgresql-common 119s powa-collector python3-psycopg2 ssl-cert 119s Suggested packages: 119s powa-web postgresql-doc-16 python-psycopg2-doc 119s Recommended packages: 119s libjson-xs-perl 119s The following NEW packages will be installed: 119s autopkgtest-satdep libjson-perl libpq5 libxslt1.1 postgresql-16 119s postgresql-16-powa postgresql-client-16 postgresql-client-common 119s postgresql-common powa-collector python3-psycopg2 ssl-cert 119s 0 upgraded, 12 newly installed, 0 to remove and 0 not upgraded. 119s Need to get 18.5 MB/18.5 MB of archives. 119s After this operation, 55.9 MB of additional disk space will be used. 119s Get:1 /tmp/autopkgtest.kljfNV/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [716 B] 119s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-perl all 4.10000-1 [81.9 kB] 120s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-client-common all 262 [36.7 kB] 120s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB] 120s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-common all 262 [162 kB] 120s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libpq5 s390x 17.0-1 [252 kB] 120s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libxslt1.1 s390x 1.1.39-0exp1ubuntu1 [169 kB] 120s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-client-16 s390x 16.4-3 [1294 kB] 120s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x postgresql-16 s390x 16.4-3 [16.3 MB] 120s Get:10 http://ftpmaster.internal/ubuntu plucky/universe s390x postgresql-16-powa s390x 4.2.2-1 [48.2 kB] 120s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x python3-psycopg2 s390x 2.9.9-2 [132 kB] 120s Get:12 http://ftpmaster.internal/ubuntu plucky/universe s390x powa-collector all 1.2.0-3 [15.9 kB] 121s Preconfiguring packages ... 121s Fetched 18.5 MB in 1s (13.9 MB/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 ... 55517 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_262_all.deb ... 121s Unpacking postgresql-client-common (262) ... 121s Selecting previously unselected package ssl-cert. 121s Preparing to unpack .../02-ssl-cert_1.1.2ubuntu2_all.deb ... 121s Unpacking ssl-cert (1.1.2ubuntu2) ... 121s Selecting previously unselected package postgresql-common. 121s Preparing to unpack .../03-postgresql-common_262_all.deb ... 121s Adding 'diversion of /usr/bin/pg_config to /usr/bin/pg_config.libpq-dev by postgresql-common' 121s Unpacking postgresql-common (262) ... 121s Selecting previously unselected package libpq5:s390x. 121s Preparing to unpack .../04-libpq5_17.0-1_s390x.deb ... 121s Unpacking libpq5:s390x (17.0-1) ... 121s Selecting previously unselected package libxslt1.1:s390x. 121s Preparing to unpack .../05-libxslt1.1_1.1.39-0exp1ubuntu1_s390x.deb ... 121s Unpacking libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 121s Selecting previously unselected package postgresql-client-16. 121s Preparing to unpack .../06-postgresql-client-16_16.4-3_s390x.deb ... 121s Unpacking postgresql-client-16 (16.4-3) ... 121s Selecting previously unselected package postgresql-16. 121s Preparing to unpack .../07-postgresql-16_16.4-3_s390x.deb ... 121s Unpacking postgresql-16 (16.4-3) ... 121s Selecting previously unselected package postgresql-16-powa. 121s Preparing to unpack .../08-postgresql-16-powa_4.2.2-1_s390x.deb ... 121s Unpacking postgresql-16-powa (4.2.2-1) ... 121s Selecting previously unselected package python3-psycopg2. 121s Preparing to unpack .../09-python3-psycopg2_2.9.9-2_s390x.deb ... 121s Unpacking python3-psycopg2 (2.9.9-2) ... 121s Selecting previously unselected package powa-collector. 121s Preparing to unpack .../10-powa-collector_1.2.0-3_all.deb ... 121s Unpacking powa-collector (1.2.0-3) ... 121s Selecting previously unselected package autopkgtest-satdep. 121s Preparing to unpack .../11-1-autopkgtest-satdep.deb ... 121s Unpacking autopkgtest-satdep (0) ... 121s Setting up postgresql-client-common (262) ... 121s Setting up libpq5:s390x (17.0-1) ... 121s Setting up ssl-cert (1.1.2ubuntu2) ... 122s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 122s Setting up python3-psycopg2 (2.9.9-2) ... 122s Setting up libjson-perl (4.10000-1) ... 122s Setting up libxslt1.1:s390x (1.1.39-0exp1ubuntu1) ... 122s Setting up postgresql-client-16 (16.4-3) ... 122s 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 122s Setting up powa-collector (1.2.0-3) ... 122s info: The home dir /nonexistent you specified can't be accessed: No such file or directory 122s 122s info: Selecting UID from range 100 to 999 ... 122s 122s info: Selecting GID from range 100 to 999 ... 122s info: Adding system user `powa' (UID 107) ... 122s info: Adding new group `powa' (GID 111) ... 122s info: Adding new user `powa' (UID 107) with group `powa' ... 122s info: Not creating `/nonexistent'. 122s Created symlink '/etc/systemd/system/multi-user.target.wants/powa-collector.service' → '/usr/lib/systemd/system/powa-collector.service'. 123s Setting up postgresql-common (262) ... 123s 123s Creating config file /etc/postgresql-common/createcluster.conf with new version 123s Building PostgreSQL dictionaries from installed myspell/hunspell packages... 123s Removing obsolete dictionary files: 123s Created symlink '/etc/systemd/system/multi-user.target.wants/postgresql.service' → '/usr/lib/systemd/system/postgresql.service'. 124s Setting up postgresql-16 (16.4-3) ... 124s Creating new PostgreSQL cluster 16/main ... 124s /usr/lib/postgresql/16/bin/initdb -D /var/lib/postgresql/16/main --auth-local peer --auth-host scram-sha-256 --no-instructions 124s The files belonging to this database system will be owned by user "postgres". 124s This user must also own the server process. 124s 124s The database cluster will be initialized with locale "C.UTF-8". 124s The default database encoding has accordingly been set to "UTF8". 124s The default text search configuration will be set to "english". 124s 124s Data page checksums are disabled. 124s 124s fixing permissions on existing directory /var/lib/postgresql/16/main ... ok 124s creating subdirectories ... ok 124s selecting dynamic shared memory implementation ... posix 124s selecting default max_connections ... 100 124s selecting default shared_buffers ... 128MB 124s selecting default time zone ... Etc/UTC 124s creating configuration files ... ok 124s running bootstrap script ... ok 124s performing post-bootstrap initialization ... ok 124s syncing data to disk ... ok 127s Setting up postgresql-16-powa (4.2.2-1) ... 127s Setting up autopkgtest-satdep (0) ... 127s Processing triggers for man-db (2.12.1-3) ... 128s Processing triggers for libc-bin (2.40-1ubuntu3) ... 130s (Reading database ... 57542 files and directories currently installed.) 130s Removing autopkgtest-satdep (0) ... 130s autopkgtest [10:31:42]: test collector: [----------------------- 130s + : figure out which PG version to use (we depend on 'postgresql-powa' which might have pulled in any version) 130s + version=16/extension/powa.control 130s + version=16 130s + pg_virtualenv -v 16 -o shared_preload_libraries=pg_stat_statements 130s Creating new PostgreSQL cluster 16/regress ... 133s + createdb powa 133s + export PGDATABASE=powa 133s + PGDATABASE=powa 133s + psql -Xc 'CREATE EXTENSION powa CASCADE' 133s NOTICE: installing required extension "pg_stat_statements" 133s NOTICE: installing required extension "btree_gist" 133s CREATE EXTENSION 133s + : register server 133s + psql -Xxc 'SELECT powa_register_server(hostname:='\''localhost'\'', port:='\''5433'\'', username:='\''ubuntu'\'', password:='\''0c5f8658af37317ffc8572eaafcc6cce'\'')' 133s -[ RECORD 1 ]--------+-- 133s powa_register_server | t 133s 133s + psql -Xxc 'SELECT * FROM powa_servers WHERE id <> 0' 133s -[ RECORD 1 ]-------+--------------------------------- 133s id | 1 133s hostname | localhost 133s alias | 133s port | 5433 133s username | ubuntu 133s password | 0c5f8658af37317ffc8572eaafcc6cce 133s dbname | powa 133s frequency | 300 133s powa_coalesce | 100 133s retention | 1 day 133s allow_ui_connection | t 133s version | 133s 133s + psql -Xxc 'SELECT * FROM powa_snapshot_metas WHERE srvid <> 0' 133s -[ RECORD 1 ]+---------- 133s srvid | 1 133s coalesce_seq | 1 133s snapts | -infinity 133s aggts | -infinity 133s purgets | -infinity 133s errors | 133s 133s + : start collector 133s + echo '{ "repository": { "dsn": "postgresql://ubuntu:0c5f8658af37317ffc8572eaafcc6cce@localhost:5433/powa" }, "debug": false }' 133s + sleep 10 133s + powa-collector 133s 2024-11-13 10:31:45,916 - INFO : Starting powa-collector... 133s 2024-11-13 10:31:45,928 localhost:5433 INFO : Starting worker 133s 2024-11-13 10:31:45,928 - INFO : List of workers: 133s 2024-11-13 10:31:45,928 - INFO : localhost:5433: {'host': 'localhost', 'port': 5433, 'user': 'ubuntu', 'password': '0c5f8658af37317ffc8572eaafcc6cce', 'dbname': 'powa'} (no connection to remote server) 143s + kill 4401 143s + : check if snapshot was taken 143s + psql -Xxc 'SELECT * FROM powa_servers WHERE id <> 0' 143s 2024-11-13 10:31:55,878 localhost:5433 INFO : Asked to stop... 143s 2024-11-13 10:31:55,878 localhost:5433 INFO : Disconnecting from remote server 143s 2024-11-13 10:31:55,881 localhost:5433 INFO : stopped 143s -[ RECORD 1 ]-------+--------------------------------- 143s id | 1 143s hostname | localhost 143s alias | 143s port | 5433 143s username | ubuntu 143s password | 0c5f8658af37317ffc8572eaafcc6cce 143s dbname | powa 143s frequency | 300 143s powa_coalesce | 100 143s retention | 1 day 143s allow_ui_connection | t 143s version | 16.4 (Ubuntu 16.4-3) 143s 143s + psql -Xxc 'SELECT * FROM powa_snapshot_metas WHERE srvid <> 0' 143s -[ RECORD 1 ]+------------------------------ 143s srvid | 1 143s coalesce_seq | 2 143s snapts | 2024-11-13 10:31:45.957354+00 143s aggts | -infinity 143s purgets | -infinity 143s errors | 143s 143s ++ psql -XAtc 'SELECT snapts > now() - '\''20s'\''::interval FROM powa_snapshot_metas WHERE srvid <> 0' 144s + '[' t = t ']' 144s Dropping cluster 16/regress ... 144s autopkgtest [10:31:56]: test collector: -----------------------] 144s autopkgtest [10:31:56]: test collector: - - - - - - - - - - results - - - - - - - - - - 144s collector PASS 145s autopkgtest [10:31:57]: @@@@@@@@@@@@@@@@@@@@ summary 145s collector PASS 157s nova [W] Using flock in prodstack6-s390x 157s flock: timeout while waiting to get lock 157s Creating nova instance adt-plucky-s390x-powa-collector-20241113-102932-juju-7f2275-prod-proposed-migration-environment-20-809c27b3-ce70-4370-8736-5d03762c1683 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...