0s autopkgtest [05:36:50]: starting date and time: 2025-05-02 05:36:50+0000
  0s autopkgtest [05:36:50]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production'
  0s autopkgtest [05:36:50]: host juju-7f2275-prod-proposed-migration-environment-23; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.mv8zyzsb/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:opensmtpd --apt-upgrade inn2 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=opensmtpd/7.6.0p1-1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-23@bos03-arm64-8.secgroup --name adt-questing-arm64-inn2-20250502-053649-juju-7f2275-prod-proposed-migration-environment-23-88b89f9c-6d1d-4cab-b165-955bdb33933f --image adt/ubuntu-questing-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-23 --net-id=net_prod-proposed-migration -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/
133s autopkgtest [05:39:03]: testbed dpkg architecture: arm64
133s autopkgtest [05:39:03]: testbed apt version: 3.0.0
134s autopkgtest [05:39:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
134s autopkgtest [05:39:04]: testbed release detected to be: None
135s autopkgtest [05:39:05]: updating testbed package index (apt update)
135s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
136s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
136s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
136s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
136s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
136s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
136s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
136s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main arm64 Packages [227 kB]
136s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe arm64 Packages [1472 kB]
136s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse arm64 Packages [16.5 kB]
137s Fetched 4269 kB in 1s (3228 kB/s)
137s Reading package lists...
138s autopkgtest [05:39:08]: upgrading testbed (apt dist-upgrade and autopurge)
138s Reading package lists...
139s Building dependency tree...
139s Reading state information...
140s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
140s Starting 2 pkgProblemResolver with broken count: 0
140s Done
141s Entering ResolveByKeep
141s 
141s Calculating upgrade...
141s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
142s Reading package lists...
142s Building dependency tree...
142s Reading state information...
142s Starting pkgProblemResolver with broken count: 0
142s Starting 2 pkgProblemResolver with broken count: 0
142s Done
143s Solving dependencies...
143s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
146s autopkgtest [05:39:16]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Sun Apr  6 14:37:51 UTC 2025
146s autopkgtest [05:39:16]: @@@@@@@@@@@@@@@@@@@@ apt-source inn2
149s Get:1 http://ftpmaster.internal/ubuntu questing/universe inn2 2.7.3~20250201-1 (dsc) [1650 B]
149s Get:2 http://ftpmaster.internal/ubuntu questing/universe inn2 2.7.3~20250201-1 (tar) [1575 kB]
149s Get:3 http://ftpmaster.internal/ubuntu questing/universe inn2 2.7.3~20250201-1 (diff) [37.4 kB]
149s gpgv: Signature made Fri Feb 21 17:35:31 2025 UTC
149s gpgv:                using EDDSA key 272945CD836D38DFB7427E86CB3EC33AE1DED781
149s gpgv: Can't check signature: No public key
149s dpkg-source: warning: cannot verify inline signature for ./inn2_2.7.3~20250201-1.dsc: no acceptable signature found
149s autopkgtest [05:39:19]: testing package inn2 version 2.7.3~20250201-1
150s autopkgtest [05:39:20]: build not needed
151s autopkgtest [05:39:21]: test daemon: preparing testbed
151s Reading package lists...
151s Building dependency tree...
151s Reading state information...
152s Starting pkgProblemResolver with broken count: 0
152s Starting 2 pkgProblemResolver with broken count: 0
152s Done
153s The following NEW packages will be installed:
153s   inn2 inn2-inews libcanlock3 libconvert-binhex-perl libio-socket-ssl-perl
153s   libipc-system-simple-perl libmailtools-perl libmime-tools-perl
153s   libnet-smtp-ssl-perl libnet-ssleay-perl libpath-tiny-perl libtimedate-perl
153s   perl-openssl-defaults postfix
153s 0 upgraded, 14 newly installed, 0 to remove and 0 not upgraded.
153s Need to get 3640 kB of archives.
153s After this operation, 15.8 MB of additional disk space will be used.
153s Get:1 http://ftpmaster.internal/ubuntu questing/main arm64 postfix arm64 3.9.1-10ubuntu1 [1286 kB]
153s Get:2 http://ftpmaster.internal/ubuntu questing/universe arm64 inn2-inews arm64 2.7.3~20250201-1 [135 kB]
153s Get:3 http://ftpmaster.internal/ubuntu questing/universe arm64 libcanlock3 arm64 3.3.1-1 [15.8 kB]
153s Get:4 http://ftpmaster.internal/ubuntu questing/main arm64 libconvert-binhex-perl all 1.125-3 [27.1 kB]
153s Get:5 http://ftpmaster.internal/ubuntu questing/main arm64 perl-openssl-defaults arm64 7build3 [6628 B]
153s Get:6 http://ftpmaster.internal/ubuntu questing/main arm64 libnet-ssleay-perl arm64 1.94-3 [307 kB]
153s Get:7 http://ftpmaster.internal/ubuntu questing/main arm64 libio-socket-ssl-perl all 2.089-1 [200 kB]
153s Get:8 http://ftpmaster.internal/ubuntu questing/main arm64 libnet-smtp-ssl-perl all 1.04-2 [6218 B]
153s Get:9 http://ftpmaster.internal/ubuntu questing/main arm64 libtimedate-perl all 2.3300-2 [34.0 kB]
153s Get:10 http://ftpmaster.internal/ubuntu questing/main arm64 libmailtools-perl all 2.22-1 [77.1 kB]
153s Get:11 http://ftpmaster.internal/ubuntu questing/main arm64 libmime-tools-perl all 5.515-1 [187 kB]
153s Get:12 http://ftpmaster.internal/ubuntu questing/universe arm64 inn2 arm64 2.7.3~20250201-1 [1287 kB]
153s Get:13 http://ftpmaster.internal/ubuntu questing/main arm64 libipc-system-simple-perl all 1.30-2 [22.3 kB]
153s Get:14 http://ftpmaster.internal/ubuntu questing/main arm64 libpath-tiny-perl all 0.146-1 [47.5 kB]
154s Preconfiguring packages ...
154s Fetched 3640 kB in 1s (4088 kB/s)
154s Selecting previously unselected package postfix.
154s (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 ... 117820 files and directories currently installed.)
154s Preparing to unpack .../00-postfix_3.9.1-10ubuntu1_arm64.deb ...
154s Unpacking postfix (3.9.1-10ubuntu1) ...
154s Selecting previously unselected package inn2-inews.
154s Preparing to unpack .../01-inn2-inews_2.7.3~20250201-1_arm64.deb ...
154s Unpacking inn2-inews (2.7.3~20250201-1) ...
154s Selecting previously unselected package libcanlock3:arm64.
154s Preparing to unpack .../02-libcanlock3_3.3.1-1_arm64.deb ...
154s Unpacking libcanlock3:arm64 (3.3.1-1) ...
154s Selecting previously unselected package libconvert-binhex-perl.
154s Preparing to unpack .../03-libconvert-binhex-perl_1.125-3_all.deb ...
154s Unpacking libconvert-binhex-perl (1.125-3) ...
154s Selecting previously unselected package perl-openssl-defaults:arm64.
155s Preparing to unpack .../04-perl-openssl-defaults_7build3_arm64.deb ...
155s Unpacking perl-openssl-defaults:arm64 (7build3) ...
155s Selecting previously unselected package libnet-ssleay-perl:arm64.
155s Preparing to unpack .../05-libnet-ssleay-perl_1.94-3_arm64.deb ...
155s Unpacking libnet-ssleay-perl:arm64 (1.94-3) ...
155s Selecting previously unselected package libio-socket-ssl-perl.
155s Preparing to unpack .../06-libio-socket-ssl-perl_2.089-1_all.deb ...
155s Unpacking libio-socket-ssl-perl (2.089-1) ...
155s Selecting previously unselected package libnet-smtp-ssl-perl.
155s Preparing to unpack .../07-libnet-smtp-ssl-perl_1.04-2_all.deb ...
155s Unpacking libnet-smtp-ssl-perl (1.04-2) ...
155s Selecting previously unselected package libtimedate-perl.
155s Preparing to unpack .../08-libtimedate-perl_2.3300-2_all.deb ...
155s Unpacking libtimedate-perl (2.3300-2) ...
155s Selecting previously unselected package libmailtools-perl.
155s Preparing to unpack .../09-libmailtools-perl_2.22-1_all.deb ...
155s Unpacking libmailtools-perl (2.22-1) ...
155s Selecting previously unselected package libmime-tools-perl.
155s Preparing to unpack .../10-libmime-tools-perl_5.515-1_all.deb ...
155s Unpacking libmime-tools-perl (5.515-1) ...
155s Setting up inn2-inews (2.7.3~20250201-1) ...
155s Selecting previously unselected package inn2.
155s (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 ... 118402 files and directories currently installed.)
155s Preparing to unpack .../inn2_2.7.3~20250201-1_arm64.deb ...
155s Unpacking inn2 (2.7.3~20250201-1) ...
155s Selecting previously unselected package libipc-system-simple-perl.
155s Preparing to unpack .../libipc-system-simple-perl_1.30-2_all.deb ...
155s Unpacking libipc-system-simple-perl (1.30-2) ...
155s Selecting previously unselected package libpath-tiny-perl.
155s Preparing to unpack .../libpath-tiny-perl_0.146-1_all.deb ...
155s Unpacking libpath-tiny-perl (0.146-1) ...
155s Setting up libconvert-binhex-perl (1.125-3) ...
155s Setting up perl-openssl-defaults:arm64 (7build3) ...
155s Setting up libipc-system-simple-perl (1.30-2) ...
155s Setting up libtimedate-perl (2.3300-2) ...
155s Setting up postfix (3.9.1-10ubuntu1) ...
155s Created symlink '/etc/systemd/system/multi-user.target.wants/postfix.service' → '/usr/lib/systemd/system/postfix.service'.

156s info: Selecting UID from range 100 to 999 ...
156s 
156s info: Selecting GID from range 100 to 999 ...
156s info: Adding system user `postfix' (UID 107) ...
156s info: Adding new group `postfix' (GID 108) ...
156s info: Adding new user `postfix' (UID 107) with group `postfix' ...
156s info: Not creating home directory `/var/spool/postfix'.
156s info: Selecting GID from range 100 to 999 ...
156s info: Adding group `postdrop' (GID 111) ...
156s Creating /etc/postfix/dynamicmaps.cf
156s setting myhostname: autopkgtest.local
156s setting alias maps
156s setting alias database
156s changing /etc/mailname to autopkgtest.local
156s setting myorigin
156s setting destinations: $myhostname, autopkgtest.local, localhost.local, , localhost
156s setting relayhost: 
156s setting mynetworks: 127.0.0.0/8 [::ffff:127.0.0.0]/104 [::1]/128
156s clearing mailbox_command
156s setting mailbox_size_limit: 0
156s setting recipient_delimiter: +
158s setting inet_interfaces: all
160s setting inet_protocols: all
160s /etc/aliases does not exist, creating it.
160s WARNING: /etc/aliases exists, but does not have a root alias.
160s 
160s Postfix (main.cf) is now set up with a default configuration.  If you need to 
160s make changes, edit /etc/postfix/main.cf (and others) as needed.  To view 
160s Postfix configuration values, see postconf(1).
160s 
160s After modifying main.cf, be sure to run 'systemctl reload postfix'.
160s 
162s Setting up libpath-tiny-perl (0.146-1) ...
162s Setting up libcanlock3:arm64 (3.3.1-1) ...
162s Setting up libnet-ssleay-perl:arm64 (1.94-3) ...
162s Setting up libio-socket-ssl-perl (2.089-1) ...
162s Setting up libnet-smtp-ssl-perl (1.04-2) ...
162s Setting up libmailtools-perl (2.22-1) ...
162s Setting up libmime-tools-perl (5.515-1) ...
162s Setting up inn2 (2.7.3~20250201-1) ...
162s Installing initial content for /var/lib/news/active
162s Installing initial content for /var/lib/news/newsgroups
162s Building history database in /var/lib/news... makehistory: tradspool: mapping file /var/spool/news/tradspool.map not found
162s done.
163s Adding alias for pseudo-user usenet to /etc/aliases.
163s Created symlink '/etc/systemd/system/multi-user.target.wants/inn2.service' → '/usr/lib/systemd/system/inn2.service'.

163s Processing triggers for rsyslog (8.2412.0-2ubuntu2) ...
163s Processing triggers for ufw (0.36.2-9) ...
164s Processing triggers for man-db (2.13.0-1) ...
165s Processing triggers for libc-bin (2.41-6ubuntu1) ...
165s Processing triggers for postfix (3.9.1-10ubuntu1) ...
165s Restarting postfix
166s autopkgtest [05:39:36]: test daemon: [-----------------------
167s systemd 257 (257.4-1ubuntu3)
167s +PAM +AUDIT +SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK +BTF -XKBCOMMON -UTMP +SYSVINIT +LIBARCHIVE
167s 
167s Run makehistory...
167s 
167s Start innd...
167s Running as unit: testinn.service; invocation ID: 46fbd4c0907140c18bdae66c080f9dee
167s Listening on [::]:1119 as 3.
169s Communication attempt on fd 3.
169s Execing /usr/lib/news/bin/innd (/usr/lib/news/bin/innd -f)
169s 
169s Connect to innd...
169s 
169s Connect to innd...
169s 
169s Run ctlinnd mode...
169s Server running
169s Allowing remote connections
169s Parameters c 10 i 50 (1) l 1000000 o 1010 t 300 H 2 T 60 X 0 normal specified
169s Not reserved
169s Readers follow enabled
169s Perl filtering disabled
169s Python filtering disabled
169s 
169s Post an article with NNTP IHAVE...
169s 
169s Post an article with NNTP POST...
169s 
169s Post an article with rnews...
169s 
169s Post an article with inews...
169s 
169s Shut down innd...
169s 
169s Stop the testinn.service unit...
170s 
170s Exiting /tmp/autopkgtest.H8kH55/build.t67/src/debian/tests/daemon.
170s Finished with result: success
170s Main processes terminated with: code=exited, status=0/SUCCESS
170s Service runtime: 3.226s
170s CPU time consumed: 44ms
170s Memory peak: 10.7M (swap: 0B)
170s autopkgtest [05:39:40]: test daemon: -----------------------]
171s autopkgtest [05:39:41]: test daemon:  - - - - - - - - - - results - - - - - - - - - -
171s daemon               PASS
171s autopkgtest [05:39:41]: @@@@@@@@@@@@@@@@@@@@ summary
171s daemon               PASS
215s nova [W] Using flock in prodstack6-arm64
215s flock: timeout while waiting to get lock
215s Creating nova instance adt-questing-arm64-inn2-20250502-053649-juju-7f2275-prod-proposed-migration-environment-23-88b89f9c-6d1d-4cab-b165-955bdb33933f from image adt/ubuntu-questing-arm64-server-20250502.img (UUID a0b7b7fd-ad05-4ea9-97eb-0f52dbbe98e1)...
215s nova [W] Timed out waiting for 4ea45db3-3f84-4398-896a-7c96202bf653 to get deleted.