0s autopkgtest [19:41:00]: starting date and time: 2026-01-22 19:41:00+0000 0s autopkgtest [19:41:00]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [19:41:00]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8a7icff7/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,localhost,localdomain,internal,login.ubuntu.com,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:python3-defaults --apt-upgrade postfix --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=python3-defaults/3.14.2-1 -- lxd -r lxd-armhf-10.145.243.221 lxd-armhf-10.145.243.221:autopkgtest/ubuntu/resolute/armhf 23s autopkgtest [19:41:23]: testbed dpkg architecture: armhf 25s autopkgtest [19:41:25]: testbed apt version: 3.1.12 29s autopkgtest [19:41:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup 31s autopkgtest [19:41:31]: testbed release detected to be: None 39s autopkgtest [19:41:39]: updating testbed package index (apt update) 42s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 42s Get:2 http://ftpmaster.internal/ubuntu resolute InRelease [124 kB] 42s Get:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease [124 kB] 43s Get:4 http://ftpmaster.internal/ubuntu resolute-security InRelease [124 kB] 43s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [19.2 kB] 43s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [80.9 kB] 43s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [815 kB] 43s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [2820 B] 43s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf Packages [97.4 kB] 43s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf Packages [571 kB] 43s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse armhf Packages [3644 B] 43s Get:12 http://ftpmaster.internal/ubuntu resolute/multiverse Sources [310 kB] 43s Get:13 http://ftpmaster.internal/ubuntu resolute/universe Sources [21.4 MB] 46s Get:14 http://ftpmaster.internal/ubuntu resolute/main Sources [1402 kB] 46s Get:15 http://ftpmaster.internal/ubuntu resolute/main armhf Packages [1371 kB] 46s Get:16 http://ftpmaster.internal/ubuntu resolute/universe armhf Packages [14.9 MB] 47s Get:17 http://ftpmaster.internal/ubuntu resolute/multiverse armhf Packages [175 kB] 50s Fetched 41.6 MB in 8s (5413 kB/s) 51s Reading package lists... 57s autopkgtest [19:41:57]: upgrading testbed (apt dist-upgrade and autopurge) 59s Reading package lists... 59s Building dependency tree... 59s Reading state information... 60s Calculating upgrade... 61s The following packages were automatically installed and are no longer required: 61s libpython3.13-minimal libpython3.13-stdlib python3.13 python3.13-minimal 61s Use 'apt autoremove' to remove them. 61s The following NEW packages will be installed: 61s libpython3.14-minimal libpython3.14-stdlib python3.14 python3.14-minimal 61s The following packages will be upgraded: 61s libpython3-stdlib python3 python3-gdbm python3-minimal 62s 4 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 62s Need to get 6219 kB of archives. 62s After this operation, 22.5 MB of additional disk space will be used. 62s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf libpython3.14-minimal armhf 3.14.2-1 [905 kB] 62s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf python3.14-minimal armhf 3.14.2-1 [2155 kB] 62s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf python3-gdbm armhf 3.14.2-1 [11.1 kB] 62s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf python3-minimal armhf 3.14.2-1 [28.2 kB] 62s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf python3 armhf 3.14.2-1 [22.9 kB] 62s Get:6 http://ftpmaster.internal/ubuntu resolute/main armhf libpython3.14-stdlib armhf 3.14.2-1 [2270 kB] 62s Get:7 http://ftpmaster.internal/ubuntu resolute/main armhf python3.14 armhf 3.14.2-1 [816 kB] 62s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libpython3-stdlib armhf 3.14.2-1 [10.9 kB] 63s Fetched 6219 kB in 1s (6313 kB/s) 63s Selecting previously unselected package libpython3.14-minimal:armhf. 63s (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 ... 66485 files and directories currently installed.) 63s Preparing to unpack .../libpython3.14-minimal_3.14.2-1_armhf.deb ... 63s Unpacking libpython3.14-minimal:armhf (3.14.2-1) ... 63s Selecting previously unselected package python3.14-minimal. 63s Preparing to unpack .../python3.14-minimal_3.14.2-1_armhf.deb ... 63s Unpacking python3.14-minimal (3.14.2-1) ... 64s Preparing to unpack .../python3-gdbm_3.14.2-1_armhf.deb ... 64s Unpacking python3-gdbm (3.14.2-1) over (3.13.9-1) ... 64s Setting up libpython3.14-minimal:armhf (3.14.2-1) ... 64s Setting up python3.14-minimal (3.14.2-1) ... 65s (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 ... 66827 files and directories currently installed.) 65s Preparing to unpack .../python3-minimal_3.14.2-1_armhf.deb ... 65s Unpacking python3-minimal (3.14.2-1) over (3.13.7-1) ... 65s Setting up python3-minimal (3.14.2-1) ... 66s (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 ... 66827 files and directories currently installed.) 66s Preparing to unpack .../python3_3.14.2-1_armhf.deb ... 66s Unpacking python3 (3.14.2-1) over (3.13.7-1) ... 66s Selecting previously unselected package libpython3.14-stdlib:armhf. 66s Preparing to unpack .../libpython3.14-stdlib_3.14.2-1_armhf.deb ... 66s Unpacking libpython3.14-stdlib:armhf (3.14.2-1) ... 66s Selecting previously unselected package python3.14. 66s Preparing to unpack .../python3.14_3.14.2-1_armhf.deb ... 66s Unpacking python3.14 (3.14.2-1) ... 66s Preparing to unpack .../libpython3-stdlib_3.14.2-1_armhf.deb ... 66s Unpacking libpython3-stdlib:armhf (3.14.2-1) over (3.13.7-1) ... 66s Setting up libpython3.14-stdlib:armhf (3.14.2-1) ... 66s Setting up python3.14 (3.14.2-1) ... 68s Setting up libpython3-stdlib:armhf (3.14.2-1) ... 68s Setting up python3-gdbm (3.14.2-1) ... 68s Setting up python3 (3.14.2-1) ... 68s Processing triggers for man-db (2.13.1-1) ... 69s Processing triggers for systemd (259-1ubuntu2) ... 71s Reading package lists... 72s Building dependency tree... 72s Reading state information... 72s Solving dependencies... 73s The following packages will be REMOVED: 73s libpython3.13-minimal* libpython3.13-stdlib* python3.13* python3.13-minimal* 74s 0 upgraded, 0 newly installed, 4 to remove and 0 not upgraded. 74s After this operation, 21.3 MB disk space will be freed. 74s (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 ... 67257 files and directories currently installed.) 74s Removing python3.13 (3.13.11-1) ... 74s Removing libpython3.13-stdlib:armhf (3.13.11-1) ... 74s Removing python3.13-minimal (3.13.11-1) ... 75s Removing libpython3.13-minimal:armhf (3.13.11-1) ... 76s Processing triggers for man-db (2.13.1-1) ... 76s Processing triggers for systemd (259-1ubuntu2) ... 76s (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 ... 66518 files and directories currently installed.) 76s Purging configuration files for libpython3.13-minimal:armhf (3.13.11-1) ... 76s Purging configuration files for python3.13-minimal (3.13.11-1) ... 78s autopkgtest [19:42:18]: rebooting testbed after setup commands that affected boot 125s autopkgtest [19:43:05]: testbed running kernel: Linux 6.8.0-87-generic #88~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue Oct 14 14:00:09 UTC 2 151s autopkgtest [19:43:31]: @@@@@@@@@@@@@@@@@@@@ apt-source postfix 199s Get:1 http://ftpmaster.internal/ubuntu resolute/main postfix 3.10.6-1ubuntu1 (dsc) [3252 B] 199s Get:2 http://ftpmaster.internal/ubuntu resolute/main postfix 3.10.6-1ubuntu1 (tar) [5040 kB] 199s Get:3 http://ftpmaster.internal/ubuntu resolute/main postfix 3.10.6-1ubuntu1 (asc) [220 B] 199s Get:4 http://ftpmaster.internal/ubuntu resolute/main postfix 3.10.6-1ubuntu1 (diff) [201 kB] 199s gpgv: Signature made Mon Dec 8 17:24:29 2025 UTC 199s gpgv: using RSA key 92978A6E195E4921825F7FF0F34F09744E9F5DD9 199s gpgv: Can't check signature: No public key 199s dpkg-source: warning: cannot verify inline signature for ./postfix_3.10.6-1ubuntu1.dsc: no acceptable signature found 200s autopkgtest [19:44:20]: testing package postfix version 3.10.6-1ubuntu1 203s autopkgtest [19:44:23]: build not needed 206s autopkgtest [19:44:26]: test postfix: preparing testbed 209s Reading package lists... 209s Building dependency tree... 209s Reading state information... 209s Solving dependencies... 210s The following NEW packages will be installed: 210s db-util db5.3-util procmail sasl2-bin ssl-cert 211s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 211s Need to get 327 kB of archives. 211s After this operation, 2124 kB of additional disk space will be used. 211s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf db5.3-util armhf 5.3.28+dfsg2-10ubuntu1 [71.5 kB] 211s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf db-util all 1:5.3.21ubuntu3 [2666 B] 211s Get:3 http://ftpmaster.internal/ubuntu resolute/main armhf sasl2-bin armhf 2.1.28+dfsg1-9ubuntu1 [95.4 kB] 211s Get:4 http://ftpmaster.internal/ubuntu resolute/main armhf procmail armhf 3.24-1ubuntu4 [139 kB] 211s Get:5 http://ftpmaster.internal/ubuntu resolute/main armhf ssl-cert all 1.1.3ubuntu2 [18.8 kB] 211s Preconfiguring packages ... 212s Fetched 327 kB in 0s (679 kB/s) 212s Selecting previously unselected package db5.3-util. 212s (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 ... 66518 files and directories currently installed.) 212s Preparing to unpack .../db5.3-util_5.3.28+dfsg2-10ubuntu1_armhf.deb ... 212s Unpacking db5.3-util (5.3.28+dfsg2-10ubuntu1) ... 212s Selecting previously unselected package db-util. 212s Preparing to unpack .../db-util_1%3a5.3.21ubuntu3_all.deb ... 212s Unpacking db-util (1:5.3.21ubuntu3) ... 212s Selecting previously unselected package sasl2-bin. 212s Preparing to unpack .../sasl2-bin_2.1.28+dfsg1-9ubuntu1_armhf.deb ... 212s Unpacking sasl2-bin (2.1.28+dfsg1-9ubuntu1) ... 212s Selecting previously unselected package procmail. 212s Preparing to unpack .../procmail_3.24-1ubuntu4_armhf.deb ... 212s Unpacking procmail (3.24-1ubuntu4) ... 212s Selecting previously unselected package ssl-cert. 212s Preparing to unpack .../ssl-cert_1.1.3ubuntu2_all.deb ... 212s Unpacking ssl-cert (1.1.3ubuntu2) ... 212s Setting up ssl-cert (1.1.3ubuntu2) ... 213s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'. 213s Setting up db5.3-util (5.3.28+dfsg2-10ubuntu1) ... 213s Setting up procmail (3.24-1ubuntu4) ... 213s Setting up db-util (1:5.3.21ubuntu3) ... 213s Setting up sasl2-bin (2.1.28+dfsg1-9ubuntu1) ... 214s saslauthd.service is a disabled or a static unit, not starting it. 214s Processing triggers for man-db (2.13.1-1) ... 222s autopkgtest [19:44:42]: test postfix: [----------------------- 225s Reading package lists... 225s Building dependency tree... 225s Reading state information... 226s Solving dependencies... 226s The following additional packages will be installed: 226s libnsl2 227s Suggested packages: 227s mail-reader postfix-cdb postfix-doc postfix-ldap postfix-lmdb 227s postfix-mta-sts-resolver postfix-mongodb postfix-mysql postfix-pcre 227s postfix-pgsql postfix-sqlite 227s The following NEW packages will be installed: 227s libnsl2 postfix 227s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 227s Need to get 1284 kB of archives. 227s After this operation, 5552 kB of additional disk space will be used. 227s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf libnsl2 armhf 1.3.0-3build4 [36.8 kB] 227s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf postfix armhf 3.10.6-1ubuntu1 [1248 kB] 228s Preconfiguring packages ... 228s Fetched 1284 kB in 1s (1866 kB/s) 228s Selecting previously unselected package libnsl2:armhf. 228s (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 ... 66644 files and directories currently installed.) 228s Preparing to unpack .../libnsl2_1.3.0-3build4_armhf.deb ... 228s Unpacking libnsl2:armhf (1.3.0-3build4) ... 228s Selecting previously unselected package postfix. 228s Preparing to unpack .../postfix_3.10.6-1ubuntu1_armhf.deb ... 228s Unpacking postfix (3.10.6-1ubuntu1) ... 229s Setting up libnsl2:armhf (1.3.0-3build4) ... 229s Setting up postfix (3.10.6-1ubuntu1) ... 229s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'. 230s Creating /etc/postfix/dynamicmaps.cf 230s setting myhostname: localhost.lxd 230s setting alias maps 230s setting alias database 230s mailname is not a fully qualified domain name. Not changing /etc/mailname. 230s setting destinations: $myhostname, localhost, localhost.localdomain, localhost 230s setting relayhost: 230s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128 230s setting mailbox_command 230s setting mailbox_size_limit: 0 230s setting recipient_delimiter: + 232s setting inet_interfaces: all 234s setting inet_protocols: all 234s /etc/aliases does not exist, creating it. 234s WARNING: /etc/aliases exists, but does not have a root alias. 234s 234s Postfix (main.cf) is now set up with a default configuration. If you need to 234s make changes, edit /etc/postfix/main.cf (and others) as needed. To view 234s Postfix configuration values, see postconf(1). 234s 234s After modifying main.cf, be sure to run 'systemctl reload postfix'. 234s 236s Processing triggers for rsyslog (8.2512.0-1ubuntu2) ... 236s Processing triggers for ufw (0.36.2-9build1) ... 237s Processing triggers for man-db (2.13.1-1) ... 237s Processing triggers for libc-bin (2.42-2ubuntu4) ... 238s Processing triggers for postfix (3.10.6-1ubuntu1) ... 238s Restarting postfix 242s postfix/postlog: warning: not owned by root: /var/spool/postfix/etc/resolv.conf 316s ........E...... 316s ====================================================================== 316s ERROR: test_11_security_CVE_2008_2936 (__main__.PostfixTest.test_11_security_CVE_2008_2936) 316s CVE-2008-2936 fixed 316s ---------------------------------------------------------------------- 316s Traceback (most recent call last): 316s File "/tmp/autopkgtest.GE5Uxz/build.j8O/src/debian/tests/test-postfix.py", line 393, in test_11_security_CVE_2008_2936 316s os.link('/var/tmp/secret.link','/var/mail/%s' % (self.user.login)) 316s ~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 316s PermissionError: [Errno 13] Permission denied: '/var/tmp/secret.link' -> '/var/mail/tjrubiau' 316s 316s ---------------------------------------------------------------------- 316s Ran 15 tests in 71.976s 316s 316s FAILED (errors=1) 316s ===== postfix.log contents: 316s Jan 22 19:45:02 localhost postfix/master[1991]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:45:02 localhost postfix/postfix-script[2088]: warning: not owned by root: /var/spool/postfix/etc/resolv.conf 316s Jan 22 19:45:06 localhost postfix/postfix-script[2551]: stopping the Postfix mail system 316s Jan 22 19:45:06 localhost postfix/master[1991]: terminating on signal 15 316s Jan 22 19:45:07 localhost postfix/master[2679]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:45:09 localhost postfix/smtpd[2684]: initializing the server-side TLS engine 316s Jan 22 19:45:09 localhost postfix/smtpd[2684]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: initializing the server-side TLS engine 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:45:09 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:45:09 localhost postfix/smtpd[2684]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 316s Jan 22 19:45:10 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:10 localhost postfix/smtpd[2687]: 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]> 316s Jan 22 19:45:10 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] ehlo=1 vrfy=2/3 quit=1 help=1 commands=5/6 316s Jan 22 19:45:10 localhost postfix/smtpd[2684]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:10 localhost postfix/smtpd[2684]: 7E1941433D: client=localhost[127.0.0.1] 316s Jan 22 19:45:10 localhost postfix/smtpd[2684]: 7E1941433D: 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]> 316s Jan 22 19:45:10 localhost postfix/cleanup[2735]: 7E1941433D: message-id=<20260122194510.7E1941433D@localhost.lxd> 316s Jan 22 19:45:10 localhost postfix/qmgr[2681]: 7E1941433D: from=, size=396, nrcpt=1 (queue active) 316s Jan 22 19:45:11 localhost postfix/local[2736]: 7E1941433D: to=, orig_to=, relay=local, delay=1.1, delays=0.03/0.01/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 316s Jan 22 19:45:11 localhost postfix/qmgr[2681]: 7E1941433D: removed 316s Jan 22 19:45:13 localhost postfix/smtpd[2684]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1/2 data=1 quit=1 commands=5/6 316s Jan 22 19:45:13 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:15 localhost postfix/smtpd[2687]: warning: SASL authentication failure: Password verification failed 316s Jan 22 19:45:15 localhost postfix/smtpd[2687]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=root 316s Jan 22 19:45:17 localhost postfix/smtpd[2687]: warning: SASL authentication failure: Password verification failed 316s Jan 22 19:45:17 localhost postfix/smtpd[2687]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=thhejmfi 316s Jan 22 19:45:17 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 quit=1 commands=3/5 316s Jan 22 19:45:17 localhost postfix/smtpd[2684]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:18 localhost postfix/smtpd[2684]: 38DE714380: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=tiepyaye 316s Jan 22 19:45:18 localhost postfix/smtpd[2684]: 38DE714380: 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]> sasl_method=PLAIN sasl_username=tiepyaye 316s Jan 22 19:45:18 localhost postfix/cleanup[2735]: 38DE714380: message-id=<20260122194518.38DE714380@localhost.lxd> 316s Jan 22 19:45:18 localhost postfix/qmgr[2681]: 38DE714380: from=, size=432, nrcpt=1 (queue active) 316s Jan 22 19:45:19 localhost postfix/local[2736]: 38DE714380: 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") 316s Jan 22 19:45:19 localhost postfix/qmgr[2681]: 38DE714380: removed 316s Jan 22 19:45:21 localhost postfix/smtpd[2684]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1 mail=1 rcpt=1/2 data=1 quit=1 commands=6/7 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: setting up TLS connection from localhost[127.0.0.1] 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: localhost[127.0.0.1]: TLS cipher list "aNULL:-aNULL:HIGH:MEDIUM:!SEED:!IDEA:!3DES:!RC2:!RC4:!RC5:!kDH:!kECDH:!aDSS:!MD5:+RC4:@STRENGTH" 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:before SSL initialization 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:before SSL initialization 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS read client hello 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS write server hello 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS write change cipher spec 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:TLSv1.3 write encrypted extensions 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS write certificate 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:TLSv1.3 write server certificate verify 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS write finished 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:TLSv1.3 early data 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:TLSv1.3 early data 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS read finished 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: localhost[127.0.0.1]: Issuing session ticket, key expiration: 1769112920 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: SSL_accept:SSLv3/TLS write session ticket 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: 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 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: 8214C143A2: client=localhost[127.0.0.1] 316s Jan 22 19:45:21 localhost postfix/smtpd[2687]: 8214C143A2: 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]> 316s Jan 22 19:45:21 localhost postfix/cleanup[2735]: 8214C143A2: message-id=<20260122194521.8214C143A2@localhost.lxd> 316s Jan 22 19:45:21 localhost postfix/qmgr[2681]: 8214C143A2: from=, size=397, nrcpt=1 (queue active) 316s Jan 22 19:45:22 localhost postfix/local[2736]: 8214C143A2: to=, orig_to=, relay=local, delay=1, delays=0.02/0/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 316s Jan 22 19:45:22 localhost postfix/qmgr[2681]: 8214C143A2: removed 316s Jan 22 19:45:24 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] ehlo=2 starttls=1 mail=1 rcpt=1/2 data=1 quit=1 commands=7/8 316s Jan 22 19:45:24 localhost postfix/smtpd[2684]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:24 localhost postfix/smtpd[2684]: EA20E143D9: client=localhost[127.0.0.1] 316s Jan 22 19:45:24 localhost postfix/smtpd[2684]: EA20E143D9: 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]> 316s Jan 22 19:45:24 localhost postfix/cleanup[2735]: EA20E143D9: message-id=<20260122194524.EA20E143D9@localhost.lxd> 316s Jan 22 19:45:24 localhost postfix/qmgr[2681]: EA20E143D9: from=, size=396, nrcpt=1 (queue active) 316s Jan 22 19:45:24 localhost postfix/cleanup[2735]: ECEDD143DA: message-id=<20260122194524.EA20E143D9@localhost.lxd> 316s Jan 22 19:45:24 localhost postfix/local[2736]: EA20E143D9: to=, orig_to=, relay=local, delay=0.02, delays=0.01/0/0/0.01, dsn=2.0.0, status=sent (forwarded as ECEDD143DA) 316s Jan 22 19:45:24 localhost postfix/qmgr[2681]: ECEDD143DA: from=, size=527, nrcpt=1 (queue active) 316s Jan 22 19:45:24 localhost postfix/qmgr[2681]: EA20E143D9: removed 316s Jan 22 19:45:25 localhost postfix/local[2736]: ECEDD143DA: 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") 316s Jan 22 19:45:25 localhost postfix/qmgr[2681]: ECEDD143DA: removed 316s Jan 22 19:45:28 localhost postfix/smtpd[2684]: disconnect from localhost[127.0.0.1] ehlo=1 mail=1 rcpt=1/2 data=1 quit=1 commands=5/6 316s Jan 22 19:45:28 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:28 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:28 localhost postfix/smtpd[2684]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:28 localhost postfix/smtpd[2684]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:28 localhost postfix/smtpd[2687]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:28 localhost postfix/smtpd[2687]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:32 localhost postfix/postfix-script[2964]: stopping the Postfix mail system 316s Jan 22 19:45:32 localhost postfix/master[2679]: terminating on signal 15 316s Jan 22 19:45:34 localhost postfix/master[3093]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: initializing the server-side TLS engine 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:36 localhost postfix/smtpd[3101]: initializing the server-side TLS engine 316s Jan 22 19:45:36 localhost postfix/smtpd[3101]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:36 localhost postfix/smtpd[3101]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:45:36 localhost postfix/smtpd[3101]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication failed: authentication failure, sasl_username=root 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: warning: SASL authentication failure: incorrect digest response 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication failed: authentication failure, sasl_username=tqqjqwhh 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: 5603514470: client=localhost[127.0.0.1], sasl_method=CRAM-MD5, sasl_username=tqqjqwhh 316s Jan 22 19:45:36 localhost postfix/smtpd[3098]: 5603514470: 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]> sasl_method=CRAM-MD5 sasl_username=tqqjqwhh 316s Jan 22 19:45:36 localhost postfix/cleanup[3103]: 5603514470: message-id=<20260122194536.5603514470@localhost.lxd> 316s Jan 22 19:45:36 localhost postfix/qmgr[3095]: 5603514470: from=, size=432, nrcpt=1 (queue active) 316s Jan 22 19:45:37 localhost postfix/local[3104]: 5603514470: to=, orig_to=, relay=local, delay=1, delays=0.02/0.01/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 316s Jan 22 19:45:37 localhost postfix/qmgr[3095]: 5603514470: removed 316s Jan 22 19:45:39 localhost postfix/smtpd[3098]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 mail=1 rcpt=1/2 data=1 quit=1 commands=6/9 316s Jan 22 19:45:39 localhost postfix/smtpd[3101]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:39 localhost postfix/smtpd[3101]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:43 localhost postfix/postfix-script[3147]: stopping the Postfix mail system 316s Jan 22 19:45:43 localhost postfix/master[3093]: terminating on signal 15 316s Jan 22 19:45:44 localhost postfix/master[3276]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:45:46 localhost postfix/smtpd[3281]: initializing the server-side TLS engine 316s Jan 22 19:45:47 localhost postfix/smtpd[3281]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: initializing the server-side TLS engine 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:45:47 localhost postfix/smtpd[3281]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:47 localhost postfix/smtpd[3284]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:51 localhost postfix/postfix-script[3325]: stopping the Postfix mail system 316s Jan 22 19:45:51 localhost postfix/master[3276]: terminating on signal 15 316s Jan 22 19:45:52 localhost postfix/master[3454]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:45:55 localhost postfix/smtpd[3459]: initializing the server-side TLS engine 316s Jan 22 19:45:55 localhost postfix/smtpd[3459]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: initializing the server-side TLS engine 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:45:55 localhost postfix/smtpd[3459]: disconnect from localhost[127.0.0.1] ehlo=1 quit=1 commands=2 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: connect from localhost[127.0.0.1] 316s Jan 22 19:45:55 localhost postfix/smtpd[3462]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:45:59 localhost postfix/postfix-script[3503]: stopping the Postfix mail system 316s Jan 22 19:45:59 localhost postfix/master[3454]: terminating on signal 15 316s Jan 22 19:46:00 localhost postfix/master[3632]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: initializing the server-side TLS engine 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:03 localhost postfix/smtpd[3640]: initializing the server-side TLS engine 316s Jan 22 19:46:03 localhost postfix/smtpd[3640]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:03 localhost postfix/smtpd[3640]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:46:03 localhost postfix/smtpd[3640]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: warning: SASL authentication failure: Password verification failed 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=root 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: warning: SASL authentication failure: Password verification failed 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: warning: localhost[127.0.0.1]: SASL PLAIN authentication failed: authentication failure, sasl_username=tjfnjlll 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: 22A8B14538: client=localhost[127.0.0.1], sasl_method=PLAIN, sasl_username=tjfnjlll 316s Jan 22 19:46:03 localhost postfix/smtpd[3637]: 22A8B14538: 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]> sasl_method=PLAIN sasl_username=tjfnjlll 316s Jan 22 19:46:03 localhost postfix/cleanup[3642]: 22A8B14538: message-id=<20260122194603.22A8B14538@localhost.lxd> 316s Jan 22 19:46:03 localhost postfix/qmgr[3634]: 22A8B14538: from=, size=432, nrcpt=1 (queue active) 316s Jan 22 19:46:04 localhost postfix/local[3643]: 22A8B14538: to=, orig_to=, relay=local, delay=1, delays=0.02/0.01/0/1, dsn=2.0.0, status=sent (delivered to command: procmail -a "$EXTENSION") 316s Jan 22 19:46:04 localhost postfix/qmgr[3634]: 22A8B14538: removed 316s Jan 22 19:46:06 localhost postfix/smtpd[3637]: disconnect from localhost[127.0.0.1] ehlo=1 auth=1/3 mail=1 rcpt=1/2 data=1 quit=1 commands=6/9 316s Jan 22 19:46:06 localhost postfix/smtpd[3640]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:06 localhost postfix/smtpd[3640]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s Jan 22 19:46:10 localhost postfix/postfix-script[3686]: stopping the Postfix mail system 316s Jan 22 19:46:10 localhost postfix/master[3632]: terminating on signal 15 316s Jan 22 19:46:12 localhost postfix/master[3815]: daemon started -- version 3.10.6, configuration /etc/postfix 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: initializing the server-side TLS engine 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:14 localhost postfix/smtpd[3825]: initializing the server-side TLS engine 316s Jan 22 19:46:14 localhost postfix/smtpd[3825]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:14 localhost postfix/smtpd[3825]: NOQUEUE: lost connection after CONNECT from localhost[127.0.0.1] 316s Jan 22 19:46:14 localhost postfix/smtpd[3825]: disconnect from localhost[127.0.0.1] commands=0/0 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: warning: localhost[127.0.0.1]: SASL CRAM-MD5 authentication aborted 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: warning: SASL authentication failure: Parse error 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: warning: localhost[127.0.0.1]: SASL DIGEST-MD5 authentication failed: authentication failure, sasl_username=(unavailable) 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: NOQUEUE: lost connection after AUTH from localhost[127.0.0.1] 316s Jan 22 19:46:14 localhost postfix/smtpd[3822]: disconnect from localhost[127.0.0.1] ehlo=1 auth=0/2 commands=1/3 316s Jan 22 19:46:14 localhost postfix/smtpd[3825]: connect from localhost[127.0.0.1] 316s Jan 22 19:46:16 localhost postfix/smtpd[3825]: disconnect from localhost[127.0.0.1] quit=1 commands=1 316s autopkgtest [19:46:16]: test postfix: -----------------------] 321s autopkgtest [19:46:21]: test postfix: - - - - - - - - - - results - - - - - - - - - - 321s postfix FAIL non-zero exit status 1 326s autopkgtest [19:46:26]: @@@@@@@@@@@@@@@@@@@@ summary 326s postfix FAIL non-zero exit status 1