0s autopkgtest [06:55:08]: starting date and time: 2025-02-22 06:55:08+0000 0s autopkgtest [06:55:08]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [06:55:08]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.fqpem6jl/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:courier-authlib --apt-upgrade courier-authlib --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=courier-authlib/0.72.3-4 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-10.secgroup --name adt-plucky-s390x-courier-authlib-20250222-065508-juju-7f2275-prod-proposed-migration-environment-15-dd1c245c-5a4b-4c50-95ba-0c3a588a7d1b --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 71s autopkgtest [06:56:19]: testbed dpkg architecture: s390x 71s autopkgtest [06:56:19]: testbed apt version: 2.9.30ubuntu1 71s autopkgtest [06:56:19]: @@@@@@@@@@@@@@@@@@@@ test bed setup 72s autopkgtest [06:56:20]: testbed release detected to be: None 72s autopkgtest [06:56:20]: updating testbed package index (apt update) 73s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 73s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 73s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 73s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 73s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 73s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.9 kB] 73s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 73s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [504 kB] 73s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [125 kB] 73s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 73s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [424 kB] 73s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [2816 B] 73s Fetched 1264 kB in 1s (1507 kB/s) 74s Reading package lists... 75s + lsb_release --codename --short 75s + RELEASE=plucky 75s + cat 75s + [ plucky != trusty ] 75s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 75s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Calculating upgrade... 75s Calculating upgrade... 75s The following packages were automatically installed and are no longer required: 75s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 75s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 75s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 75s linux-tools-6.11.0-8-generic 75s Use 'sudo apt autoremove' to remove them. 75s The following packages will be upgraded: 75s curl libcurl3t64-gnutls libcurl4t64 75s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 75s Need to get 1041 kB of archives. 75s After this operation, 7168 B disk space will be freed. 75s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x curl s390x 8.12.1-2ubuntu1 [251 kB] 76s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl4t64 s390x 8.12.1-2ubuntu1 [397 kB] 76s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x libcurl3t64-gnutls s390x 8.12.1-2ubuntu1 [393 kB] 76s Fetched 1041 kB in 1s (1966 kB/s) 76s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81030 files and directories currently installed.) 76s Preparing to unpack .../curl_8.12.1-2ubuntu1_s390x.deb ... 76s Unpacking curl (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 76s Preparing to unpack .../libcurl4t64_8.12.1-2ubuntu1_s390x.deb ... 76s Unpacking libcurl4t64:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 76s Preparing to unpack .../libcurl3t64-gnutls_8.12.1-2ubuntu1_s390x.deb ... 76s Unpacking libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) over (8.12.0+git20250209.89ed161+ds-1ubuntu1) ... 76s Setting up libcurl4t64:s390x (8.12.1-2ubuntu1) ... 76s Setting up libcurl3t64-gnutls:s390x (8.12.1-2ubuntu1) ... 76s Setting up curl (8.12.1-2ubuntu1) ... 76s Processing triggers for man-db (2.13.0-1) ... 76s Processing triggers for libc-bin (2.40-4ubuntu1) ... 77s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 77s + /usr/lib/apt/apt-helper analyze-pattern ?true 77s + uname -r 77s + sed s/\./\\./g 77s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 77s + apt list ?obsolete 77s + tail -n+2 77s + cut -d/ -f1 77s + grep -v ^linux-.*6\.12\.0-15-generic.* 77s + true 77s + obsolete_pkgs= 77s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 77s Reading package lists... 77s Building dependency tree... 77s Reading state information... 77s Solving dependencies... 77s The following packages will be REMOVED: 77s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 77s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 77s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 77s linux-tools-6.11.0-8-generic* 77s 0 upgraded, 0 newly installed, 9 to remove and 0 not upgraded. 77s After this operation, 167 MB disk space will be freed. 77s (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 ... 81030 files and directories currently installed.) 77s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 77s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 77s Removing libpython3.12t64:s390x (3.12.9-1) ... 77s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 77s Removing libnsl2:s390x (1.3.0-3build3) ... 77s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 77s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 77s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 78s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 78s Processing triggers for libc-bin (2.40-4ubuntu1) ... 78s (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 ... 55930 files and directories currently installed.) 78s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 78s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 79s + grep -q trusty /etc/lsb-release 79s + [ ! -d /usr/share/doc/unattended-upgrades ] 79s + [ ! -d /usr/share/doc/lxd ] 79s + [ ! -d /usr/share/doc/lxd-client ] 79s + [ ! -d /usr/share/doc/snapd ] 79s + type iptables 79s + cat 79s + chmod 755 /etc/rc.local 79s + . /etc/rc.local 79s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 79s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 79s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 79s + uname -m 79s + [ s390x = ppc64le ] 79s + [ -d /run/systemd/system ] 79s + systemd-detect-virt --quiet --vm 79s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 79s + cat 79s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 79s + echo COMPRESS=lz4 79s autopkgtest [06:56:27]: upgrading testbed (apt dist-upgrade and autopurge) 79s Reading package lists... 79s Building dependency tree... 79s Reading state information... 79s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 79s Starting 2 pkgProblemResolver with broken count: 0 79s Done 79s Entering ResolveByKeep 79s 79s Calculating upgrade... 79s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 80s Reading package lists... 80s Building dependency tree... 80s Reading state information... 80s Starting pkgProblemResolver with broken count: 0 80s Starting 2 pkgProblemResolver with broken count: 0 80s Done 80s Solving dependencies... 80s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 80s autopkgtest [06:56:28]: rebooting testbed after setup commands that affected boot 100s autopkgtest [06:56:48]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 103s autopkgtest [06:56:51]: @@@@@@@@@@@@@@@@@@@@ apt-source courier-authlib 108s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/universe courier-authlib 0.72.3-4 (dsc) [3015 B] 108s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe courier-authlib 0.72.3-4 (tar) [2290 kB] 108s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe courier-authlib 0.72.3-4 (asc) [260 B] 108s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/universe courier-authlib 0.72.3-4 (diff) [17.5 kB] 108s gpgv: Signature made Fri Feb 21 18:23:52 2025 UTC 108s gpgv: using RSA key 24A54DDB235466795CA8E23EC2E7CB27AEB0B603 108s gpgv: Can't check signature: No public key 108s dpkg-source: warning: cannot verify inline signature for ./courier-authlib_0.72.3-4.dsc: no acceptable signature found 109s autopkgtest [06:56:57]: testing package courier-authlib version 0.72.3-4 110s autopkgtest [06:56:58]: build not needed 111s autopkgtest [06:56:59]: test pam: preparing testbed 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 112s Starting pkgProblemResolver with broken count: 0 112s Starting 2 pkgProblemResolver with broken count: 0 112s Done 112s The following NEW packages will be installed: 112s bsdmainutils courier-authdaemon courier-authlib libltdl7 ncal 112s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 176 kB of archives. 112s After this operation, 931 kB of additional disk space will be used. 112s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libltdl7 s390x 2.5.4-3build1 [43.9 kB] 112s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x courier-authlib s390x 0.72.3-4 [78.7 kB] 112s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x courier-authdaemon s390x 0.72.3-4 [28.7 kB] 112s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x ncal s390x 12.1.8 [21.6 kB] 112s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x bsdmainutils all 12.1.8 [3176 B] 112s Fetched 176 kB in 0s (420 kB/s) 112s Selecting previously unselected package libltdl7:s390x. 113s (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 ... 55928 files and directories currently installed.) 113s Preparing to unpack .../libltdl7_2.5.4-3build1_s390x.deb ... 113s Unpacking libltdl7:s390x (2.5.4-3build1) ... 113s Selecting previously unselected package courier-authlib. 113s Preparing to unpack .../courier-authlib_0.72.3-4_s390x.deb ... 113s Unpacking courier-authlib (0.72.3-4) ... 113s Selecting previously unselected package courier-authdaemon. 113s Preparing to unpack .../courier-authdaemon_0.72.3-4_s390x.deb ... 113s Unpacking courier-authdaemon (0.72.3-4) ... 113s Selecting previously unselected package ncal. 113s Preparing to unpack .../archives/ncal_12.1.8_s390x.deb ... 113s Unpacking ncal (12.1.8) ... 113s Selecting previously unselected package bsdmainutils. 113s Preparing to unpack .../bsdmainutils_12.1.8_all.deb ... 113s Unpacking bsdmainutils (12.1.8) ... 113s Setting up ncal (12.1.8) ... 113s Setting up bsdmainutils (12.1.8) ... 113s Setting up libltdl7:s390x (2.5.4-3build1) ... 113s Setting up courier-authlib (0.72.3-4) ... 113s Setting up courier-authdaemon (0.72.3-4) ... 113s Created symlink '/etc/systemd/system/multi-user.target.wants/courier-authdaemon.service' → '/usr/lib/systemd/system/courier-authdaemon.service'. 113s Processing triggers for man-db (2.13.0-1) ... 114s Processing triggers for libc-bin (2.40-4ubuntu1) ... 115s autopkgtest [06:57:03]: test pam: [----------------------- 115s == backup config files... 115s == creating test users... 116s == starting authdameon... 116s == check enumeration... 116s checking for alice: ok 116s checking for bob: ok 116s checking for carol: ok 116s == test completed 116s == dump... 116s ===== BEGIN /etc/courier/authdaemonrc ===== 116s ##VERSION: $Id:$ 116s # 116s # Copyright 2000-2005 Double Precision, Inc. See COPYING for 116s # distribution information. 116s # 116s # authdaemonrc created from authdaemonrc.dist by sysconftool 116s # 116s # Do not alter lines that begin with ##, they are used when upgrading 116s # this configuration. 116s # 116s # This file configures authdaemond, the resident authentication daemon. 116s # 116s # Comments in this file are ignored. Although this file is intended to 116s # be sourced as a shell script, authdaemond parses it manually, so 116s # the acceptable syntax is a bit limited. Multiline variable contents, 116s # with the \ continuation character, are not allowed. Everything must 116s # fit on one line. Do not use any additional whitespace for indentation, 116s # or anything else. 116s 116s ##NAME: authmodulelist:3 116s # 116s # The authentication modules that are linked into authdaemond. The 116s # default list is installed. You may selectively disable modules simply 116s # by removing them from the following list. The available modules you 116s # can use are: authuserdb authpam authpgsql authldap authmysql authsqlite authcustom authpipe 116s 116s authmodulelist="authpam" 116s 116s ##NAME: authmodulelistorig:4 116s # 116s # This setting is used by Courier's webadmin module, and should be left 116s # alone 116s 116s authmodulelistorig="authuserdb authpam authpgsql authldap authmysql authsqlite authcustom authpipe" 116s 116s ##NAME: daemons:0 116s # 116s # The number of daemon processes that are started. authdaemon is typically 116s # installed where authentication modules are relatively expensive: such 116s # as authldap, or authmysql, so it's better to have a number of them running. 116s # PLEASE NOTE: Some platforms may experience a problem if there's more than 116s # one daemon. Specifically, SystemV derived platforms that use TLI with 116s # socket emulation. I'm suspicious of TLI's ability to handle multiple 116s # processes accepting connections on the same filesystem domain socket. 116s # 116s # You may need to increase daemons if as your system load increases. Symptoms 116s # include sporadic authentication failures. If you start getting 116s # authentication failures, increase daemons. However, the default of 5 116s # SHOULD be sufficient. Bumping up daemon count is only a short-term 116s # solution. The permanent solution is to add more resources: RAM, faster 116s # disks, faster CPUs... 116s 116s daemons=5 116s 116s ##NAME: authdaemonvar:2 116s # 116s # authdaemonvar is here, but is not used directly by authdaemond. It's 116s # used by various configuration and build scripts, so don't touch it! 116s 116s authdaemonvar=/run/courier/authdaemon 116s 116s ##NAME: DEBUG_LOGIN:0 116s # 116s # Dump additional diagnostics to syslog 116s # 116s # DEBUG_LOGIN=0 - turn off debugging 116s # DEBUG_LOGIN=1 - turn on debugging 116s # DEBUG_LOGIN=2 - turn on debugging + log passwords too 116s # 116s # ** YES ** - DEBUG_LOGIN=2 places passwords into syslog. 116s # 116s # Note that most information is sent to syslog at level 'debug', so 116s # you may need to modify your /etc/syslog.conf to be able to see it. 116s 116s DEBUG_LOGIN=0 116s 116s ##NAME: DEFAULTOPTIONS:0 116s # 116s # A comma-separated list of option=value pairs. Each option is applied 116s # to an account if the account does not have its own specific value for 116s # that option. So for example, you can set 116s # DEFAULTOPTIONS="disablewebmail=1,disableimap=1" 116s # and then enable webmail and/or imap on individual accounts by setting 116s # disablewebmail=0 and/or disableimap=0 on the account. 116s 116s DEFAULTOPTIONS="" 116s 116s ##NAME: LOGGEROPTS:0 116s # 116s # courierlogger(1) options, e.g. to set syslog facility 116s # 116s 116s LOGGEROPTS="" 116s 116s ##NAME: LDAP_TLS_OPTIONS:0 116s # 116s # Options documented in ldap.conf(5) can be set here, prefixed with 'LDAP'. 116s # Examples: 116s # 116s #LDAPTLS_CACERT=/path/to/cacert.pem 116s #LDAPTLS_REQCERT=demand 116s #LDAPTLS_CERT=/path/to/clientcert.pem 116s #LDAPTLS_KEY=/path/to/clientkey.pem 116s ===== END /etc/courier/authdaemonrc ===== 116s ===== BEGIN /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.err ===== 116s ===== END /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.err ===== 116s ===== BEGIN /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.exitcode ===== 116s 0 116s ===== END /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.exitcode ===== 116s ===== BEGIN /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.out ===== 116s nobody 65534 65534 /nonexistent 116s systemd-network 998 998 / 116s systemd-timesync 996 996 / 116s dhcpcd 100 65534 /usr/lib/dhcpcd 116s messagebus 101 101 /nonexistent 116s systemd-resolve 991 991 / 116s syslog 102 102 /nonexistent 116s uuidd 103 104 /run/uuidd 116s sshd 104 65534 /run/sshd 116s pollinate 105 1 /var/cache/pollinate 116s tcpdump 106 109 /nonexistent 116s fwupd-refresh 990 990 /var/lib/fwupd 116s polkitd 989 989 / 116s ubuntu 1000 1000 /home/ubuntu 116s courier 107 110 /var/lib/courier 116s alice 1001 1001 /home/alice 116s bob 1002 1002 /home/bob 116s carol 1003 1003 /home/carol 116s ===== END /tmp/autopkgtest.RfLMdZ/pam-artifacts/authenumerate.out ===== 116s == finish... 116s == dropping user alice 116s == dropping user bob 116s == dropping user carol 116s == restore config files... 116s == stopping service courier-authdaemon... 117s autopkgtest [06:57:05]: test pam: -----------------------] 117s autopkgtest [06:57:05]: test pam: - - - - - - - - - - results - - - - - - - - - - 117s pam PASS 117s autopkgtest [06:57:05]: @@@@@@@@@@@@@@@@@@@@ summary 117s pam PASS 122s nova [W] Using flock in prodstack6-s390x 122s Creating nova instance adt-plucky-s390x-courier-authlib-20250222-065508-juju-7f2275-prod-proposed-migration-environment-15-dd1c245c-5a4b-4c50-95ba-0c3a588a7d1b from image adt/ubuntu-plucky-s390x-server-20250222.img (UUID ae633cda-0dee-481c-9805-d0ef3f3b5166)... 122s nova [W] Timed out waiting for f2d58213-3af9-4548-8dfc-86c229c3f20d to get deleted.