0s autopkgtest [14:26:37]: starting date and time: 2025-03-15 14:26:37+0000 0s autopkgtest [14:26:37]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [14:26:37]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.uv1yoasj/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade postfix --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-21.secgroup --name adt-plucky-arm64-postfix-20250315-142637-juju-7f2275-prod-proposed-migration-environment-15-4bd4ac00-89f7-4797-98ab-17ea4df4f194 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 149s autopkgtest [14:29:06]: testbed dpkg architecture: arm64 149s autopkgtest [14:29:06]: testbed apt version: 2.9.33 150s autopkgtest [14:29:07]: @@@@@@@@@@@@@@@@@@@@ test bed setup 150s autopkgtest [14:29:07]: testbed release detected to be: None 151s autopkgtest [14:29:08]: updating testbed package index (apt update) 151s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 151s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 151s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 152s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 152s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 152s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [404 kB] 152s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [101 kB] 152s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [78.2 kB] 152s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1976 B] 152s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 152s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [346 kB] 152s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [15.8 kB] 152s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B] 152s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [572 B] 153s Fetched 1094 kB in 1s (731 kB/s) 153s Reading package lists... 154s + lsb_release --codename --short 154s + RELEASE=plucky 154s + cat 154s + [ plucky != trusty ] 154s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 155s Calculating upgrade... 155s Calculating upgrade... 155s The following packages will be upgraded: 155s python3-jinja2 strace 156s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 156s Need to get 608 kB of archives. 156s After this operation, 11.3 kB of additional disk space will be used. 156s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 156s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 157s Fetched 608 kB in 1s (630 kB/s) 157s (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 ... 117701 files and directories currently installed.) 157s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 157s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 157s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 157s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 157s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 158s Setting up strace (6.13+ds-1ubuntu1) ... 158s Processing triggers for man-db (2.13.0-1) ... 158s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 158s + /usr/lib/apt/apt-helper analyze-pattern ?true 158s + uname -r 158s + sed s/\./\\./g 158s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 158s + apt list ?obsolete 158s + tail -n+2 158s + + grep -v ^linux-.*6\.14\.0-10-generic.* 158s cut -d/ -f1 159s + obsolete_pkgs=linux-headers-6.11.0-8-generic 159s linux-headers-6.11.0-8 159s linux-image-6.11.0-8-generic 159s linux-modules-6.11.0-8-generic 159s linux-tools-6.11.0-8-generic 159s linux-tools-6.11.0-8 159s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-generic linux-headers-6.11.0-8 linux-image-6.11.0-8-generic linux-modules-6.11.0-8-generic linux-tools-6.11.0-8-generic linux-tools-6.11.0-8 159s Reading package lists... 159s Building dependency tree... 159s Reading state information... 159s Solving dependencies... 160s The following packages will be REMOVED: 160s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 160s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 160s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 160s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 160s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded. 160s After this operation, 267 MB disk space will be freed. 160s (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 ... 117701 files and directories currently installed.) 160s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 160s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 160s Removing libpython3.12t64:arm64 (3.12.9-1) ... 160s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 161s Removing libnsl2:arm64 (1.3.0-3build3) ... 161s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 161s Removing libunwind8:arm64 (1.6.2-3.1) ... 161s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 161s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 163s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 163s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 163s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 163s /etc/kernel/postrm.d/initramfs-tools: 163s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 163s /etc/kernel/postrm.d/zz-flash-kernel: 163s flash-kernel: Kernel 6.11.0-8-generic has been removed. 163s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 163s /etc/kernel/postrm.d/zz-update-grub: 163s Sourcing file `/etc/default/grub' 163s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 163s Generating grub configuration file ... 163s Found linux image: /boot/vmlinuz-6.14.0-10-generic 163s Found initrd image: /boot/initrd.img-6.14.0-10-generic 164s Warning: os-prober will not be executed to detect other bootable partitions. 164s Systems on them will not be added to the GRUB boot configuration. 164s Check GRUB_DISABLE_OS_PROBER documentation entry. 164s Adding boot menu entry for UEFI Firmware Settings ... 164s done 164s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 164s Processing triggers for libc-bin (2.41-1ubuntu1) ... 164s (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 ... 81650 files and directories currently installed.) 164s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 164s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 164s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 164s + grep -q trusty /etc/lsb-release 164s + [ ! -d /usr/share/doc/unattended-upgrades ] 164s + [ ! -d /usr/share/doc/lxd ] 164s + [ ! -d /usr/share/doc/lxd-client ] 164s + [ ! -d /usr/share/doc/snapd ] 164s + type iptables 164s + cat 164s + chmod 755 /etc/rc.local 164s + . /etc/rc.local 164s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 164s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 164s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 164s + uname -m 164s + [ aarch64 = ppc64le ] 164s + [ -d /run/systemd/system ] 164s + systemd-detect-virt --quiet --vm 164s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 164s + cat 164s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 164s + echo COMPRESS=lz4 164s autopkgtest [14:29:21]: upgrading testbed (apt dist-upgrade and autopurge) 165s Reading package lists... 165s Building dependency tree... 165s Reading state information... 165s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 166s Starting 2 pkgProblemResolver with broken count: 0 166s Done 166s Entering ResolveByKeep 167s 167s Calculating upgrade... 167s The following packages will be upgraded: 167s libc-bin libc-dev-bin libc6 libc6-dev locales 167s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 167s Need to get 9530 kB of archives. 167s After this operation, 0 B of additional disk space will be used. 167s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB] 169s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB] 169s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB] 171s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB] 172s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB] 176s Preconfiguring packages ... 176s Fetched 9530 kB in 8s (1131 kB/s) 176s (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 ... 81647 files and directories currently installed.) 176s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ... 176s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 176s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ... 176s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 176s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ... 177s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 177s Setting up libc6:arm64 (2.41-1ubuntu2) ... 177s (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 ... 81647 files and directories currently installed.) 177s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ... 177s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 177s Setting up libc-bin (2.41-1ubuntu2) ... 177s (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 ... 81647 files and directories currently installed.) 177s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 177s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 177s Setting up locales (2.41-1ubuntu2) ... 178s Generating locales (this might take a while)... 180s en_US.UTF-8... done 180s Generation complete. 180s Setting up libc-dev-bin (2.41-1ubuntu2) ... 180s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ... 180s Processing triggers for man-db (2.13.0-1) ... 181s Processing triggers for systemd (257.3-1ubuntu3) ... 182s Reading package lists... 182s Building dependency tree... 182s Reading state information... 183s Starting pkgProblemResolver with broken count: 0 183s Starting 2 pkgProblemResolver with broken count: 0 183s Done 183s Solving dependencies... 184s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 184s autopkgtest [14:29:41]: rebooting testbed after setup commands that affected boot 208s autopkgtest [14:30:05]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 210s autopkgtest [14:30:07]: @@@@@@@@@@@@@@@@@@@@ apt-source postfix 222s Get:1 http://ftpmaster.internal/ubuntu plucky/main postfix 3.9.1-10ubuntu1 (dsc) [3002 B] 222s Get:2 http://ftpmaster.internal/ubuntu plucky/main postfix 3.9.1-10ubuntu1 (tar) [4954 kB] 222s Get:3 http://ftpmaster.internal/ubuntu plucky/main postfix 3.9.1-10ubuntu1 (diff) [202 kB] 222s gpgv: Signature made Fri Jan 31 12:46:11 2025 UTC 222s gpgv: using RSA key 8AFD08D3D1B817B2DF8982F501AC4B4083590A98 222s gpgv: Can't check signature: No public key 222s dpkg-source: warning: cannot verify inline signature for ./postfix_3.9.1-10ubuntu1.dsc: no acceptable signature found 223s autopkgtest [14:30:20]: testing package postfix version 3.9.1-10ubuntu1 224s autopkgtest [14:30:21]: build not needed 226s autopkgtest [14:30:23]: test postfix: preparing testbed 226s Reading package lists... 226s Building dependency tree... 226s Reading state information... 227s Starting pkgProblemResolver with broken count: 0 227s Starting 2 pkgProblemResolver with broken count: 0 227s Done 227s The following NEW packages will be installed: 227s db-util db5.3-util procmail python3-pexpect python3-ptyprocess sasl2-bin 227s ssl-cert 228s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 228s Need to get 399 kB of archives. 228s After this operation, 2544 kB of additional disk space will be used. 228s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 db5.3-util arm64 5.3.28+dfsg2-9 [72.1 kB] 228s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 db-util all 1:5.3.21ubuntu2 [2412 B] 228s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 sasl2-bin arm64 2.1.28+dfsg1-9 [95.2 kB] 228s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 procmail arm64 3.24-1ubuntu3 [147 kB] 228s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-ptyprocess all 0.7.0-6 [14.8 kB] 228s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-pexpect all 4.9-3 [48.1 kB] 228s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 ssl-cert all 1.1.3ubuntu1 [18.7 kB] 228s Preconfiguring packages ... 228s Fetched 399 kB in 1s (572 kB/s) 229s Selecting previously unselected package db5.3-util. 229s (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 ... 81647 files and directories currently installed.) 229s Preparing to unpack .../0-db5.3-util_5.3.28+dfsg2-9_arm64.deb ... 229s Unpacking db5.3-util (5.3.28+dfsg2-9) ... 229s Selecting previously unselected package db-util. 229s Preparing to unpack .../1-db-util_1%3a5.3.21ubuntu2_all.deb ... 229s Unpacking db-util (1:5.3.21ubuntu2) ... 229s Selecting previously unselected package sasl2-bin. 229s Preparing to unpack .../2-sasl2-bin_2.1.28+dfsg1-9_arm64.deb ... 229s Unpacking sasl2-bin (2.1.28+dfsg1-9) ... 229s Selecting previously unselected package procmail. 229s Preparing to unpack .../3-procmail_3.24-1ubuntu3_arm64.deb ... 229s Unpacking procmail (3.24-1ubuntu3) ... 229s Selecting previously unselected package python3-ptyprocess. 229s Preparing to unpack .../4-python3-ptyprocess_0.7.0-6_all.deb ... 229s Unpacking python3-ptyprocess (0.7.0-6) ... 229s Selecting previously unselected package python3-pexpect. 229s Preparing to unpack .../5-python3-pexpect_4.9-3_all.deb ... 229s Unpacking python3-pexpect (4.9-3) ... 229s Selecting previously unselected package ssl-cert. 229s Preparing to unpack .../6-ssl-cert_1.1.3ubuntu1_all.deb ... 229s Unpacking ssl-cert (1.1.3ubuntu1) ... 229s Setting up ssl-cert (1.1.3ubuntu1) ... 230s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 230s Setting up db5.3-util (5.3.28+dfsg2-9) ... 230s Setting up procmail (3.24-1ubuntu3) ... 230s Setting up python3-ptyprocess (0.7.0-6) ... 230s Setting up db-util (1:5.3.21ubuntu2) ... 230s Setting up sasl2-bin (2.1.28+dfsg1-9) ... 231s saslauthd.service is a disabled or a static unit, not starting it. 231s Setting up python3-pexpect (4.9-3) ... 231s Processing triggers for man-db (2.13.0-1) ... 233s autopkgtest [14:30:30]: test postfix: [----------------------- 234s Reading package lists... 234s Building dependency tree... 234s Reading state information... 234s Solving dependencies... 235s The following additional packages will be installed: 235s libnsl2 235s Suggested packages: 235s mail-reader postfix-cdb postfix-doc postfix-ldap postfix-lmdb 235s postfix-mta-sts-resolver postfix-mongodb postfix-mysql postfix-pcre 235s postfix-pgsql postfix-sqlite 235s The following NEW packages will be installed: 235s libnsl2 postfix 235s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 235s Need to get 1327 kB of archives. 235s After this operation, 6226 kB of additional disk space will be used. 235s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libnsl2 arm64 1.3.0-3build3 [41.6 kB] 235s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 postfix arm64 3.9.1-10ubuntu1 [1286 kB] 237s Preconfiguring packages ... 237s Fetched 1327 kB in 2s (767 kB/s) 237s Selecting previously unselected package libnsl2:arm64. 237s (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 ... 81813 files and directories currently installed.) 237s Preparing to unpack .../libnsl2_1.3.0-3build3_arm64.deb ... 237s Unpacking libnsl2:arm64 (1.3.0-3build3) ... 237s Selecting previously unselected package postfix. 237s Preparing to unpack .../postfix_3.9.1-10ubuntu1_arm64.deb ... 237s Unpacking postfix (3.9.1-10ubuntu1) ... 237s Setting up libnsl2:arm64 (1.3.0-3build3) ... 237s Setting up postfix (3.9.1-10ubuntu1) ... 238s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 238s info: Selecting UID from range 100 to 999 ... 238s 238s info: Selecting GID from range 100 to 999 ... 238s info: Adding system user `postfix' (UID 107) ... 238s info: Adding new group `postfix' (GID 111) ... 238s info: Adding new user `postfix' (UID 107) with group `postfix' ... 238s info: Not creating home directory `/var/spool/postfix'. 238s info: Selecting GID from range 100 to 999 ... 238s info: Adding group `postdrop' (GID 112) ... 238s Creating /etc/postfix/dynamicmaps.cf 238s setting myhostname: localhost 238s setting alias maps 238s setting alias database 238s mailname is not a fully qualified domain name. Not changing /etc/mailname. 238s setting destinations: $myhostname, localhost, localhost.localdomain, localhost 238s setting relayhost: 238s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 238s setting mailbox_command 238s setting mailbox_size_limit: 0 238s setting recipient_delimiter: + 240s setting inet_interfaces: all 242s setting inet_protocols: all 242s /etc/aliases does not exist, creating it. 242s WARNING: /etc/aliases exists, but does not have a root alias. 242s 242s Postfix (main.cf) is now set up with a default configuration. If you need to 242s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 242s Postfix configuration values, see postconf(1). 242s 242s After modifying main.cf, be sure to run 'systemctl reload postfix'. 242s 244s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ... 244s Processing triggers for ufw (0.36.2-9) ... 244s Processing triggers for man-db (2.13.0-1) ... 245s Processing triggers for libc-bin (2.41-1ubuntu2) ... 245s Processing triggers for postfix (3.9.1-10ubuntu1) ... 245s Restarting postfix 249s postfix/postlog: warning: not owned by root: /var/spool/postfix/etc/resolv.conf 317s ............... 317s ---------------------------------------------------------------------- 317s Ran 15 tests in 67.613s 317s 317s OK 317s ===== postfix.log contents: 317s Mar 15 14:30:45 localhost postfix/master[2358]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:30:46 localhost postfix/postfix-script[2453]: warning: not owned by root: /var/spool/postfix/etc/resolv.conf 317s Mar 15 14:30:49 localhost postfix/postfix-script[2912]: stopping the Postfix mail system 317s Mar 15 14:30:49 localhost postfix/master[2358]: terminating on signal 15 317s Mar 15 14:30:50 localhost postfix/master[3038]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: initializing the server-side TLS engine 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: initializing the server-side TLS engine 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: NOQUEUE: reject: VRFY from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:30:52 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] ehlo=1 vrfy=2/3 quit=1 help=1 commands=5/6 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: E7DB859E5: client=localhost[127.0.0.1] 317s Mar 15 14:30:52 localhost postfix/smtpd[3043]: E7DB859E5: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:30:52 localhost postfix/cleanup[3088]: E7DB859E5: message-id=<20250315143052.E7DB859E5@localhost> 317s Mar 15 14:30:52 localhost postfix/qmgr[3040]: E7DB859E5: from=, size=378, nrcpt=1 (queue active) 317s Mar 15 14:30:53 localhost postfix/local[3089]: E7DB859E5: to=, orig_to=, relay=local, delay=1, delays=0.01/0.01/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:30:53 localhost postfix/qmgr[3040]: E7DB859E5: removed 317s Mar 15 14:30:55 localhost postfix/smtpd[3043]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1/2 data=1 quit=1 commands=5/6 317s Mar 15 14:30:56 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:30:57 localhost postfix/smtpd[3046]: warning: SASL authentication failure: Password verification failed 317s Mar 15 14:30:57 localhost postfix/smtpd[3046]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=root 317s Mar 15 14:30:59 localhost postfix/smtpd[3046]: warning: SASL authentication failure: Password verification failed 317s Mar 15 14:30:59 localhost postfix/smtpd[3046]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=tnykgkex 317s Mar 15 14:30:59 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 quit=1 commands=3/5 317s Mar 15 14:30:59 localhost postfix/smtpd[3043]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:00 localhost postfix/smtpd[3043]: 0928459E5: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=tbauxdvb 317s Mar 15 14:31:00 localhost postfix/smtpd[3043]: 0928459E5: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:31:00 localhost postfix/cleanup[3088]: 0928459E5: message-id=<20250315143100.0928459E5@localhost> 317s Mar 15 14:31:00 localhost postfix/qmgr[3040]: 0928459E5: from=, size=414, nrcpt=1 (queue active) 317s Mar 15 14:31:01 localhost postfix/local[3089]: 0928459E5: to=, orig_to=, relay=local, delay=1, delays=0.01/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:01 localhost postfix/qmgr[3040]: 0928459E5: removed 317s Mar 15 14:31:03 localhost postfix/smtpd[3043]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1 mail=1 rcpt=1/2 data=1 quit=1 commands=6/7 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: setting up TLS connection from localhost[127.0.0.1] 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: localhost[127.0.0.1]: TLS cipher list "aNULL:-aNULL:HIGH:MEDIUM:!SEED:!IDEA:!3DES:!RC2:!RC4:!RC5:!kDH:!kECDH:!aDSS:!MD5:+RC4:@STRENGTH" 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:before SSL initialization 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:before SSL initialization 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS read client hello 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS write server hello 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS write change cipher spec 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:TLSv1.3 write encrypted extensions 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS write certificate 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:TLSv1.3 write server certificate verify 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS write finished 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:TLSv1.3 early data 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:TLSv1.3 early data 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS read finished 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: localhost[127.0.0.1]: Issuing session ticket, key expiration: 1742050862 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: SSL_accept:SSLv3/TLS write session ticket 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: Anonymous TLS connection established from localhost[127.0.0.1]: TLSv1.3 with cipher TLS_AES_256_GCM_SHA384 (256/256 bits) key-exchange X25519 server-signature RSA-PSS (2048 bits) server-digest SHA256 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: 42AF059E5: client=localhost[127.0.0.1] 317s Mar 15 14:31:03 localhost postfix/smtpd[3046]: 42AF059E5: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:31:03 localhost postfix/cleanup[3088]: 42AF059E5: message-id=<20250315143103.42AF059E5@localhost> 317s Mar 15 14:31:03 localhost postfix/qmgr[3040]: 42AF059E5: from=, size=379, nrcpt=1 (queue active) 317s Mar 15 14:31:04 localhost postfix/local[3089]: 42AF059E5: to=, orig_to=, relay=local, delay=1, delays=0.01/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:04 localhost postfix/qmgr[3040]: 42AF059E5: removed 317s Mar 15 14:31:06 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] ehlo=2 starttls=1 mail=1 rcpt=1/2 data=1 quit=1 commands=7/8 317s Mar 15 14:31:06 localhost postfix/smtpd[3043]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:06 localhost postfix/smtpd[3043]: 8BD2859EB: client=localhost[127.0.0.1] 317s Mar 15 14:31:06 localhost postfix/smtpd[3043]: 8BD2859EB: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:31:06 localhost postfix/cleanup[3088]: 8BD2859EB: message-id=<20250315143106.8BD2859EB@localhost> 317s Mar 15 14:31:06 localhost postfix/qmgr[3040]: 8BD2859EB: from=, size=378, nrcpt=1 (queue active) 317s Mar 15 14:31:06 localhost postfix/cleanup[3088]: 8D8EE59ED: message-id=<20250315143106.8BD2859EB@localhost> 317s Mar 15 14:31:06 localhost postfix/local[3089]: 8BD2859EB: to=, orig_to=, relay=local, delay=0.01, delays=0.01/0/0/0, dsn=2.0.0, status=sent (forwarded as 8D8EE59ED) 317s Mar 15 14:31:06 localhost postfix/qmgr[3040]: 8D8EE59ED: from=, size=500, nrcpt=1 (queue active) 317s Mar 15 14:31:06 localhost postfix/qmgr[3040]: 8BD2859EB: removed 317s Mar 15 14:31:07 localhost postfix/local[3089]: 8D8EE59ED: to=, orig_to=, relay=local, delay=1, delays=0/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:07 localhost postfix/qmgr[3040]: 8D8EE59ED: removed 317s Mar 15 14:31:09 localhost postfix/smtpd[3043]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1/2 data=1 quit=1 commands=5/6 317s Mar 15 14:31:09 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:09 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:09 localhost postfix/smtpd[3043]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:10 localhost postfix/smtpd[3043]: 00CD259E8: client=localhost[127.0.0.1] 317s Mar 15 14:31:10 localhost postfix/cleanup[3088]: 00CD259E8: message-id=<20250315143110.00CD259E8@localhost> 317s Mar 15 14:31:10 localhost postfix/qmgr[3040]: 00CD259E8: from=, size=387, nrcpt=1 (queue active) 317s Mar 15 14:31:12 localhost postfix/smtpd[3043]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1 data=1 quit=1 commands=5 317s Mar 15 14:31:12 localhost postfix/smtpd[3046]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:12 localhost postfix/smtpd[3046]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:16 localhost postfix/postfix-script[3283]: stopping the Postfix mail system 317s Mar 15 14:31:16 localhost postfix/master[3038]: terminating on signal 15 317s Mar 15 14:31:17 localhost postfix/master[3410]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:31:17 localhost postfix/qmgr[3412]: 00CD259E8: from=, size=387, nrcpt=1 (queue active) 317s Mar 15 14:31:17 localhost postfix/local[3416]: 00CD259E8: to=, orig_to=, relay=local, delay=7.3, delays=7.3/0.01/0/0.01, dsn=5.1.1, status=bounced (unknown user: "tvnnbhvl") 317s Mar 15 14:31:17 localhost postfix/cleanup[3419]: 5571259ED: message-id=<20250315143117.5571259ED@localhost> 317s Mar 15 14:31:17 localhost postfix/bounce[3417]: 00CD259E8: sender non-delivery notification: 5571259ED 317s Mar 15 14:31:17 localhost postfix/qmgr[3412]: 5571259ED: from=<>, size=2180, nrcpt=1 (queue active) 317s Mar 15 14:31:17 localhost postfix/qmgr[3412]: 00CD259E8: removed 317s Mar 15 14:31:18 localhost postfix/local[3416]: 5571259ED: to=, relay=local, delay=1, delays=0.01/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:18 localhost postfix/qmgr[3412]: 5571259ED: removed 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: initializing the server-side TLS engine 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:19 localhost postfix/smtpd[3425]: initializing the server-side TLS engine 317s Mar 15 14:31:19 localhost postfix/smtpd[3425]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:19 localhost postfix/smtpd[3425]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:31:19 localhost postfix/smtpd[3425]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication failed: authentication failure, sasl_username=root 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: warning: SASL authentication failure: incorrect digest response 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication failed: authentication failure, sasl_username=tnbofamp 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: 7146259EC: client=localhost[127.0.0.1], sasl_method=CRAM-MD5, sasl_username=tnbofamp 317s Mar 15 14:31:19 localhost postfix/smtpd[3422]: 7146259EC: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:31:19 localhost postfix/cleanup[3419]: 7146259EC: message-id=<20250315143119.7146259EC@localhost> 317s Mar 15 14:31:19 localhost postfix/qmgr[3412]: 7146259EC: from=, size=414, nrcpt=1 (queue active) 317s Mar 15 14:31:20 localhost postfix/local[3416]: 7146259EC: to=, orig_to=, relay=local, delay=1, delays=0.01/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:20 localhost postfix/qmgr[3412]: 7146259EC: removed 317s Mar 15 14:31:22 localhost postfix/smtpd[3422]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 mail=1 rcpt=1/2 data=1 quit=1 commands=6/9 317s Mar 15 14:31:22 localhost postfix/smtpd[3425]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:22 localhost postfix/smtpd[3425]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:26 localhost postfix/postfix-script[3465]: stopping the Postfix mail system 317s Mar 15 14:31:26 localhost postfix/master[3410]: terminating on signal 15 317s Mar 15 14:31:27 localhost postfix/master[3592]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:31:29 localhost postfix/smtpd[3597]: initializing the server-side TLS engine 317s Mar 15 14:31:29 localhost postfix/smtpd[3597]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: initializing the server-side TLS engine 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:31:29 localhost postfix/smtpd[3597]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:29 localhost postfix/smtpd[3600]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:33 localhost postfix/postfix-script[3638]: stopping the Postfix mail system 317s Mar 15 14:31:33 localhost postfix/master[3592]: terminating on signal 15 317s Mar 15 14:31:34 localhost postfix/master[3765]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:31:36 localhost postfix/smtpd[3770]: initializing the server-side TLS engine 317s Mar 15 14:31:36 localhost postfix/smtpd[3770]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: initializing the server-side TLS engine 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:31:36 localhost postfix/smtpd[3770]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:36 localhost postfix/smtpd[3773]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:40 localhost postfix/postfix-script[3811]: stopping the Postfix mail system 317s Mar 15 14:31:40 localhost postfix/master[3765]: terminating on signal 15 317s Mar 15 14:31:41 localhost postfix/master[3938]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: initializing the server-side TLS engine 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:43 localhost postfix/smtpd[3946]: initializing the server-side TLS engine 317s Mar 15 14:31:43 localhost postfix/smtpd[3946]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:43 localhost postfix/smtpd[3946]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:31:43 localhost postfix/smtpd[3946]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: warning: SASL authentication failure: Password verification failed 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=root 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: warning: SASL authentication failure: Password verification failed 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=tfbjnvtt 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: 4DE7859E6: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=tfbjnvtt 317s Mar 15 14:31:43 localhost postfix/smtpd[3943]: 4DE7859E6: reject: RCPT from localhost[127.0.0.1]: 550 5.1.1 : Recipient address rejected: User unknown in local recipient table; from= to= proto=ESMTP helo=<[127.0.0.1]> 317s Mar 15 14:31:43 localhost postfix/cleanup[3948]: 4DE7859E6: message-id=<20250315143143.4DE7859E6@localhost> 317s Mar 15 14:31:43 localhost postfix/qmgr[3940]: 4DE7859E6: from=, size=414, nrcpt=1 (queue active) 317s Mar 15 14:31:44 localhost postfix/local[3949]: 4DE7859E6: to=, orig_to=, relay=local, delay=1, delays=0.01/0.01/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 317s Mar 15 14:31:44 localhost postfix/qmgr[3940]: 4DE7859E6: removed 317s Mar 15 14:31:46 localhost postfix/smtpd[3943]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 mail=1 rcpt=1/2 data=1 quit=1 commands=6/9 317s Mar 15 14:31:46 localhost postfix/smtpd[3946]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:46 localhost postfix/smtpd[3946]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s Mar 15 14:31:50 localhost postfix/postfix-script[3989]: stopping the Postfix mail system 317s Mar 15 14:31:50 localhost postfix/master[3938]: terminating on signal 15 317s Mar 15 14:31:51 localhost postfix/master[4116]: daemon started -- version 3.9.1, configuration /etc/postfix 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: initializing the server-side TLS engine 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:53 localhost postfix/smtpd[4126]: initializing the server-side TLS engine 317s Mar 15 14:31:53 localhost postfix/smtpd[4126]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:53 localhost postfix/smtpd[4126]: lost connection after CONNECT from localhost[127.0.0.1] 317s Mar 15 14:31:53 localhost postfix/smtpd[4126]: disconnect from localhost[127.0.0.1] commands=0/0 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication aborted 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: warning: SASL authentication failure: Parse error 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: warning: localhost[127.0.0.1]: SASL DIGEST-MD5 authentication failed: authentication failure, sasl_username=(unavailable) 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: lost connection after AUTH from localhost[127.0.0.1] 317s Mar 15 14:31:53 localhost postfix/smtpd[4123]: disconnect from localhost[127.0.0.1] ehlo=1 auth=0/2 commands=1/3 317s Mar 15 14:31:53 localhost postfix/smtpd[4126]: connect from localhost[127.0.0.1] 317s Mar 15 14:31:54 localhost postfix/smtpd[4126]: disconnect from localhost[127.0.0.1] quit=1 commands=1 317s autopkgtest [14:31:54]: test postfix: -----------------------] 318s postfix PASS 318s autopkgtest [14:31:55]: test postfix: - - - - - - - - - - results - - - - - - - - - - 319s autopkgtest [14:31:56]: @@@@@@@@@@@@@@@@@@@@ summary 319s postfix PASS 338s nova [W] Using flock in prodstack6-arm64 338s Creating nova instance adt-plucky-arm64-postfix-20250315-142637-juju-7f2275-prod-proposed-migration-environment-15-4bd4ac00-89f7-4797-98ab-17ea4df4f194 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 338s nova [W] Timed out waiting for d23732f6-d1ab-4382-8157-233f221df931 to get deleted.