0s autopkgtest [06:52:39]: starting date and time: 2025-02-21 06:52:39+0000 0s autopkgtest [06:52:39]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [06:52:39]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.k2maslb7/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:libcap2,src:vsftpd --apt-upgrade vsftpd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=libcap2/1:2.73-4ubuntu1 vsftpd/3.0.5-0.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-ppc64el-19.secgroup --name adt-plucky-ppc64el-vsftpd-20250221-065238-juju-7f2275-prod-proposed-migration-environment-15-48f47e6c-2e13-4ba5-9be7-6eb4968633f5 --image adt/ubuntu-plucky-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-ppc64el -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/ 90s autopkgtest [06:54:09]: testbed dpkg architecture: ppc64el 90s autopkgtest [06:54:09]: testbed apt version: 2.9.30ubuntu1 90s autopkgtest [06:54:09]: @@@@@@@@@@@@@@@@@@@@ test bed setup 91s autopkgtest [06:54:10]: testbed release detected to be: None 91s autopkgtest [06:54:10]: updating testbed package index (apt update) 92s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 92s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 92s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 92s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 92s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [94.6 kB] 92s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.8 kB] 92s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [722 kB] 93s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 93s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el Packages [138 kB] 93s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted ppc64el Packages [760 B] 93s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe ppc64el Packages [685 kB] 93s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse ppc64el Packages [4908 B] 93s Fetched 1773 kB in 1s (1569 kB/s) 94s Reading package lists... 94s + lsb_release --codename --short 94s + RELEASE=plucky 94s + cat 94s + [ plucky != trusty ] 94s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 94s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Calculating upgrade... 95s Calculating upgrade... 95s The following packages will be upgraded: 95s apport apport-core-dump-handler cloud-init cloud-init-base python3-apport 95s python3-problem-report 95s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 95s Need to get 839 kB of archives. 95s After this operation, 18.4 kB of additional disk space will be used. 95s Get:1 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-problem-report all 2.31.0+git20250220-0ubuntu1 [26.0 kB] 96s Get:2 http://ftpmaster.internal/ubuntu plucky/main ppc64el python3-apport all 2.31.0+git20250220-0ubuntu1 [93.5 kB] 96s Get:3 http://ftpmaster.internal/ubuntu plucky/main ppc64el apport-core-dump-handler all 2.31.0+git20250220-0ubuntu1 [18.7 kB] 96s Get:4 http://ftpmaster.internal/ubuntu plucky/main ppc64el apport all 2.31.0+git20250220-0ubuntu1 [83.1 kB] 96s Get:5 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init-base all 25.1-0ubuntu1 [616 kB] 96s Get:6 http://ftpmaster.internal/ubuntu plucky/main ppc64el cloud-init all 25.1-0ubuntu1 [2088 B] 96s Preconfiguring packages ... 96s Fetched 839 kB in 1s (1491 kB/s) 97s (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 ... 106370 files and directories currently installed.) 97s Preparing to unpack .../0-python3-problem-report_2.31.0+git20250220-0ubuntu1_all.deb ... 97s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 97s for fn in glob1(directory, "%s.*" % fname): 97s Unpacking python3-problem-report (2.31.0+git20250220-0ubuntu1) over (2.31.0-0ubuntu5) ... 97s Preparing to unpack .../1-python3-apport_2.31.0+git20250220-0ubuntu1_all.deb ... 97s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 97s for fn in glob1(directory, "%s.*" % fname): 97s Unpacking python3-apport (2.31.0+git20250220-0ubuntu1) over (2.31.0-0ubuntu5) ... 97s Preparing to unpack .../2-apport-core-dump-handler_2.31.0+git20250220-0ubuntu1_all.deb ... 97s Unpacking apport-core-dump-handler (2.31.0+git20250220-0ubuntu1) over (2.31.0-0ubuntu5) ... 97s Preparing to unpack .../3-apport_2.31.0+git20250220-0ubuntu1_all.deb ... 97s Unpacking apport (2.31.0+git20250220-0ubuntu1) over (2.31.0-0ubuntu5) ... 97s Preparing to unpack .../4-cloud-init-base_25.1-0ubuntu1_all.deb ... 97s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 97s for fn in glob1(directory, "%s.*" % fname): 97s Unpacking cloud-init-base (25.1-0ubuntu1) over (25.1~3geb1965a4-0ubuntu1) ... 97s Preparing to unpack .../5-cloud-init_25.1-0ubuntu1_all.deb ... 97s Unpacking cloud-init (25.1-0ubuntu1) over (25.1~3geb1965a4-0ubuntu1) ... 97s Setting up python3-problem-report (2.31.0+git20250220-0ubuntu1) ... 97s Setting up cloud-init-base (25.1-0ubuntu1) ... 99s Setting up python3-apport (2.31.0+git20250220-0ubuntu1) ... 99s Setting up cloud-init (25.1-0ubuntu1) ... 99s Setting up apport-core-dump-handler (2.31.0+git20250220-0ubuntu1) ... 100s Setting up apport (2.31.0+git20250220-0ubuntu1) ... 101s apport-autoreport.service is a disabled or a static unit not running, not starting it. 101s Processing triggers for rsyslog (8.2412.0-2ubuntu1) ... 101s Processing triggers for man-db (2.13.0-1) ... 102s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 102s + /usr/lib/apt/apt-helper analyze-pattern ?true 102s + uname -r 102s + sed s/\./\\./g 102s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 102s + apt list ?obsolete 102s + tail -n+2 102s + cut -d/ -f1+ grep -v ^linux-.*6\.12\.0-15-generic.* 102s 102s + true 102s + obsolete_pkgs= 102s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 103s Reading package lists... 103s Building dependency tree... 103s Reading state information... 103s Solving dependencies... 103s 0 upgraded, 0 newly installed, 0 to remove and 3 not upgraded. 103s + grep -q trusty /etc/lsb-release 103s + [ ! -d /usr/share/doc/unattended-upgrades ] 103s + [ ! -d /usr/share/doc/lxd ] 103s + [ ! -d /usr/share/doc/lxd-client ] 103s + [ ! -d /usr/share/doc/snapd ] 103s + type iptables 103s + cat 103s + chmod 755 /etc/rc.local 103s + . /etc/rc.local 103s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 103s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 103s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 103s + uname -m 103s + [ ppc64le = ppc64le ] 103s + systemctl is-active keyboard-setup.service 103s + [ active = failed ] 103s + [ -d /run/systemd/system ] 103s + systemd-detect-virt --quiet --vm 103s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 103s + cat 103s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 103s + echo COMPRESS=lz4 103s autopkgtest [06:54:22]: upgrading testbed (apt dist-upgrade and autopurge) 104s Reading package lists... 104s Building dependency tree... 104s Reading state information... 104s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 104s Starting 2 pkgProblemResolver with broken count: 0 104s Done 105s Entering ResolveByKeep 105s 105s Calculating upgrade... 106s The following packages will be upgraded: 106s libcap2 libcap2-bin libpam-cap 106s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 106s Need to get 86.0 kB of archives. 106s After this operation, 3072 B of additional disk space will be used. 106s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libcap2 ppc64el 1:2.73-4ubuntu1 [35.9 kB] 106s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libpam-cap ppc64el 1:2.73-4ubuntu1 [14.1 kB] 106s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el libcap2-bin ppc64el 1:2.73-4ubuntu1 [36.0 kB] 106s Fetched 86.0 kB in 0s (300 kB/s) 106s (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 ... 106371 files and directories currently installed.) 106s Preparing to unpack .../libcap2_1%3a2.73-4ubuntu1_ppc64el.deb ... 106s Unpacking libcap2:ppc64el (1:2.73-4ubuntu1) over (1:2.66-5ubuntu3) ... 106s Setting up libcap2:ppc64el (1:2.73-4ubuntu1) ... 106s (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 ... 106371 files and directories currently installed.) 106s Preparing to unpack .../libpam-cap_1%3a2.73-4ubuntu1_ppc64el.deb ... 107s Unpacking libpam-cap:ppc64el (1:2.73-4ubuntu1) over (1:2.66-5ubuntu3) ... 107s Preparing to unpack .../libcap2-bin_1%3a2.73-4ubuntu1_ppc64el.deb ... 107s Unpacking libcap2-bin (1:2.73-4ubuntu1) over (1:2.66-5ubuntu3) ... 107s Setting up libcap2-bin (1:2.73-4ubuntu1) ... 107s Setting up libpam-cap:ppc64el (1:2.73-4ubuntu1) ... 107s Processing triggers for man-db (2.13.0-1) ... 108s Processing triggers for libc-bin (2.40-4ubuntu1) ... 108s Reading package lists... 108s Building dependency tree... 108s Reading state information... 109s Starting pkgProblemResolver with broken count: 0 109s Starting 2 pkgProblemResolver with broken count: 0 109s Done 109s Solving dependencies... 109s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 109s autopkgtest [06:54:28]: rebooting testbed after setup commands that affected boot 142s autopkgtest [06:55:01]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 16:32:08 UTC 2025 145s autopkgtest [06:55:04]: @@@@@@@@@@@@@@@@@@@@ apt-source vsftpd 148s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main vsftpd 3.0.5-0.1 (dsc) [1854 B] 148s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main vsftpd 3.0.5-0.1 (tar) [198 kB] 148s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main vsftpd 3.0.5-0.1 (diff) [35.9 kB] 148s gpgv: Signature made Wed Jan 15 11:30:55 2025 UTC 148s gpgv: using RSA key 7D1ACFFAD9E0806C9C4CD3925C13D6DB93052E03 148s gpgv: Can't check signature: No public key 148s dpkg-source: warning: cannot verify inline signature for ./vsftpd_3.0.5-0.1.dsc: no acceptable signature found 148s autopkgtest [06:55:07]: testing package vsftpd version 3.0.5-0.1 149s autopkgtest [06:55:08]: build not needed 150s autopkgtest [06:55:09]: test smoke: preparing testbed 151s Reading package lists... 151s Building dependency tree... 151s Reading state information... 151s Starting pkgProblemResolver with broken count: 0 151s Starting 2 pkgProblemResolver with broken count: 0 151s Done 151s The following NEW packages will be installed: 151s vsftpd 152s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 152s Need to get 130 kB of archives. 152s After this operation, 353 kB of additional disk space will be used. 152s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main ppc64el vsftpd ppc64el 3.0.5-0.1 [130 kB] 152s Preconfiguring packages ... 152s Fetched 130 kB in 0s (370 kB/s) 152s Selecting previously unselected package vsftpd. 152s (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 ... 106371 files and directories currently installed.) 152s Preparing to unpack .../vsftpd_3.0.5-0.1_ppc64el.deb ... 152s Unpacking vsftpd (3.0.5-0.1) ... 152s Setting up vsftpd (3.0.5-0.1) ... 153s Created symlink '/etc/systemd/system/multi-user.target.wants/vsftpd.service' → '/usr/lib/systemd/system/vsftpd.service'. 153s /usr/lib/tmpfiles.d/vsftpd.conf:1: Line references path below legacy directory /var/run/, updating /var/run/vsftpd/empty → /run/vsftpd/empty; please update the tmpfiles.d/ drop-in file accordingly. 153s Processing triggers for man-db (2.13.0-1) ... 155s autopkgtest [06:55:14]: test smoke: [----------------------- 156s + sed -i s/^#\(write_enable=YES\)$/\1/ /etc/vsftpd.conf 156s + service vsftpd reload 156s + adduser --disabled-password --gecos ftptest 156s info: Adding user `ftptest' ... 156s info: Selecting UID/GID from range 1000 to 59999 ... 156s info: Adding new group `ftptest' (1001) ... 156s info: Adding new user `ftptest' (1001) with group `ftptest (1001)' ... 156s info: Creating home directory `/home/ftptest' ... 156s info: Copying files from `/etc/skel' ... 156s info: Adding new user `ftptest' to supplemental / extra groups `users' ... 156s info: Adding user `ftptest' to group `users' ... 156s + echo ftptest:dep8 156s + chpasswd ftptest 156s + 156s + chown ftptest: /home/ftptest/.netrc 156s + chmod 600 /home/ftptest/.netrc 156s + cat 156s + mkdir /home/ftptest/local /home/ftptest/remote 156s + echo Hello, world! 1. 156s + echo Hello, world! 2. 156s + chown -R ftptest: /home/ftptest/local /home/ftptest/remote 156s + su -c ftp localhost - ftptest 156s ftp: Can't read `/home/ftptest/.netrc': Permission denied 157s Password: Name (localhost:ubuntu): Login incorrect. 157s Please login with USER and PASS. 157s Please login with USER and PASS. 157s ftp: Login failed 157s ftp: Can't bind for data connection: Address already in use 157s ftp: Can't open `put': No such file or directory 157s + cmp /home/ftptest/local/put /home/ftptest/remote/put 157s cmp: /home/ftptest/remote/put: No such file or directory 157s autopkgtest [06:55:16]: test smoke: -----------------------] 158s smoke FAIL non-zero exit status 2 158s autopkgtest [06:55:17]: test smoke: - - - - - - - - - - results - - - - - - - - - - 158s autopkgtest [06:55:17]: @@@@@@@@@@@@@@@@@@@@ summary 158s smoke FAIL non-zero exit status 2 177s nova [W] Using flock in prodstack6-ppc64el 177s Creating nova instance adt-plucky-ppc64el-vsftpd-20250221-065238-juju-7f2275-prod-proposed-migration-environment-15-48f47e6c-2e13-4ba5-9be7-6eb4968633f5 from image adt/ubuntu-plucky-ppc64el-server-20250221.img (UUID 2f98d860-9c02-405f-ad5b-1c2fc9874794)... 177s nova [W] Timed out waiting for ffde9ea1-6ea6-4b7a-8ebf-efbae3c9a1d2 to get deleted.