0s autopkgtest [03:02:42]: starting date and time: 2024-07-21 03:02:42+0000 0s autopkgtest [03:02:42]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [03:02:42]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ltn7vypa/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 postfix --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.4-1 python3-stdlib-extensions/3.12.4-2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos01-s390x-15.secgroup --name adt-oracular-s390x-postfix-20240721-030241-juju-7f2275-prod-proposed-migration-environment-2-7746677f-4a98-4bd8-91a1-b0cc8e7ba6f2 --image adt/ubuntu-oracular-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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://us.ports.ubuntu.com/ubuntu-ports/ 94s autopkgtest [03:04:16]: testbed dpkg architecture: s390x 94s autopkgtest [03:04:16]: testbed apt version: 2.9.6 94s autopkgtest [03:04:16]: @@@@@@@@@@@@@@@@@@@@ test bed setup 95s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 96s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [62.2 kB] 96s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 96s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [4724 B] 96s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [408 kB] 96s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [101 kB] 96s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x c-n-f Metadata [2112 B] 96s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1368 B] 96s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x c-n-f Metadata [120 B] 96s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [463 kB] 96s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x c-n-f Metadata [8372 B] 96s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [2744 B] 96s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x c-n-f Metadata [120 B] 97s Fetched 1188 kB in 1s (934 kB/s) 97s Reading package lists... 99s Reading package lists... 99s Building dependency tree... 99s Reading state information... 100s Calculating upgrade... 100s The following packages will be upgraded: 100s libbpf1 libpython3-stdlib python3 python3-gdbm python3-minimal 100s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 100s Need to get 259 kB of archives. 100s After this operation, 26.6 kB of additional disk space will be used. 100s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-minimal s390x 3.12.4-1 [27.1 kB] 100s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3 s390x 3.12.4-1 [24.0 kB] 100s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x libpython3-stdlib s390x 3.12.4-1 [9826 B] 100s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x libbpf1 s390x 1:1.4.5-1 [180 kB] 100s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-gdbm s390x 3.12.4-2 [18.5 kB] 101s Fetched 259 kB in 0s (532 kB/s) 101s (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 ... 54753 files and directories currently installed.) 101s Preparing to unpack .../python3-minimal_3.12.4-1_s390x.deb ... 101s Unpacking python3-minimal (3.12.4-1) over (3.12.3-0ubuntu1) ... 101s Setting up python3-minimal (3.12.4-1) ... 101s (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 ... 54753 files and directories currently installed.) 101s Preparing to unpack .../python3_3.12.4-1_s390x.deb ... 101s Unpacking python3 (3.12.4-1) over (3.12.3-0ubuntu1) ... 101s Preparing to unpack .../libpython3-stdlib_3.12.4-1_s390x.deb ... 101s Unpacking libpython3-stdlib:s390x (3.12.4-1) over (3.12.3-0ubuntu1) ... 101s Preparing to unpack .../libbpf1_1%3a1.4.5-1_s390x.deb ... 101s Unpacking libbpf1:s390x (1:1.4.5-1) over (1:1.4.3-1) ... 101s Preparing to unpack .../python3-gdbm_3.12.4-2_s390x.deb ... 101s Unpacking python3-gdbm:s390x (3.12.4-2) over (3.12.3-0ubuntu1) ... 101s Setting up libbpf1:s390x (1:1.4.5-1) ... 101s Setting up libpython3-stdlib:s390x (3.12.4-1) ... 101s Setting up python3 (3.12.4-1) ... 101s Setting up python3-gdbm:s390x (3.12.4-2) ... 101s Processing triggers for man-db (2.12.1-2) ... 102s Processing triggers for libc-bin (2.39-0ubuntu9) ... 102s Reading package lists... 102s Building dependency tree... 102s Reading state information... 103s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 103s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 103s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 103s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 103s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 104s Reading package lists... 104s Reading package lists... 105s Building dependency tree... 105s Reading state information... 105s Calculating upgrade... 105s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 105s Reading package lists... 105s Building dependency tree... 105s Reading state information... 106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s autopkgtest [03:04:31]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:14:26 UTC 2024 109s autopkgtest [03:04:31]: @@@@@@@@@@@@@@@@@@@@ apt-source postfix 117s Get:1 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (dsc) [3101 B] 117s Get:2 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (tar) [4953 kB] 117s Get:3 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (asc) [220 B] 117s Get:4 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (diff) [199 kB] 117s gpgv: Signature made Tue Apr 2 13:18:11 2024 UTC 117s gpgv: using RSA key E7729BFFBE85400FEEEE23B178D7DEFB9AD59AF1 117s gpgv: Can't check signature: No public key 117s dpkg-source: warning: cannot verify inline signature for ./postfix_3.9.0-2.dsc: no acceptable signature found 118s autopkgtest [03:04:40]: testing package postfix version 3.9.0-2 119s autopkgtest [03:04:41]: build not needed 120s autopkgtest [03:04:42]: test postfix: preparing testbed 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Starting pkgProblemResolver with broken count: 0 122s Starting 2 pkgProblemResolver with broken count: 0 122s Done 122s The following additional packages will be installed: 122s db-util db5.3-util procmail python3-pexpect python3-ptyprocess sasl2-bin 122s Suggested packages: 122s python-pexpect-doc 122s Recommended packages: 122s default-mta | mail-transport-agent | fetchmail 122s The following NEW packages will be installed: 122s autopkgtest-satdep db-util db5.3-util procmail python3-pexpect 122s python3-ptyprocess sasl2-bin 122s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 122s Need to get 397 kB/398 kB of archives. 122s After this operation, 1267 kB of additional disk space will be used. 122s Get:1 /tmp/autopkgtest.QyAXHN/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [752 B] 122s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x db5.3-util s390x 5.3.28+dfsg2-7 [75.6 kB] 123s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x db-util all 1:5.3.21ubuntu2 [2412 B] 123s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x sasl2-bin s390x 2.1.28+dfsg1-5ubuntu3 [97.9 kB] 123s Get:5 http://ftpmaster.internal/ubuntu oracular/main s390x procmail s390x 3.24-1ubuntu2 [158 kB] 123s Get:6 http://ftpmaster.internal/ubuntu oracular/main s390x python3-ptyprocess all 0.7.0-5 [15.1 kB] 123s Get:7 http://ftpmaster.internal/ubuntu oracular/main s390x python3-pexpect all 4.9-2 [48.1 kB] 123s Preconfiguring packages ... 123s Fetched 397 kB in 1s (794 kB/s) 123s Selecting previously unselected package db5.3-util. 123s (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 ... 54756 files and directories currently installed.) 123s Preparing to unpack .../0-db5.3-util_5.3.28+dfsg2-7_s390x.deb ... 123s Unpacking db5.3-util (5.3.28+dfsg2-7) ... 123s Selecting previously unselected package db-util. 123s Preparing to unpack .../1-db-util_1%3a5.3.21ubuntu2_all.deb ... 123s Unpacking db-util (1:5.3.21ubuntu2) ... 123s Selecting previously unselected package sasl2-bin. 123s Preparing to unpack .../2-sasl2-bin_2.1.28+dfsg1-5ubuntu3_s390x.deb ... 123s Unpacking sasl2-bin (2.1.28+dfsg1-5ubuntu3) ... 123s Selecting previously unselected package procmail. 123s Preparing to unpack .../3-procmail_3.24-1ubuntu2_s390x.deb ... 123s Unpacking procmail (3.24-1ubuntu2) ... 123s Selecting previously unselected package python3-ptyprocess. 123s Preparing to unpack .../4-python3-ptyprocess_0.7.0-5_all.deb ... 123s Unpacking python3-ptyprocess (0.7.0-5) ... 123s Selecting previously unselected package python3-pexpect. 123s Preparing to unpack .../5-python3-pexpect_4.9-2_all.deb ... 123s Unpacking python3-pexpect (4.9-2) ... 123s Selecting previously unselected package autopkgtest-satdep. 123s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 123s Unpacking autopkgtest-satdep (0) ... 123s Setting up db5.3-util (5.3.28+dfsg2-7) ... 123s Setting up procmail (3.24-1ubuntu2) ... 123s Setting up python3-ptyprocess (0.7.0-5) ... 124s Setting up db-util (1:5.3.21ubuntu2) ... 124s Setting up sasl2-bin (2.1.28+dfsg1-5ubuntu3) ... 124s saslauthd.service is a disabled or a static unit, not starting it. 124s Setting up python3-pexpect (4.9-2) ... 125s Setting up autopkgtest-satdep (0) ... 125s Processing triggers for man-db (2.12.1-2) ... 127s (Reading database ... 54910 files and directories currently installed.) 127s Removing autopkgtest-satdep (0) ... 128s autopkgtest [03:04:50]: test postfix: [----------------------- 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 129s The following additional packages will be installed: 129s libnsl2 ssl-cert 129s Suggested packages: 129s mail-reader postfix-cdb postfix-doc postfix-ldap postfix-lmdb 129s postfix-mta-sts-resolver postfix-mongodb postfix-mysql postfix-pcre 129s postfix-pgsql postfix-sqlite 129s The following NEW packages will be installed: 129s libnsl2 postfix ssl-cert 129s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 129s Need to get 1345 kB of archives. 129s After this operation, 4330 kB of additional disk space will be used. 129s Get:1 http://ftpmaster.internal/ubuntu oracular/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB] 129s Get:2 http://ftpmaster.internal/ubuntu oracular/main s390x libnsl2 s390x 1.3.0-3build3 [44.1 kB] 129s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x postfix s390x 3.9.0-2 [1283 kB] 130s Preconfiguring packages ... 130s Fetched 1345 kB in 1s (1497 kB/s) 130s Selecting previously unselected package ssl-cert. 130s (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 ... 54912 files and directories currently installed.) 130s Preparing to unpack .../ssl-cert_1.1.2ubuntu2_all.deb ... 130s Unpacking ssl-cert (1.1.2ubuntu2) ... 130s Selecting previously unselected package libnsl2:s390x. 130s Preparing to unpack .../libnsl2_1.3.0-3build3_s390x.deb ... 130s Unpacking libnsl2:s390x (1.3.0-3build3) ... 130s Selecting previously unselected package postfix. 130s Preparing to unpack .../postfix_3.9.0-2_s390x.deb ... 130s Unpacking postfix (3.9.0-2) ... 131s Setting up ssl-cert (1.1.2ubuntu2) ... 131s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 132s Setting up libnsl2:s390x (1.3.0-3build3) ... 132s Setting up postfix (3.9.0-2) ... 133s info: Selecting GID from range 100 to 999 ... 133s info: Adding group `postfix' (GID 113) ... 133s info: Selecting UID from range 100 to 999 ... 133s 133s info: Adding system user `postfix' (UID 107) ... 133s info: Adding new user `postfix' (UID 107) with group `postfix' ... 133s info: Not creating home directory `/var/spool/postfix'. 133s Creating /etc/postfix/dynamicmaps.cf 133s info: Selecting GID from range 100 to 999 ... 133s info: Adding group `postdrop' (GID 114) ... 133s setting myhostname: localhost 133s setting alias maps 133s setting alias database 133s mailname is not a fully qualified domain name. Not changing /etc/mailname. 133s setting destinations: $myhostname, localhost, localhost.localdomain, localhost 133s setting relayhost: 133s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 133s setting mailbox_command 133s setting mailbox_size_limit: 0 133s setting recipient_delimiter: + 135s setting inet_interfaces: all 137s setting inet_protocols: all 137s /etc/aliases does not exist, creating it. 137s WARNING: /etc/aliases exists, but does not have a root alias. 137s 137s Postfix (main.cf) is now set up with a default configuration. If you need to 137s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 137s Postfix configuration values, see postconf(1). 137s 137s After modifying main.cf, be sure to run 'systemctl reload postfix'. 137s 139s Running newaliases 140s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 141s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 141s Processing triggers for ufw (0.36.2-6) ... 141s Processing triggers for man-db (2.12.1-2) ... 142s Processing triggers for libc-bin (2.39-0ubuntu9) ... 144s /tmp/autopkgtest.QyAXHN/build.I5d/src/debian/tests/testlib.py:103: SyntaxWarning: invalid escape sequence '\s' 144s if re.search("^\s*%s\s*=" % (field), line): 144s /tmp/autopkgtest.QyAXHN/build.I5d/src/debian/tests/testlib.py:122: SyntaxWarning: invalid escape sequence '\s' 144s if re.search("^\s*%s\s*=" % (field), line): 144s /tmp/autopkgtest.QyAXHN/build.I5d/src/debian/tests/testlib.py:281: SyntaxWarning: invalid escape sequence '\(' 144s re.match('^\(' + exe + '\)', tmp[0]): 144s /tmp/autopkgtest.QyAXHN/build.I5d/src/debian/tests/testlib.py:281: SyntaxWarning: invalid escape sequence '\)' 144s re.match('^\(' + exe + '\)', tmp[0]): 144s /tmp/autopkgtest.QyAXHN/build.I5d/src/debian/tests/testlib.py:597: SyntaxWarning: invalid escape sequence '\(' 144s if re.search('%s \(' % path, line): 218s ............... 218s ---------------------------------------------------------------------- 218s Ran 15 tests in 72.033s 218s 218s OK 219s autopkgtest [03:06:21]: test postfix: -----------------------] 220s autopkgtest [03:06:22]: test postfix: - - - - - - - - - - results - - - - - - - - - - 220s postfix PASS 220s autopkgtest [03:06:22]: @@@@@@@@@@@@@@@@@@@@ summary 220s postfix PASS 234s nova [W] Using flock in scalingstack-bos01-s390x 234s Creating nova instance adt-oracular-s390x-postfix-20240721-030241-juju-7f2275-prod-proposed-migration-environment-2-7746677f-4a98-4bd8-91a1-b0cc8e7ba6f2 from image adt/ubuntu-oracular-s390x-server-20240720.img (UUID c4813fc9-ab2b-41de-947e-4df7311c6440)...