0s autopkgtest [07:36:58]: starting date and time: 2025-05-02 07:36:58+0000
  0s autopkgtest [07:36:58]: git checkout: 9986aa8c Merge branch 'skia/fix_network_interface' into 'ubuntu/production'
  0s autopkgtest [07:36:58]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.6qjgeewd/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:ruby-rack,src:ruby-adsf,src:ruby-sinatra,src:unicorn --apt-upgrade auto-apt-proxy --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=ruby-rack/3.1.12-1 ruby-adsf/1.5.2+dfsg1-2 ruby-sinatra/4.1.1-5 unicorn/6.1.0+git.20250131.1370f52-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-8.secgroup --name adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 --image adt/ubuntu-questing-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/
 96s autopkgtest [07:38:34]: testbed dpkg architecture: s390x
 96s autopkgtest [07:38:34]: testbed apt version: 3.0.0
 96s autopkgtest [07:38:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup
 97s autopkgtest [07:38:35]: testbed release detected to be: None
 97s autopkgtest [07:38:35]: updating testbed package index (apt update)
 98s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
 98s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
 98s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
 98s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
 98s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
 98s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
 98s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
 98s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
 98s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
 98s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
 99s Fetched 3868 kB in 1s (2994 kB/s)
100s Reading package lists...
100s autopkgtest [07:38:38]: upgrading testbed (apt dist-upgrade and autopurge)
100s Reading package lists...
100s Building dependency tree...
100s Reading state information...
101s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
101s Starting 2 pkgProblemResolver with broken count: 0
101s Done
101s Entering ResolveByKeep
101s 
101s Calculating upgrade...
102s The following packages will be upgraded:
102s   dpkg dpkg-dev libdpkg-perl
102s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
102s Need to get 2667 kB of archives.
102s After this operation, 1024 B of additional disk space will be used.
102s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x dpkg s390x 1.22.18ubuntu3 [1297 kB]
102s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x dpkg-dev all 1.22.18ubuntu3 [1089 kB]
103s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libdpkg-perl all 1.22.18ubuntu3 [281 kB]
103s Fetched 2667 kB in 1s (3536 kB/s)
103s (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 ... 81472 files and directories currently installed.)
103s Preparing to unpack .../dpkg_1.22.18ubuntu3_s390x.deb ...
103s Unpacking dpkg (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
103s Setting up dpkg (1.22.18ubuntu3) ...
104s (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 ... 81472 files and directories currently installed.)
104s Preparing to unpack .../dpkg-dev_1.22.18ubuntu3_all.deb ...
104s Unpacking dpkg-dev (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
104s Preparing to unpack .../libdpkg-perl_1.22.18ubuntu3_all.deb ...
104s Unpacking libdpkg-perl (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
104s Setting up libdpkg-perl (1.22.18ubuntu3) ...
104s Setting up dpkg-dev (1.22.18ubuntu3) ...
104s Processing triggers for man-db (2.13.0-1) ...
106s Reading package lists...
106s Building dependency tree...
106s Reading state information...
106s Starting pkgProblemResolver with broken count: 0
106s Starting 2 pkgProblemResolver with broken count: 0
106s Done
106s Solving dependencies...
106s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
106s autopkgtest [07:38:44]: rebooting testbed after setup commands that affected boot
133s autopkgtest [07:39:11]: testbed running kernel: Linux 6.14.0-15-generic #15-Ubuntu SMP Sun Apr  6 13:39:00 UTC 2025
135s autopkgtest [07:39:13]: @@@@@@@@@@@@@@@@@@@@ apt-source auto-apt-proxy
137s Get:1 http://ftpmaster.internal/ubuntu questing/universe auto-apt-proxy 16.5 (dsc) [1795 B]
137s Get:2 http://ftpmaster.internal/ubuntu questing/universe auto-apt-proxy 16.5 (tar) [20.6 kB]
137s gpgv: Signature made Fri Mar 28 18:24:24 2025 UTC
137s gpgv:                using RSA key B2DEE66036C40829FCD0F10CFC0DB1BBCD460BDE
137s gpgv: Can't check signature: No public key
137s dpkg-source: warning: cannot verify inline signature for ./auto-apt-proxy_16.5.dsc: no acceptable signature found
137s autopkgtest [07:39:15]: testing package auto-apt-proxy version 16.5
137s autopkgtest [07:39:15]: build not needed
138s autopkgtest [07:39:16]: test apt-integration: preparing testbed
138s Reading package lists...
138s Building dependency tree...
138s Reading state information...
138s Starting pkgProblemResolver with broken count: 0
138s Starting 2 pkgProblemResolver with broken count: 0
138s Done
138s The following NEW packages will be installed:
138s   apt-cacher-ng auto-apt-proxy libcares2 libevent-2.1-7t64
138s   libevent-pthreads-2.1-7t64 libfuse2t64
138s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded.
138s Need to get 975 kB of archives.
138s After this operation, 2747 kB of additional disk space will be used.
138s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libcares2 s390x 1.34.4-2.1 [101 kB]
139s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x libevent-2.1-7t64 s390x 2.1.12-stable-10 [145 kB]
139s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libevent-pthreads-2.1-7t64 s390x 2.1.12-stable-10 [7870 B]
139s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x libfuse2t64 s390x 2.9.9-9 [89.9 kB]
139s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x apt-cacher-ng s390x 3.7.5-1 [621 kB]
139s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
139s Preconfiguring packages ...
139s Fetched 975 kB in 1s (1241 kB/s)
139s Selecting previously unselected package libcares2:s390x.
140s (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 ... 81472 files and directories currently installed.)
140s Preparing to unpack .../0-libcares2_1.34.4-2.1_s390x.deb ...
140s Unpacking libcares2:s390x (1.34.4-2.1) ...
140s Selecting previously unselected package libevent-2.1-7t64:s390x.
140s Preparing to unpack .../1-libevent-2.1-7t64_2.1.12-stable-10_s390x.deb ...
140s Unpacking libevent-2.1-7t64:s390x (2.1.12-stable-10) ...
140s Selecting previously unselected package libevent-pthreads-2.1-7t64:s390x.
140s Preparing to unpack .../2-libevent-pthreads-2.1-7t64_2.1.12-stable-10_s390x.deb ...
140s Unpacking libevent-pthreads-2.1-7t64:s390x (2.1.12-stable-10) ...
140s Selecting previously unselected package libfuse2t64:s390x.
140s Preparing to unpack .../3-libfuse2t64_2.9.9-9_s390x.deb ...
140s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64'
140s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64'
140s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64'
140s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64'
140s Unpacking libfuse2t64:s390x (2.9.9-9) ...
140s Selecting previously unselected package apt-cacher-ng.
140s Preparing to unpack .../4-apt-cacher-ng_3.7.5-1_s390x.deb ...
140s Unpacking apt-cacher-ng (3.7.5-1) ...
140s Selecting previously unselected package auto-apt-proxy.
140s Preparing to unpack .../5-auto-apt-proxy_16.5_all.deb ...
140s Unpacking auto-apt-proxy (16.5) ...
140s Setting up libevent-pthreads-2.1-7t64:s390x (2.1.12-stable-10) ...
140s Setting up libevent-2.1-7t64:s390x (2.1.12-stable-10) ...
140s Setting up libcares2:s390x (1.34.4-2.1) ...
140s Setting up auto-apt-proxy (16.5) ...
140s Setting up libfuse2t64:s390x (2.9.9-9) ...
140s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64'
140s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64'
140s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64'
140s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64'
140s Setting up apt-cacher-ng (3.7.5-1) ...
141s Created symlink '/etc/systemd/system/multi-user.target.wants/apt-cacher-ng.service' → '/usr/lib/systemd/system/apt-cacher-ng.service'.

141s Processing triggers for man-db (2.13.0-1) ...
142s Processing triggers for libc-bin (2.41-6ubuntu1) ...
143s autopkgtest [07:39:21]: test apt-integration: [-----------------------
143s #1 download package
143s Reading package lists...
143s NOTICE: 'auto-apt-proxy' packaging is maintained in the 'Git' version control system at:
143s https://salsa.debian.org/debian/auto-apt-proxy.git
143s Please use:
143s git clone https://salsa.debian.org/debian/auto-apt-proxy.git
143s to retrieve the latest (possibly unreleased) updates to the package.
143s Need to get 22.4 kB of source archives.
143s Get:1 http://ftpmaster.internal/ubuntu questing/universe auto-apt-proxy 16.5 (dsc) [1795 B]
143s Get:2 http://ftpmaster.internal/ubuntu questing/universe auto-apt-proxy 16.5 (tar) [20.6 kB]
144s dpkg-source: info: extracting auto-apt-proxy in auto-apt-proxy-16.5
144s dpkg-source: info: unpacking auto-apt-proxy_16.5.tar.xz
144s Fetched 22.4 kB in 0s (73.0 kB/s)
144s #2 check that the package was downloaded via the proxy
144s 1746171561|I|2317|127.0.0.1|ftpmaster.internal/ubuntu/pool/universe/a/auto-apt-proxy/auto-apt-proxy_16.5.dsc
144s 1746171561|O|2091|127.0.0.1|ftpmaster.internal/ubuntu/pool/universe/a/auto-apt-proxy/auto-apt-proxy_16.5.dsc
144s 1746171561|I|21172|127.0.0.1|ftpmaster.internal/ubuntu/pool/universe/a/auto-apt-proxy/auto-apt-proxy_16.5.tar.xz
144s 1746171561|O|20884|127.0.0.1|ftpmaster.internal/ubuntu/pool/universe/a/auto-apt-proxy/auto-apt-proxy_16.5.tar.xz
144s #2 OK
144s autopkgtest [07:39:22]: test apt-integration: -----------------------]
144s apt-integration      PASS
144s autopkgtest [07:39:22]: test apt-integration:  - - - - - - - - - - results - - - - - - - - - -
145s autopkgtest [07:39:23]: test apt-cacher-ng: preparing testbed
145s Reading package lists...
145s Building dependency tree...
145s Reading state information...
145s Starting pkgProblemResolver with broken count: 0
145s Starting 2 pkgProblemResolver with broken count: 0
145s Done
145s The following NEW packages will be installed:
145s   clitest
146s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
146s Need to get 19.0 kB of archives.
146s After this operation, 54.3 kB of additional disk space will be used.
146s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x clitest all 0.5.0-1 [19.0 kB]
146s Fetched 19.0 kB in 0s (82.2 kB/s)
146s Selecting previously unselected package clitest.
146s (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 ... 81583 files and directories currently installed.)
146s Preparing to unpack .../clitest_0.5.0-1_all.deb ...
146s Unpacking clitest (0.5.0-1) ...
146s Setting up clitest (0.5.0-1) ...
146s Processing triggers for man-db (2.13.0-1) ...
147s autopkgtest [07:39:25]: test apt-cacher-ng: clitest debian/tests/apt-cacher-ng.txt
147s autopkgtest [07:39:25]: test apt-cacher-ng: [-----------------------
147s #1	export AUTO_APT_PROXY_NO_CACHE=1
147s #2	auto-apt-proxy 
147s OK: 2 of 2 tests passed
148s autopkgtest [07:39:26]: test apt-cacher-ng: -----------------------]
148s apt-cacher-ng        PASS
148s autopkgtest [07:39:26]: test apt-cacher-ng:  - - - - - - - - - - results - - - - - - - - - -
148s autopkgtest [07:39:26]: test approx: preparing testbed
276s autopkgtest [07:41:34]: testbed dpkg architecture: s390x
276s autopkgtest [07:41:34]: testbed apt version: 3.0.0
276s autopkgtest [07:41:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup
277s autopkgtest [07:41:35]: testbed release detected to be: questing
277s autopkgtest [07:41:35]: updating testbed package index (apt update)
278s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
278s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
278s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
278s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
278s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
278s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
278s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
278s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
278s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
279s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
279s Fetched 3868 kB in 1s (3023 kB/s)
280s Reading package lists...
280s autopkgtest [07:41:38]: upgrading testbed (apt dist-upgrade and autopurge)
280s Reading package lists...
280s Building dependency tree...
280s Reading state information...
281s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
281s Starting 2 pkgProblemResolver with broken count: 0
281s Done
281s Entering ResolveByKeep
281s 
281s Calculating upgrade...
281s The following packages will be upgraded:
281s   dpkg dpkg-dev libdpkg-perl
281s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
281s Need to get 2667 kB of archives.
281s After this operation, 1024 B of additional disk space will be used.
281s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x dpkg s390x 1.22.18ubuntu3 [1297 kB]
283s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x dpkg-dev all 1.22.18ubuntu3 [1089 kB]
285s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libdpkg-perl all 1.22.18ubuntu3 [281 kB]
285s Fetched 2667 kB in 4s (735 kB/s)
285s (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 ... 81472 files and directories currently installed.)
285s Preparing to unpack .../dpkg_1.22.18ubuntu3_s390x.deb ...
285s Unpacking dpkg (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
285s Setting up dpkg (1.22.18ubuntu3) ...
286s (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 ... 81472 files and directories currently installed.)
286s Preparing to unpack .../dpkg-dev_1.22.18ubuntu3_all.deb ...
286s Unpacking dpkg-dev (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
286s Preparing to unpack .../libdpkg-perl_1.22.18ubuntu3_all.deb ...
286s Unpacking libdpkg-perl (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
286s Setting up libdpkg-perl (1.22.18ubuntu3) ...
286s Setting up dpkg-dev (1.22.18ubuntu3) ...
286s Processing triggers for man-db (2.13.0-1) ...
288s Reading package lists...
288s Building dependency tree...
288s Reading state information...
288s Starting pkgProblemResolver with broken count: 0
288s Starting 2 pkgProblemResolver with broken count: 0
288s Done
288s Solving dependencies...
288s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
288s autopkgtest [07:41:46]: rebooting testbed after setup commands that affected boot
312s Reading package lists...
312s Building dependency tree...
312s Reading state information...
313s Starting pkgProblemResolver with broken count: 0
313s Starting 2 pkgProblemResolver with broken count: 0
313s Done
313s The following NEW packages will be installed:
313s   approx auto-apt-proxy clitest
313s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded.
313s Need to get 2020 kB of archives.
313s After this operation, 9665 kB of additional disk space will be used.
313s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x approx s390x 5.13-1build3 [1991 kB]
315s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
315s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x clitest all 0.5.0-1 [19.0 kB]
315s Fetched 2020 kB in 2s (951 kB/s)
315s Selecting previously unselected package approx.
315s (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 ... 81472 files and directories currently installed.)
315s Preparing to unpack .../approx_5.13-1build3_s390x.deb ...
315s Unpacking approx (5.13-1build3) ...
315s Selecting previously unselected package auto-apt-proxy.
315s Preparing to unpack .../auto-apt-proxy_16.5_all.deb ...
315s Unpacking auto-apt-proxy (16.5) ...
316s Selecting previously unselected package clitest.
316s Preparing to unpack .../clitest_0.5.0-1_all.deb ...
316s Unpacking clitest (0.5.0-1) ...
316s Setting up auto-apt-proxy (16.5) ...
316s Setting up approx (5.13-1build3) ...
316s Created symlink '/etc/systemd/system/sockets.target.wants/approx.socket' → '/usr/lib/systemd/system/approx.socket'.

316s Setting up clitest (0.5.0-1) ...
316s Processing triggers for man-db (2.13.0-1) ...
319s autopkgtest [07:42:17]: test approx: clitest debian/tests/approx.txt
319s autopkgtest [07:42:17]: test approx: [-----------------------
319s #1	auto-apt-proxy
319s OK: 1 of 1 test passed
319s autopkgtest [07:42:17]: test approx: -----------------------]
320s approx               PASS
320s autopkgtest [07:42:18]: test approx:  - - - - - - - - - - results - - - - - - - - - -
320s autopkgtest [07:42:18]: test apt-cacher: preparing testbed
444s autopkgtest [07:44:22]: testbed dpkg architecture: s390x
444s autopkgtest [07:44:22]: testbed apt version: 3.0.0
444s autopkgtest [07:44:22]: @@@@@@@@@@@@@@@@@@@@ test bed setup
444s autopkgtest [07:44:22]: testbed release detected to be: questing
445s autopkgtest [07:44:23]: updating testbed package index (apt update)
445s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
446s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
446s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
446s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
446s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
446s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
446s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
446s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
446s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
446s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
447s Fetched 3868 kB in 1s (3070 kB/s)
447s Reading package lists...
448s autopkgtest [07:44:26]: upgrading testbed (apt dist-upgrade and autopurge)
448s Reading package lists...
448s Building dependency tree...
448s Reading state information...
448s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
448s Starting 2 pkgProblemResolver with broken count: 0
448s Done
449s Entering ResolveByKeep
449s 
449s Calculating upgrade...
449s The following packages will be upgraded:
449s   dpkg dpkg-dev libdpkg-perl
449s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
449s Need to get 2667 kB of archives.
449s After this operation, 1024 B of additional disk space will be used.
449s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x dpkg s390x 1.22.18ubuntu3 [1297 kB]
450s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x dpkg-dev all 1.22.18ubuntu3 [1089 kB]
450s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libdpkg-perl all 1.22.18ubuntu3 [281 kB]
450s Fetched 2667 kB in 1s (3618 kB/s)
450s (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 ... 81472 files and directories currently installed.)
450s Preparing to unpack .../dpkg_1.22.18ubuntu3_s390x.deb ...
450s Unpacking dpkg (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
450s Setting up dpkg (1.22.18ubuntu3) ...
451s (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 ... 81472 files and directories currently installed.)
451s Preparing to unpack .../dpkg-dev_1.22.18ubuntu3_all.deb ...
451s Unpacking dpkg-dev (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
451s Preparing to unpack .../libdpkg-perl_1.22.18ubuntu3_all.deb ...
451s Unpacking libdpkg-perl (1.22.18ubuntu3) over (1.22.18ubuntu2) ...
451s Setting up libdpkg-perl (1.22.18ubuntu3) ...
451s Setting up dpkg-dev (1.22.18ubuntu3) ...
451s Processing triggers for man-db (2.13.0-1) ...
452s Reading package lists...
453s Building dependency tree...
453s Reading state information...
453s Starting pkgProblemResolver with broken count: 0
453s Starting 2 pkgProblemResolver with broken count: 0
453s Done
453s Solving dependencies...
453s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
453s autopkgtest [07:44:31]: rebooting testbed after setup commands that affected boot
479s Reading package lists...
479s Building dependency tree...
479s Reading state information...
479s Starting pkgProblemResolver with broken count: 0
479s Starting 2 pkgProblemResolver with broken count: 0
479s Done
479s The following NEW packages will be installed:
479s   apt-cacher auto-apt-proxy clitest libclone-perl libcompress-raw-bzip2-perl
479s   libcompress-raw-lzma-perl libcompress-raw-zlib-perl libencode-locale-perl
479s   libfile-listing-perl libfilesys-df-perl libhtml-parser-perl
479s   libhtml-tagset-perl libhtml-tree-perl libhttp-cookies-perl libhttp-date-perl
479s   libhttp-message-perl libhttp-negotiate-perl libio-compress-lzma-perl
479s   libio-compress-perl libio-html-perl libio-interactive-perl
479s   libio-interface-perl libio-socket-ssl-perl libipc-sharelite-perl
479s   liblwp-mediatypes-perl liblwp-protocol-https-perl libnet-http-perl
479s   libnet-ssleay-perl libnetaddr-ip-perl libsys-syscall-perl libtimedate-perl
479s   libtry-tiny-perl liburi-perl libwww-curl-perl libwww-perl
479s   libwww-robotrules-perl perl-openssl-defaults update-inetd
479s 0 upgraded, 38 newly installed, 0 to remove and 0 not upgraded.
479s Need to get 2126 kB of archives.
479s After this operation, 7230 kB of additional disk space will be used.
479s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libfilesys-df-perl s390x 0.92-7build5 [11.1 kB]
479s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x libcompress-raw-lzma-perl s390x 2.213-1 [35.3 kB]
479s Get:3 http://ftpmaster.internal/ubuntu questing/universe s390x libcompress-raw-bzip2-perl s390x 2.213-2 [22.2 kB]
479s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x libcompress-raw-zlib-perl s390x 2.213-1 [46.5 kB]
480s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x libio-compress-perl all 2.213-1 [264 kB]
480s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x libio-compress-lzma-perl all 2.213-1 [61.6 kB]
480s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x libio-interactive-perl all 1.026-1 [10.8 kB]
480s Get:8 http://ftpmaster.internal/ubuntu questing/universe s390x libio-interface-perl s390x 1.09-2build6 [23.3 kB]
480s Get:9 http://ftpmaster.internal/ubuntu questing/universe s390x libipc-sharelite-perl s390x 0.17-5build4 [21.4 kB]
480s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x libnetaddr-ip-perl s390x 4.079+dfsg-2build5 [80.6 kB]
480s Get:11 http://ftpmaster.internal/ubuntu questing/universe s390x libsys-syscall-perl s390x 0.25-7 [9922 B]
480s Get:12 http://ftpmaster.internal/ubuntu questing/universe s390x libwww-curl-perl s390x 4.17-11 [57.0 kB]
480s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x libencode-locale-perl all 1.05-3 [11.6 kB]
480s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x libtimedate-perl all 2.3300-2 [34.0 kB]
480s Get:15 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-date-perl all 6.06-1 [10.2 kB]
480s Get:16 http://ftpmaster.internal/ubuntu questing/main s390x libfile-listing-perl all 6.16-1 [11.3 kB]
480s Get:17 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-tagset-perl all 3.24-1 [14.1 kB]
480s Get:18 http://ftpmaster.internal/ubuntu questing/main s390x liburi-perl all 5.30-1 [94.4 kB]
480s Get:19 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-parser-perl s390x 3.83-1build1 [87.8 kB]
480s Get:20 http://ftpmaster.internal/ubuntu questing/main s390x libhtml-tree-perl all 5.07-3 [200 kB]
480s Get:21 http://ftpmaster.internal/ubuntu questing/main s390x libclone-perl s390x 0.47-1 [10.7 kB]
480s Get:22 http://ftpmaster.internal/ubuntu questing/main s390x libio-html-perl all 1.004-3 [15.9 kB]
480s Get:23 http://ftpmaster.internal/ubuntu questing/main s390x liblwp-mediatypes-perl all 6.04-2 [20.1 kB]
480s Get:24 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-message-perl all 7.00-2ubuntu1 [75.9 kB]
480s Get:25 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-cookies-perl all 6.11-1 [18.2 kB]
480s Get:26 http://ftpmaster.internal/ubuntu questing/main s390x libhttp-negotiate-perl all 6.01-2 [12.4 kB]
480s Get:27 http://ftpmaster.internal/ubuntu questing/main s390x perl-openssl-defaults s390x 7build3 [6628 B]
480s Get:28 http://ftpmaster.internal/ubuntu questing/main s390x libnet-ssleay-perl s390x 1.94-3 [320 kB]
480s Get:29 http://ftpmaster.internal/ubuntu questing/main s390x libio-socket-ssl-perl all 2.089-1 [200 kB]
480s Get:30 http://ftpmaster.internal/ubuntu questing/main s390x libnet-http-perl all 6.23-1 [22.3 kB]
480s Get:31 http://ftpmaster.internal/ubuntu questing/main s390x liblwp-protocol-https-perl all 6.14-1 [9040 B]
480s Get:32 http://ftpmaster.internal/ubuntu questing/main s390x libtry-tiny-perl all 0.32-1 [21.2 kB]
480s Get:33 http://ftpmaster.internal/ubuntu questing/main s390x libwww-robotrules-perl all 6.02-1 [12.6 kB]
480s Get:34 http://ftpmaster.internal/ubuntu questing/main s390x libwww-perl all 6.78-1 [139 kB]
480s Get:35 http://ftpmaster.internal/ubuntu questing/main s390x update-inetd all 4.53 [24.0 kB]
480s Get:36 http://ftpmaster.internal/ubuntu questing/universe s390x apt-cacher all 1.7.30 [81.5 kB]
480s Get:37 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
480s Get:38 http://ftpmaster.internal/ubuntu questing/universe s390x clitest all 0.5.0-1 [19.0 kB]
481s Preconfiguring packages ...
481s Fetched 2126 kB in 1s (1658 kB/s)
481s Selecting previously unselected package libfilesys-df-perl.
481s (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 ... 81472 files and directories currently installed.)
481s Preparing to unpack .../00-libfilesys-df-perl_0.92-7build5_s390x.deb ...
481s Unpacking libfilesys-df-perl (0.92-7build5) ...
481s Selecting previously unselected package libcompress-raw-lzma-perl:s390x.
481s Preparing to unpack .../01-libcompress-raw-lzma-perl_2.213-1_s390x.deb ...
481s Unpacking libcompress-raw-lzma-perl:s390x (2.213-1) ...
481s Selecting previously unselected package libcompress-raw-bzip2-perl.
481s Preparing to unpack .../02-libcompress-raw-bzip2-perl_2.213-2_s390x.deb ...
481s Unpacking libcompress-raw-bzip2-perl (2.213-2) ...
481s Selecting previously unselected package libcompress-raw-zlib-perl:s390x.
481s Preparing to unpack .../03-libcompress-raw-zlib-perl_2.213-1_s390x.deb ...
481s Unpacking libcompress-raw-zlib-perl:s390x (2.213-1) ...
481s Selecting previously unselected package libio-compress-perl.
481s Preparing to unpack .../04-libio-compress-perl_2.213-1_all.deb ...
481s Adding 'diversion of /usr/bin/zipdetails to /usr/bin/zipdetails.bundled by libio-compress-perl'
481s Adding 'diversion of /usr/share/man/man1/zipdetails.1.gz to /usr/share/man/man1/zipdetails.bundled.1.gz by libio-compress-perl'
481s Adding 'diversion of /usr/bin/streamzip to /usr/bin/streamzip.bundled by libio-compress-perl'
481s Adding 'diversion of /usr/share/man/man1/streamzip.1.gz to /usr/share/man/man1/streamzip.bundled.1.gz by libio-compress-perl'
481s Unpacking libio-compress-perl (2.213-1) ...
481s Selecting previously unselected package libio-compress-lzma-perl.
481s Preparing to unpack .../05-libio-compress-lzma-perl_2.213-1_all.deb ...
481s Unpacking libio-compress-lzma-perl (2.213-1) ...
481s Selecting previously unselected package libio-interactive-perl.
481s Preparing to unpack .../06-libio-interactive-perl_1.026-1_all.deb ...
481s Unpacking libio-interactive-perl (1.026-1) ...
481s Selecting previously unselected package libio-interface-perl.
481s Preparing to unpack .../07-libio-interface-perl_1.09-2build6_s390x.deb ...
481s Unpacking libio-interface-perl (1.09-2build6) ...
481s Selecting previously unselected package libipc-sharelite-perl.
481s Preparing to unpack .../08-libipc-sharelite-perl_0.17-5build4_s390x.deb ...
481s Unpacking libipc-sharelite-perl (0.17-5build4) ...
481s Selecting previously unselected package libnetaddr-ip-perl.
481s Preparing to unpack .../09-libnetaddr-ip-perl_4.079+dfsg-2build5_s390x.deb ...
481s Unpacking libnetaddr-ip-perl (4.079+dfsg-2build5) ...
481s Selecting previously unselected package libsys-syscall-perl.
481s Preparing to unpack .../10-libsys-syscall-perl_0.25-7_s390x.deb ...
481s Unpacking libsys-syscall-perl (0.25-7) ...
481s Selecting previously unselected package libwww-curl-perl:s390x.
481s Preparing to unpack .../11-libwww-curl-perl_4.17-11_s390x.deb ...
481s Unpacking libwww-curl-perl:s390x (4.17-11) ...
481s Selecting previously unselected package libencode-locale-perl.
481s Preparing to unpack .../12-libencode-locale-perl_1.05-3_all.deb ...
481s Unpacking libencode-locale-perl (1.05-3) ...
481s Selecting previously unselected package libtimedate-perl.
481s Preparing to unpack .../13-libtimedate-perl_2.3300-2_all.deb ...
481s Unpacking libtimedate-perl (2.3300-2) ...
481s Selecting previously unselected package libhttp-date-perl.
481s Preparing to unpack .../14-libhttp-date-perl_6.06-1_all.deb ...
481s Unpacking libhttp-date-perl (6.06-1) ...
481s Selecting previously unselected package libfile-listing-perl.
481s Preparing to unpack .../15-libfile-listing-perl_6.16-1_all.deb ...
481s Unpacking libfile-listing-perl (6.16-1) ...
481s Selecting previously unselected package libhtml-tagset-perl.
481s Preparing to unpack .../16-libhtml-tagset-perl_3.24-1_all.deb ...
481s Unpacking libhtml-tagset-perl (3.24-1) ...
481s Selecting previously unselected package liburi-perl.
481s Preparing to unpack .../17-liburi-perl_5.30-1_all.deb ...
481s Unpacking liburi-perl (5.30-1) ...
481s Selecting previously unselected package libhtml-parser-perl:s390x.
481s Preparing to unpack .../18-libhtml-parser-perl_3.83-1build1_s390x.deb ...
481s Unpacking libhtml-parser-perl:s390x (3.83-1build1) ...
481s Selecting previously unselected package libhtml-tree-perl.
481s Preparing to unpack .../19-libhtml-tree-perl_5.07-3_all.deb ...
481s Unpacking libhtml-tree-perl (5.07-3) ...
481s Selecting previously unselected package libclone-perl:s390x.
481s Preparing to unpack .../20-libclone-perl_0.47-1_s390x.deb ...
481s Unpacking libclone-perl:s390x (0.47-1) ...
481s Selecting previously unselected package libio-html-perl.
481s Preparing to unpack .../21-libio-html-perl_1.004-3_all.deb ...
481s Unpacking libio-html-perl (1.004-3) ...
481s Selecting previously unselected package liblwp-mediatypes-perl.
481s Preparing to unpack .../22-liblwp-mediatypes-perl_6.04-2_all.deb ...
481s Unpacking liblwp-mediatypes-perl (6.04-2) ...
481s Selecting previously unselected package libhttp-message-perl.
481s Preparing to unpack .../23-libhttp-message-perl_7.00-2ubuntu1_all.deb ...
481s Unpacking libhttp-message-perl (7.00-2ubuntu1) ...
481s Selecting previously unselected package libhttp-cookies-perl.
481s Preparing to unpack .../24-libhttp-cookies-perl_6.11-1_all.deb ...
481s Unpacking libhttp-cookies-perl (6.11-1) ...
481s Selecting previously unselected package libhttp-negotiate-perl.
481s Preparing to unpack .../25-libhttp-negotiate-perl_6.01-2_all.deb ...
481s Unpacking libhttp-negotiate-perl (6.01-2) ...
481s Selecting previously unselected package perl-openssl-defaults:s390x.
481s Preparing to unpack .../26-perl-openssl-defaults_7build3_s390x.deb ...
481s Unpacking perl-openssl-defaults:s390x (7build3) ...
481s Selecting previously unselected package libnet-ssleay-perl:s390x.
481s Preparing to unpack .../27-libnet-ssleay-perl_1.94-3_s390x.deb ...
481s Unpacking libnet-ssleay-perl:s390x (1.94-3) ...
481s Selecting previously unselected package libio-socket-ssl-perl.
481s Preparing to unpack .../28-libio-socket-ssl-perl_2.089-1_all.deb ...
481s Unpacking libio-socket-ssl-perl (2.089-1) ...
481s Selecting previously unselected package libnet-http-perl.
481s Preparing to unpack .../29-libnet-http-perl_6.23-1_all.deb ...
481s Unpacking libnet-http-perl (6.23-1) ...
481s Selecting previously unselected package liblwp-protocol-https-perl.
481s Preparing to unpack .../30-liblwp-protocol-https-perl_6.14-1_all.deb ...
481s Unpacking liblwp-protocol-https-perl (6.14-1) ...
481s Selecting previously unselected package libtry-tiny-perl.
481s Preparing to unpack .../31-libtry-tiny-perl_0.32-1_all.deb ...
481s Unpacking libtry-tiny-perl (0.32-1) ...
481s Selecting previously unselected package libwww-robotrules-perl.
481s Preparing to unpack .../32-libwww-robotrules-perl_6.02-1_all.deb ...
481s Unpacking libwww-robotrules-perl (6.02-1) ...
481s Selecting previously unselected package libwww-perl.
481s Preparing to unpack .../33-libwww-perl_6.78-1_all.deb ...
481s Unpacking libwww-perl (6.78-1) ...
481s Selecting previously unselected package update-inetd.
481s Preparing to unpack .../34-update-inetd_4.53_all.deb ...
481s Unpacking update-inetd (4.53) ...
481s Selecting previously unselected package apt-cacher.
481s Preparing to unpack .../35-apt-cacher_1.7.30_all.deb ...
481s Unpacking apt-cacher (1.7.30) ...
481s Selecting previously unselected package auto-apt-proxy.
481s Preparing to unpack .../36-auto-apt-proxy_16.5_all.deb ...
481s Unpacking auto-apt-proxy (16.5) ...
481s Selecting previously unselected package clitest.
481s Preparing to unpack .../37-clitest_0.5.0-1_all.deb ...
481s Unpacking clitest (0.5.0-1) ...
481s Setting up libcompress-raw-zlib-perl:s390x (2.213-1) ...
481s Setting up libclone-perl:s390x (0.47-1) ...
481s Setting up libhtml-tagset-perl (3.24-1) ...
481s Setting up libipc-sharelite-perl (0.17-5build4) ...
481s Setting up libfilesys-df-perl (0.92-7build5) ...
481s Setting up liblwp-mediatypes-perl (6.04-2) ...
481s Setting up libio-interactive-perl (1.026-1) ...
481s Setting up libtry-tiny-perl (0.32-1) ...
481s Setting up perl-openssl-defaults:s390x (7build3) ...
481s Setting up update-inetd (4.53) ...
482s Setting up libwww-curl-perl:s390x (4.17-11) ...
482s Setting up libencode-locale-perl (1.05-3) ...
482s Setting up libsys-syscall-perl (0.25-7) ...
482s Setting up libcompress-raw-lzma-perl:s390x (2.213-1) ...
482s Setting up libnetaddr-ip-perl (4.079+dfsg-2build5) ...
482s Setting up libio-html-perl (1.004-3) ...
482s Setting up libcompress-raw-bzip2-perl (2.213-2) ...
482s Setting up auto-apt-proxy (16.5) ...
482s Setting up libtimedate-perl (2.3300-2) ...
482s Setting up libio-interface-perl (1.09-2build6) ...
482s Setting up liburi-perl (5.30-1) ...
482s Setting up clitest (0.5.0-1) ...
482s Setting up libnet-ssleay-perl:s390x (1.94-3) ...
482s Setting up libhttp-date-perl (6.06-1) ...
482s Setting up libfile-listing-perl (6.16-1) ...
482s Setting up libio-compress-perl (2.213-1) ...
482s Setting up libnet-http-perl (6.23-1) ...
482s Setting up libio-compress-lzma-perl (2.213-1) ...
482s Setting up libwww-robotrules-perl (6.02-1) ...
482s Setting up libhtml-parser-perl:s390x (3.83-1build1) ...
482s Setting up libio-socket-ssl-perl (2.089-1) ...
482s Setting up libhttp-message-perl (7.00-2ubuntu1) ...
482s Setting up libhttp-negotiate-perl (6.01-2) ...
482s Setting up libhttp-cookies-perl (6.11-1) ...
482s Setting up libhtml-tree-perl (5.07-3) ...
482s Setting up liblwp-protocol-https-perl (6.14-1) ...
482s Setting up libwww-perl (6.78-1) ...
482s Setting up apt-cacher (1.7.30) ...
482s Running apt-cacher's install script...
482s Doing mkdir(/var/cache/apt-cacher, 0755)
482s Doing mkdir(/var/log/apt-cacher, 0755)
482s Info: /var/cache/apt-cacher/private missing. Doing mkdir -p /var/cache/apt-cacher/private
482s Info: /var/cache/apt-cacher/import missing. Doing mkdir -p /var/cache/apt-cacher/import
482s Info: /var/cache/apt-cacher/packages missing. Doing mkdir -p /var/cache/apt-cacher/packages
482s Info: /var/cache/apt-cacher/headers missing. Doing mkdir -p /var/cache/apt-cacher/headers
482s Info: /var/run/apt-cacher/ missing. Doing mkdir -p /var/run/apt-cacher/
482s Warning: /var/log/apt-cacher/access.log missing. Creating.
482s Warning: /var/log/apt-cacher/access.log -- setting ownership to 33:33
482s Warning: /var/log/apt-cacher/error.log missing. Creating.
482s Warning: /var/log/apt-cacher/error.log -- setting ownership to 33:33
482s Setup apt-cacher running as standalone daemon.
482s Processing triggers for man-db (2.13.0-1) ...
485s autopkgtest [07:45:03]: test apt-cacher: clitest debian/tests/apt-cacher.txt
485s autopkgtest [07:45:03]: test apt-cacher: [-----------------------
485s #1	auto-apt-proxy 
485s OK: 1 of 1 test passed
485s autopkgtest [07:45:03]: test apt-cacher: -----------------------]
486s apt-cacher           PASS
486s autopkgtest [07:45:04]: test apt-cacher:  - - - - - - - - - - results - - - - - - - - - -
486s autopkgtest [07:45:04]: test wrapper-mode: preparing testbed
609s autopkgtest [07:47:07]: testbed dpkg architecture: s390x
610s autopkgtest [07:47:08]: testbed apt version: 3.0.0
610s autopkgtest [07:47:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup
610s autopkgtest [07:47:08]: testbed release detected to be: questing
611s autopkgtest [07:47:09]: updating testbed package index (apt update)
611s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
611s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
611s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
611s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
611s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
612s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
612s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
612s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
612s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
612s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
612s Fetched 3868 kB in 1s (3217 kB/s)
613s Reading package lists...
613s autopkgtest [07:47:11]: upgrading testbed (apt dist-upgrade and autopurge)
613s Reading package lists...
614s Building dependency tree...
614s Reading state information...
614s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
614s Starting 2 pkgProblemResolver with broken count: 0
614s Done
614s Entering ResolveByKeep
614s 
614s Calculating upgrade...
614s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
615s Reading package lists...
615s Building dependency tree...
615s Reading state information...
615s Starting pkgProblemResolver with broken count: 0
615s Starting 2 pkgProblemResolver with broken count: 0
615s Done
615s Solving dependencies...
615s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
618s Reading package lists...
618s Building dependency tree...
618s Reading state information...
618s Starting pkgProblemResolver with broken count: 0
618s Starting 2 pkgProblemResolver with broken count: 0
618s Done
618s The following NEW packages will be installed:
618s   apt-cacher-ng auto-apt-proxy clitest libcares2 libevent-2.1-7t64
618s   libevent-pthreads-2.1-7t64 libfuse2t64
619s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded.
619s Need to get 994 kB of archives.
619s After this operation, 2802 kB of additional disk space will be used.
619s Get:1 http://ftpmaster.internal/ubuntu questing/main s390x libcares2 s390x 1.34.4-2.1 [101 kB]
619s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x libevent-2.1-7t64 s390x 2.1.12-stable-10 [145 kB]
619s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x libevent-pthreads-2.1-7t64 s390x 2.1.12-stable-10 [7870 B]
619s Get:4 http://ftpmaster.internal/ubuntu questing/universe s390x libfuse2t64 s390x 2.9.9-9 [89.9 kB]
619s Get:5 http://ftpmaster.internal/ubuntu questing/universe s390x apt-cacher-ng s390x 3.7.5-1 [621 kB]
619s Get:6 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
619s Get:7 http://ftpmaster.internal/ubuntu questing/universe s390x clitest all 0.5.0-1 [19.0 kB]
619s Preconfiguring packages ...
619s Fetched 994 kB in 1s (1553 kB/s)
619s Selecting previously unselected package libcares2:s390x.
619s (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 ... 81472 files and directories currently installed.)
619s Preparing to unpack .../0-libcares2_1.34.4-2.1_s390x.deb ...
619s Unpacking libcares2:s390x (1.34.4-2.1) ...
619s Selecting previously unselected package libevent-2.1-7t64:s390x.
619s Preparing to unpack .../1-libevent-2.1-7t64_2.1.12-stable-10_s390x.deb ...
619s Unpacking libevent-2.1-7t64:s390x (2.1.12-stable-10) ...
619s Selecting previously unselected package libevent-pthreads-2.1-7t64:s390x.
619s Preparing to unpack .../2-libevent-pthreads-2.1-7t64_2.1.12-stable-10_s390x.deb ...
619s Unpacking libevent-pthreads-2.1-7t64:s390x (2.1.12-stable-10) ...
619s Selecting previously unselected package libfuse2t64:s390x.
620s Preparing to unpack .../3-libfuse2t64_2.9.9-9_s390x.deb ...
620s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64'
620s Adding 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64'
620s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64'
620s Adding 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64'
620s Unpacking libfuse2t64:s390x (2.9.9-9) ...
620s Selecting previously unselected package apt-cacher-ng.
620s Preparing to unpack .../4-apt-cacher-ng_3.7.5-1_s390x.deb ...
620s Unpacking apt-cacher-ng (3.7.5-1) ...
620s Selecting previously unselected package auto-apt-proxy.
620s Preparing to unpack .../5-auto-apt-proxy_16.5_all.deb ...
620s Unpacking auto-apt-proxy (16.5) ...
620s Selecting previously unselected package clitest.
620s Preparing to unpack .../6-clitest_0.5.0-1_all.deb ...
620s Unpacking clitest (0.5.0-1) ...
620s Setting up libevent-pthreads-2.1-7t64:s390x (2.1.12-stable-10) ...
620s Setting up libevent-2.1-7t64:s390x (2.1.12-stable-10) ...
620s Setting up libcares2:s390x (1.34.4-2.1) ...
620s Setting up auto-apt-proxy (16.5) ...
620s Setting up libfuse2t64:s390x (2.9.9-9) ...
620s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2 to /lib/s390x-linux-gnu/libfuse.so.2.usr-is-merged by libfuse2t64'
620s Removing 'diversion of /lib/s390x-linux-gnu/libfuse.so.2.9.9 to /lib/s390x-linux-gnu/libfuse.so.2.9.9.usr-is-merged by libfuse2t64'
620s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.usr-is-merged by libfuse2t64'
620s Removing 'diversion of /lib/s390x-linux-gnu/libulockmgr.so.1.0.1 to /lib/s390x-linux-gnu/libulockmgr.so.1.0.1.usr-is-merged by libfuse2t64'
620s Setting up clitest (0.5.0-1) ...
620s Setting up apt-cacher-ng (3.7.5-1) ...
620s Created symlink '/etc/systemd/system/multi-user.target.wants/apt-cacher-ng.service' → '/usr/lib/systemd/system/apt-cacher-ng.service'.

620s Processing triggers for man-db (2.13.0-1) ...
621s Processing triggers for libc-bin (2.41-6ubuntu1) ...
623s autopkgtest [07:47:21]: test wrapper-mode: clitest debian/tests/wrapper-mode.txt
623s autopkgtest [07:47:21]: test wrapper-mode: [-----------------------
623s #1	auto-apt-proxy sh -c 'echo $http_proxy; echo $HTTP_PROXY'
623s OK: 1 of 1 test passed
623s autopkgtest [07:47:21]: test wrapper-mode: -----------------------]
624s autopkgtest [07:47:22]: test wrapper-mode:  - - - - - - - - - - results - - - - - - - - - -
624s wrapper-mode         PASS
624s autopkgtest [07:47:22]: test remove: preparing testbed
713s autopkgtest [07:48:51]: testbed dpkg architecture: s390x
714s autopkgtest [07:48:52]: testbed apt version: 3.0.0
714s autopkgtest [07:48:52]: @@@@@@@@@@@@@@@@@@@@ test bed setup
714s autopkgtest [07:48:52]: testbed release detected to be: questing
715s autopkgtest [07:48:53]: updating testbed package index (apt update)
715s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
715s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
715s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
716s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
716s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
716s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
716s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
716s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
716s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
716s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
716s Fetched 3868 kB in 1s (2893 kB/s)
717s Reading package lists...
718s autopkgtest [07:48:56]: upgrading testbed (apt dist-upgrade and autopurge)
718s Reading package lists...
718s Building dependency tree...
718s Reading state information...
718s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
718s Starting 2 pkgProblemResolver with broken count: 0
718s Done
718s Entering ResolveByKeep
718s 
718s Calculating upgrade...
719s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
719s Reading package lists...
719s Building dependency tree...
719s Reading state information...
719s Starting pkgProblemResolver with broken count: 0
719s Starting 2 pkgProblemResolver with broken count: 0
719s Done
719s Solving dependencies...
719s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
722s Reading package lists...
722s Building dependency tree...
722s Reading state information...
722s Starting pkgProblemResolver with broken count: 0
722s Starting 2 pkgProblemResolver with broken count: 0
722s Done
722s The following NEW packages will be installed:
722s   auto-apt-proxy clitest
723s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded.
723s Need to get 29.0 kB of archives.
723s After this operation, 89.1 kB of additional disk space will be used.
723s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
723s Get:2 http://ftpmaster.internal/ubuntu questing/universe s390x clitest all 0.5.0-1 [19.0 kB]
723s Fetched 29.0 kB in 0s (131 kB/s)
723s Selecting previously unselected package auto-apt-proxy.
723s (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 ... 81472 files and directories currently installed.)
723s Preparing to unpack .../auto-apt-proxy_16.5_all.deb ...
723s Unpacking auto-apt-proxy (16.5) ...
723s Selecting previously unselected package clitest.
723s Preparing to unpack .../clitest_0.5.0-1_all.deb ...
723s Unpacking clitest (0.5.0-1) ...
723s Setting up auto-apt-proxy (16.5) ...
723s Setting up clitest (0.5.0-1) ...
723s Processing triggers for man-db (2.13.0-1) ...
725s autopkgtest [07:49:03]: test remove: [-----------------------
725s + apt-get remove -qy auto-apt-proxy
725s Reading package lists...
726s Building dependency tree...
726s Reading state information...
726s Solving dependencies...
726s The following packages will be REMOVED:
726s   auto-apt-proxy
726s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded.
726s After this operation, 34.8 kB disk space will be freed.
726s (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 ... 81485 files and directories currently installed.)
726s Removing auto-apt-proxy (16.5) ...
726s Processing triggers for man-db (2.13.0-1) ...
726s + apt-get update
727s Hit:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease
727s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
727s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
727s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
728s Reading package lists...
728s autopkgtest [07:49:06]: test remove: -----------------------]
728s autopkgtest [07:49:06]: test remove:  - - - - - - - - - - results - - - - - - - - - -
728s remove               PASS
729s autopkgtest [07:49:07]: test reinstall: preparing testbed
729s Reading package lists...
729s Building dependency tree...
729s Reading state information...
729s Starting pkgProblemResolver with broken count: 0
729s Starting 2 pkgProblemResolver with broken count: 0
729s Done
729s The following NEW packages will be installed:
729s   auto-apt-proxy
730s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
730s Need to get 0 B/9990 B of archives.
730s After this operation, 34.8 kB of additional disk space will be used.
730s Selecting previously unselected package auto-apt-proxy.
730s (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 ... 81479 files and directories currently installed.)
730s Preparing to unpack .../auto-apt-proxy_16.5_all.deb ...
730s Unpacking auto-apt-proxy (16.5) ...
730s Setting up auto-apt-proxy (16.5) ...
730s Processing triggers for man-db (2.13.0-1) ...
731s autopkgtest [07:49:09]: test reinstall: [-----------------------
731s + apt-get remove -qy auto-apt-proxy
731s Reading package lists...
731s Building dependency tree...
731s Reading state information...
731s Solving dependencies...
731s The following packages will be REMOVED:
731s   auto-apt-proxy
731s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded.
731s After this operation, 34.8 kB disk space will be freed.
732s (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 ... 81485 files and directories currently installed.)
732s Removing auto-apt-proxy (16.5) ...
732s Processing triggers for man-db (2.13.0-1) ...
732s + apt-get install -qy auto-apt-proxy
732s Reading package lists...
732s Building dependency tree...
732s Reading state information...
732s Solving dependencies...
732s Suggested packages:
732s   avahi-utils
732s The following NEW packages will be installed:
732s   auto-apt-proxy
733s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
733s Need to get 0 B/9990 B of archives.
733s After this operation, 34.8 kB of additional disk space will be used.
733s Selecting previously unselected package auto-apt-proxy.
733s (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 ... 81479 files and directories currently installed.)
733s Preparing to unpack .../auto-apt-proxy_16.5_all.deb ...
733s Unpacking auto-apt-proxy (16.5) ...
733s Setting up auto-apt-proxy (16.5) ...
733s Processing triggers for man-db (2.13.0-1) ...
733s + apt-config shell proxy Acquire::http::Proxy-Auto-Detect
733s + eval proxy='/usr/bin/auto-apt-proxy'
733s + proxy=/usr/bin/auto-apt-proxy
733s + test /usr/bin/auto-apt-proxy = /usr/bin/auto-apt-proxy
733s autopkgtest [07:49:11]: test reinstall: -----------------------]
734s autopkgtest [07:49:12]: test reinstall:  - - - - - - - - - - results - - - - - - - - - -
734s reinstall            PASS
734s autopkgtest [07:49:12]: test timeout: preparing testbed
843s autopkgtest [07:51:01]: testbed dpkg architecture: s390x
843s autopkgtest [07:51:01]: testbed apt version: 3.0.0
844s autopkgtest [07:51:02]: @@@@@@@@@@@@@@@@@@@@ test bed setup
844s autopkgtest [07:51:02]: testbed release detected to be: questing
845s autopkgtest [07:51:03]: updating testbed package index (apt update)
845s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
845s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
845s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
845s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
845s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
845s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
846s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
846s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
846s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
846s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
846s Fetched 3868 kB in 1s (2585 kB/s)
847s Reading package lists...
847s autopkgtest [07:51:05]: upgrading testbed (apt dist-upgrade and autopurge)
848s Reading package lists...
848s Building dependency tree...
848s Reading state information...
848s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
848s Starting 2 pkgProblemResolver with broken count: 0
848s Done
848s Entering ResolveByKeep
848s 
848s Calculating upgrade...
848s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
849s Reading package lists...
849s Building dependency tree...
849s Reading state information...
849s Starting pkgProblemResolver with broken count: 0
849s Starting 2 pkgProblemResolver with broken count: 0
849s Done
849s Solving dependencies...
849s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
852s Reading package lists...
852s Building dependency tree...
852s Reading state information...
852s Starting pkgProblemResolver with broken count: 0
852s Starting 2 pkgProblemResolver with broken count: 0
852s Done
852s The following NEW packages will be installed:
852s   auto-apt-proxy libruby libruby3.3 rake ruby ruby-did-you-mean ruby-minitest
852s   ruby-net-telnet ruby-power-assert ruby-rack ruby-rackup ruby-rubygems
852s   ruby-test-unit ruby-webrick ruby-xmlrpc ruby3.3 rubygems-integration
852s 0 upgraded, 17 newly installed, 0 to remove and 0 not upgraded.
852s Need to get 6649 kB of archives.
852s After this operation, 33.4 MB of additional disk space will be used.
852s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
852s Get:2 http://ftpmaster.internal/ubuntu questing/main s390x rubygems-integration all 1.19 [5550 B]
852s Get:3 http://ftpmaster.internal/ubuntu questing/main s390x ruby3.3 s390x 3.3.7-1ubuntu2 [49.1 kB]
852s Get:4 http://ftpmaster.internal/ubuntu questing/main s390x ruby-rubygems all 3.6.3-1 [332 kB]
853s Get:5 http://ftpmaster.internal/ubuntu questing/main s390x ruby s390x 1:3.3~ubuntu3 [3618 B]
853s Get:6 http://ftpmaster.internal/ubuntu questing/main s390x rake all 13.2.1-1 [45.8 kB]
853s Get:7 http://ftpmaster.internal/ubuntu questing/main s390x ruby-did-you-mean all 1.6.3-2 [14.8 kB]
853s Get:8 http://ftpmaster.internal/ubuntu questing/main s390x ruby-minitest all 5.25.4-2ubuntu1 [48.9 kB]
853s Get:9 http://ftpmaster.internal/ubuntu questing/main s390x ruby-net-telnet all 0.2.0-1 [13.3 kB]
853s Get:10 http://ftpmaster.internal/ubuntu questing/main s390x ruby-power-assert all 2.0.3-1 [12.0 kB]
853s Get:11 http://ftpmaster.internal/ubuntu questing/main s390x ruby-test-unit all 3.6.2-1 [67.0 kB]
853s Get:12 http://ftpmaster.internal/ubuntu questing/main s390x ruby-webrick all 1.8.1-1ubuntu1 [52.6 kB]
853s Get:13 http://ftpmaster.internal/ubuntu questing/main s390x ruby-xmlrpc all 0.3.3-2 [24.8 kB]
853s Get:14 http://ftpmaster.internal/ubuntu questing/main s390x libruby3.3 s390x 3.3.7-1ubuntu2 [5871 kB]
854s Get:15 http://ftpmaster.internal/ubuntu questing/main s390x libruby s390x 1:3.3~ubuntu3 [5038 B]
854s Get:16 http://ftpmaster.internal/ubuntu questing-proposed/main s390x ruby-rack all 3.1.12-1 [79.3 kB]
854s Get:17 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x ruby-rackup all 2.1.0-4 [13.0 kB]
854s Fetched 6649 kB in 2s (4282 kB/s)
854s Selecting previously unselected package auto-apt-proxy.
854s (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 ... 81472 files and directories currently installed.)
854s Preparing to unpack .../00-auto-apt-proxy_16.5_all.deb ...
854s Unpacking auto-apt-proxy (16.5) ...
854s Selecting previously unselected package rubygems-integration.
854s Preparing to unpack .../01-rubygems-integration_1.19_all.deb ...
854s Unpacking rubygems-integration (1.19) ...
854s Selecting previously unselected package ruby3.3.
854s Preparing to unpack .../02-ruby3.3_3.3.7-1ubuntu2_s390x.deb ...
854s Unpacking ruby3.3 (3.3.7-1ubuntu2) ...
854s Selecting previously unselected package ruby-rubygems.
854s Preparing to unpack .../03-ruby-rubygems_3.6.3-1_all.deb ...
854s Unpacking ruby-rubygems (3.6.3-1) ...
854s Selecting previously unselected package ruby.
854s Preparing to unpack .../04-ruby_1%3a3.3~ubuntu3_s390x.deb ...
854s Unpacking ruby (1:3.3~ubuntu3) ...
854s Selecting previously unselected package rake.
854s Preparing to unpack .../05-rake_13.2.1-1_all.deb ...
854s Unpacking rake (13.2.1-1) ...
854s Selecting previously unselected package ruby-did-you-mean.
854s Preparing to unpack .../06-ruby-did-you-mean_1.6.3-2_all.deb ...
854s Unpacking ruby-did-you-mean (1.6.3-2) ...
854s Selecting previously unselected package ruby-minitest.
854s Preparing to unpack .../07-ruby-minitest_5.25.4-2ubuntu1_all.deb ...
854s Unpacking ruby-minitest (5.25.4-2ubuntu1) ...
854s Selecting previously unselected package ruby-net-telnet.
854s Preparing to unpack .../08-ruby-net-telnet_0.2.0-1_all.deb ...
854s Unpacking ruby-net-telnet (0.2.0-1) ...
854s Selecting previously unselected package ruby-power-assert.
854s Preparing to unpack .../09-ruby-power-assert_2.0.3-1_all.deb ...
854s Unpacking ruby-power-assert (2.0.3-1) ...
854s Selecting previously unselected package ruby-test-unit.
854s Preparing to unpack .../10-ruby-test-unit_3.6.2-1_all.deb ...
854s Unpacking ruby-test-unit (3.6.2-1) ...
854s Selecting previously unselected package ruby-webrick.
854s Preparing to unpack .../11-ruby-webrick_1.8.1-1ubuntu1_all.deb ...
854s Unpacking ruby-webrick (1.8.1-1ubuntu1) ...
854s Selecting previously unselected package ruby-xmlrpc.
854s Preparing to unpack .../12-ruby-xmlrpc_0.3.3-2_all.deb ...
854s Unpacking ruby-xmlrpc (0.3.3-2) ...
854s Selecting previously unselected package libruby3.3:s390x.
854s Preparing to unpack .../13-libruby3.3_3.3.7-1ubuntu2_s390x.deb ...
854s Unpacking libruby3.3:s390x (3.3.7-1ubuntu2) ...
854s Selecting previously unselected package libruby:s390x.
854s Preparing to unpack .../14-libruby_1%3a3.3~ubuntu3_s390x.deb ...
854s Unpacking libruby:s390x (1:3.3~ubuntu3) ...
854s Selecting previously unselected package ruby-rack.
854s Preparing to unpack .../15-ruby-rack_3.1.12-1_all.deb ...
854s Unpacking ruby-rack (3.1.12-1) ...
854s Selecting previously unselected package ruby-rackup.
854s Preparing to unpack .../16-ruby-rackup_2.1.0-4_all.deb ...
854s Unpacking ruby-rackup (2.1.0-4) ...
854s Setting up ruby-power-assert (2.0.3-1) ...
854s Setting up rubygems-integration (1.19) ...
854s Setting up ruby-minitest (5.25.4-2ubuntu1) ...
854s Setting up ruby-test-unit (3.6.2-1) ...
854s Setting up ruby-net-telnet (0.2.0-1) ...
854s Setting up auto-apt-proxy (16.5) ...
854s Setting up ruby-webrick (1.8.1-1ubuntu1) ...
854s Setting up ruby-did-you-mean (1.6.3-2) ...
854s Setting up ruby-xmlrpc (0.3.3-2) ...
854s Setting up rake (13.2.1-1) ...
854s Setting up libruby3.3:s390x (3.3.7-1ubuntu2) ...
854s Setting up ruby3.3 (3.3.7-1ubuntu2) ...
854s Setting up libruby:s390x (1:3.3~ubuntu3) ...
854s Setting up ruby (1:3.3~ubuntu3) ...
854s Setting up ruby-rack (3.1.12-1) ...
854s Setting up ruby-rubygems (3.6.3-1) ...
854s Setting up ruby-rackup (2.1.0-4) ...
854s Processing triggers for libc-bin (2.41-6ubuntu1) ...
854s Processing triggers for man-db (2.13.0-1) ...
857s autopkgtest [07:51:15]: test timeout: [-----------------------
857s + timeout --signal=KILL 15 auto-apt-proxy
872s Killed
872s + cat proxy.pid
872s + kill -9 1755
873s autopkgtest [07:51:31]: test timeout: -----------------------]
873s timeout              FAIL non-zero exit status 137
873s autopkgtest [07:51:31]: test timeout:  - - - - - - - - - - results - - - - - - - - - -
873s autopkgtest [07:51:31]: test getent-timeout: preparing testbed
874s Reading package lists...
874s Building dependency tree...
874s Reading state information...
874s Starting pkgProblemResolver with broken count: 0
874s Starting 2 pkgProblemResolver with broken count: 0
874s Done
874s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
875s autopkgtest [07:51:33]: test getent-timeout: [-----------------------
875s + timeout --signal=KILL 20 auto-apt-proxy
895s Killed
896s autopkgtest [07:51:54]: test getent-timeout: -----------------------]
896s autopkgtest [07:51:54]: test getent-timeout:  - - - - - - - - - - results - - - - - - - - - -
896s getent-timeout       FAIL non-zero exit status 137
896s autopkgtest [07:51:54]: test insecure-cache-dir: preparing testbed
1003s autopkgtest [07:53:41]: testbed dpkg architecture: s390x
1003s autopkgtest [07:53:41]: testbed apt version: 3.0.0
1004s autopkgtest [07:53:42]: @@@@@@@@@@@@@@@@@@@@ test bed setup
1004s autopkgtest [07:53:42]: testbed release detected to be: questing
1005s autopkgtest [07:53:43]: updating testbed package index (apt update)
1005s Get:1 http://ftpmaster.internal/ubuntu questing-proposed InRelease [110 kB]
1005s Hit:2 http://ftpmaster.internal/ubuntu questing InRelease
1005s Hit:3 http://ftpmaster.internal/ubuntu questing-updates InRelease
1005s Hit:4 http://ftpmaster.internal/ubuntu questing-security InRelease
1005s Get:5 http://ftpmaster.internal/ubuntu questing-proposed/main Sources [184 kB]
1006s Get:6 http://ftpmaster.internal/ubuntu questing-proposed/multiverse Sources [57.4 kB]
1006s Get:7 http://ftpmaster.internal/ubuntu questing-proposed/universe Sources [2202 kB]
1006s Get:8 http://ftpmaster.internal/ubuntu questing-proposed/main s390x Packages [216 kB]
1006s Get:9 http://ftpmaster.internal/ubuntu questing-proposed/universe s390x Packages [1083 kB]
1006s Get:10 http://ftpmaster.internal/ubuntu questing-proposed/multiverse s390x Packages [15.9 kB]
1006s Fetched 3868 kB in 1s (3208 kB/s)
1007s Reading package lists...
1007s autopkgtest [07:53:45]: upgrading testbed (apt dist-upgrade and autopurge)
1007s Reading package lists...
1008s Building dependency tree...
1008s Reading state information...
1008s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
1008s Starting 2 pkgProblemResolver with broken count: 0
1008s Done
1008s Entering ResolveByKeep
1008s 
1008s Calculating upgrade...
1008s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1008s Reading package lists...
1009s Building dependency tree...
1009s Reading state information...
1009s Starting pkgProblemResolver with broken count: 0
1009s Starting 2 pkgProblemResolver with broken count: 0
1009s Done
1009s Solving dependencies...
1009s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
1012s Reading package lists...
1012s Building dependency tree...
1012s Reading state information...
1012s Starting pkgProblemResolver with broken count: 0
1012s Starting 2 pkgProblemResolver with broken count: 0
1012s Done
1012s The following NEW packages will be installed:
1012s   auto-apt-proxy
1013s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
1013s Need to get 9990 B of archives.
1013s After this operation, 34.8 kB of additional disk space will be used.
1013s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x auto-apt-proxy all 16.5 [9990 B]
1013s Fetched 9990 B in 0s (69.6 kB/s)
1013s Selecting previously unselected package auto-apt-proxy.
1013s (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 ... 81472 files and directories currently installed.)
1013s Preparing to unpack .../auto-apt-proxy_16.5_all.deb ...
1013s Unpacking auto-apt-proxy (16.5) ...
1013s Setting up auto-apt-proxy (16.5) ...
1013s Processing triggers for man-db (2.13.0-1) ...
1015s autopkgtest [07:53:53]: test insecure-cache-dir: [-----------------------
1016s + id -u ubuntu
1016s + uid=1000
1016s + mkdir /tmp/.auto-apt-proxy-1000
1016s + rc=0
1016s + runuser -u ubuntu auto-apt-proxy
1016s E: insecure cache dir /tmp/.auto-apt-proxy-1000. Must be owned by UID 1000 and have permissions 700
1016s + rc=1
1016s + test 1 -ne 0
1016s + rmdir /tmp/.auto-apt-proxy-1000
1016s + runuser -u ubuntu auto-apt-proxy
1036s autopkgtest [07:54:14]: test insecure-cache-dir: -----------------------]
1037s autopkgtest [07:54:15]: test insecure-cache-dir:  - - - - - - - - - - results - - - - - - - - - -
1037s insecure-cache-dir   PASS
1037s autopkgtest [07:54:15]: test noproxy: preparing testbed
1037s Reading package lists...
1037s Building dependency tree...
1037s Reading state information...
1037s Starting pkgProblemResolver with broken count: 0
1037s Starting 2 pkgProblemResolver with broken count: 0
1037s Done
1038s The following NEW packages will be installed:
1038s   newpid
1058s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
1058s Need to get 8670 B of archives.
1058s After this operation, 28.7 kB of additional disk space will be used.
1058s Get:1 http://ftpmaster.internal/ubuntu questing/universe s390x newpid s390x 14 [8670 B]
1058s Fetched 8670 B in 20s (428 B/s)
1058s Selecting previously unselected package newpid.
1058s (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 ... 81479 files and directories currently installed.)
1058s Preparing to unpack .../archives/newpid_14_s390x.deb ...
1058s Unpacking newpid (14) ...
1058s Setting up newpid (14) ...
1058s Processing triggers for man-db (2.13.0-1) ...
1059s autopkgtest [07:54:37]: test noproxy: [-----------------------
1059s Running auto-apt-proxy on a fresh network namespace
1059s Proxy should be empty
1059s Proxy = ""
1060s autopkgtest [07:54:38]: test noproxy: -----------------------]
1060s autopkgtest [07:54:38]: test noproxy:  - - - - - - - - - - results - - - - - - - - - -
1060s noproxy              PASS
1061s autopkgtest [07:54:39]: @@@@@@@@@@@@@@@@@@@@ summary
1061s apt-integration      PASS
1061s apt-cacher-ng        PASS
1061s approx               PASS
1061s apt-cacher           PASS
1061s wrapper-mode         PASS
1061s remove               PASS
1061s reinstall            PASS
1061s timeout              FAIL non-zero exit status 137
1061s getent-timeout       FAIL non-zero exit status 137
1061s insecure-cache-dir   PASS
1061s noproxy              PASS
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250501.img (UUID 06a11845-48a4-4c28-9288-51dd7b757c52)...
1078s nova [W] Timed out waiting for 36834ef9-ee20-46de-ac8f-0f2fc4c069e0 to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s flock: timeout while waiting to get lock
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250501.img (UUID 06a11845-48a4-4c28-9288-51dd7b757c52)...
1078s nova [W] Timed out waiting for a9912421-0d27-4e8d-a671-6c9293423865 to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250501.img (UUID 06a11845-48a4-4c28-9288-51dd7b757c52)...
1078s nova [W] Timed out waiting for 415049dc-6869-4923-944c-45abae136be9 to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
1078s nova [W] Timed out waiting for 12b5dafd-4d6b-4939-8361-8a47c5382526 to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
1078s nova [W] Timed out waiting for 9e335975-45af-4c0e-b3d8-e711bc69fbdb to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
1078s nova [W] Timed out waiting for 22b43e84-5d47-425d-be4e-9ff7dcdd1101 to get deleted.
1078s nova [W] Using flock in prodstack6-s390x
1078s Creating nova instance adt-questing-s390x-auto-apt-proxy-20250502-073658-juju-7f2275-prod-proposed-migration-environment-15-b1749619-33c7-425e-8f1b-91b15bd9d8d7 from image adt/ubuntu-questing-s390x-server-20250502.img (UUID 632ecfca-a19d-4f3a-af48-b7883fa0ccf2)...
1078s nova [W] Timed out waiting for 7c740b37-83a7-4d85-9510-2b82cee86fec to get deleted.