autopkgtest [21:06:27]: git checkout: 433f1b0 debian/rules: reuse /usr/share/dpkg/pkg-info.mk autopkgtest [21:06:27]: host juju-prod-ues-proposed-migration-machine-11; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jlmz6qkk/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:docker.io --apt-upgrade docker.io '--env=ADT_TEST_TRIGGERS=docker.io/17.03.2-0ubuntu1~16.04.1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --nova-reboot --flavor autopkgtest --name adt-xenial-s390x-docker.io-20171121-210627 --image '(auto-sync|ubuntu)/ubuntu-xenial-.*-s390x-server-.*' --keyname testbed-juju-prod-ues-proposed-migration-machine-11 --net-id=net_ues_proposed_migration -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,localhost,localdomain,novalocal,internal,archive.ubuntu.com,security.ubuntu.com,changelogs.ubuntu.com,ddebs.ubuntu.com,ppa.launchpad.net'"'"'' --mirror=http://ftpmaster.internal/ubuntu autopkgtest [21:07:00]: @@@@@@@@@@@@@@@@@@@@ test bed setup Get:1 http://ftpmaster.internal/ubuntu xenial-proposed InRelease [253 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-proposed/main Sources [78.1 kB] Get:3 http://ftpmaster.internal/ubuntu xenial-proposed/restricted Sources [968 B] Get:4 http://ftpmaster.internal/ubuntu xenial-proposed/universe Sources [38.6 kB] Get:5 http://ftpmaster.internal/ubuntu xenial-proposed/multiverse Sources [1,872 B] Get:6 http://ftpmaster.internal/ubuntu xenial-proposed/main s390x Packages [73.8 kB] Get:7 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x Packages [32.4 kB] Get:8 http://ftpmaster.internal/ubuntu xenial-proposed/multiverse s390x Packages [1,772 B] Fetched 481 kB in 0s (526 kB/s) Reading package lists... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: lxd* 0 upgraded, 0 newly installed, 1 to remove and 7 not upgraded. After this operation, 22.1 MB disk space will be freed. (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 ... 46556 files and directories currently installed.) Removing lxd (2.0.10-0ubuntu1~16.04.2) ... Warning: Stopping lxd.service, but it can still be activated by: lxd.socket Purging configuration files for lxd (2.0.10-0ubuntu1~16.04.2) ... Failed to stop lxd.service: Unit lxd.service not loaded. dpkg: warning: while removing lxd, directory '/var/lib/lxd' not empty so not removed Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: lxd-client* 0 upgraded, 0 newly installed, 1 to remove and 7 not upgraded. After this operation, 12.0 MB disk space will be freed. (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 ... 46533 files and directories currently installed.) Removing lxd-client (2.0.10-0ubuntu1~16.04.2) ... Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: snapd* ubuntu-core-launcher* 0 upgraded, 0 newly installed, 2 to remove and 7 not upgraded. After this operation, 75.6 MB disk space will be freed. (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 ... 46526 files and directories currently installed.) Removing ubuntu-core-launcher (2.28.5) ... Removing snapd (2.28.5) ... Warning: Stopping snapd.service, but it can still be activated by: snapd.socket Purging configuration files for snapd (2.28.5) ... Final directory cleanup Discarding preserved snap namespaces umount: /run/snapd/ns/*.mnt: mountpoint not found umount: /run/snapd/ns/: mountpoint not found Removing extra snap-confine apparmor rules Removing snapd state Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... eatmydata is already the newest version (105-3). dbus is already the newest version (1.10.6-1ubuntu3.3). 0 upgraded, 0 newly installed, 0 to remove and 7 not upgraded. Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: libhavege1 The following NEW packages will be installed: haveged libhavege1 0 upgraded, 2 newly installed, 0 to remove and 7 not upgraded. Need to get 49.5 kB of archives. After this operation, 227 kB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial/universe s390x libhavege1 s390x 1.9.1-3 [21.5 kB] Get:2 http://ftpmaster.internal/ubuntu xenial/universe s390x haveged s390x 1.9.1-3 [28.0 kB] Fetched 49.5 kB in 0s (191 kB/s) Selecting previously unselected package libhavege1:s390x. (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 ... 46472 files and directories currently installed.) Preparing to unpack .../libhavege1_1.9.1-3_s390x.deb ... Unpacking libhavege1:s390x (1.9.1-3) ... Selecting previously unselected package haveged. Preparing to unpack .../haveged_1.9.1-3_s390x.deb ... Unpacking haveged (1.9.1-3) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... Processing triggers for man-db (2.7.5-1) ... Setting up libhavege1:s390x (1.9.1-3) ... Setting up haveged (1.9.1-3) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: binutils libdpkg-perl make Suggested packages: binutils-doc debian-keyring gcc | c-compiler make-doc Recommended packages: gcc | c-compiler build-essential fakeroot libalgorithm-merge-perl libfile-fcntllock-perl The following NEW packages will be installed: binutils dpkg-dev libdpkg-perl make 0 upgraded, 4 newly installed, 0 to remove and 7 not upgraded. Need to get 1,986 kB of archives. After this operation, 8,760 kB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial-updates/main s390x binutils s390x 2.26.1-1ubuntu1~16.04.5 [1,057 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-updates/main s390x libdpkg-perl all 1.18.4ubuntu1.2 [195 kB] Get:3 http://ftpmaster.internal/ubuntu xenial/main s390x make s390x 4.1-6 [149 kB] Get:4 http://ftpmaster.internal/ubuntu xenial-updates/main s390x dpkg-dev all 1.18.4ubuntu1.2 [584 kB] Fetched 1,986 kB in 1s (1,702 kB/s) Selecting previously unselected package binutils. (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 ... 46488 files and directories currently installed.) Preparing to unpack .../binutils_2.26.1-1ubuntu1~16.04.5_s390x.deb ... Unpacking binutils (2.26.1-1ubuntu1~16.04.5) ... Selecting previously unselected package libdpkg-perl. Preparing to unpack .../libdpkg-perl_1.18.4ubuntu1.2_all.deb ... Unpacking libdpkg-perl (1.18.4ubuntu1.2) ... Selecting previously unselected package make. Preparing to unpack .../archives/make_4.1-6_s390x.deb ... Unpacking make (4.1-6) ... Selecting previously unselected package dpkg-dev. Preparing to unpack .../dpkg-dev_1.18.4ubuntu1.2_all.deb ... Unpacking dpkg-dev (1.18.4ubuntu1.2) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for man-db (2.7.5-1) ... Setting up binutils (2.26.1-1ubuntu1~16.04.5) ... Setting up libdpkg-perl (1.18.4ubuntu1.2) ... Setting up make (4.1-6) ... Setting up dpkg-dev (1.18.4ubuntu1.2) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: cloud-init* 0 upgraded, 0 newly installed, 1 to remove and 7 not upgraded. After this operation, 1,664 kB disk space will be freed. (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 ... 46952 files and directories currently installed.) Removing cloud-init (17.1-27-geb292c18-0ubuntu1~16.04.1) ... Removing 'diversion of /etc/init/ureadahead.conf to /etc/init/ureadahead.conf.disabled by cloud-init' Purging configuration files for cloud-init (17.1-27-geb292c18-0ubuntu1~16.04.1) ... dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: crda iw libnl-3-200 libnl-genl-3-200 linux-firmware linux-headers-4.4.0-101 linux-headers-4.4.0-101-generic linux-headers-generic linux-headers-virtual linux-image-4.4.0-101-generic linux-image-extra-4.4.0-101-generic linux-image-generic linux-image-virtual linux-virtual wireless-regdb Suggested packages: fdutils linux-doc-4.4.0 | linux-source-4.4.0 linux-tools The following NEW packages will be installed: crda iw libnl-3-200 libnl-genl-3-200 linux-firmware linux-generic linux-headers-4.4.0-101 linux-headers-4.4.0-101-generic linux-image-4.4.0-101-generic linux-image-extra-4.4.0-101-generic linux-image-generic wireless-regdb The following packages will be upgraded: linux-headers-generic linux-headers-virtual linux-image-virtual linux-virtual 4 upgraded, 12 newly installed, 0 to remove and 3 not upgraded. Need to get 70.4 MB of archives. After this operation, 333 MB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial-updates/main s390x libnl-3-200 s390x 3.2.27-1ubuntu0.16.04.1 [49.7 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-updates/main s390x libnl-genl-3-200 s390x 3.2.27-1ubuntu0.16.04.1 [11.0 kB] Get:3 http://ftpmaster.internal/ubuntu xenial/main s390x wireless-regdb all 2015.07.20-1ubuntu1 [9,058 B] Get:4 http://ftpmaster.internal/ubuntu xenial/main s390x iw s390x 3.17-1 [59.8 kB] Get:5 http://ftpmaster.internal/ubuntu xenial/main s390x crda s390x 3.13-1 [59.7 kB] Get:6 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-firmware all 1.157.13 [44.4 MB] Get:7 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-image-4.4.0-101-generic s390x 4.4.0-101.124 [12.9 MB] Get:8 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-image-extra-4.4.0-101-generic s390x 4.4.0-101.124 [2,576 kB] Get:9 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-image-generic s390x 4.4.0.101.106 [2,286 B] Get:10 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-virtual s390x 4.4.0.101.106 [1,782 B] Get:11 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-image-virtual s390x 4.4.0.101.106 [2,282 B] Get:12 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-headers-virtual s390x 4.4.0.101.106 [1,756 B] Get:13 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-headers-4.4.0-101 all 4.4.0-101.124 [9,916 kB] Get:14 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-headers-4.4.0-101-generic s390x 4.4.0-101.124 [447 kB] Get:15 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-headers-generic s390x 4.4.0.101.106 [2,270 B] Get:16 http://ftpmaster.internal/ubuntu xenial-updates/main s390x linux-generic s390x 4.4.0.101.106 [1,784 B] Fetched 70.4 MB in 22s (3,144 kB/s) Selecting previously unselected package libnl-3-200:s390x. (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 ... 46640 files and directories currently installed.) Preparing to unpack .../libnl-3-200_3.2.27-1ubuntu0.16.04.1_s390x.deb ... Unpacking libnl-3-200:s390x (3.2.27-1ubuntu0.16.04.1) ... Selecting previously unselected package libnl-genl-3-200:s390x. Preparing to unpack .../libnl-genl-3-200_3.2.27-1ubuntu0.16.04.1_s390x.deb ... Unpacking libnl-genl-3-200:s390x (3.2.27-1ubuntu0.16.04.1) ... Selecting previously unselected package wireless-regdb. Preparing to unpack .../wireless-regdb_2015.07.20-1ubuntu1_all.deb ... Unpacking wireless-regdb (2015.07.20-1ubuntu1) ... Selecting previously unselected package iw. Preparing to unpack .../archives/iw_3.17-1_s390x.deb ... Unpacking iw (3.17-1) ... Selecting previously unselected package crda. Preparing to unpack .../archives/crda_3.13-1_s390x.deb ... Unpacking crda (3.13-1) ... Selecting previously unselected package linux-firmware. Preparing to unpack .../linux-firmware_1.157.13_all.deb ... Unpacking linux-firmware (1.157.13) ... Selecting previously unselected package linux-image-4.4.0-101-generic. Preparing to unpack .../linux-image-4.4.0-101-generic_4.4.0-101.124_s390x.deb ... Done. Unpacking linux-image-4.4.0-101-generic (4.4.0-101.124) ... Selecting previously unselected package linux-image-extra-4.4.0-101-generic. Preparing to unpack .../linux-image-extra-4.4.0-101-generic_4.4.0-101.124_s390x.deb ... Unpacking linux-image-extra-4.4.0-101-generic (4.4.0-101.124) ... Selecting previously unselected package linux-image-generic. Preparing to unpack .../linux-image-generic_4.4.0.101.106_s390x.deb ... Unpacking linux-image-generic (4.4.0.101.106) ... Preparing to unpack .../linux-virtual_4.4.0.101.106_s390x.deb ... Unpacking linux-virtual (4.4.0.101.106) over (4.4.0.98.103) ... Preparing to unpack .../linux-image-virtual_4.4.0.101.106_s390x.deb ... Unpacking linux-image-virtual (4.4.0.101.106) over (4.4.0.98.103) ... Preparing to unpack .../linux-headers-virtual_4.4.0.101.106_s390x.deb ... Unpacking linux-headers-virtual (4.4.0.101.106) over (4.4.0.98.103) ... Selecting previously unselected package linux-headers-4.4.0-101. Preparing to unpack .../linux-headers-4.4.0-101_4.4.0-101.124_all.deb ... Unpacking linux-headers-4.4.0-101 (4.4.0-101.124) ... Selecting previously unselected package linux-headers-4.4.0-101-generic. Preparing to unpack .../linux-headers-4.4.0-101-generic_4.4.0-101.124_s390x.deb ... Unpacking linux-headers-4.4.0-101-generic (4.4.0-101.124) ... Preparing to unpack .../linux-headers-generic_4.4.0.101.106_s390x.deb ... Unpacking linux-headers-generic (4.4.0.101.106) over (4.4.0.98.103) ... Selecting previously unselected package linux-generic. Preparing to unpack .../linux-generic_4.4.0.101.106_s390x.deb ... Unpacking linux-generic (4.4.0.101.106) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for man-db (2.7.5-1) ... Setting up libnl-3-200:s390x (3.2.27-1ubuntu0.16.04.1) ... Setting up libnl-genl-3-200:s390x (3.2.27-1ubuntu0.16.04.1) ... Setting up wireless-regdb (2015.07.20-1ubuntu1) ... Setting up iw (3.17-1) ... Setting up crda (3.13-1) ... Setting up linux-firmware (1.157.13) ... update-initramfs: Generating /boot/initrd.img-4.4.0-98-generic W: mdadm: /etc/mdadm/mdadm.conf defines no arrays. Using config file '/etc/zipl.conf' Building bootmap in '/boot' Adding IPL section 'ubuntu' (default) Preparing boot device: vda (0000). Done. Setting up linux-image-4.4.0-101-generic (4.4.0-101.124) ... Running depmod. update-initramfs: deferring update (hook will be called later) Examining /etc/kernel/postinst.d. run-parts: executing /etc/kernel/postinst.d/apt-auto-removal 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/initramfs-tools 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic update-initramfs: Generating /boot/initrd.img-4.4.0-101-generic W: mdadm: /etc/mdadm/mdadm.conf defines no arrays. Using config file '/etc/zipl.conf' Building bootmap in '/boot' Adding IPL section 'ubuntu' (default) Preparing boot device: vda (0000). Done. run-parts: executing /etc/kernel/postinst.d/unattended-upgrades 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/update-notifier 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/zz-zipl 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic Using config file '/etc/zipl.conf' Building bootmap in '/boot' Adding IPL section 'ubuntu' (default) Preparing boot device: vda (0000). Done. Setting up linux-image-extra-4.4.0-101-generic (4.4.0-101.124) ... run-parts: executing /etc/kernel/postinst.d/apt-auto-removal 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/initramfs-tools 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic update-initramfs: Generating /boot/initrd.img-4.4.0-101-generic W: mdadm: /etc/mdadm/mdadm.conf defines no arrays. Using config file '/etc/zipl.conf' Building bootmap in '/boot' Adding IPL section 'ubuntu' (default) Preparing boot device: vda (0000). Done. run-parts: executing /etc/kernel/postinst.d/unattended-upgrades 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/update-notifier 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic run-parts: executing /etc/kernel/postinst.d/zz-zipl 4.4.0-101-generic /boot/vmlinuz-4.4.0-101-generic Using config file '/etc/zipl.conf' Building bootmap in '/boot' Adding IPL section 'ubuntu' (default) Preparing boot device: vda (0000). Done. Setting up linux-image-generic (4.4.0.101.106) ... Setting up linux-image-virtual (4.4.0.101.106) ... Setting up linux-headers-4.4.0-101 (4.4.0-101.124) ... Setting up linux-headers-4.4.0-101-generic (4.4.0-101.124) ... Setting up linux-headers-generic (4.4.0.101.106) ... Setting up linux-headers-virtual (4.4.0.101.106) ... Setting up linux-virtual (4.4.0.101.106) ... Setting up linux-generic (4.4.0.101.106) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Hit:1 http://ftpmaster.internal/ubuntu xenial InRelease Hit:2 http://ftpmaster.internal/ubuntu xenial-updates InRelease Hit:3 http://ftpmaster.internal/ubuntu xenial-proposed InRelease Reading package lists... Reading package lists... Building dependency tree... Reading state information... Calculating upgrade... The following packages will be upgraded: apport python3-apport python3-problem-report 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Need to get 210 kB of archives. After this operation, 0 B of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial-updates/main s390x python3-problem-report all 2.20.1-0ubuntu2.13 [10.1 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-updates/main s390x python3-apport all 2.20.1-0ubuntu2.13 [79.5 kB] Get:3 http://ftpmaster.internal/ubuntu xenial-updates/main s390x apport all 2.20.1-0ubuntu2.13 [120 kB] Fetched 210 kB in 0s (540 kB/s) (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 ... 69314 files and directories currently installed.) Preparing to unpack .../python3-problem-report_2.20.1-0ubuntu2.13_all.deb ... Unpacking python3-problem-report (2.20.1-0ubuntu2.13) over (2.20.1-0ubuntu2.12) ... Preparing to unpack .../python3-apport_2.20.1-0ubuntu2.13_all.deb ... Unpacking python3-apport (2.20.1-0ubuntu2.13) over (2.20.1-0ubuntu2.12) ... Preparing to unpack .../apport_2.20.1-0ubuntu2.13_all.deb ... Unpacking apport (2.20.1-0ubuntu2.13) over (2.20.1-0ubuntu2.12) ... Processing triggers for man-db (2.7.5-1) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... Setting up python3-problem-report (2.20.1-0ubuntu2.13) ... Setting up python3-apport (2.20.1-0ubuntu2.13) ... Setting up apport (2.20.1-0ubuntu2.13) ... Installing new version of config file /etc/init/apport.conf ... Processing triggers for ureadahead (0.100.0-19) ... autopkgtest [21:08:04]: rebooting testbed after setup commands that affected boot Connection to 10.44.42.192 closed by remote host. autopkgtest [21:08:20]: testbed running kernel: Linux 4.4.0-101-generic #124-Ubuntu SMP Fri Nov 10 18:29:39 UTC 2017 autopkgtest [21:08:21]: testbed dpkg architecture: s390x autopkgtest [21:08:22]: @@@@@@@@@@@@@@@@@@@@ apt-source docker.io Get:1 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (dsc) [3,896 B] Get:2 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (tar) [1,021 kB] Get:3 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (tar) [2,112 kB] Get:4 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (tar) [562 kB] Get:5 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (tar) [27.8 kB] Get:6 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (tar) [7,784 kB] Get:7 http://ftpmaster.internal/ubuntu xenial-proposed/universe docker.io 17.03.2-0ubuntu1~16.04.1 (diff) [38.6 kB] gpgv: Signature made Fri 17 Nov 2017 01:07:06 AM UTC using RSA key ID CCA39893 gpgv: Can't check signature: public key not found dpkg-source: warning: failed to verify signature on ./docker.io_17.03.2-0ubuntu1~16.04.1.dsc autopkgtest [21:08:26]: testing package docker.io version 17.03.2-0ubuntu1~16.04.1 autopkgtest [21:08:26]: build not needed autopkgtest [21:08:32]: test basic-smoke: preparing testbed Reading package lists... Building dependency tree... Reading state information... Correcting dependencies...Starting pkgProblemResolver with broken count: 0 Starting 2 pkgProblemResolver with broken count: 0 Done Done Starting pkgProblemResolver with broken count: 0 Starting 2 pkgProblemResolver with broken count: 0 Done The following additional packages will be installed: aufs-tools debian-archive-keyring debootstrap docker-doc docker.io golang-docker-dev golang-github-docker-docker-dev vim-syntax-docker Suggested packages: rinse zfs-fuse | zfsutils Recommended packages: cgroupfs-mount | cgroup-lite ubuntu-fan vim-addon-manager The following NEW packages will be installed: aufs-tools debian-archive-keyring debootstrap docker-doc docker.io golang-docker-dev golang-github-docker-docker-dev vim-syntax-docker 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded. 1 not fully installed or removed. Need to get 23.0 MB of archives. After this operation, 157 MB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial/universe s390x aufs-tools s390x 1:3.2+20130722-1.1ubuntu1 [92.8 kB] Get:2 http://ftpmaster.internal/ubuntu xenial/universe s390x debian-archive-keyring all 2014.3 [39.3 kB] Get:3 http://ftpmaster.internal/ubuntu xenial-updates/main s390x debootstrap all 1.0.78+nmu1ubuntu1.5 [36.4 kB] Get:4 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x docker.io s390x 17.03.2-0ubuntu1~16.04.1 [18.6 MB] Get:5 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x vim-syntax-docker all 17.03.2-0ubuntu1~16.04.1 [14.1 kB] Get:6 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x golang-github-docker-docker-dev all 17.03.2-0ubuntu1~16.04.1 [3,570 kB] Get:7 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x golang-docker-dev all 17.03.2-0ubuntu1~16.04.1 [11.5 kB] Get:8 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x docker-doc all 17.03.2-0ubuntu1~16.04.1 [587 kB] Fetched 23.0 MB in 2s (8,360 kB/s) Selecting previously unselected package aufs-tools. (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 ... 69314 files and directories currently installed.) Preparing to unpack .../aufs-tools_1%3a3.2+20130722-1.1ubuntu1_s390x.deb ... Unpacking aufs-tools (1:3.2+20130722-1.1ubuntu1) ... Selecting previously unselected package debian-archive-keyring. Preparing to unpack .../debian-archive-keyring_2014.3_all.deb ... Unpacking debian-archive-keyring (2014.3) ... Selecting previously unselected package debootstrap. Preparing to unpack .../debootstrap_1.0.78+nmu1ubuntu1.5_all.deb ... Unpacking debootstrap (1.0.78+nmu1ubuntu1.5) ... Selecting previously unselected package docker.io. Preparing to unpack .../docker.io_17.03.2-0ubuntu1~16.04.1_s390x.deb ... Unpacking docker.io (17.03.2-0ubuntu1~16.04.1) ... Selecting previously unselected package vim-syntax-docker. Preparing to unpack .../vim-syntax-docker_17.03.2-0ubuntu1~16.04.1_all.deb ... Unpacking vim-syntax-docker (17.03.2-0ubuntu1~16.04.1) ... Selecting previously unselected package golang-github-docker-docker-dev. Preparing to unpack .../golang-github-docker-docker-dev_17.03.2-0ubuntu1~16.04.1_all.deb ... Unpacking golang-github-docker-docker-dev (17.03.2-0ubuntu1~16.04.1) ... Selecting previously unselected package golang-docker-dev. Preparing to unpack .../golang-docker-dev_17.03.2-0ubuntu1~16.04.1_all.deb ... Unpacking golang-docker-dev (17.03.2-0ubuntu1~16.04.1) ... Selecting previously unselected package docker-doc. Preparing to unpack .../docker-doc_17.03.2-0ubuntu1~16.04.1_all.deb ... Unpacking docker-doc (17.03.2-0ubuntu1~16.04.1) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for man-db (2.7.5-1) ... Processing triggers for ureadahead (0.100.0-19) ... Processing triggers for systemd (229-4ubuntu21) ... Setting up aufs-tools (1:3.2+20130722-1.1ubuntu1) ... Setting up debian-archive-keyring (2014.3) ... Setting up debootstrap (1.0.78+nmu1ubuntu1.5) ... Setting up docker.io (17.03.2-0ubuntu1~16.04.1) ... Adding group `docker' (GID 118) ... Done. Setting up vim-syntax-docker (17.03.2-0ubuntu1~16.04.1) ... Setting up golang-github-docker-docker-dev (17.03.2-0ubuntu1~16.04.1) ... Setting up golang-docker-dev (17.03.2-0ubuntu1~16.04.1) ... Setting up docker-doc (17.03.2-0ubuntu1~16.04.1) ... Setting up autopkgtest-satdep (0) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... (Reading database ... 72887 files and directories currently installed.) Removing autopkgtest-satdep (0) ... autopkgtest [21:08:44]: test basic-smoke: [----------------------- ++ set -o pipefail ++ exitTraps=('true') ++ trap doExit EXIT +++ mktemp -d ++ tempDir=/tmp/tmp.WuGYKbuuwp ++ defer 'rm -rf '\''/tmp/tmp.WuGYKbuuwp'\''' ++ exitTraps=("$@" "${exitTraps[@]}") + /etc/init.d/docker start Starting docker (via systemctl): docker.service+ defer '/etc/init.d/docker stop' + exitTraps=("$@" "${exitTraps[@]}") + defer 'journalctl -u docker | tail' + exitTraps=("$@" "${exitTraps[@]}") + docker version . Client: Version: 17.03.2-ce API version: 1.27 Go version: go1.6.2 Git commit: f5ec1e2 Built: Tue Nov 21 16:41:55 2017 OS/Arch: linux/s390x Server: Version: 17.03.2-ce API version: 1.27 (minimum version 1.12) Go version: go1.6.2 Git commit: f5ec1e2 Built: Tue Nov 21 16:41:55 2017 OS/Arch: linux/s390x Experimental: false + debootstrap --variant=minbase stable /tmp/tmp.WuGYKbuuwp http://httpredir.debian.org/debian I: Retrieving InRelease I: Failed to retrieve InRelease I: Retrieving Release I: Retrieving Release.gpg I: Checking Release signature I: Valid Release signature (key id 126C0D24BD8A2942CC7DF8AC7638D0442B90D010) I: Retrieving Packages I: Validating Packages I: Resolving dependencies of required packages... I: Resolving dependencies of base packages... I: Found additional required dependencies: libaudit-common libaudit1 libbz2-1.0 libcap-ng0 libdb5.3 libdebconfclient0 libgcrypt20 libgpg-error0 liblz4-1 libncursesw5 libsemanage-common libsemanage1 libsystemd0 libudev1 libustr-1.0-1 I: Found additional base dependencies: adduser debian-archive-keyring gpgv libapt-pkg5.0 libstdc++6 I: Checking component main on http://httpredir.debian.org/debian... I: Retrieving libacl1 2.2.52-3+b1 I: Validating libacl1 2.2.52-3+b1 I: Retrieving adduser 3.115 I: Validating adduser 3.115 I: Retrieving apt 1.4.8 I: Validating apt 1.4.8 I: Retrieving libapt-pkg5.0 1.4.8 I: Validating libapt-pkg5.0 1.4.8 I: Retrieving libattr1 1:2.4.47-2+b2 I: Validating libattr1 1:2.4.47-2+b2 I: Retrieving libaudit-common 1:2.6.7-2 I: Validating libaudit-common 1:2.6.7-2 I: Retrieving libaudit1 1:2.6.7-2 I: Validating libaudit1 1:2.6.7-2 I: Retrieving base-files 9.9+deb9u1 I: Validating base-files 9.9+deb9u1 I: Retrieving base-passwd 3.5.43 I: Validating base-passwd 3.5.43 I: Retrieving bash 4.4-5 I: Validating bash 4.4-5 I: Retrieving libbz2-1.0 1.0.6-8.1 I: Validating libbz2-1.0 1.0.6-8.1 I: Retrieving libdebconfclient0 0.227 I: Validating libdebconfclient0 0.227 I: Retrieving coreutils 8.26-3 I: Validating coreutils 8.26-3 I: Retrieving dash 0.5.8-2.4 I: Validating dash 0.5.8-2.4 I: Retrieving libdb5.3 5.3.28-12+deb9u1 I: Validating libdb5.3 5.3.28-12+deb9u1 I: Retrieving debconf 1.5.61 I: Validating debconf 1.5.61 I: Retrieving debian-archive-keyring 2017.5 I: Validating debian-archive-keyring 2017.5 I: Retrieving debianutils 4.8.1.1 I: Validating debianutils 4.8.1.1 I: Retrieving diffutils 1:3.5-3 I: Validating diffutils 1:3.5-3 I: Retrieving dpkg 1.18.24 I: Validating dpkg 1.18.24 I: Retrieving e2fslibs 1.43.4-2 I: Validating e2fslibs 1.43.4-2 I: Retrieving e2fsprogs 1.43.4-2 I: Validating e2fsprogs 1.43.4-2 I: Retrieving libcomerr2 1.43.4-2 I: Validating libcomerr2 1.43.4-2 I: Retrieving libss2 1.43.4-2 I: Validating libss2 1.43.4-2 I: Retrieving findutils 4.6.0+git+20161106-2 I: Validating findutils 4.6.0+git+20161106-2 I: Retrieving gcc-6-base 6.3.0-18 I: Validating gcc-6-base 6.3.0-18 I: Retrieving libgcc1 1:6.3.0-18 I: Validating libgcc1 1:6.3.0-18 I: Retrieving libstdc++6 6.3.0-18 I: Validating libstdc++6 6.3.0-18 I: Retrieving libc-bin 2.24-11+deb9u1 I: Validating libc-bin 2.24-11+deb9u1 I: Retrieving libc6 2.24-11+deb9u1 I: Validating libc6 2.24-11+deb9u1 I: Retrieving multiarch-support 2.24-11+deb9u1 I: Validating multiarch-support 2.24-11+deb9u1 I: Retrieving gpgv 2.1.18-8~deb9u1 I: Validating gpgv 2.1.18-8~deb9u1 I: Retrieving grep 2.27-2 I: Validating grep 2.27-2 I: Retrieving gzip 1.6-5+b1 I: Validating gzip 1.6-5+b1 I: Retrieving hostname 3.18+b1 I: Validating hostname 3.18+b1 I: Retrieving init-system-helpers 1.48 I: Validating init-system-helpers 1.48 I: Retrieving libcap-ng0 0.7.7-3+b1 I: Validating libcap-ng0 0.7.7-3+b1 I: Retrieving libgcrypt20 1.7.6-2+deb9u2 I: Validating libgcrypt20 1.7.6-2+deb9u2 I: Retrieving libgpg-error0 1.26-2 I: Validating libgpg-error0 1.26-2 I: Retrieving libselinux1 2.6-3+b3 I: Validating libselinux1 2.6-3+b3 I: Retrieving libsemanage-common 2.6-2 I: Validating libsemanage-common 2.6-2 I: Retrieving libsemanage1 2.6-2 I: Validating libsemanage1 2.6-2 I: Retrieving libsepol1 2.6-2 I: Validating libsepol1 2.6-2 I: Retrieving lsb-base 9.20161125 I: Validating lsb-base 9.20161125 I: Retrieving liblz4-1 0.0~r131-2+b1 I: Validating liblz4-1 0.0~r131-2+b1 I: Retrieving mawk 1.3.3-17+b3 I: Validating mawk 1.3.3-17+b3 I: Retrieving libncursesw5 6.0+20161126-1+deb9u1 I: Validating libncursesw5 6.0+20161126-1+deb9u1 I: Retrieving libtinfo5 6.0+20161126-1+deb9u1 I: Validating libtinfo5 6.0+20161126-1+deb9u1 I: Retrieving ncurses-base 6.0+20161126-1+deb9u1 I: Validating ncurses-base 6.0+20161126-1+deb9u1 I: Retrieving ncurses-bin 6.0+20161126-1+deb9u1 I: Validating ncurses-bin 6.0+20161126-1+deb9u1 I: Retrieving libpam-modules 1.1.8-3.6 I: Validating libpam-modules 1.1.8-3.6 I: Retrieving libpam-modules-bin 1.1.8-3.6 I: Validating libpam-modules-bin 1.1.8-3.6 I: Retrieving libpam-runtime 1.1.8-3.6 I: Validating libpam-runtime 1.1.8-3.6 I: Retrieving libpam0g 1.1.8-3.6 I: Validating libpam0g 1.1.8-3.6 I: Retrieving libpcre3 2:8.39-3 I: Validating libpcre3 2:8.39-3 I: Retrieving perl-base 5.24.1-3+deb9u2 I: Validating perl-base 5.24.1-3+deb9u2 I: Retrieving sed 4.4-1 I: Validating sed 4.4-1 I: Retrieving sensible-utils 0.0.9 I: Validating sensible-utils 0.0.9 I: Retrieving login 1:4.4-4.1 I: Validating login 1:4.4-4.1 I: Retrieving passwd 1:4.4-4.1 I: Validating passwd 1:4.4-4.1 I: Retrieving libsystemd0 232-25+deb9u1 I: Validating libsystemd0 232-25+deb9u1 I: Retrieving libudev1 232-25+deb9u1 I: Validating libudev1 232-25+deb9u1 I: Retrieving sysvinit-utils 2.88dsf-59.9 I: Validating sysvinit-utils 2.88dsf-59.9 I: Retrieving tar 1.29b-1.1 I: Validating tar 1.29b-1.1 I: Retrieving tzdata 2017b-1 I: Validating tzdata 2017b-1 I: Retrieving libustr-1.0-1 1.0.4-6 I: Validating libustr-1.0-1 1.0.4-6 I: Retrieving bsdutils 1:2.29.2-1 I: Validating bsdutils 1:2.29.2-1 I: Retrieving libblkid1 2.29.2-1 I: Validating libblkid1 2.29.2-1 I: Retrieving libfdisk1 2.29.2-1 I: Validating libfdisk1 2.29.2-1 I: Retrieving libmount1 2.29.2-1 I: Validating libmount1 2.29.2-1 I: Retrieving libsmartcols1 2.29.2-1 I: Validating libsmartcols1 2.29.2-1 I: Retrieving libuuid1 2.29.2-1 I: Validating libuuid1 2.29.2-1 I: Retrieving mount 2.29.2-1 I: Validating mount 2.29.2-1 I: Retrieving util-linux 2.29.2-1 I: Validating util-linux 2.29.2-1 I: Retrieving liblzma5 5.2.2-1.2+b1 I: Validating liblzma5 5.2.2-1.2+b1 I: Retrieving zlib1g 1:1.2.8.dfsg-5 I: Validating zlib1g 1:1.2.8.dfsg-5 I: Chosen extractor for .deb packages: dpkg-deb I: Extracting libacl1... I: Extracting libattr1... I: Extracting libaudit-common... I: Extracting libaudit1... I: Extracting base-files... I: Extracting base-passwd... I: Extracting bash... I: Extracting libbz2-1.0... I: Extracting libdebconfclient0... I: Extracting coreutils... I: Extracting dash... I: Extracting libdb5.3... I: Extracting debconf... I: Extracting debianutils... I: Extracting diffutils... I: Extracting dpkg... I: Extracting e2fslibs... I: Extracting e2fsprogs... I: Extracting libcomerr2... I: Extracting libss2... I: Extracting findutils... I: Extracting gcc-6-base... I: Extracting libgcc1... I: Extracting libc-bin... I: Extracting libc6... I: Extracting multiarch-support... I: Extracting grep... I: Extracting gzip... I: Extracting hostname... I: Extracting init-system-helpers... I: Extracting libcap-ng0... I: Extracting libgcrypt20... I: Extracting libgpg-error0... I: Extracting libselinux1... I: Extracting libsemanage-common... I: Extracting libsemanage1... I: Extracting libsepol1... I: Extracting lsb-base... I: Extracting liblz4-1... I: Extracting mawk... I: Extracting libncursesw5... I: Extracting libtinfo5... I: Extracting ncurses-base... I: Extracting ncurses-bin... I: Extracting libpam-modules... I: Extracting libpam-modules-bin... I: Extracting libpam-runtime... I: Extracting libpam0g... I: Extracting libpcre3... I: Extracting perl-base... I: Extracting sed... I: Extracting sensible-utils... I: Extracting login... I: Extracting passwd... I: Extracting libsystemd0... I: Extracting libudev1... I: Extracting sysvinit-utils... I: Extracting tar... I: Extracting tzdata... I: Extracting libustr-1.0-1... I: Extracting bsdutils... I: Extracting libblkid1... I: Extracting libfdisk1... I: Extracting libmount1... I: Extracting libsmartcols1... I: Extracting libuuid1... I: Extracting mount... I: Extracting util-linux... I: Extracting liblzma5... I: Extracting zlib1g... I: Installing core packages... I: Unpacking required packages... I: Unpacking libacl1:s390x... I: Unpacking libattr1:s390x... I: Unpacking libaudit-common... I: Unpacking libaudit1:s390x... I: Unpacking base-files... I: Unpacking base-passwd... I: Unpacking bash... I: Unpacking libbz2-1.0:s390x... I: Unpacking libdebconfclient0:s390x... I: Unpacking coreutils... I: Unpacking dash... I: Unpacking libdb5.3:s390x... I: Unpacking debconf... I: Unpacking debianutils... I: Unpacking diffutils... I: Unpacking dpkg... I: Unpacking e2fslibs:s390x... I: Unpacking e2fsprogs... I: Unpacking libcomerr2:s390x... I: Unpacking libss2:s390x... I: Unpacking findutils... I: Unpacking gcc-6-base:s390x... I: Unpacking libgcc1:s390x... I: Unpacking libc-bin... I: Unpacking libc6:s390x... I: Unpacking multiarch-support... I: Unpacking grep... I: Unpacking gzip... I: Unpacking hostname... I: Unpacking init-system-helpers... I: Unpacking libcap-ng0:s390x... I: Unpacking libgcrypt20:s390x... I: Unpacking libgpg-error0:s390x... I: Unpacking libselinux1:s390x... I: Unpacking libsemanage-common... I: Unpacking libsemanage1:s390x... I: Unpacking libsepol1:s390x... I: Unpacking lsb-base... I: Unpacking liblz4-1:s390x... I: Unpacking mawk... I: Unpacking libncursesw5:s390x... I: Unpacking libtinfo5:s390x... I: Unpacking ncurses-base... I: Unpacking ncurses-bin... I: Unpacking libpam-modules:s390x... I: Unpacking libpam-modules-bin... I: Unpacking libpam-runtime... I: Unpacking libpam0g:s390x... I: Unpacking libpcre3:s390x... I: Unpacking perl-base... I: Unpacking sed... I: Unpacking sensible-utils... I: Unpacking login... I: Unpacking passwd... I: Unpacking libsystemd0:s390x... I: Unpacking libudev1:s390x... I: Unpacking sysvinit-utils... I: Unpacking tar... I: Unpacking tzdata... I: Unpacking libustr-1.0-1:s390x... I: Unpacking bsdutils... I: Unpacking libblkid1:s390x... I: Unpacking libfdisk1:s390x... I: Unpacking libmount1:s390x... I: Unpacking libsmartcols1:s390x... I: Unpacking libuuid1:s390x... I: Unpacking mount... I: Unpacking util-linux... I: Unpacking liblzma5:s390x... I: Unpacking zlib1g:s390x... I: Configuring required packages... I: Configuring gcc-6-base:s390x... I: Configuring lsb-base... I: Configuring sensible-utils... I: Configuring ncurses-base... I: Configuring libsemanage-common... I: Configuring libaudit-common... I: Configuring libc6:s390x... I: Configuring libbz2-1.0:s390x... I: Configuring libgpg-error0:s390x... I: Configuring libc-bin... I: Configuring libdebconfclient0:s390x... I: Configuring diffutils... I: Configuring libcomerr2:s390x... I: Configuring libcap-ng0:s390x... I: Configuring libsepol1:s390x... I: Configuring libgcc1:s390x... I: Configuring libustr-1.0-1:s390x... I: Configuring libsmartcols1:s390x... I: Configuring libaudit1:s390x... I: Configuring libtinfo5:s390x... I: Configuring libudev1:s390x... I: Configuring libattr1:s390x... I: Configuring libss2:s390x... I: Configuring liblzma5:s390x... I: Configuring base-passwd... I: Configuring e2fslibs:s390x... I: Configuring liblz4-1:s390x... I: Configuring debianutils... I: Configuring libgcrypt20:s390x... I: Configuring libncursesw5:s390x... I: Configuring libdb5.3:s390x... I: Configuring zlib1g:s390x... I: Configuring hostname... I: Configuring multiarch-support... I: Configuring mawk... I: Configuring libpcre3:s390x... I: Configuring base-files... I: Configuring libselinux1:s390x... I: Configuring findutils... I: Configuring libacl1:s390x... I: Configuring ncurses-bin... I: Configuring sed... I: Configuring libsystemd0:s390x... I: Configuring coreutils... I: Configuring tar... I: Configuring libsemanage1:s390x... I: Configuring dpkg... I: Configuring perl-base... I: Configuring grep... I: Configuring debconf... I: Configuring tzdata... I: Configuring gzip... I: Configuring bsdutils... I: Configuring dash... I: Configuring init-system-helpers... I: Configuring libpam0g:s390x... I: Configuring libpam-modules-bin... I: Configuring bash... I: Configuring libpam-modules:s390x... I: Configuring libpam-runtime... I: Configuring passwd... I: Configuring login... I: Configuring libuuid1:s390x... I: Configuring libblkid1:s390x... I: Configuring libmount1:s390x... I: Configuring mount... I: Configuring libfdisk1:s390x... I: Configuring util-linux... I: Configuring e2fsprogs... I: Configuring sysvinit-utils... I: Configuring libc-bin... I: Unpacking the base system... I: Unpacking adduser... I: Unpacking apt... I: Unpacking libapt-pkg5.0:s390x... I: Unpacking debian-archive-keyring... I: Unpacking libstdc++6:s390x... I: Unpacking gpgv... I: Configuring the base system... I: Configuring gpgv... I: Configuring debian-archive-keyring... I: Configuring libstdc++6:s390x... I: Configuring adduser... I: Configuring libapt-pkg5.0:s390x... I: Configuring apt... I: Configuring libc-bin... I: Base system installed successfully. + docker import - debian + tar -cC /tmp/tmp.WuGYKbuuwp . sha256:98e5c585c25bb47c766e636bc65d550385cbaaffb36d03c861de21d2fdb69030 + defer 'docker rmi debian' + exitTraps=("$@" "${exitTraps[@]}") + docker run --name test debian true + defer 'docker rm -f test' + exitTraps=("$@" "${exitTraps[@]}") + doExit + for exitTrap in '"${exitTraps[@]}"' + eval 'docker rm -f test' ++ docker rm -f test test + for exitTrap in '"${exitTraps[@]}"' + eval 'docker rmi debian' ++ docker rmi debian Untagged: debian:latest Deleted: sha256:98e5c585c25bb47c766e636bc65d550385cbaaffb36d03c861de21d2fdb69030 Deleted: sha256:25bce125b3c76ec43ba6affa6b45708ddd7b82a17952cc822804f1e14fef1fd8 + for exitTrap in '"${exitTraps[@]}"' + eval 'journalctl -u docker | tail' ++ tail ++ journalctl -u docker + for exitTrap in '"${exitTraps[@]}"' + eval '/etc/init.d/docker stop' ++ /etc/init.d/docker stop Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.018612000Z" level=info msg="Loading containers: start." Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.040090000Z" level=info msg="Firewalld running: false" Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.126233000Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.173050000Z" level=info msg="Loading containers: done." Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.186294000Z" level=warning msg="failed to retrieve docker-init version: unknown output format: tini version 0.13.0\n" Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.186507000Z" level=info msg="Daemon has completed initialization" Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.186605000Z" level=info msg="Docker daemon" commit=f5ec1e2 graphdriver=aufs version=17.03.2-ce Nov 21 21:08:33 autopkgtest systemd[1]: Started Docker Application Container Engine. Nov 21 21:08:33 autopkgtest dockerd[2223]: time="2017-11-21T21:08:33.211944000Z" level=info msg="API listen on /var/run/docker.sock" Nov 21 21:08:35 autopkgtest systemd[1]: Started Docker Application Container Engine. Stopping docker (via systemctl): docker.service+ for exitTrap in '"${exitTraps[@]}"' + eval 'rm -rf '\''/tmp/tmp.WuGYKbuuwp'\''' ++ rm -rf /tmp/tmp.WuGYKbuuwp . + for exitTrap in '"${exitTraps[@]}"' + eval true ++ true autopkgtest [21:10:34]: test basic-smoke: -----------------------] autopkgtest [21:10:34]: test basic-smoke: - - - - - - - - - - results - - - - - - - - - - basic-smoke PASS autopkgtest [21:10:35]: test docker-in-lxd: preparing testbed Creating nova instance adt-xenial-s390x-docker.io-20171121-210627 from image auto-sync/ubuntu-xenial-daily-s390x-server-20171118-disk1.img (UUID 48eeb751-9a9b-4bdb-af1d-945309dad5b0)... Creating nova instance adt-xenial-s390x-docker.io-20171121-210627 from image auto-sync/ubuntu-xenial-daily-s390x-server-20171118-disk1.img (UUID 48eeb751-9a9b-4bdb-af1d-945309dad5b0)... nova boot failed (attempt #1): DEBUG (extension:157) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') DEBUG (extension:157) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') DEBUG (extension:157) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') DEBUG (extension:157) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') DEBUG (extension:157) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') DEBUG (extension:157) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') DEBUG (extension:157) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') DEBUG (extension:157) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') DEBUG (extension:157) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') DEBUG (session:248) REQ: curl -g -i -X GET http://keystone.infra.bos02.scalingstack:5000/v2.0/ -H "Accept: application/json" -H "User-Agent: keystoneauth1/2.4.1 python-requests/2.9.1 CPython/3.5.2" INFO (connectionpool:208) Starting new HTTP connection (1): keystone.infra.bos02.scalingstack DEBUG (connectionpool:388) "GET /v2.0/ HTTP/1.1" 200 359 DEBUG (session:277) RESP: [200] Server: Apache/2.4.18 (Ubuntu) Content-Length: 359 Connection: Keep-Alive Date: Tue, 21 Nov 2017 21:10:48 GMT Vary: X-Auth-Token x-openstack-request-id: req-4f3adf74-1a89-44a3-b7fa-80137e8fa381 Content-Type: application/json X-Distribution: Ubuntu Keep-Alive: timeout=5, max=100 RESP BODY: {"version": {"status": "stable", "updated": "2014-04-17T00:00:00Z", "media-types": [{"base": "application/json", "type": "application/vnd.openstack.identity-v2.0+json"}], "id": "v2.0", "links": [{"href": "http://keystone.infra.bos02.scalingstack:5000/v2.0/", "rel": "self"}, {"href": "http://docs.openstack.org/", "type": "text/html", "rel": "describedby"}]}} DEBUG (v2:63) Making authentication request to http://keystone.infra.bos02.scalingstack:5000/v2.0/tokens DEBUG (connectionpool:388) "POST /v2.0/tokens HTTP/1.1" 200 2251 DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734 -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" INFO (connectionpool:208) Starting new HTTP connection (1): nova-api.infra.bos02.scalingstack DEBUG (connectionpool:388) "GET /v2/1b1acdc76c1d4b9c86cdad125fa43734 HTTP/1.1" 404 52 DEBUG (session:277) RESP: [404] X-Compute-Request-Id: req-31623acb-a207-4234-bab8-f9973012e2a4 Content-Length: 52 Content-Type: text/plain; charset=UTF-8 Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:48 GMT RESP BODY: 404 Not Found The resource could not be found. DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/ -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" DEBUG (connectionpool:388) "GET /v2/ HTTP/1.1" 200 398 DEBUG (session:277) RESP: [200] X-Compute-Request-Id: req-b418b67f-8145-484d-8d27-9e1c62929c0b Content-Length: 398 Content-Type: application/json Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:48 GMT RESP BODY: {"version": {"status": "SUPPORTED", "updated": "2011-01-21T11:33:21Z", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/", "rel": "self"}, {"href": "http://docs.openstack.org/", "type": "text/html", "rel": "describedby"}], "min_version": "", "version": "", "media-types": [{"base": "application/json", "type": "application/vnd.openstack.compute+json;version=2"}], "id": "v2.0"}} DEBUG (extension:157) found extension EntryPoint.parse('v3token = keystoneauth1.loading._plugins.identity.v3:Token') DEBUG (extension:157) found extension EntryPoint.parse('v2token = keystoneauth1.loading._plugins.identity.v2:Token') DEBUG (extension:157) found extension EntryPoint.parse('v3password = keystoneauth1.loading._plugins.identity.v3:Password') DEBUG (extension:157) found extension EntryPoint.parse('token = keystoneauth1.loading._plugins.identity.generic:Token') DEBUG (extension:157) found extension EntryPoint.parse('admin_token = keystoneauth1.loading._plugins.admin_token:AdminToken') DEBUG (extension:157) found extension EntryPoint.parse('password = keystoneauth1.loading._plugins.identity.generic:Password') DEBUG (extension:157) found extension EntryPoint.parse('v2password = keystoneauth1.loading._plugins.identity.v2:Password') DEBUG (extension:157) found extension EntryPoint.parse('v3oidcpassword = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectPassword') DEBUG (extension:157) found extension EntryPoint.parse('v3oidcauthcode = keystoneauth1.loading._plugins.identity.v3:OpenIDConnectAuthorizationCode') WARNING: Option "--key_name" is deprecated; use "--key-name"; this option will be removed in novaclient 3.3.0. DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/images/48eeb751-9a9b-4bdb-af1d-945309dad5b0 -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" DEBUG (connectionpool:388) "GET /v2/1b1acdc76c1d4b9c86cdad125fa43734/images/48eeb751-9a9b-4bdb-af1d-945309dad5b0 HTTP/1.1" 200 1029 DEBUG (session:277) RESP: [200] X-Compute-Request-Id: req-fddb2be5-aa89-42f4-9646-d49b30dd88af Content-Length: 1029 Content-Type: application/json Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:49 GMT RESP BODY: {"image": {"status": "ACTIVE", "updated": "2017-11-19T06:25:37Z", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/images/48eeb751-9a9b-4bdb-af1d-945309dad5b0", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/images/48eeb751-9a9b-4bdb-af1d-945309dad5b0", "rel": "bookmark"}, {"href": "http://10.189.128.129:9292/images/48eeb751-9a9b-4bdb-af1d-945309dad5b0", "type": "application/vnd.openstack.image", "rel": "alternate"}], "id": "48eeb751-9a9b-4bdb-af1d-945309dad5b0", "OS-EXT-IMG-SIZE:size": 275316736, "name": "auto-sync/ubuntu-xenial-daily-s390x-server-20171118-disk1.img", "created": "2017-11-19T06:25:35Z", "minDisk": 0, "progress": 100, "minRam": 0, "metadata": {"item_name": "disk1.img", "hypervisor_type": "kvm", "architecture": "s390x", "version_name": "20171118", "content_id": "auto.sync", "product_name": "com.ubuntu.cloud.daily:server:16.04:s390x", "source_content_id": "com.ubuntu.cloud:daily:download"}}} DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/autopkgtest -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" DEBUG (connectionpool:388) "GET /v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/autopkgtest HTTP/1.1" 404 84 DEBUG (session:277) RESP: [404] X-Compute-Request-Id: req-29d2938f-edd0-4c5f-a392-0aeba07fd38b Content-Length: 84 Content-Type: application/json; charset=UTF-8 Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:49 GMT RESP BODY: {"itemNotFound": {"message": "Flavor autopkgtest could not be found.", "code": 404}} DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors?is_public=None -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" DEBUG (connectionpool:388) "GET /v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors?is_public=None HTTP/1.1" 200 3046 DEBUG (session:277) RESP: [200] X-Compute-Request-Id: req-00349188-37ee-447c-8c06-a7bc04c7fd0d Content-Length: 3046 Content-Type: application/json Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:49 GMT RESP BODY: {"flavors": [{"id": "1", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/1", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/1", "rel": "bookmark"}], "name": "m1.tiny"}, {"id": "2", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/2", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/2", "rel": "bookmark"}], "name": "m1.small"}, {"id": "263811d3-f0a6-4177-b2ec-861e400683de", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/263811d3-f0a6-4177-b2ec-861e400683de", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/263811d3-f0a6-4177-b2ec-861e400683de", "rel": "bookmark"}], "name": "vbuilder"}, {"id": "3", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/3", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/3", "rel": "bookmark"}], "name": "m1.medium"}, {"id": "4", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/4", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/4", "rel": "bookmark"}], "name": "m1.large"}, {"id": "42d22faf-2fc5-4866-b3f9-6669ddd3ea84", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/42d22faf-2fc5-4866-b3f9-6669ddd3ea84", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/42d22faf-2fc5-4866-b3f9-6669ddd3ea84", "rel": "bookmark"}], "name": "jenkaas-slave-cpu2-ram8-disk50"}, {"id": "5", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/5", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/5", "rel": "bookmark"}], "name": "m1.xlarge"}, {"id": "aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "rel": "bookmark"}], "name": "autopkgtest"}, {"id": "be224e05-6ebe-4484-8c1c-3bdcde32a89d", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/be224e05-6ebe-4484-8c1c-3bdcde32a89d", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/be224e05-6ebe-4484-8c1c-3bdcde32a89d", "rel": "bookmark"}], "name": "jenkaas-slave-cpu4-ram8-disk50"}]} DEBUG (session:248) REQ: curl -g -i -X GET http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807 -H "Accept: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" DEBUG (connectionpool:388) "GET /v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807 HTTP/1.1" 200 575 DEBUG (session:277) RESP: [200] X-Compute-Request-Id: req-4cc168a7-c380-4cce-aa36-7a6e463f4be0 Content-Length: 575 Content-Type: application/json Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:49 GMT RESP BODY: {"flavor": {"name": "autopkgtest", "links": [{"href": "http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "rel": "self"}, {"href": "http://nova-api.infra.bos02.scalingstack:8774/1b1acdc76c1d4b9c86cdad125fa43734/flavors/aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "rel": "bookmark"}], "ram": 1536, "OS-FLV-DISABLED:disabled": false, "vcpus": 1, "swap": "", "os-flavor-access:is_public": true, "rxtx_factor": 1.0, "OS-FLV-EXT-DATA:ephemeral": 0, "disk": 20, "id": "aea8bb59-2c51-4a96-9fea-89fe8bfe1807"}} DEBUG (session:248) REQ: curl -g -i -X POST http://nova-api.infra.bos02.scalingstack:8774/v2/1b1acdc76c1d4b9c86cdad125fa43734/servers -H "Accept: application/json" -H "Content-Type: application/json" -H "User-Agent: python-novaclient" -H "X-Auth-Token: {SHA1}c8d39d6b1a3c1fe84a1e2e469b12746fe7a0db04" -d '{"server": {"user_data": "I2Nsb3VkLWNvbmZpZwpob3N0bmFtZTogYXV0b3BrZ3Rlc3QKbWFuYWdlX2V0Y19ob3N0czogdHJ1ZQphcHRfdXBkYXRlOiB0cnVlCmFwdF91cGdyYWRlOiBmYWxzZQphcHRfbWlycm9yOiBodHRwOi8vZnRwbWFzdGVyLmludGVybmFsL3VidW50dQoKcnVuY21kOgogLSBlY2hvICdBY3F1aXJlOjpMYW5ndWFnZXMgIm5vbmUiOycgPiAvZXRjL2FwdC9hcHQuY29uZi5kLzkwbm9sYW5ndWFnZXMKIC0gZWNobyAnZm9yY2UtdW5zYWZlLWlvJyA+IC9ldGMvZHBrZy9kcGtnLmNmZy5kL2F1dG9wa2d0ZXN0CiAtIHByaW50ZiAnXG4naHR0cF9wcm94eT1odHRwOi8vc3F1aWQuaW50ZXJuYWw6MzEyOCdcbidodHRwc19wcm94eT1odHRwOi8vc3F1aWQuaW50ZXJuYWw6MzEyOCdcbidub19wcm94eT0xMjcuMC4wLjEsMTI3LjAuMS4xLGxvY2FsaG9zdCxsb2NhbGRvbWFpbixub3ZhbG9jYWwsaW50ZXJuYWwsYXJjaGl2ZS51YnVudHUuY29tLHNlY3VyaXR5LnVidW50dS5jb20sY2hhbmdlbG9ncy51YnVudHUuY29tLGRkZWJzLnVidW50dS5jb20scHBhLmxhdW5jaHBhZC5uZXQnJyA+PiAvZXRjL2Vudmlyb25tZW50CiAtIHNlZCAtaSAtciAnL14xMjcuMC4xLjEvIHMvYXV0b3BrZ3Rlc3QtW14gXStcLi9hdXRvcGtndGVzdFwuLycgL2V0Yy9ob3N0cwo=", "networks": [{"uuid": "035def34-7037-40da-bdf8-fc02be1b1d5a"}], "key_name": "testbed-juju-prod-ues-proposed-migration-machine-11", "name": "adt-xenial-s390x-docker.io-20171121-210627", "imageRef": "48eeb751-9a9b-4bdb-af1d-945309dad5b0", "flavorRef": "aea8bb59-2c51-4a96-9fea-89fe8bfe1807", "max_count": 1, "min_count": 1}}' DEBUG (connectionpool:388) "POST /v2/1b1acdc76c1d4b9c86cdad125fa43734/servers HTTP/1.1" 403 75 DEBUG (session:277) RESP: [403] X-Compute-Request-Id: req-9bec4261-c2c5-48d8-9630-88fa9d1b9ad2 Content-Length: 75 Content-Type: application/json; charset=UTF-8 Connection: keep-alive Date: Tue, 21 Nov 2017 21:10:49 GMT RESP BODY: {"forbidden": {"message": "Maximum number of ports exceeded", "code": 403}} DEBUG (shell:1082) Maximum number of ports exceeded (HTTP 403) (Request-ID: req-9bec4261-c2c5-48d8-9630-88fa9d1b9ad2) Traceback (most recent call last): File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 1080, in main OpenStackComputeShell().main(argv) File "/usr/lib/python3/dist-packages/novaclient/shell.py", line 1007, in main args.func(self.cs, args) File "/usr/lib/python3/dist-packages/novaclient/v2/shell.py", line 589, in do_boot server = cs.servers.create(*boot_args, **boot_kwargs) File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 1233, in create **boot_kwargs) File "/usr/lib/python3/dist-packages/novaclient/v2/servers.py", line 667, in _boot return_raw=return_raw, **kwargs) File "/usr/lib/python3/dist-packages/novaclient/base.py", line 345, in _create resp, body = self.api.client.post(url, body=body) File "/usr/lib/python3/dist-packages/keystoneauth1/adapter.py", line 179, in post return self.request(url, 'POST', **kwargs) File "/usr/lib/python3/dist-packages/novaclient/client.py", line 94, in request raise exceptions.from_response(resp, body, url, method) novaclient.exceptions.Forbidden: Maximum number of ports exceeded (HTTP 403) (Request-ID: req-9bec4261-c2c5-48d8-9630-88fa9d1b9ad2) ERROR (Forbidden): Maximum number of ports exceeded (HTTP 403) (Request-ID: req-9bec4261-c2c5-48d8-9630-88fa9d1b9ad2) autopkgtest [21:16:21]: @@@@@@@@@@@@@@@@@@@@ test bed setup Get:1 http://ftpmaster.internal/ubuntu xenial-proposed InRelease [253 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-proposed/main Sources [78.1 kB] Get:3 http://ftpmaster.internal/ubuntu xenial-proposed/restricted Sources [968 B] Get:4 http://ftpmaster.internal/ubuntu xenial-proposed/universe Sources [38.6 kB] Get:5 http://ftpmaster.internal/ubuntu xenial-proposed/multiverse Sources [1,872 B] Get:6 http://ftpmaster.internal/ubuntu xenial-proposed/main s390x Packages [73.8 kB] Get:7 http://ftpmaster.internal/ubuntu xenial-proposed/universe s390x Packages [32.4 kB] Get:8 http://ftpmaster.internal/ubuntu xenial-proposed/multiverse s390x Packages [1,772 B] Fetched 481 kB in 0s (534 kB/s) Reading package lists... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: lxd* 0 upgraded, 0 newly installed, 1 to remove and 7 not upgraded. After this operation, 22.1 MB disk space will be freed. (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 ... 46556 files and directories currently installed.) Removing lxd (2.0.10-0ubuntu1~16.04.2) ... Warning: Stopping lxd.service, but it can still be activated by: lxd.socket Purging configuration files for lxd (2.0.10-0ubuntu1~16.04.2) ... Failed to stop lxd.service: Unit lxd.service not loaded. dpkg: warning: while removing lxd, directory '/var/lib/lxd' not empty so not removed Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: lxd-client* 0 upgraded, 0 newly installed, 1 to remove and 7 not upgraded. After this operation, 12.0 MB disk space will be freed. (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 ... 46533 files and directories currently installed.) Removing lxd-client (2.0.10-0ubuntu1~16.04.2) ... Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... The following packages will be REMOVED: snapd* ubuntu-core-launcher* 0 upgraded, 0 newly installed, 2 to remove and 7 not upgraded. After this operation, 75.6 MB disk space will be freed. (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 ... 46526 files and directories currently installed.) Removing ubuntu-core-launcher (2.28.5) ... Removing snapd (2.28.5) ... Warning: Stopping snapd.service, but it can still be activated by: snapd.socket Purging configuration files for snapd (2.28.5) ... Final directory cleanup Discarding preserved snap namespaces umount: /run/snapd/ns/*.mnt: mountpoint not found umount: /run/snapd/ns/: mountpoint not found Removing extra snap-confine apparmor rules Removing snapd state Processing triggers for man-db (2.7.5-1) ... Reading package lists... Building dependency tree... Reading state information... eatmydata is already the newest version (105-3). dbus is already the newest version (1.10.6-1ubuntu3.3). 0 upgraded, 0 newly installed, 0 to remove and 7 not upgraded. Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: libhavege1 The following NEW packages will be installed: haveged libhavege1 0 upgraded, 2 newly installed, 0 to remove and 7 not upgraded. Need to get 49.5 kB of archives. After this operation, 227 kB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial/universe s390x libhavege1 s390x 1.9.1-3 [21.5 kB] Get:2 http://ftpmaster.internal/ubuntu xenial/universe s390x haveged s390x 1.9.1-3 [28.0 kB] Fetched 49.5 kB in 0s (191 kB/s) Selecting previously unselected package libhavege1:s390x. (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 ... 46472 files and directories currently installed.) Preparing to unpack .../libhavege1_1.9.1-3_s390x.deb ... Unpacking libhavege1:s390x (1.9.1-3) ... Selecting previously unselected package haveged. Preparing to unpack .../haveged_1.9.1-3_s390x.deb ... Unpacking haveged (1.9.1-3) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... Processing triggers for man-db (2.7.5-1) ... Setting up libhavege1:s390x (1.9.1-3) ... Setting up haveged (1.9.1-3) ... Processing triggers for libc-bin (2.23-0ubuntu9) ... Processing triggers for systemd (229-4ubuntu21) ... Processing triggers for ureadahead (0.100.0-19) ... Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: binutils libdpkg-perl make Suggested packages: binutils-doc debian-keyring gcc | c-compiler make-doc Recommended packages: gcc | c-compiler build-essential fakeroot libalgorithm-merge-perl libfile-fcntllock-perl The following NEW packages will be installed: binutils dpkg-dev libdpkg-perl make 0 upgraded, 4 newly installed, 0 to remove and 7 not upgraded. Need to get 1,986 kB of archives. After this operation, 8,760 kB of additional disk space will be used. Get:1 http://ftpmaster.internal/ubuntu xenial-updates/main s390x binutils s390x 2.26.1-1ubuntu1~16.04.5 [1,057 kB] Get:2 http://ftpmaster.internal/ubuntu xenial-updates/main s390x libdpkg-perl all 1.18.4ubuntu1.2 [195 kB] Get:3 http://ftpmaster.internal/ubuntu xenial/main s390x make s390x 4.1-6 [149 kB] Get:4 http://ftpmaster.internal/ubuntu xenial-updates/main s390x dpkg-dev all 1.18.4ubuntu1.2 [584 kB] Fetched 1,986 kB in 0s (2,757 kB/s) dpkg: error: dpkg status database is locked by another process E: Sub-process /usr/bin/dpkg returned an error code (2) Exit request sent. blame: docker.io badpkg: testbed setup commands failed with status 100 autopkgtest [21:16:47]: ERROR: erroneous package: testbed setup commands failed with status 100