0s autopkgtest [08:38:29]: starting date and time: 2024-07-23 08:38:29+0000 0s autopkgtest [08:38:29]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [08:38:29]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.nuopb6v7/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-3@bos03-arm64-22.secgroup --name adt-oracular-arm64-postfix-20240723-083828-juju-7f2275-prod-proposed-migration-environment-3-4aa4006f-c4e2-4009-ae6d-c710b9694549 --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/ 294s autopkgtest [08:43:23]: testbed dpkg architecture: arm64 294s autopkgtest [08:43:23]: testbed apt version: 2.9.6 294s autopkgtest [08:43:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 295s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 297s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [5704 B] 297s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 297s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [396 kB] 297s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [59.4 kB] 298s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [115 kB] 298s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 c-n-f Metadata [2116 B] 298s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [43.9 kB] 298s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 c-n-f Metadata [364 B] 298s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [461 kB] 298s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 c-n-f Metadata [8752 B] 298s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [8204 B] 298s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 c-n-f Metadata [276 B] 302s Fetched 1235 kB in 3s (490 kB/s) 302s Reading package lists... 310s Reading package lists... 311s Building dependency tree... 311s Reading state information... 312s Calculating upgrade... 313s The following packages will be upgraded: 313s gcc-14-base gdisk libgcc-s1 libpython3-stdlib libstdc++6 netcat-openbsd 313s python3 python3-gdbm python3-minimal systemd-hwe-hwdb 313s 10 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 313s Need to get 1235 kB of archives. 313s After this operation, 71.7 kB of additional disk space will be used. 313s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 python3-minimal arm64 3.12.4-1 [27.1 kB] 313s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 python3 arm64 3.12.4-1 [24.0 kB] 313s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libpython3-stdlib arm64 3.12.4-1 [9824 B] 313s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 gcc-14-base arm64 14.1.0-5ubuntu1 [49.9 kB] 313s Get:5 http://ftpmaster.internal/ubuntu oracular/main arm64 libstdc++6 arm64 14.1.0-5ubuntu1 [749 kB] 314s Get:6 http://ftpmaster.internal/ubuntu oracular/main arm64 libgcc-s1 arm64 14.1.0-5ubuntu1 [61.8 kB] 314s Get:7 http://ftpmaster.internal/ubuntu oracular/main arm64 netcat-openbsd arm64 1.226-1.1 [43.3 kB] 314s Get:8 http://ftpmaster.internal/ubuntu oracular/main arm64 systemd-hwe-hwdb all 256.2.1 [3210 B] 314s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 python3-gdbm arm64 3.12.4-2 [18.0 kB] 314s Get:10 http://ftpmaster.internal/ubuntu oracular/main arm64 gdisk arm64 1.0.10-2 [249 kB] 320s Fetched 1235 kB in 1s (1095 kB/s) 321s (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 ... 78393 files and directories currently installed.) 321s Preparing to unpack .../python3-minimal_3.12.4-1_arm64.deb ... 322s Unpacking python3-minimal (3.12.4-1) over (3.12.3-0ubuntu1) ... 323s Setting up python3-minimal (3.12.4-1) ... 325s (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 ... 78393 files and directories currently installed.) 325s Preparing to unpack .../python3_3.12.4-1_arm64.deb ... 326s Unpacking python3 (3.12.4-1) over (3.12.3-0ubuntu1) ... 327s Preparing to unpack .../libpython3-stdlib_3.12.4-1_arm64.deb ... 327s Unpacking libpython3-stdlib:arm64 (3.12.4-1) over (3.12.3-0ubuntu1) ... 328s Preparing to unpack .../gcc-14-base_14.1.0-5ubuntu1_arm64.deb ... 328s Unpacking gcc-14-base:arm64 (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 329s Setting up gcc-14-base:arm64 (14.1.0-5ubuntu1) ... 329s (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 ... 78393 files and directories currently installed.) 329s Preparing to unpack .../libstdc++6_14.1.0-5ubuntu1_arm64.deb ... 330s Unpacking libstdc++6:arm64 (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 331s Setting up libstdc++6:arm64 (14.1.0-5ubuntu1) ... 332s (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 ... 78393 files and directories currently installed.) 332s Preparing to unpack .../libgcc-s1_14.1.0-5ubuntu1_arm64.deb ... 332s Unpacking libgcc-s1:arm64 (14.1.0-5ubuntu1) over (14.1.0-4ubuntu2) ... 333s Setting up libgcc-s1:arm64 (14.1.0-5ubuntu1) ... 335s (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 ... 78393 files and directories currently installed.) 335s Preparing to unpack .../netcat-openbsd_1.226-1.1_arm64.deb ... 335s Unpacking netcat-openbsd (1.226-1.1) over (1.226-1ubuntu2) ... 337s Preparing to unpack .../systemd-hwe-hwdb_256.2.1_all.deb ... 337s Unpacking systemd-hwe-hwdb (256.2.1) over (255.1.3) ... 338s Preparing to unpack .../python3-gdbm_3.12.4-2_arm64.deb ... 338s Unpacking python3-gdbm:arm64 (3.12.4-2) over (3.12.3-0ubuntu1) ... 339s Preparing to unpack .../gdisk_1.0.10-2_arm64.deb ... 339s Unpacking gdisk (1.0.10-2) over (1.0.10-1build1) ... 339s Setting up netcat-openbsd (1.226-1.1) ... 340s Setting up gdisk (1.0.10-2) ... 340s Setting up systemd-hwe-hwdb (256.2.1) ... 340s Setting up libpython3-stdlib:arm64 (3.12.4-1) ... 340s Setting up python3 (3.12.4-1) ... 343s Setting up python3-gdbm:arm64 (3.12.4-2) ... 343s Processing triggers for man-db (2.12.1-2) ... 345s Processing triggers for udev (256-1ubuntu1) ... 345s Processing triggers for libc-bin (2.39-0ubuntu9) ... 347s Reading package lists... 347s Building dependency tree... 347s Reading state information... 348s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 354s Hit:1 http://ftpmaster.internal/ubuntu oracular InRelease 354s Hit:2 http://ftpmaster.internal/ubuntu oracular-updates InRelease 354s Hit:3 http://ftpmaster.internal/ubuntu oracular-security InRelease 354s Hit:4 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 362s Reading package lists... 362s Reading package lists... 362s Building dependency tree... 362s Reading state information... 363s Calculating upgrade... 363s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 363s Reading package lists... 364s Building dependency tree... 364s Reading state information... 364s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 371s autopkgtest [08:44:40]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 371s autopkgtest [08:44:40]: @@@@@@@@@@@@@@@@@@@@ apt-source postfix 395s Get:1 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (dsc) [3101 B] 395s Get:2 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (tar) [4953 kB] 395s Get:3 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (asc) [220 B] 395s Get:4 http://ftpmaster.internal/ubuntu oracular/main postfix 3.9.0-2 (diff) [199 kB] 396s gpgv: Signature made Tue Apr 2 13:18:11 2024 UTC 396s gpgv: using RSA key E7729BFFBE85400FEEEE23B178D7DEFB9AD59AF1 396s gpgv: Can't check signature: No public key 396s dpkg-source: warning: cannot verify inline signature for ./postfix_3.9.0-2.dsc: no acceptable signature found 398s autopkgtest [08:45:07]: testing package postfix version 3.9.0-2 399s autopkgtest [08:45:08]: build not needed 400s autopkgtest [08:45:09]: test postfix: preparing testbed 402s Reading package lists... 403s Building dependency tree... 403s Reading state information... 403s Starting pkgProblemResolver with broken count: 0 403s Starting 2 pkgProblemResolver with broken count: 0 403s Done 404s The following additional packages will be installed: 404s db-util db5.3-util procmail python3-pexpect python3-ptyprocess sasl2-bin 404s Suggested packages: 404s python-pexpect-doc 404s Recommended packages: 404s default-mta | mail-transport-agent | fetchmail 404s The following NEW packages will be installed: 404s autopkgtest-satdep db-util db5.3-util procmail python3-pexpect 404s python3-ptyprocess sasl2-bin 404s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 404s Need to get 379 kB/379 kB of archives. 404s After this operation, 2475 kB of additional disk space will be used. 404s Get:1 /tmp/autopkgtest.tsVaNL/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [748 B] 404s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 db5.3-util arm64 5.3.28+dfsg2-7 [71.5 kB] 405s Get:3 http://ftpmaster.internal/ubuntu oracular/main arm64 db-util all 1:5.3.21ubuntu2 [2412 B] 405s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 sasl2-bin arm64 2.1.28+dfsg1-5ubuntu3 [95.0 kB] 405s Get:5 http://ftpmaster.internal/ubuntu oracular/main arm64 procmail arm64 3.24-1ubuntu2 [147 kB] 405s Get:6 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-ptyprocess all 0.7.0-5 [15.1 kB] 405s Get:7 http://ftpmaster.internal/ubuntu oracular/main arm64 python3-pexpect all 4.9-2 [48.1 kB] 407s Preconfiguring packages ... 408s Fetched 379 kB in 1s (454 kB/s) 408s Selecting previously unselected package db5.3-util. 409s (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 ... 78396 files and directories currently installed.) 409s Preparing to unpack .../0-db5.3-util_5.3.28+dfsg2-7_arm64.deb ... 409s Unpacking db5.3-util (5.3.28+dfsg2-7) ... 409s Selecting previously unselected package db-util. 410s Preparing to unpack .../1-db-util_1%3a5.3.21ubuntu2_all.deb ... 410s Unpacking db-util (1:5.3.21ubuntu2) ... 410s Selecting previously unselected package sasl2-bin. 410s Preparing to unpack .../2-sasl2-bin_2.1.28+dfsg1-5ubuntu3_arm64.deb ... 410s Unpacking sasl2-bin (2.1.28+dfsg1-5ubuntu3) ... 410s Selecting previously unselected package procmail. 411s Preparing to unpack .../3-procmail_3.24-1ubuntu2_arm64.deb ... 411s Unpacking procmail (3.24-1ubuntu2) ... 411s Selecting previously unselected package python3-ptyprocess. 412s Preparing to unpack .../4-python3-ptyprocess_0.7.0-5_all.deb ... 412s Unpacking python3-ptyprocess (0.7.0-5) ... 412s Selecting previously unselected package python3-pexpect. 412s Preparing to unpack .../5-python3-pexpect_4.9-2_all.deb ... 412s Unpacking python3-pexpect (4.9-2) ... 412s Selecting previously unselected package autopkgtest-satdep. 413s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 413s Unpacking autopkgtest-satdep (0) ... 413s Setting up db5.3-util (5.3.28+dfsg2-7) ... 413s Setting up procmail (3.24-1ubuntu2) ... 413s Setting up python3-ptyprocess (0.7.0-5) ... 414s Setting up db-util (1:5.3.21ubuntu2) ... 414s Setting up sasl2-bin (2.1.28+dfsg1-5ubuntu3) ... 418s saslauthd.service is a disabled or a static unit, not starting it. 418s Setting up python3-pexpect (4.9-2) ... 419s Setting up autopkgtest-satdep (0) ... 419s Processing triggers for man-db (2.12.1-2) ... 424s (Reading database ... 78550 files and directories currently installed.) 424s Removing autopkgtest-satdep (0) ... 424s autopkgtest [08:45:33]: test postfix: [----------------------- 426s Reading package lists... 426s Building dependency tree... 426s Reading state information... 426s The following additional packages will be installed: 426s ssl-cert 427s Suggested packages: 427s mail-reader postfix-cdb postfix-doc postfix-ldap postfix-lmdb 427s postfix-mta-sts-resolver postfix-mongodb postfix-mysql postfix-pcre 427s postfix-pgsql postfix-sqlite 427s The following NEW packages will be installed: 427s postfix ssl-cert 427s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 427s Need to get 1278 kB of archives. 427s After this operation, 6204 kB of additional disk space will be used. 427s Get:1 http://ftpmaster.internal/ubuntu oracular/main arm64 ssl-cert all 1.1.2ubuntu2 [18.0 kB] 427s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 postfix arm64 3.9.0-2 [1260 kB] 429s Preconfiguring packages ... 430s Fetched 1278 kB in 1s (2061 kB/s) 430s Selecting previously unselected package ssl-cert. 430s (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 ... 78552 files and directories currently installed.) 430s Preparing to unpack .../ssl-cert_1.1.2ubuntu2_all.deb ... 430s Unpacking ssl-cert (1.1.2ubuntu2) ... 430s Selecting previously unselected package postfix. 430s Preparing to unpack .../postfix_3.9.0-2_arm64.deb ... 431s Unpacking postfix (3.9.0-2) ... 431s Setting up ssl-cert (1.1.2ubuntu2) ... 432s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 435s Setting up postfix (3.9.0-2) ... 435s info: Selecting GID from range 100 to 999 ... 435s info: Adding group `postfix' (GID 115) ... 435s info: Selecting UID from range 100 to 999 ... 435s 435s info: Adding system user `postfix' (UID 107) ... 435s info: Adding new user `postfix' (UID 107) with group `postfix' ... 435s info: Not creating home directory `/var/spool/postfix'. 435s Creating /etc/postfix/dynamicmaps.cf 436s info: Selecting GID from range 100 to 999 ... 436s info: Adding group `postdrop' (GID 116) ... 436s setting myhostname: localhost 436s setting alias maps 436s setting alias database 436s mailname is not a fully qualified domain name. Not changing /etc/mailname. 436s setting destinations: $myhostname, localhost, localhost.localdomain, localhost 436s setting relayhost: 436s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 436s setting mailbox_command 436s setting mailbox_size_limit: 0 436s setting recipient_delimiter: + 438s setting inet_interfaces: all 440s setting inet_protocols: all 440s /etc/aliases does not exist, creating it. 440s WARNING: /etc/aliases exists, but does not have a root alias. 440s 440s Postfix (main.cf) is now set up with a default configuration. If you need to 440s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 440s Postfix configuration values, see postconf(1). 440s 440s After modifying main.cf, be sure to run 'systemctl reload postfix'. 440s 442s Running newaliases 443s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 452s Processing triggers for ufw (0.36.2-6) ... 452s Processing triggers for man-db (2.12.1-2) ... 454s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 462s /tmp/autopkgtest.tsVaNL/build.7My/src/debian/tests/testlib.py:103: SyntaxWarning: invalid escape sequence '\s' 462s if re.search("^\s*%s\s*=" % (field), line): 462s /tmp/autopkgtest.tsVaNL/build.7My/src/debian/tests/testlib.py:122: SyntaxWarning: invalid escape sequence '\s' 462s if re.search("^\s*%s\s*=" % (field), line): 462s /tmp/autopkgtest.tsVaNL/build.7My/src/debian/tests/testlib.py:281: SyntaxWarning: invalid escape sequence '\(' 462s re.match('^\(' + exe + '\)', tmp[0]): 462s /tmp/autopkgtest.tsVaNL/build.7My/src/debian/tests/testlib.py:281: SyntaxWarning: invalid escape sequence '\)' 462s re.match('^\(' + exe + '\)', tmp[0]): 462s /tmp/autopkgtest.tsVaNL/build.7My/src/debian/tests/testlib.py:597: SyntaxWarning: invalid escape sequence '\(' 462s if re.search('%s \(' % path, line): 590s ............... 590s ---------------------------------------------------------------------- 590s Ran 15 tests in 119.339s 590s 590s OK 601s autopkgtest [08:48:30]: test postfix: -----------------------] 602s autopkgtest [08:48:31]: test postfix: - - - - - - - - - - results - - - - - - - - - - 602s postfix PASS 604s autopkgtest [08:48:33]: @@@@@@@@@@@@@@@@@@@@ summary 604s postfix PASS 703s nova [W] Skipping flock in bos03-arm64 703s Creating nova instance adt-oracular-arm64-postfix-20240723-083828-juju-7f2275-prod-proposed-migration-environment-3-4aa4006f-c4e2-4009-ae6d-c710b9694549 from image adt/ubuntu-oracular-arm64-server-20240721.img (UUID 82bde252-f2f6-4a5f-8912-308e3b0a85c9)...