0s autopkgtest [17:04:31]: starting date and time: 2024-11-13 17:04:31+0000
  0s autopkgtest [17:04:31]: git checkout: 6f3be7a8 Fix armhf LXD image generation for plucky
  0s autopkgtest [17:04:31]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.u_t_bm65/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-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-s390x-3.secgroup --name adt-plucky-s390x-dovecot-20241113-170430-juju-7f2275-prod-proposed-migration-environment-20-8c2590d7-f95a-4fdd-afda-7ad9886c3588 --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-s390x -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/
 89s autopkgtest [17:06:00]: testbed dpkg architecture: s390x
 89s autopkgtest [17:06:00]: testbed apt version: 2.9.8
 89s autopkgtest [17:06:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 90s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
 90s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
 90s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
 90s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
 90s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
 90s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [112 kB]
 90s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [646 kB]
 90s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [17.8 kB]
 90s Fetched 1949 kB in 1s (2546 kB/s)
 91s Reading package lists...
 92s Reading package lists...
 93s Building dependency tree...
 93s Reading state information...
 93s Calculating upgrade...
 93s The following packages will be upgraded:
 93s   apparmor libapparmor1 libgnutls30t64 libgpgme11t64 libjson-glib-1.0-0
 93s   libjson-glib-1.0-common libutempter0
 93s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 93s Need to get 1975 kB of archives.
 93s After this operation, 7168 B of additional disk space will be used.
 93s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libgnutls30t64 s390x 3.8.8-2ubuntu1 [950 kB]
 94s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libapparmor1 s390x 4.1.0~beta1-0ubuntu4 [52.7 kB]
 94s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x apparmor s390x 4.1.0~beta1-0ubuntu4 [739 kB]
 94s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB]
 94s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
 94s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-0 s390x 1.10.0+ds-3 [67.5 kB]
 94s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libutempter0 s390x 1.2.1-4 [9708 B]
 94s Preconfiguring packages ...
 94s Fetched 1975 kB in 1s (2416 kB/s)
 94s (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 ... 55510 files and directories currently installed.)
 94s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_s390x.deb ...
 94s Unpacking libgnutls30t64:s390x (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
 94s Setting up libgnutls30t64:s390x (3.8.8-2ubuntu1) ...
 94s (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 ... 55510 files and directories currently installed.)
 94s Preparing to unpack .../0-libapparmor1_4.1.0~beta1-0ubuntu4_s390x.deb ...
 94s Unpacking libapparmor1:s390x (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
 94s Preparing to unpack .../1-apparmor_4.1.0~beta1-0ubuntu4_s390x.deb ...
 94s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
 95s Preparing to unpack .../2-libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ...
 95s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ...
 95s Preparing to unpack .../3-libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
 95s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
 95s Preparing to unpack .../4-libjson-glib-1.0-0_1.10.0+ds-3_s390x.deb ...
 95s Unpacking libjson-glib-1.0-0:s390x (1.10.0+ds-3) over (1.10.0+ds-2) ...
 95s Preparing to unpack .../5-libutempter0_1.2.1-4_s390x.deb ...
 95s Unpacking libutempter0:s390x (1.2.1-4) over (1.2.1-3build1) ...
 95s Setting up libapparmor1:s390x (4.1.0~beta1-0ubuntu4) ...
 95s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
 95s Reloading AppArmor profiles 
 96s Setting up libutempter0:s390x (1.2.1-4) ...
 96s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
 96s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ...
 96s Setting up libjson-glib-1.0-0:s390x (1.10.0+ds-3) ...
 96s Processing triggers for man-db (2.12.1-3) ...
 97s Processing triggers for libc-bin (2.40-1ubuntu3) ...
 97s Reading package lists...
 97s Building dependency tree...
 97s Reading state information...
 97s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 98s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
 98s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
 98s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
 98s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
 99s Reading package lists...
 99s Reading package lists...
 99s Building dependency tree...
 99s Reading state information...
 99s Calculating upgrade...
 99s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
 99s Reading package lists...
 99s Building dependency tree...
 99s Reading state information...
 99s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
100s autopkgtest [17:06:11]: rebooting testbed after setup commands that affected boot
104s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
116s autopkgtest [17:06:27]: testbed running kernel: Linux 6.11.0-8-generic #8-Ubuntu SMP Mon Sep 16 12:49:35 UTC 2024
118s autopkgtest [17:06:29]: @@@@@@@@@@@@@@@@@@@@ apt-source dovecot
127s Get:1 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (dsc) [4195 B]
127s Get:2 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (tar) [1688 kB]
127s Get:3 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (tar) [7842 kB]
127s Get:4 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (asc) [866 B]
127s Get:5 http://ftpmaster.internal/ubuntu plucky/main dovecot 1:2.3.21.1+dfsg1-1ubuntu1 (diff) [70.0 kB]
127s gpgv: Signature made Tue Aug 27 21:06:16 2024 UTC
127s gpgv:                using RSA key 63EEFC3DE14D5146CE7F24BF34B8AD7D9529E793
127s gpgv: Can't check signature: No public key
127s dpkg-source: warning: cannot verify inline signature for ./dovecot_2.3.21.1+dfsg1-1ubuntu1.dsc: no acceptable signature found
127s autopkgtest [17:06:38]: testing package dovecot version 1:2.3.21.1+dfsg1-1ubuntu1
128s autopkgtest [17:06:39]: build not needed
130s autopkgtest [17:06:41]: test doveadm: preparing testbed
131s Reading package lists...
131s Building dependency tree...
131s Reading state information...
131s Starting pkgProblemResolver with broken count: 0
131s Starting 2 pkgProblemResolver with broken count: 0
131s Done
131s The following additional packages will be installed:
131s   dovecot-core libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23
131s   libstemmer0d ssl-cert
131s Suggested packages:
131s   dovecot-gssapi dovecot-imapd dovecot-ldap dovecot-lmtpd dovecot-managesieved
131s   dovecot-mysql dovecot-pgsql dovecot-pop3d dovecot-sieve dovecot-solr
131s   dovecot-sqlite dovecot-submissiond ntp
131s The following NEW packages will be installed:
131s   autopkgtest-satdep dovecot-core libexttextcat-2.0-0 libexttextcat-data
131s   liblua5.4-0 libsodium23 libstemmer0d ssl-cert
131s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded.
131s Need to get 4077 kB/4077 kB of archives.
131s After this operation, 13.3 MB of additional disk space will be used.
131s Get:1 /tmp/autopkgtest.OlV5kl/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [712 B]
132s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB]
132s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-data all 3.4.7-1build1 [193 kB]
132s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-2.0-0 s390x 3.4.7-1build1 [14.1 kB]
132s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x liblua5.4-0 s390x 5.4.6-3build2 [179 kB]
132s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libsodium23 s390x 1.0.18-1build3 [138 kB]
132s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libstemmer0d s390x 2.2.0-4build1 [174 kB]
132s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-core s390x 1:2.3.21.1+dfsg1-1ubuntu1 [3361 kB]
133s Preconfiguring packages ...
133s Fetched 4077 kB in 1s (4338 kB/s)
133s Selecting previously unselected package ssl-cert.
133s (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 ... 55510 files and directories currently installed.)
133s Preparing to unpack .../0-ssl-cert_1.1.2ubuntu2_all.deb ...
133s Unpacking ssl-cert (1.1.2ubuntu2) ...
133s Selecting previously unselected package libexttextcat-data.
133s Preparing to unpack .../1-libexttextcat-data_3.4.7-1build1_all.deb ...
133s Unpacking libexttextcat-data (3.4.7-1build1) ...
133s Selecting previously unselected package libexttextcat-2.0-0:s390x.
133s Preparing to unpack .../2-libexttextcat-2.0-0_3.4.7-1build1_s390x.deb ...
133s Unpacking libexttextcat-2.0-0:s390x (3.4.7-1build1) ...
133s Selecting previously unselected package liblua5.4-0:s390x.
133s Preparing to unpack .../3-liblua5.4-0_5.4.6-3build2_s390x.deb ...
133s Unpacking liblua5.4-0:s390x (5.4.6-3build2) ...
133s Selecting previously unselected package libsodium23:s390x.
133s Preparing to unpack .../4-libsodium23_1.0.18-1build3_s390x.deb ...
133s Unpacking libsodium23:s390x (1.0.18-1build3) ...
133s Selecting previously unselected package libstemmer0d:s390x.
133s Preparing to unpack .../5-libstemmer0d_2.2.0-4build1_s390x.deb ...
133s Unpacking libstemmer0d:s390x (2.2.0-4build1) ...
133s Selecting previously unselected package dovecot-core.
133s Preparing to unpack .../6-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
133s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
133s Selecting previously unselected package autopkgtest-satdep.
133s Preparing to unpack .../7-1-autopkgtest-satdep.deb ...
133s Unpacking autopkgtest-satdep (0) ...
133s Setting up libsodium23:s390x (1.0.18-1build3) ...
133s Setting up ssl-cert (1.1.2ubuntu2) ...
134s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

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

138s dovecot.socket is a disabled or a static unit, not starting it.
138s Setting up autopkgtest-satdep (0) ...
138s Processing triggers for man-db (2.12.1-3) ...
139s Processing triggers for libc-bin (2.40-1ubuntu3) ...
141s (Reading database ... 56273 files and directories currently installed.)
141s Removing autopkgtest-satdep (0) ...
142s autopkgtest [17:06:53]: test doveadm: [-----------------------
142s Checking if dovecot is running
142s OK
142s autopkgtest [17:06:53]: test doveadm: -----------------------]
142s doveadm              PASS
142s autopkgtest [17:06:53]: test doveadm:  - - - - - - - - - - results - - - - - - - - - -
143s autopkgtest [17:06:54]: test systemd: preparing testbed
144s Reading package lists...
144s Building dependency tree...
144s Reading state information...
144s Starting pkgProblemResolver with broken count: 0
144s Starting 2 pkgProblemResolver with broken count: 0
144s Done
144s The following NEW packages will be installed:
144s   autopkgtest-satdep
144s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
144s Need to get 0 B/720 B of archives.
144s After this operation, 0 B of additional disk space will be used.
144s Get:1 /tmp/autopkgtest.OlV5kl/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B]
145s Selecting previously unselected package autopkgtest-satdep.
145s (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 ... 56273 files and directories currently installed.)
145s Preparing to unpack .../2-autopkgtest-satdep.deb ...
145s Unpacking autopkgtest-satdep (0) ...
145s Setting up autopkgtest-satdep (0) ...
146s (Reading database ... 56273 files and directories currently installed.)
146s Removing autopkgtest-satdep (0) ...
147s autopkgtest [17:06:57]: test systemd: [-----------------------
147s Checking whether dovecot.service is enabled
147s enabled
147s Checking whether dovecot.service is a native unit
147s OK (no SourcePath found)
147s Checking whether dovecot.socket is inactive
147s inactive
147s autopkgtest [17:06:58]: test systemd: -----------------------]
147s autopkgtest [17:06:58]: test systemd:  - - - - - - - - - - results - - - - - - - - - -
147s systemd              PASS
148s autopkgtest [17:06:59]: test command1: preparing testbed
226s autopkgtest [17:08:17]: testbed dpkg architecture: s390x
227s autopkgtest [17:08:18]: testbed apt version: 2.9.8
227s autopkgtest [17:08:18]: @@@@@@@@@@@@@@@@@@@@ test bed setup
227s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
228s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
228s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
228s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
228s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
228s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [112 kB]
228s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [646 kB]
228s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [17.8 kB]
228s Fetched 1949 kB in 1s (2346 kB/s)
228s Reading package lists...
230s Reading package lists...
230s Building dependency tree...
230s Reading state information...
230s Calculating upgrade...
230s The following packages will be upgraded:
230s   apparmor libapparmor1 libgnutls30t64 libgpgme11t64 libjson-glib-1.0-0
230s   libjson-glib-1.0-common libutempter0
230s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
230s Need to get 1975 kB of archives.
230s After this operation, 7168 B of additional disk space will be used.
230s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libgnutls30t64 s390x 3.8.8-2ubuntu1 [950 kB]
231s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libapparmor1 s390x 4.1.0~beta1-0ubuntu4 [52.7 kB]
231s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x apparmor s390x 4.1.0~beta1-0ubuntu4 [739 kB]
231s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB]
231s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
231s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-0 s390x 1.10.0+ds-3 [67.5 kB]
231s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libutempter0 s390x 1.2.1-4 [9708 B]
231s Preconfiguring packages ...
231s Fetched 1975 kB in 1s (2948 kB/s)
231s (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 ... 55510 files and directories currently installed.)
231s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_s390x.deb ...
231s Unpacking libgnutls30t64:s390x (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
231s Setting up libgnutls30t64:s390x (3.8.8-2ubuntu1) ...
231s (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 ... 55510 files and directories currently installed.)
231s Preparing to unpack .../0-libapparmor1_4.1.0~beta1-0ubuntu4_s390x.deb ...
231s Unpacking libapparmor1:s390x (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
231s Preparing to unpack .../1-apparmor_4.1.0~beta1-0ubuntu4_s390x.deb ...
232s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
232s Preparing to unpack .../2-libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ...
232s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ...
232s Preparing to unpack .../3-libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
232s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
232s Preparing to unpack .../4-libjson-glib-1.0-0_1.10.0+ds-3_s390x.deb ...
232s Unpacking libjson-glib-1.0-0:s390x (1.10.0+ds-3) over (1.10.0+ds-2) ...
232s Preparing to unpack .../5-libutempter0_1.2.1-4_s390x.deb ...
232s Unpacking libutempter0:s390x (1.2.1-4) over (1.2.1-3build1) ...
232s Setting up libapparmor1:s390x (4.1.0~beta1-0ubuntu4) ...
232s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
233s Reloading AppArmor profiles 
233s Setting up libutempter0:s390x (1.2.1-4) ...
233s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
233s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ...
233s Setting up libjson-glib-1.0-0:s390x (1.10.0+ds-3) ...
233s Processing triggers for man-db (2.12.1-3) ...
234s Processing triggers for libc-bin (2.40-1ubuntu3) ...
234s Reading package lists...
234s Building dependency tree...
234s Reading state information...
235s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
235s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
235s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
235s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
235s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
236s Reading package lists...
236s Reading package lists...
236s Building dependency tree...
236s Reading state information...
236s Calculating upgrade...
236s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
236s Reading package lists...
236s Building dependency tree...
236s Reading state information...
236s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
237s autopkgtest [17:08:28]: rebooting testbed after setup commands that affected boot
241s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
259s Reading package lists...
260s Building dependency tree...
260s Reading state information...
260s Starting pkgProblemResolver with broken count: 0
260s Starting 2 pkgProblemResolver with broken count: 0
260s Done
260s The following additional packages will be installed:
260s   dovecot-core dovecot-imapd dovecot-pop3d libexttextcat-2.0-0
260s   libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d ssl-cert
260s Suggested packages:
260s   dovecot-gssapi dovecot-ldap dovecot-lmtpd dovecot-managesieved dovecot-mysql
260s   dovecot-pgsql dovecot-sieve dovecot-solr dovecot-sqlite dovecot-submissiond
260s   ntp
260s The following NEW packages will be installed:
260s   autopkgtest-satdep dovecot-core dovecot-imapd dovecot-pop3d
260s   libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d
260s   ssl-cert
260s 0 upgraded, 10 newly installed, 0 to remove and 0 not upgraded.
260s Need to get 4306 kB/4307 kB of archives.
260s After this operation, 14.1 MB of additional disk space will be used.
260s Get:1 /tmp/autopkgtest.OlV5kl/3-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [720 B]
260s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB]
260s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-data all 3.4.7-1build1 [193 kB]
260s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-2.0-0 s390x 3.4.7-1build1 [14.1 kB]
260s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x liblua5.4-0 s390x 5.4.6-3build2 [179 kB]
260s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libsodium23 s390x 1.0.18-1build3 [138 kB]
261s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libstemmer0d s390x 2.2.0-4build1 [174 kB]
261s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-core s390x 1:2.3.21.1+dfsg1-1ubuntu1 [3361 kB]
261s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-imapd s390x 1:2.3.21.1+dfsg1-1ubuntu1 [192 kB]
261s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-pop3d s390x 1:2.3.21.1+dfsg1-1ubuntu1 [37.5 kB]
261s Preconfiguring packages ...
261s Fetched 4306 kB in 1s (5639 kB/s)
261s Selecting previously unselected package ssl-cert.
261s (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 ... 55510 files and directories currently installed.)
261s Preparing to unpack .../0-ssl-cert_1.1.2ubuntu2_all.deb ...
261s Unpacking ssl-cert (1.1.2ubuntu2) ...
261s Selecting previously unselected package libexttextcat-data.
261s Preparing to unpack .../1-libexttextcat-data_3.4.7-1build1_all.deb ...
261s Unpacking libexttextcat-data (3.4.7-1build1) ...
261s Selecting previously unselected package libexttextcat-2.0-0:s390x.
261s Preparing to unpack .../2-libexttextcat-2.0-0_3.4.7-1build1_s390x.deb ...
261s Unpacking libexttextcat-2.0-0:s390x (3.4.7-1build1) ...
261s Selecting previously unselected package liblua5.4-0:s390x.
261s Preparing to unpack .../3-liblua5.4-0_5.4.6-3build2_s390x.deb ...
261s Unpacking liblua5.4-0:s390x (5.4.6-3build2) ...
261s Selecting previously unselected package libsodium23:s390x.
261s Preparing to unpack .../4-libsodium23_1.0.18-1build3_s390x.deb ...
261s Unpacking libsodium23:s390x (1.0.18-1build3) ...
261s Selecting previously unselected package libstemmer0d:s390x.
261s Preparing to unpack .../5-libstemmer0d_2.2.0-4build1_s390x.deb ...
261s Unpacking libstemmer0d:s390x (2.2.0-4build1) ...
261s Selecting previously unselected package dovecot-core.
261s Preparing to unpack .../6-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
261s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
261s Selecting previously unselected package dovecot-imapd.
261s Preparing to unpack .../7-dovecot-imapd_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
261s Unpacking dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
261s Selecting previously unselected package dovecot-pop3d.
261s Preparing to unpack .../8-dovecot-pop3d_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
261s Unpacking dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
261s Selecting previously unselected package autopkgtest-satdep.
261s Preparing to unpack .../9-3-autopkgtest-satdep.deb ...
261s Unpacking autopkgtest-satdep (0) ...
261s Setting up libsodium23:s390x (1.0.18-1build3) ...
261s Setting up ssl-cert (1.1.2ubuntu2) ...
262s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

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

266s dovecot.socket is a disabled or a static unit, not starting it.
266s Setting up dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
266s 
266s Creating config file /etc/dovecot/conf.d/20-imap.conf with new version
266s Setting up dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
266s 
266s Creating config file /etc/dovecot/conf.d/20-pop3.conf with new version
266s Setting up autopkgtest-satdep (0) ...
266s Processing triggers for ufw (0.36.2-8) ...
267s Processing triggers for man-db (2.12.1-3) ...
267s Processing triggers for libc-bin (2.40-1ubuntu3) ...
267s Processing triggers for dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
271s (Reading database ... 56298 files and directories currently installed.)
271s Removing autopkgtest-satdep (0) ...
278s autopkgtest [17:09:09]: test command1: run-parts --report --exit-on-error debian/tests/usage
278s autopkgtest [17:09:09]: test command1: [-----------------------
278s debian/tests/usage/00_setup:
278s Setting up dovecot for the test
278s Restarting the service
280s Sending a test message via the LDA
280s Verifying that the email was correctly delivered
280s Done
280s 
280s debian/tests/usage/imap:
280s   09:11.31 imaplib version 2.58
280s   09:11.31 new IMAP4 connection, tag=b'MJNB'
280s   09:11.32 < b'* OK [CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ STARTTLS AUTH=PLAIN] Dovecot (Ubuntu) ready.'
280s   09:11.32 > b'MJNB0 CAPABILITY'
280s   09:11.32 < b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ STARTTLS AUTH=PLAIN'
280s   09:11.32 < b'MJNB0 OK Pre-login capabilities listed, post-login capabilities have more.'
280s   09:11.32 CAPABILITIES: ('IMAP4REV1', 'SASL-IR', 'LOGIN-REFERRALS', 'ID', 'ENABLE', 'IDLE', 'LITERAL+', 'STARTTLS', 'AUTH=PLAIN')
280s   09:11.32 > b'MJNB1 STARTTLS'
280s   09:11.32 < b'MJNB1 OK Begin TLS negotiation now.'
280s   09:11.33 > b'MJNB2 CAPABILITY'
280s   09:11.34 < b'* CAPABILITY IMAP4rev1 SASL-IR LOGIN-REFERRALS ID ENABLE IDLE LITERAL+ AUTH=PLAIN'
280s   09:11.34 < b'MJNB2 OK Pre-login capabilities listed, post-login capabilities have more.'
280s   09:11.34 > b'MJNB3 LOGIN dep8 "test"'
280s   09:11.34 < 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'
280s   09:11.34 < b'MJNB3 OK Logged in'
280s   09:11.34 > b'MJNB4 SELECT INBOX'
280s   09:11.34 < b'* FLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft)'
280s Testing IMAP
280s Connecting
280s Checking for STARTTLS capability
280s Logging in
280s Selecting INBOX
280s Looking for the test message
280s Fetching and verifying test message
280s Done
280s   09:11.34 < b'* OK [PERMANENTFLAGS (\\Answered \\Flagged \\Deleted \\Seen \\Draft \\*)] Flags permitted.'
280s   09:11.34 < b'* 1 EXISTS'
280s   09:11.34 < b'* 1 RECENT'
280s   09:11.35 < b'* OK [UNSEEN 1] First unseen.'
280s   09:11.35 < b'* OK [UIDVALIDITY 1731517751] UIDs valid'
280s   09:11.35 < b'* OK [UIDNEXT 2] Predicted next UID'
280s   09:11.35 < b'MJNB4 OK [READ-WRITE] Select completed (0.001 + 0.000 secs).'
280s   09:11.35 > b'MJNB5 SEARCH HEADER MESSAGE-ID "<dep8-test-1@debian.org>"'
280s   09:11.35 < b'* SEARCH 1'
280s   09:11.35 < b'MJNB5 OK Search completed (0.001 + 0.000 secs).'
280s   09:11.35 > b'MJNB6 FETCH 1 (RFC822)'
280s   09:11.35 < b'* 1 FETCH (FLAGS (\\Seen \\Recent) RFC822 {180}'
280s   09:11.35 read literal size 180
280s   09:11.35 < b')'
280s   09:11.35 < b'MJNB6 OK Fetch completed (0.001 + 0.000 secs).'
280s debian/tests/usage/pop3:
280s Testing POP3
280s Connecting
280s Checking for STARTTLS capability
280s *cmd* 'CAPA'
280s *put* b'CAPA'
280s *get* b'+OK\r\n'
280s *resp* b'+OK'
280s *get* b'CAPA\r\n'
280s *get* b'TOP\r\n'
280s *get* b'UIDL\r\n'
280s *get* b'RESP-CODES\r\n'
280s *get* b'PIPELINING\r\n'
280s *get* b'AUTH-RESP-CODE\r\n'
280s *get* b'STLS\r\n'
280s *get* b'USER\r\n'
280s *get* b'SASL PLAIN\r\n'
280s *get* b'.\r\n'
280s *cmd* 'CAPA'
280s *put* b'CAPA'
280s *get* b'+OK\r\n'
280s *resp* b'+OK'
280s *get* b'CAPA\r\n'
280s *get* b'TOP\r\n'
280s *get* b'UIDL\r\n'
280s *get* b'RESP-CODES\r\n'
280s *get* b'PIPELINING\r\n'
280s *get* b'AUTH-RESP-CODE\r\n'
280s *get* b'STLS\r\n'
280s *get* b'USER\r\n'
280s *get* b'SASL PLAIN\r\n'
280s *get* b'.\r\n'
280s *cmd* 'STLS'
280s *put* b'STLS'
280s *get* b'+OK Begin TLS negotiation now.\r\n'
280s *resp* b'+OK Begin TLS negotiation now.'
280s Logging in
280s *cmd* 'USER dep8'
280s *put* b'USER dep8'
280s *get* b'+OK\r\n'
280s *resp* b'+OK'
280s *cmd* 'PASS test'
280s *put* b'PASS test'
280s *get* b'+OK Logged in.\r\n'
280s *resp* b'+OK Logged in.'
280s Listing INBOX
280s *cmd* 'LIST'
280s *put* b'LIST'
280s *get* b'+OK 1 messages:\r\n'
280s *resp* b'+OK 1 messages:'
280s *get* b'1 180\r\n'
280s *get* b'.\r\n'
280s Fetching and verifying test message
280s *cmd* 'RETR 1'
280s *put* b'RETR 1'
280s *get* b'+OK 180 octets\r\n'
280s *resp* b'+OK 180 octets'
280s *get* b'Return-Path: <test@example.com>\r\n'
280s *get* b'Message-Id: <dep8-test-1@debian.org>\r\n'
280s *get* b'From: Test User <test@example.com>\r\n'
280s *get* b'To: dep8 <dep8@example.com>\r\n'
280s *get* b'Subject: DEP-8 test\r\n'
280s *get* b'\r\n'
280s *get* b'This is just a test\r\n'
280s *get* b'.\r\n'
280s Done
280s autopkgtest [17:09:11]: test command1: -----------------------]
281s command1             PASS
281s autopkgtest [17:09:12]: test command1:  - - - - - - - - - - results - - - - - - - - - -
281s autopkgtest [17:09:12]: test testmails: preparing testbed
389s autopkgtest [17:11:00]: testbed dpkg architecture: s390x
389s autopkgtest [17:11:00]: testbed apt version: 2.9.8
389s autopkgtest [17:11:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup
389s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [73.9 kB]
390s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [104 kB]
390s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [17.2 kB]
390s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [7016 B]
390s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [971 kB]
390s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [112 kB]
390s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [646 kB]
390s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [17.8 kB]
390s Fetched 1949 kB in 1s (1932 kB/s)
390s Reading package lists...
392s Reading package lists...
392s Building dependency tree...
392s Reading state information...
392s Calculating upgrade...
392s The following packages will be upgraded:
392s   apparmor libapparmor1 libgnutls30t64 libgpgme11t64 libjson-glib-1.0-0
392s   libjson-glib-1.0-common libutempter0
393s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
393s Need to get 1975 kB of archives.
393s After this operation, 7168 B of additional disk space will be used.
393s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libgnutls30t64 s390x 3.8.8-2ubuntu1 [950 kB]
393s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libapparmor1 s390x 4.1.0~beta1-0ubuntu4 [52.7 kB]
393s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x apparmor s390x 4.1.0~beta1-0ubuntu4 [739 kB]
393s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libgpgme11t64 s390x 1.23.2-5ubuntu4 [151 kB]
393s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-common all 1.10.0+ds-3 [5586 B]
393s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libjson-glib-1.0-0 s390x 1.10.0+ds-3 [67.5 kB]
393s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libutempter0 s390x 1.2.1-4 [9708 B]
394s Preconfiguring packages ...
394s Fetched 1975 kB in 1s (2115 kB/s)
394s (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 ... 55510 files and directories currently installed.)
394s Preparing to unpack .../libgnutls30t64_3.8.8-2ubuntu1_s390x.deb ...
394s Unpacking libgnutls30t64:s390x (3.8.8-2ubuntu1) over (3.8.6-2ubuntu1) ...
394s Setting up libgnutls30t64:s390x (3.8.8-2ubuntu1) ...
394s (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 ... 55510 files and directories currently installed.)
394s Preparing to unpack .../0-libapparmor1_4.1.0~beta1-0ubuntu4_s390x.deb ...
394s Unpacking libapparmor1:s390x (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
394s Preparing to unpack .../1-apparmor_4.1.0~beta1-0ubuntu4_s390x.deb ...
394s Unpacking apparmor (4.1.0~beta1-0ubuntu4) over (4.1.0~beta1-0ubuntu3) ...
394s Preparing to unpack .../2-libgpgme11t64_1.23.2-5ubuntu4_s390x.deb ...
394s Unpacking libgpgme11t64:s390x (1.23.2-5ubuntu4) over (1.18.0-4.1ubuntu4) ...
394s Preparing to unpack .../3-libjson-glib-1.0-common_1.10.0+ds-3_all.deb ...
394s Unpacking libjson-glib-1.0-common (1.10.0+ds-3) over (1.10.0+ds-2) ...
394s Preparing to unpack .../4-libjson-glib-1.0-0_1.10.0+ds-3_s390x.deb ...
394s Unpacking libjson-glib-1.0-0:s390x (1.10.0+ds-3) over (1.10.0+ds-2) ...
394s Preparing to unpack .../5-libutempter0_1.2.1-4_s390x.deb ...
394s Unpacking libutempter0:s390x (1.2.1-4) over (1.2.1-3build1) ...
394s Setting up libapparmor1:s390x (4.1.0~beta1-0ubuntu4) ...
394s Setting up apparmor (4.1.0~beta1-0ubuntu4) ...
395s Reloading AppArmor profiles 
396s Setting up libutempter0:s390x (1.2.1-4) ...
396s Setting up libjson-glib-1.0-common (1.10.0+ds-3) ...
396s Setting up libgpgme11t64:s390x (1.23.2-5ubuntu4) ...
396s Setting up libjson-glib-1.0-0:s390x (1.10.0+ds-3) ...
396s Processing triggers for man-db (2.12.1-3) ...
396s Processing triggers for libc-bin (2.40-1ubuntu3) ...
397s Reading package lists...
397s Building dependency tree...
397s Reading state information...
397s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
397s Hit:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease
397s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
397s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
397s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
398s Reading package lists...
398s Reading package lists...
398s Building dependency tree...
398s Reading state information...
398s Calculating upgrade...
398s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
398s Reading package lists...
399s Building dependency tree...
399s Reading state information...
399s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
399s autopkgtest [17:11:10]: rebooting testbed after setup commands that affected boot
403s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
423s Reading package lists...
424s Building dependency tree...
424s Reading state information...
424s Starting pkgProblemResolver with broken count: 0
424s Starting 2 pkgProblemResolver with broken count: 0
424s Done
424s The following additional packages will be installed:
424s   dovecot-core dovecot-imapd dovecot-pop3d libexttextcat-2.0-0
424s   libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d python3-passlib
424s   ssl-cert
424s Suggested packages:
424s   dovecot-gssapi dovecot-ldap dovecot-lmtpd dovecot-managesieved dovecot-mysql
424s   dovecot-pgsql dovecot-sieve dovecot-solr dovecot-sqlite dovecot-submissiond
424s   ntp
424s The following NEW packages will be installed:
424s   autopkgtest-satdep dovecot-core dovecot-imapd dovecot-pop3d
424s   libexttextcat-2.0-0 libexttextcat-data liblua5.4-0 libsodium23 libstemmer0d
424s   python3-passlib ssl-cert
424s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
424s Need to get 4782 kB/4782 kB of archives.
424s After this operation, 16.2 MB of additional disk space will be used.
424s Get:1 /tmp/autopkgtest.OlV5kl/4-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [744 B]
424s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x ssl-cert all 1.1.2ubuntu2 [18.0 kB]
424s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-data all 3.4.7-1build1 [193 kB]
424s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libexttextcat-2.0-0 s390x 3.4.7-1build1 [14.1 kB]
424s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x liblua5.4-0 s390x 5.4.6-3build2 [179 kB]
424s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libsodium23 s390x 1.0.18-1build3 [138 kB]
424s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libstemmer0d s390x 2.2.0-4build1 [174 kB]
425s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-core s390x 1:2.3.21.1+dfsg1-1ubuntu1 [3361 kB]
425s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-imapd s390x 1:2.3.21.1+dfsg1-1ubuntu1 [192 kB]
425s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x dovecot-pop3d s390x 1:2.3.21.1+dfsg1-1ubuntu1 [37.5 kB]
425s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x python3-passlib all 1.7.4-4 [476 kB]
426s Preconfiguring packages ...
426s Fetched 4782 kB in 1s (3249 kB/s)
426s Selecting previously unselected package ssl-cert.
426s (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 ... 55510 files and directories currently installed.)
426s Preparing to unpack .../00-ssl-cert_1.1.2ubuntu2_all.deb ...
426s Unpacking ssl-cert (1.1.2ubuntu2) ...
426s Selecting previously unselected package libexttextcat-data.
426s Preparing to unpack .../01-libexttextcat-data_3.4.7-1build1_all.deb ...
426s Unpacking libexttextcat-data (3.4.7-1build1) ...
426s Selecting previously unselected package libexttextcat-2.0-0:s390x.
426s Preparing to unpack .../02-libexttextcat-2.0-0_3.4.7-1build1_s390x.deb ...
426s Unpacking libexttextcat-2.0-0:s390x (3.4.7-1build1) ...
426s Selecting previously unselected package liblua5.4-0:s390x.
426s Preparing to unpack .../03-liblua5.4-0_5.4.6-3build2_s390x.deb ...
426s Unpacking liblua5.4-0:s390x (5.4.6-3build2) ...
426s Selecting previously unselected package libsodium23:s390x.
426s Preparing to unpack .../04-libsodium23_1.0.18-1build3_s390x.deb ...
426s Unpacking libsodium23:s390x (1.0.18-1build3) ...
426s Selecting previously unselected package libstemmer0d:s390x.
426s Preparing to unpack .../05-libstemmer0d_2.2.0-4build1_s390x.deb ...
426s Unpacking libstemmer0d:s390x (2.2.0-4build1) ...
426s Selecting previously unselected package dovecot-core.
426s Preparing to unpack .../06-dovecot-core_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
426s Unpacking dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
426s Selecting previously unselected package dovecot-imapd.
426s Preparing to unpack .../07-dovecot-imapd_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
426s Unpacking dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
426s Selecting previously unselected package dovecot-pop3d.
426s Preparing to unpack .../08-dovecot-pop3d_1%3a2.3.21.1+dfsg1-1ubuntu1_s390x.deb ...
426s Unpacking dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
426s Selecting previously unselected package python3-passlib.
426s Preparing to unpack .../09-python3-passlib_1.7.4-4_all.deb ...
426s Unpacking python3-passlib (1.7.4-4) ...
426s Selecting previously unselected package autopkgtest-satdep.
426s Preparing to unpack .../10-4-autopkgtest-satdep.deb ...
426s Unpacking autopkgtest-satdep (0) ...
426s Setting up libsodium23:s390x (1.0.18-1build3) ...
426s Setting up python3-passlib (1.7.4-4) ...
426s Setting up ssl-cert (1.1.2ubuntu2) ...
427s Created symlink '/etc/systemd/system/multi-user.target.wants/ssl-cert.service' → '/usr/lib/systemd/system/ssl-cert.service'.

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

431s dovecot.socket is a disabled or a static unit, not starting it.
431s Setting up dovecot-imapd (1:2.3.21.1+dfsg1-1ubuntu1) ...
431s 
431s Creating config file /etc/dovecot/conf.d/20-imap.conf with new version
431s Setting up dovecot-pop3d (1:2.3.21.1+dfsg1-1ubuntu1) ...
431s 
431s Creating config file /etc/dovecot/conf.d/20-pop3.conf with new version
431s Setting up autopkgtest-satdep (0) ...
431s Processing triggers for ufw (0.36.2-8) ...
431s Processing triggers for man-db (2.12.1-3) ...
432s Processing triggers for libc-bin (2.40-1ubuntu3) ...
432s Processing triggers for dovecot-core (1:2.3.21.1+dfsg1-1ubuntu1) ...
435s (Reading database ... 56424 files and directories currently installed.)
435s Removing autopkgtest-satdep (0) ...
444s autopkgtest [17:11:55]: test testmails: [-----------------------
444s test_imap (__main__.DovecotBasics.test_imap)
479s Test IMAP4 protocol. ... ERROR
479s test_imaps (__main__.DovecotBasics.test_imaps)
514s Test IMAP4S protocol. ... ERROR
514s test_pop3 (__main__.DovecotBasics.test_pop3)
540s Test POP3 protocol. ... ok
540s test_pop3s (__main__.DovecotBasics.test_pop3s)
560s Test POP3S protocol. ... ok
560s 
560s ======================================================================
560s ERROR: test_imap (__main__.DovecotBasics.test_imap)
560s Test IMAP4 protocol.
560s ----------------------------------------------------------------------
560s Traceback (most recent call last):
560s   File "/usr/lib/python3.12/imaplib.py", line 1047, in _command_complete
560s     typ, data = self._get_tagged_response(tag, expect_bye=logout)
560s                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1165, in _get_tagged_response
560s     self._check_bye()
560s   File "/usr/lib/python3.12/imaplib.py", line 961, in _check_bye
560s     raise self.abort(bye[-1].decode(self._encoding, 'replace'))
560s imaplib.IMAP4.abort: Auth process broken
560s 
560s During handling of the above exception, another exception occurred:
560s 
560s Traceback (most recent call last):
560s   File "/tmp/autopkgtest.OlV5kl/build.9Eq/src/debian/tests/testmails", line 241, in test_imap
560s     imap = imaplib.IMAP4('localhost')
560s            ^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 205, in __init__
560s     self._connect()
560s   File "/usr/lib/python3.12/imaplib.py", line 255, in _connect
560s     self._get_capabilities()
560s   File "/usr/lib/python3.12/imaplib.py", line 1060, in _get_capabilities
560s     typ, dat = self.capability()
560s                ^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 454, in capability
560s     typ, dat = self._simple_command(name)
560s                ^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1230, in _simple_command
560s     return self._command_complete(name, self._command(name, *args))
560s            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1049, in _command_complete
560s     raise self.abort('command: %s => %s' % (name, val))
560s imaplib.IMAP4.abort: command: CAPABILITY => Auth process broken
560s 
560s ======================================================================
560s ERROR: test_imaps (__main__.DovecotBasics.test_imaps)
560s Test IMAP4S protocol.
560s ----------------------------------------------------------------------
560s Traceback (most recent call last):
560s   File "/usr/lib/python3.12/imaplib.py", line 1047, in _command_complete
560s     typ, data = self._get_tagged_response(tag, expect_bye=logout)
560s                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1165, in _get_tagged_response
560s     self._check_bye()
560s   File "/usr/lib/python3.12/imaplib.py", line 961, in _check_bye
560s     raise self.abort(bye[-1].decode(self._encoding, 'replace'))
560s imaplib.IMAP4.abort: Auth process broken
560s 
560s During handling of the above exception, another exception occurred:
560s 
560s Traceback (most recent call last):
560s   File "/tmp/autopkgtest.OlV5kl/build.9Eq/src/debian/tests/testmails", line 247, in test_imaps
560s     imap = imaplib.IMAP4_SSL('localhost')
560s            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1306, in __init__
560s     IMAP4.__init__(self, host, port, timeout)
560s   File "/usr/lib/python3.12/imaplib.py", line 205, in __init__
560s     self._connect()
560s   File "/usr/lib/python3.12/imaplib.py", line 255, in _connect
560s     self._get_capabilities()
560s   File "/usr/lib/python3.12/imaplib.py", line 1060, in _get_capabilities
560s     typ, dat = self.capability()
560s                ^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 454, in capability
560s     typ, dat = self._simple_command(name)
560s                ^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1230, in _simple_command
560s     return self._command_complete(name, self._command(name, *args))
560s            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
560s   File "/usr/lib/python3.12/imaplib.py", line 1049, in _command_complete
560s     raise self.abort('command: %s => %s' % (name, val))
560s imaplib.IMAP4.abort: command: CAPABILITY => Auth process broken
560s 
560s ----------------------------------------------------------------------
560s Ran 4 tests in 115.871s
560s 
560s FAILED (errors=2)
560s autopkgtest [17:13:51]: test testmails: -----------------------]
562s autopkgtest [17:13:52]: test testmails:  - - - - - - - - - - results - - - - - - - - - -
562s testmails            FAIL non-zero exit status 1
562s autopkgtest [17:13:53]: @@@@@@@@@@@@@@@@@@@@ summary
562s doveadm              PASS
562s systemd              PASS
562s command1             PASS
562s testmails            FAIL non-zero exit status 1
574s nova [W] Using flock in prodstack6-s390x
574s Creating nova instance adt-plucky-s390x-dovecot-20241113-170430-juju-7f2275-prod-proposed-migration-environment-20-8c2590d7-f95a-4fdd-afda-7ad9886c3588 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...
574s nova [W] Using flock in prodstack6-s390x
574s Creating nova instance adt-plucky-s390x-dovecot-20241113-170430-juju-7f2275-prod-proposed-migration-environment-20-8c2590d7-f95a-4fdd-afda-7ad9886c3588 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...
574s nova [W] Using flock in prodstack6-s390x
574s Creating nova instance adt-plucky-s390x-dovecot-20241113-170430-juju-7f2275-prod-proposed-migration-environment-20-8c2590d7-f95a-4fdd-afda-7ad9886c3588 from image adt/ubuntu-plucky-s390x-server-20241113.img (UUID e740277e-1f72-40ae-bfbe-46030537c71c)...