0s autopkgtest [17:10:25]: starting date and time: 2024-11-13 17:10:25+0000
  0s autopkgtest [17:10:25]: git checkout: 0acbae0a WIP show VirtSubproc stderr in real-time
  0s autopkgtest [17:10:25]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.wkywsyyp/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:apparmor --apt-upgrade dovecot --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=apparmor/4.1.0~beta1-0ubuntu4' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-24.secgroup --name adt-plucky-arm64-dovecot-20241113-125337-juju-7f2275-prod-proposed-migration-environment-2-99afae3e-90df-440f-8035-f2745962e9eb --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
339s autopkgtest [17:16:04]: testbed dpkg architecture: arm64
339s autopkgtest [17:16:04]: testbed apt version: 2.9.8
339s autopkgtest [17:16:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
341s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
341s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
341s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
341s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
341s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
341s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [130 kB]
341s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB]
341s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [684 kB]
341s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [18.2 kB]
342s Fetched 2056 kB in 1s (2052 kB/s)
342s Reading package lists...
347s Reading package lists...
347s Building dependency tree...
347s Reading state information...
348s Calculating upgrade...
349s The following packages will be upgraded:
349s   apparmor libapparmor1 libgnutls30t64 libjson-glib-1.0-0
349s   libjson-glib-1.0-common libutempter0
349s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
349s Need to get 1731 kB of archives.
349s After this operation, 1024 B of additional disk space will be used.
349s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libgnutls30t64 arm64 3.8.8-2ubuntu1 [956 kB]
349s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libapparmor1 arm64 4.1.0~beta1-0ubuntu4 [51.8 kB]
349s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 apparmor arm64 4.1.0~beta1-0ubuntu4 [642 kB]
349s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
349s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-0 arm64 1.10.0+ds-3 [66.5 kB]
349s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libutempter0 arm64 1.2.1-4 [9646 B]
350s Preconfiguring packages ...
350s Fetched 1731 kB in 1s (2638 kB/s)
350s (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 ... 79924 files and directories currently installed.)
386s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_arm64.deb ...
386s Unpacking libgnutls30t64:arm64 (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
386s Setting up libgnutls30t64:arm64 (3.8.8-2ubuntu1) ...
386s (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 ... 79924 files and directories currently installed.)
386s Preparing to unpack .../libapparmor1_4.1.0~beta1-0ubuntu4_arm64.deb ...
386s Unpacking libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
386s Preparing to unpack .../apparmor_4.1.0~beta1-0ubuntu4_arm64.deb ...
386s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
386s Preparing to unpack .../libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
386s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
386s Preparing to unpack .../libjson-glib-1.0-0_1.10.0+ds-3_arm64.deb ...
386s Unpacking libjson-glib-1.0-0:arm64 (1.10.0+ds-3) over (1.10.0+ds-2) ...
386s Preparing to unpack .../libutempter0_1.2.1-4_arm64.deb ...
386s Unpacking libutempter0:arm64 (1.2.1-4) over (1.2.1-3build1) ...
386s Setting up libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) ...
386s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
386s Reloading AppArmor profiles 
386s Setting up libutempter0:arm64 (1.2.1-4) ...
386s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
386s Setting up libjson-glib-1.0-0:arm64 (1.10.0+ds-3) ...
386s Processing triggers for man-db (2.12.1-3) ...
386s Processing triggers for libc-bin (2.40-1ubuntu3) ...
386s Reading package lists...
386s Building dependency tree...
386s Reading state information...
386s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
386s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
386s Reading package lists...
386s Building dependency tree...
386s Reading state information...
386s Calculating upgrade...
386s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
386s Reading package lists...
386s Building dependency tree...
386s Reading state information...
386s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
386s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
386s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
386s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
386s Reading package lists...
386s autopkgtest [17:16:50]: rebooting testbed after setup commands that affected boot
409s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
537s autopkgtest [17:19:22]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 16 14:19:41 UTC 2024
560s autopkgtest [17:19:45]: @@@@@@@@@@@@@@@@@@@@ apt-source dovecot
803s Get:1 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (dsc) [4195 B]
803s Get:2 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (tar) [1688 kB]
803s Get:3 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (tar) [7842 kB]
803s Get:4 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (asc) [866 B]
803s Get:5 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (diff) [70.0 kB]
804s gpgv: Signature made Tue Aug 27 21:06:16 2024 UTC
804s gpgv:                using RSA key 63EEFC3DE14D5146CE7F24BF34B8AD7D9529E793
804s gpgv: Can't check signature: No public key
804s dpkg-source: warning: cannot verify inline signature for ./dovecot_2.3.21.1+dfsg1-1ubuntu1.dsc: no acceptable signature found
804s autopkgtest [17:23:49]: testing package dovecot version 1:2.3.21.1+dfsg1-1ubuntu1
806s autopkgtest [17:23:51]: build not needed
819s autopkgtest [17:24:04]: test doveadm: preparing testbed
821s Reading package lists...
821s Building dependency tree...
821s Reading state information...
822s Starting pkgProblemResolver with broken count: 0
822s Starting 2 pkgProblemResolver with broken count: 0
822s Done
823s The following additional packages will be installed:
823s   dovecot-core libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23
823s   libstemmer0d ssl-cert
823s Suggested packages:
823s   dovecot-gssapi dovecot-imapd dovecot-ldap dovecot-lmtpd dovecot-managesieved
823s   dovecot-mysql dovecot-pgsql dovecot-pop3d dovecot-sieve dovecot-solr
823s   dovecot-sqlite dovecot-submissiond ntp
823s The following NEW packages will be installed:
823s   autopkgtest-satdep dovecot-core libexttextcat-2.0-0 libexttextcat-data
823s   liblua5.4-0 libsodium23 libstemmer0d ssl-cert
823s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
823s Need to get 3956 kB/3956 kB of archives.
823s After this operation, 16.1 MB of additional disk space will be used.
823s Get:1 /tmp/autopkgtest.Iw9HQa/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [704 B]
823s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 ssl-cert all 1.1.2ubuntu2 [18.0 kB]
823s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-data all 3.4.7-1build1 [193 kB]
823s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-2.0-0 arm64 3.4.7-1build1 [13.3 kB]
823s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 liblua5.4-0 arm64 5.4.6-3build2 [158 kB]
823s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libsodium23 arm64 1.0.18-1build3 [119 kB]
823s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 libstemmer0d arm64 2.2.0-4build1 [160 kB]
823s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-core arm64 1:2.3.21.1+dfsg1-1ubuntu1 [3295 kB]
824s Preconfiguring packages ...
824s Fetched 3956 kB in 1s (4796 kB/s)
824s Selecting previously unselected package ssl-cert.
824s (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 ... 79924 files and directories currently installed.)
824s Preparing to unpack .../0-ssl-cert_1.1.2ubuntu2_all.deb ...
824s Unpacking ssl-cert (1.1.2ubuntu2) ...
824s Selecting previously unselected package libexttextcat-data.
824s Preparing to unpack .../1-libexttextcat-data_3.4.7-1build1_all.deb ...
824s Unpacking libexttextcat-data (3.4.7-1build1) ...
824s Selecting previously unselected package libexttextcat-2.0-0:arm64.
825s Preparing to unpack .../2-libexttextcat-2.0-0_3.4.7-1build1_arm64.deb ...
825s Unpacking libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
825s Selecting previously unselected package liblua5.4-0:arm64.
825s Preparing to unpack .../3-liblua5.4-0_5.4.6-3build2_arm64.deb ...
825s Unpacking liblua5.4-0:arm64 (5.4.6-3build2) ...
825s Selecting previously unselected package libsodium23:arm64.
825s Preparing to unpack .../4-libsodium23_1.0.18-1build3_arm64.deb ...
825s Unpacking libsodium23:arm64 (1.0.18-1build3) ...
825s Selecting previously unselected package libstemmer0d:arm64.
825s Preparing to unpack .../5-libstemmer0d_2.2.0-4build1_arm64.deb ...
825s Unpacking libstemmer0d:arm64 (2.2.0-4build1) ...
825s Selecting previously unselected package dovecot-core.
825s Preparing to unpack .../6-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
825s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
825s Selecting previously unselected package autopkgtest-satdep.
825s Preparing to unpack .../7-1-autopkgtest-satdep.deb ...
825s Unpacking autopkgtest-satdep (0) ...
825s Setting up libsodium23:arm64 (1.0.18-1build3) ...
825s Setting up ssl-cert (1.1.2ubuntu2) ...
826s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

826s Setting up libexttextcat-data (3.4.7-1build1) ...
826s Setting up liblua5.4-0:arm64 (5.4.6-3build2) ...
826s Setting up libstemmer0d:arm64 (2.2.0-4build1) ...
826s Setting up libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
826s Setting up dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
827s 
827s Creating config file /etc/dovecot/dovecot.conf with new version
827s 
827s Creating config file /etc/dovecot/dovecot-dict-auth.conf.ext with new version
827s 
827s Creating config file /etc/dovecot/dovecot-dict-sql.conf.ext with new version
828s 
828s Creating config file /etc/dovecot/dovecot-sql.conf.ext with new version
828s 
828s Creating config file /etc/dovecot/conf.d/10-auth.conf with new version
829s 
829s Creating config file /etc/dovecot/conf.d/10-director.conf with new version
829s 
829s Creating config file /etc/dovecot/conf.d/10-logging.conf with new version
830s 
830s Creating config file /etc/dovecot/conf.d/10-mail.conf with new version
830s 
830s Creating config file /etc/dovecot/conf.d/10-master.conf with new version
831s 
831s Creating config file /etc/dovecot/conf.d/10-ssl.conf with new version
831s 
831s Creating config file /etc/dovecot/conf.d/10-tcpwrapper.conf with new version
831s 
831s Creating config file /etc/dovecot/conf.d/15-lda.conf with new version
832s 
832s Creating config file /etc/dovecot/conf.d/15-mailboxes.conf with new version
832s 
832s Creating config file /etc/dovecot/conf.d/90-acl.conf with new version
833s 
833s Creating config file /etc/dovecot/conf.d/90-plugin.conf with new version
833s 
833s Creating config file /etc/dovecot/conf.d/90-quota.conf with new version
833s 
833s Creating config file /etc/dovecot/conf.d/auth-checkpassword.conf.ext with new version
834s 
834s Creating config file /etc/dovecot/conf.d/auth-deny.conf.ext with new version
834s 
834s Creating config file /etc/dovecot/conf.d/auth-dict.conf.ext with new version
834s 
834s Creating config file /etc/dovecot/conf.d/auth-master.conf.ext with new version
835s 
835s Creating config file /etc/dovecot/conf.d/auth-passwdfile.conf.ext with new version
835s 
835s Creating config file /etc/dovecot/conf.d/auth-sql.conf.ext with new version
835s 
835s Creating config file /etc/dovecot/conf.d/auth-static.conf.ext with new version
835s 
835s Creating config file /etc/dovecot/conf.d/auth-system.conf.ext with new version
836s Created symlink '/etc/systemd/system/multi-user.target.wants/dovecot.service' → '/usr/lib/systemd/system/dovecot.service'.

836s dovecot.socket is a disabled or a static unit, not starting it.
836s Setting up autopkgtest-satdep (0) ...
836s Processing triggers for man-db (2.12.1-3) ...
838s Processing triggers for libc-bin (2.40-1ubuntu3) ...
891s (Reading database ... 80687 files and directories currently installed.)
891s Removing autopkgtest-satdep (0) ...
904s autopkgtest [17:25:29]: test doveadm: [-----------------------
904s Checking if dovecot is running
904s OK
904s autopkgtest [17:25:29]: test doveadm: -----------------------]
905s autopkgtest [17:25:30]: test doveadm:  - - - - - - - - - - results - - - - - - - - - -
905s doveadm              PASS
934s autopkgtest [17:25:59]: test systemd: preparing testbed
1045s Reading package lists...
1045s Building dependency tree...
1045s Reading state information...
1046s Starting pkgProblemResolver with broken count: 0
1046s Starting 2 pkgProblemResolver with broken count: 0
1046s Done
1047s The following NEW packages will be installed:
1047s   autopkgtest-satdep
1047s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
1047s Need to get 0 B/720 B of archives.
1047s After this operation, 0 B of additional disk space will be used.
1047s Get:1 /tmp/autopkgtest.Iw9HQa/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [720 B]
1047s Selecting previously unselected package autopkgtest-satdep.
1047s (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 ... 80687 files and directories currently installed.)
1047s Preparing to unpack .../2-autopkgtest-satdep.deb ...
1047s Unpacking autopkgtest-satdep (0) ...
1047s Setting up autopkgtest-satdep (0) ...
1095s (Reading database ... 80687 files and directories currently installed.)
1095s Removing autopkgtest-satdep (0) ...
1104s autopkgtest [17:28:49]: test systemd: [-----------------------
1104s Checking whether dovecot.service is enabled
1104s enabled
1104s Checking whether dovecot.service is a native unit
1104s OK (no SourcePath found)
1104s Checking whether dovecot.socket is inactive
1104s inactive
1104s autopkgtest [17:28:49]: test systemd: -----------------------]
1105s autopkgtest [17:28:50]: test systemd:  - - - - - - - - - - results - - - - - - - - - -
1105s systemd              PASS
1110s autopkgtest [17:28:55]: test command1: preparing testbed
1296s autopkgtest [17:32:01]: testbed dpkg architecture: arm64
1296s autopkgtest [17:32:01]: testbed apt version: 2.9.8
1299s autopkgtest [17:32:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup
1305s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
1305s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
1305s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
1305s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
1305s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
1305s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [130 kB]
1305s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB]
1305s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [684 kB]
1305s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [18.2 kB]
1305s Fetched 2056 kB in 1s (2440 kB/s)
1305s Reading package lists...
1315s Reading package lists...
1316s Building dependency tree...
1316s Reading state information...
1316s Calculating upgrade...
1316s The following packages will be upgraded:
1316s   apparmor libapparmor1 libgnutls30t64 libjson-glib-1.0-0
1316s   libjson-glib-1.0-common libutempter0
1317s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1317s Need to get 1731 kB of archives.
1317s After this operation, 1024 B of additional disk space will be used.
1317s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libgnutls30t64 arm64 3.8.8-2ubuntu1 [956 kB]
1317s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libapparmor1 arm64 4.1.0~beta1-0ubuntu4 [51.8 kB]
1317s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 apparmor arm64 4.1.0~beta1-0ubuntu4 [642 kB]
1317s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
1317s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-0 arm64 1.10.0+ds-3 [66.5 kB]
1317s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libutempter0 arm64 1.2.1-4 [9646 B]
1317s Preconfiguring packages ...
1317s Fetched 1731 kB in 1s (2733 kB/s)
1318s (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 ... 79924 files and directories currently installed.)
1318s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_arm64.deb ...
1318s Unpacking libgnutls30t64:arm64 (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
1318s Setting up libgnutls30t64:arm64 (3.8.8-2ubuntu1) ...
1318s (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 ... 79924 files and directories currently installed.)
1318s Preparing to unpack .../libapparmor1_4.1.0~beta1-0ubuntu4_arm64.deb ...
1318s Unpacking libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
1318s Preparing to unpack .../apparmor_4.1.0~beta1-0ubuntu4_arm64.deb ...
1318s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
1319s Preparing to unpack .../libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
1319s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
1319s Preparing to unpack .../libjson-glib-1.0-0_1.10.0+ds-3_arm64.deb ...
1319s Unpacking libjson-glib-1.0-0:arm64 (1.10.0+ds-3) over (1.10.0+ds-2) ...
1319s Preparing to unpack .../libutempter0_1.2.1-4_arm64.deb ...
1319s Unpacking libutempter0:arm64 (1.2.1-4) over (1.2.1-3build1) ...
1319s Setting up libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) ...
1319s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
1320s Reloading AppArmor profiles 
1321s Setting up libutempter0:arm64 (1.2.1-4) ...
1321s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
1321s Setting up libjson-glib-1.0-0:arm64 (1.10.0+ds-3) ...
1321s Processing triggers for man-db (2.12.1-3) ...
1322s Processing triggers for libc-bin (2.40-1ubuntu3) ...
1322s Reading package lists...
1322s Building dependency tree...
1322s Reading state information...
1323s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1334s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
1334s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
1334s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
1334s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
1335s Reading package lists...
1336s Reading package lists...
1336s Building dependency tree...
1336s Reading state information...
1336s Calculating upgrade...
1336s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1336s Reading package lists...
1336s Building dependency tree...
1336s Reading state information...
1337s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1337s autopkgtest [17:32:42]: rebooting testbed after setup commands that affected boot
1342s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
1413s Reading package lists...
1413s Building dependency tree...
1413s Reading state information...
1414s Starting pkgProblemResolver with broken count: 0
1414s Starting 2 pkgProblemResolver with broken count: 0
1414s Done
1414s The following additional packages will be installed:
1430s   dovecot-core dovecot-imapd dovecot-pop3d libexttextcat-2.0-0
1430s   libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d ssl-cert
1430s Suggested packages:
1430s   dovecot-gssapi dovecot-ldap dovecot-lmtpd dovecot-managesieved dovecot-mysql
1430s   dovecot-pgsql dovecot-sieve dovecot-solr dovecot-sqlite dovecot-submissiond
1430s   ntp
1430s The following NEW packages will be installed:
1430s   autopkgtest-satdep dovecot-core dovecot-imapd dovecot-pop3d
1430s   libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d
1430s   ssl-cert
1430s 0 upgraded, 10 newly installed, 0 to remove and 0 not upgraded.
1430s Need to get 4181 kB/4182 kB of archives.
1430s After this operation, 17.3 MB of additional disk space will be used.
1430s Get:1 /tmp/autopkgtest.Iw9HQa/3-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B]
1430s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 ssl-cert all 1.1.2ubuntu2 [18.0 kB]
1430s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-data all 3.4.7-1build1 [193 kB]
1430s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-2.0-0 arm64 3.4.7-1build1 [13.3 kB]
1430s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 liblua5.4-0 arm64 5.4.6-3build2 [158 kB]
1430s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libsodium23 arm64 1.0.18-1build3 [119 kB]
1430s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 libstemmer0d arm64 2.2.0-4build1 [160 kB]
1430s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-core arm64 1:2.3.21.1+dfsg1-1ubuntu1 [3295 kB]
1430s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-imapd arm64 1:2.3.21.1+dfsg1-1ubuntu1 [189 kB]
1430s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-pop3d arm64 1:2.3.21.1+dfsg1-1ubuntu1 [36.6 kB]
1430s Preconfiguring packages ...
1430s Fetched 4181 kB in 1s (5537 kB/s)
1430s Selecting previously unselected package ssl-cert.
1430s (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 ... 79924 files and directories currently installed.)
1430s Preparing to unpack .../0-ssl-cert_1.1.2ubuntu2_all.deb ...
1430s Unpacking ssl-cert (1.1.2ubuntu2) ...
1430s Selecting previously unselected package libexttextcat-data.
1430s Preparing to unpack .../1-libexttextcat-data_3.4.7-1build1_all.deb ...
1430s Unpacking libexttextcat-data (3.4.7-1build1) ...
1430s Selecting previously unselected package libexttextcat-2.0-0:arm64.
1430s Preparing to unpack .../2-libexttextcat-2.0-0_3.4.7-1build1_arm64.deb ...
1430s Unpacking libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
1430s Selecting previously unselected package liblua5.4-0:arm64.
1430s Preparing to unpack .../3-liblua5.4-0_5.4.6-3build2_arm64.deb ...
1430s Unpacking liblua5.4-0:arm64 (5.4.6-3build2) ...
1430s Selecting previously unselected package libsodium23:arm64.
1430s Preparing to unpack .../4-libsodium23_1.0.18-1build3_arm64.deb ...
1430s Unpacking libsodium23:arm64 (1.0.18-1build3) ...
1430s Selecting previously unselected package libstemmer0d:arm64.
1430s Preparing to unpack .../5-libstemmer0d_2.2.0-4build1_arm64.deb ...
1430s Unpacking libstemmer0d:arm64 (2.2.0-4build1) ...
1430s Selecting previously unselected package dovecot-core.
1430s Preparing to unpack .../6-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
1430s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s Selecting previously unselected package dovecot-imapd.
1430s Preparing to unpack .../7-dovecot-imapd_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
1430s Unpacking dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s Selecting previously unselected package dovecot-pop3d.
1430s Preparing to unpack .../8-dovecot-pop3d_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
1430s Unpacking dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s Selecting previously unselected package autopkgtest-satdep.
1430s Preparing to unpack .../9-3-autopkgtest-satdep.deb ...
1430s Unpacking autopkgtest-satdep (0) ...
1430s Setting up libsodium23:arm64 (1.0.18-1build3) ...
1430s Setting up ssl-cert (1.1.2ubuntu2) ...
1430s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

1430s Setting up libexttextcat-data (3.4.7-1build1) ...
1430s Setting up liblua5.4-0:arm64 (5.4.6-3build2) ...
1430s Setting up libstemmer0d:arm64 (2.2.0-4build1) ...
1430s Setting up libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
1430s Setting up dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s 
1430s Creating config file /etc/dovecot/dovecot.conf with new version
1430s 
1430s Creating config file /etc/dovecot/dovecot-dict-auth.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/dovecot-dict-sql.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/dovecot-sql.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-auth.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-director.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-logging.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-mail.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-master.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-ssl.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/10-tcpwrapper.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/15-lda.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/15-mailboxes.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/90-acl.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/90-plugin.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/90-quota.conf with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-checkpassword.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-deny.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-dict.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-master.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-passwdfile.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-sql.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-static.conf.ext with new version
1430s 
1430s Creating config file /etc/dovecot/conf.d/auth-system.conf.ext with new version
1430s Created symlink '/etc/systemd/system/multi-user.target.wants/dovecot.service' → '/usr/lib/systemd/system/dovecot.service'.

1430s dovecot.socket is a disabled or a static unit, not starting it.
1430s Setting up dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s 
1430s Creating config file /etc/dovecot/conf.d/20-imap.conf with new version
1430s Setting up dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
1430s 
1430s Creating config file /etc/dovecot/conf.d/20-pop3.conf with new version
1430s Setting up autopkgtest-satdep (0) ...
1430s Processing triggers for ufw (0.36.2-8) ...
1430s Processing triggers for man-db (2.12.1-3) ...
1430s Processing triggers for libc-bin (2.40-1ubuntu3) ...
1430s Processing triggers for dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
1484s (Reading database ... 80712 files and directories currently installed.)
1484s Removing autopkgtest-satdep (0) ...
1793s autopkgtest [17:40:18]: test command1: run-parts --report --exit-on-error debian/tests/usage
1793s autopkgtest [17:40:18]: test command1: [-----------------------
1794s debian/tests/usage/00_setup:
1794s Setting up dovecot for the test
1794s Restarting the service
1795s Sending a test message via the LDA
1795s Verifying that the email was correctly delivered
1795s Done
1795s 
1795s debian/tests/usage/imap:
1795s   40:20.37 imaplib version 2.58
1795s   40:20.37 new IMAP4 connection, tag=b'BMPN'
1795s   40:20.38 < b'* OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ STARTTLS AUTH=PLAIN] Dovecot (Ubuntu) ready.'
1795s   40:20.38 > b'BMPN0 CAPABILITY'
1795s   40:20.38 < b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ STARTTLS AUTH=PLAIN'
1795s   40:20.38 < b'BMPN0 OK Pre-login capabilities listed, post-login capabilities have more.'
1795s   40:20.38 CAPABILITIES: ('IMAP4REV1', 'SASL-IR', 'LOGIN-REFERRALS', 'ID', 'ENABLE', 'IDLE', 'LITERAL+', 'STARTTLS', 'AUTH=PLAIN')
1795s   40:20.38 > b'BMPN1 STARTTLS'
1795s   40:20.38 < b'BMPN1 OK Begin TLS negotiation now.'
1795s   40:20.40 > b'BMPN2 CAPABILITY'
1795s   40:20.40 < b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ AUTH=PLAIN'
1795s   40:20.40 < b'BMPN2 OK Pre-login capabilities listed, post-login capabilities have more.'
1795s   40:20.40 > b'BMPN3 LOGIN dep8 "test"'
1795s   40:20.41 < b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SNIPPET=FUZZY PREVIEW=FUZZY PREVIEW STATUS=SIZE SAVEDATE LITERAL+ NOTIFY SPECIAL-USE'
1795s   40:20.41 < b'BMPN3 OK Logged in'
1795s   40:20.41 > b'BMPN4 SELECT INBOX'
1795s   40:20.41 < b'* FLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft)'
1795s   40:20.41 < b'* OK [PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft \\*)] Flags permitted.'
1795s   40:20.41 < b'* 1 EXISTS'
1795s   40:20.41 < b'* 1 RECENT'
1795s   40:20.41 < b'* OK [UNSEEN 1] First unseen.'
1795s   40:20.41 < b'* OK [UIDVALIDITY 1731519620] UIDs valid'
1795s   40:20.41 < b'* OK [UIDNEXT 2] Predicted next UID'
1795s   40:20.41 < b'BMPN4 OK [READ-WRITE] Select completed (0.001 + 0.000 secs).'
1795s   40:20.41 > b'BMPN5 SEARCH HEADER MESSAGE-ID "<dep8-test-1@debian.org>"'
1795s   40:20.41 < b'* SEARCH 1'
1795s   40:20.41 < b'BMPN5 OK Search completed (0.001 + 0.000 secs).'
1795s   40:20.41 > b'BMPN6 FETCH 1 (RFC822)'
1795s Testing IMAP
1795s Connecting
1795s Checking for STARTTLS capability
1795s Logging in
1795s Selecting INBOX
1795s Looking for the test message
1795s Fetching and verifying test message
1795s Done
1795s   40:20.41 < b'* 1 FETCH (FLAGS (\\Seen \\Recent) RFC822 {180}'
1795s   40:20.41 read literal size 180
1795s   40:20.41 < b')'
1795s   40:20.41 < b'BMPN6 OK Fetch completed (0.001 + 0.000 secs).'
1795s debian/tests/usage/pop3:
1795s Testing POP3
1795s Connecting
1795s Checking for STARTTLS capability
1795s *cmd* 'CAPA'
1795s *put* b'CAPA'
1795s *get* b'+OK\r\n'
1795s *resp* b'+OK'
1795s *get* b'CAPA\r\n'
1795s *get* b'TOP\r\n'
1795s *get* b'UIDL\r\n'
1795s *get* b'RESP-CODES\r\n'
1795s *get* b'PIPELINING\r\n'
1795s *get* b'AUTH-RESP-CODE\r\n'
1795s *get* b'STLS\r\n'
1795s *get* b'USER\r\n'
1795s *get* b'SASL PLAIN\r\n'
1795s *get* b'.\r\n'
1795s *cmd* 'CAPA'
1795s *put* b'CAPA'
1795s *get* b'+OK\r\n'
1795s *resp* b'+OK'
1795s *get* b'CAPA\r\n'
1795s *get* b'TOP\r\n'
1795s *get* b'UIDL\r\n'
1795s *get* b'RESP-CODES\r\n'
1795s *get* b'PIPELINING\r\n'
1795s *get* b'AUTH-RESP-CODE\r\n'
1795s *get* b'STLS\r\n'
1795s *get* b'USER\r\n'
1795s *get* b'SASL PLAIN\r\n'
1795s *get* b'.\r\n'
1795s *cmd* 'STLS'
1795s *put* b'STLS'
1795s *get* b'+OK Begin TLS negotiation now.\r\n'
1795s *resp* b'+OK Begin TLS negotiation now.'
1795s Logging in
1795s *cmd* 'USER dep8'
1795s *put* b'USER dep8'
1795s *get* b'+OK\r\n'
1795s *resp* b'+OK'
1795s *cmd* 'PASS test'
1795s *put* b'PASS test'
1795s *get* b'+OK Logged in.\r\n'
1795s *resp* b'+OK Logged in.'
1795s Listing INBOX
1795s *cmd* 'LIST'
1795s *put* b'LIST'
1795s *get* b'+OK 1 messages:\r\n'
1795s *resp* b'+OK 1 messages:'
1795s *get* b'1 180\r\n'
1795s *get* b'.\r\n'
1795s Fetching and verifying test message
1795s *cmd* 'RETR 1'
1795s *put* b'RETR 1'
1795s *get* b'+OK 180 octets\r\n'
1795s *resp* b'+OK 180 octets'
1795s *get* b'Return-Path: <test@example.com>\r\n'
1795s *get* b'Message-Id: <dep8-test-1@debian.org>\r\n'
1795s *get* b'From: Test User <test@example.com>\r\n'
1795s *get* b'To: dep8 <dep8@example.com>\r\n'
1795s *get* b'Subject: DEP-8 test\r\n'
1795s *get* b'\r\n'
1795s *get* b'This is just a test\r\n'
1795s *get* b'.\r\n'
1795s Done
1795s autopkgtest [17:40:20]: test command1: -----------------------]
1796s autopkgtest [17:40:21]: test command1:  - - - - - - - - - - results - - - - - - - - - -
1796s command1             PASS
1827s autopkgtest [17:40:50]: test testmails: preparing testbed
2044s autopkgtest [17:44:29]: testbed dpkg architecture: arm64
2044s autopkgtest [17:44:29]: testbed apt version: 2.9.8
2044s autopkgtest [17:44:29]: @@@@@@@@@@@@@@@@@@@@ test bed setup
2053s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
2054s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
2054s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
2054s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
2054s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
2054s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [130 kB]
2054s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 Packages [50.3 kB]
2054s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [684 kB]
2054s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [18.2 kB]
2054s Fetched 2056 kB in 1s (2328 kB/s)
2054s Reading package lists...
2063s Reading package lists...
2063s Building dependency tree...
2063s Reading state information...
2064s Calculating upgrade...
2065s The following packages will be upgraded:
2065s   apparmor libapparmor1 libgnutls30t64 libjson-glib-1.0-0
2065s   libjson-glib-1.0-common libutempter0
2066s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
2066s Need to get 1731 kB of archives.
2066s After this operation, 1024 B of additional disk space will be used.
2066s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libgnutls30t64 arm64 3.8.8-2ubuntu1 [956 kB]
2066s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libapparmor1 arm64 4.1.0~beta1-0ubuntu4 [51.8 kB]
2066s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 apparmor arm64 4.1.0~beta1-0ubuntu4 [642 kB]
2066s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
2066s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 libjson-glib-1.0-0 arm64 1.10.0+ds-3 [66.5 kB]
2066s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libutempter0 arm64 1.2.1-4 [9646 B]
2067s Preconfiguring packages ...
2067s Fetched 1731 kB in 1s (2581 kB/s)
2067s (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 ... 79924 files and directories currently installed.)
2067s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_arm64.deb ...
2067s Unpacking libgnutls30t64:arm64 (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
2067s Setting up libgnutls30t64:arm64 (3.8.8-2ubuntu1) ...
2067s (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 ... 79924 files and directories currently installed.)
2067s Preparing to unpack .../libapparmor1_4.1.0~beta1-0ubuntu4_arm64.deb ...
2067s Unpacking libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
2067s Preparing to unpack .../apparmor_4.1.0~beta1-0ubuntu4_arm64.deb ...
2068s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
2068s Preparing to unpack .../libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
2068s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
2068s Preparing to unpack .../libjson-glib-1.0-0_1.10.0+ds-3_arm64.deb ...
2068s Unpacking libjson-glib-1.0-0:arm64 (1.10.0+ds-3) over (1.10.0+ds-2) ...
2068s Preparing to unpack .../libutempter0_1.2.1-4_arm64.deb ...
2068s Unpacking libutempter0:arm64 (1.2.1-4) over (1.2.1-3build1) ...
2068s Setting up libapparmor1:arm64 (4.1.0~beta1-0ubuntu4) ...
2068s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
2070s Reloading AppArmor profiles 
2071s Setting up libutempter0:arm64 (1.2.1-4) ...
2071s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
2071s Setting up libjson-glib-1.0-0:arm64 (1.10.0+ds-3) ...
2071s Processing triggers for man-db (2.12.1-3) ...
2075s Processing triggers for libc-bin (2.40-1ubuntu3) ...
2075s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
2075s Reading package lists...
2075s Building dependency tree...
2075s Reading state information...
2075s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
2075s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
2075s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
2075s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
2075s Reading package lists...
2075s Reading package lists...
2075s Building dependency tree...
2075s Reading state information...
2075s Calculating upgrade...
2076s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
2076s Reading package lists...
2076s Building dependency tree...
2076s Reading state information...
2077s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
2077s autopkgtest [17:45:02]: rebooting testbed after setup commands that affected boot
2081s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
2131s Reading package lists...
2132s Building dependency tree...
2132s Reading state information...
2132s Starting pkgProblemResolver with broken count: 0
2132s Starting 2 pkgProblemResolver with broken count: 0
2132s Done
2133s The following additional packages will be installed:
2133s   dovecot-core dovecot-imapd dovecot-pop3d libexttextcat-2.0-0
2133s   libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d python3-passlib
2133s   ssl-cert
2133s Suggested packages:
2133s   dovecot-gssapi dovecot-ldap dovecot-lmtpd dovecot-managesieved dovecot-mysql
2133s   dovecot-pgsql dovecot-sieve dovecot-solr dovecot-sqlite dovecot-submissiond
2133s   ntp
2133s The following NEW packages will be installed:
2133s   autopkgtest-satdep dovecot-core dovecot-imapd dovecot-pop3d
2133s   libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d
2133s   python3-passlib ssl-cert
2143s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
2143s Need to get 4657 kB/4658 kB of archives.
2143s After this operation, 19.4 MB of additional disk space will be used.
2143s Get:1 /tmp/autopkgtest.Iw9HQa/4-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [744 B]
2143s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 ssl-cert all 1.1.2ubuntu2 [18.0 kB]
2143s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-data all 3.4.7-1build1 [193 kB]
2143s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libexttextcat-2.0-0 arm64 3.4.7-1build1 [13.3 kB]
2143s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 liblua5.4-0 arm64 5.4.6-3build2 [158 kB]
2143s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 libsodium23 arm64 1.0.18-1build3 [119 kB]
2143s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 libstemmer0d arm64 2.2.0-4build1 [160 kB]
2143s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-core arm64 1:2.3.21.1+dfsg1-1ubuntu1 [3295 kB]
2143s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-imapd arm64 1:2.3.21.1+dfsg1-1ubuntu1 [189 kB]
2143s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 dovecot-pop3d arm64 1:2.3.21.1+dfsg1-1ubuntu1 [36.6 kB]
2143s Get:11 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-passlib all 1.7.4-4 [476 kB]
2143s Preconfiguring packages ...
2143s Fetched 4657 kB in 1s (6174 kB/s)
2143s Selecting previously unselected package ssl-cert.
2143s (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 ... 79924 files and directories currently installed.)
2143s Preparing to unpack .../00-ssl-cert_1.1.2ubuntu2_all.deb ...
2143s Unpacking ssl-cert (1.1.2ubuntu2) ...
2143s Selecting previously unselected package libexttextcat-data.
2143s Preparing to unpack .../01-libexttextcat-data_3.4.7-1build1_all.deb ...
2143s Unpacking libexttextcat-data (3.4.7-1build1) ...
2143s Selecting previously unselected package libexttextcat-2.0-0:arm64.
2143s Preparing to unpack .../02-libexttextcat-2.0-0_3.4.7-1build1_arm64.deb ...
2143s Unpacking libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
2143s Selecting previously unselected package liblua5.4-0:arm64.
2143s Preparing to unpack .../03-liblua5.4-0_5.4.6-3build2_arm64.deb ...
2143s Unpacking liblua5.4-0:arm64 (5.4.6-3build2) ...
2143s Selecting previously unselected package libsodium23:arm64.
2143s Preparing to unpack .../04-libsodium23_1.0.18-1build3_arm64.deb ...
2143s Unpacking libsodium23:arm64 (1.0.18-1build3) ...
2143s Selecting previously unselected package libstemmer0d:arm64.
2143s Preparing to unpack .../05-libstemmer0d_2.2.0-4build1_arm64.deb ...
2143s Unpacking libstemmer0d:arm64 (2.2.0-4build1) ...
2143s Selecting previously unselected package dovecot-core.
2143s Preparing to unpack .../06-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
2143s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s Selecting previously unselected package dovecot-imapd.
2143s Preparing to unpack .../07-dovecot-imapd_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
2143s Unpacking dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s Selecting previously unselected package dovecot-pop3d.
2143s Preparing to unpack .../08-dovecot-pop3d_1%3a2.3.21.1+dfsg1-1ubuntu1_arm64.deb ...
2143s Unpacking dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s Selecting previously unselected package python3-passlib.
2143s Preparing to unpack .../09-python3-passlib_1.7.4-4_all.deb ...
2143s Unpacking python3-passlib (1.7.4-4) ...
2143s Selecting previously unselected package autopkgtest-satdep.
2143s Preparing to unpack .../10-4-autopkgtest-satdep.deb ...
2143s Unpacking autopkgtest-satdep (0) ...
2143s Setting up libsodium23:arm64 (1.0.18-1build3) ...
2143s Setting up python3-passlib (1.7.4-4) ...
2143s Setting up ssl-cert (1.1.2ubuntu2) ...
2143s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

2143s Setting up libexttextcat-data (3.4.7-1build1) ...
2143s Setting up liblua5.4-0:arm64 (5.4.6-3build2) ...
2143s Setting up libstemmer0d:arm64 (2.2.0-4build1) ...
2143s Setting up libexttextcat-2.0-0:arm64 (3.4.7-1build1) ...
2143s Setting up dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s 
2143s Creating config file /etc/dovecot/dovecot.conf with new version
2143s 
2143s Creating config file /etc/dovecot/dovecot-dict-auth.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/dovecot-dict-sql.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/dovecot-sql.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-auth.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-director.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-logging.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-mail.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-master.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-ssl.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/10-tcpwrapper.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/15-lda.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/15-mailboxes.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/90-acl.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/90-plugin.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/90-quota.conf with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-checkpassword.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-deny.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-dict.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-master.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-passwdfile.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-sql.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-static.conf.ext with new version
2143s 
2143s Creating config file /etc/dovecot/conf.d/auth-system.conf.ext with new version
2143s Created symlink '/etc/systemd/system/multi-user.target.wants/dovecot.service' → '/usr/lib/systemd/system/dovecot.service'.

2143s dovecot.socket is a disabled or a static unit, not starting it.
2143s Setting up dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s 
2143s Creating config file /etc/dovecot/conf.d/20-imap.conf with new version
2143s Setting up dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
2143s 
2143s Creating config file /etc/dovecot/conf.d/20-pop3.conf with new version
2143s Setting up autopkgtest-satdep (0) ...
2143s Processing triggers for ufw (0.36.2-8) ...
2143s Processing triggers for man-db (2.12.1-3) ...
2144s Processing triggers for libc-bin (2.40-1ubuntu3) ...
2144s Processing triggers for dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
2149s (Reading database ... 80838 files and directories currently installed.)
2149s Removing autopkgtest-satdep (0) ...
2168s autopkgtest [17:46:33]: test testmails: [-----------------------
2168s test_imap (__main__.DovecotBasics.test_imap)
2187s Test IMAP4 protocol. ... ok
2187s test_imaps (__main__.DovecotBasics.test_imaps)
2207s Test IMAP4S protocol. ... ok
2207s test_pop3 (__main__.DovecotBasics.test_pop3)
2226s Test POP3 protocol. ... ok
2226s test_pop3s (__main__.DovecotBasics.test_pop3s)
2245s Test POP3S protocol. ... ok
2245s 
2245s ----------------------------------------------------------------------
2245s Ran 4 tests in 76.924s
2245s 
2245s OK
2246s autopkgtest [17:47:51]: test testmails: -----------------------]
2247s testmails            PASS
2247s autopkgtest [17:47:52]: test testmails:  - - - - - - - - - - results - - - - - - - - - -
2247s autopkgtest [17:47:52]: @@@@@@@@@@@@@@@@@@@@ summary
2247s doveadm              PASS
2247s systemd              PASS
2247s command1             PASS
2247s testmails            PASS
2259s virt: nova [W] Skipping flock in bos03-arm64
2259s virt: Creating nova instance adt-plucky-arm64-dovecot-20241113-125337-juju-7f2275-prod-proposed-migration-environment-2-99afae3e-90df-440f-8035-f2745962e9eb from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...
2259s virt: nova [W] Skipping flock in bos03-arm64
2259s virt: Creating nova instance adt-plucky-arm64-dovecot-20241113-125337-juju-7f2275-prod-proposed-migration-environment-2-99afae3e-90df-440f-8035-f2745962e9eb from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...
2259s virt: nova [W] Skipping flock in bos03-arm64
2259s virt: Creating nova instance adt-plucky-arm64-dovecot-20241113-125337-juju-7f2275-prod-proposed-migration-environment-2-99afae3e-90df-440f-8035-f2745962e9eb from image adt/ubuntu-plucky-arm64-server-20241113.img (UUID 2d7760e6-2439-4200-89d6-5ed33e5c6330)...