0s autopkgtest [19:15:41]: starting date and time: 2025-03-15 19:15:41+0000
  0s autopkgtest [19:15:41]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [19:15:41]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.lo3yhpso/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade spoa --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-5.secgroup --name adt-plucky-s390x-spoa-20250315-191541-juju-7f2275-prod-proposed-migration-environment-15-511d6177-d42b-41a6-920b-9936012844ca --image adt/ubuntu-plucky-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-s390x -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/
102s autopkgtest [19:17:23]: testbed dpkg architecture: s390x
102s autopkgtest [19:17:23]: testbed apt version: 2.9.33
103s autopkgtest [19:17:24]: @@@@@@@@@@@@@@@@@@@@ test bed setup
103s autopkgtest [19:17:24]: testbed release detected to be: None
104s autopkgtest [19:17:25]: updating testbed package index (apt update)
104s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB]
104s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
104s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
104s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
104s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB]
105s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB]
105s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB]
105s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [77.3 kB]
105s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B]
105s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B]
105s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [314 kB]
105s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.3 kB]
105s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3532 B]
105s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B]
105s Fetched 965 kB in 1s (954 kB/s)
106s Reading package lists...
106s + lsb_release --codename --short
106s + RELEASE=plucky
106s + cat
106s + [ plucky != trusty ]
106s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade
106s Reading package lists...
106s Building dependency tree...
106s Reading state information...
106s Calculating upgrade...
106s Calculating upgrade...
107s The following packages were automatically installed and are no longer required:
107s   libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64
107s   linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic
107s   linux-modules-6.11.0-8-generic linux-tools-6.11.0-8
107s   linux-tools-6.11.0-8-generic
107s Use 'sudo apt autoremove' to remove them.
107s The following packages will be upgraded:
107s   pinentry-curses python3-jinja2 strace
107s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
107s Need to get 652 kB of archives.
107s After this operation, 27.6 kB of additional disk space will be used.
107s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB]
107s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB]
107s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB]
108s Fetched 652 kB in 1s (985 kB/s)
108s (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 ... 81428 files and directories currently installed.)
108s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ...
108s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ...
108s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ...
108s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ...
108s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ...
108s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ...
108s Setting up pinentry-curses (1.3.1-2ubuntu3) ...
108s Setting up python3-jinja2 (3.1.5-2ubuntu1) ...
108s Setting up strace (6.13+ds-1ubuntu1) ...
108s Processing triggers for man-db (2.13.0-1) ...
108s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref
108s + /usr/lib/apt/apt-helper analyze-pattern ?true
108s + uname -r
108s + sed s/\./\\./g
108s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.*
108s + apt list ?obsolete
108s + + tail -n+2
108s cut -d/ -f1
108s + grep -v ^linux-.*6\.14\.0-10-generic.*
109s + obsolete_pkgs=linux-headers-6.11.0-8-generic
109s linux-headers-6.11.0-8
109s linux-modules-6.11.0-8-generic
109s linux-tools-6.11.0-8-generic
109s linux-tools-6.11.0-8
109s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-generic linux-headers-6.11.0-8 linux-modules-6.11.0-8-generic linux-tools-6.11.0-8-generic linux-tools-6.11.0-8
109s Reading package lists...
109s Building dependency tree...
109s Reading state information...
109s Solving dependencies...
109s The following packages will be REMOVED:
109s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
109s   linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
109s   linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8*
109s   linux-tools-6.11.0-8-generic*
109s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded.
109s After this operation, 167 MB disk space will be freed.
109s (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 ... 81428 files and directories currently installed.)
109s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
109s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
109s Removing libpython3.12t64:s390x (3.12.9-1) ...
109s Removing libpython3.12-stdlib:s390x (3.12.9-1) ...
109s Removing libnsl2:s390x (1.3.0-3build3) ...
109s Removing libpython3.12-minimal:s390x (3.12.9-1) ...
109s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
109s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
110s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
110s Processing triggers for libc-bin (2.41-1ubuntu1) ...
110s (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 ... 56328 files and directories currently installed.)
110s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ...
110s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
110s + grep -q trusty /etc/lsb-release
110s + [ ! -d /usr/share/doc/unattended-upgrades ]
110s + [ ! -d /usr/share/doc/lxd ]
110s + [ ! -d /usr/share/doc/lxd-client ]
110s + [ ! -d /usr/share/doc/snapd ]
110s + type iptables
110s + cat
110s + chmod 755 /etc/rc.local
110s + . /etc/rc.local
110s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu
110s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP
110s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP
110s + uname -m
110s + [ s390x = ppc64le ]
110s + [ -d /run/systemd/system ]
110s + systemd-detect-virt --quiet --vm
110s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/
110s + cat
110s + grep -q lz4 /etc/initramfs-tools/initramfs.conf
110s + echo COMPRESS=lz4
110s autopkgtest [19:17:31]: upgrading testbed (apt dist-upgrade and autopurge)
111s Reading package lists...
111s Building dependency tree...
111s Reading state information...
111s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
111s Starting 2 pkgProblemResolver with broken count: 0
111s Done
111s Entering ResolveByKeep
111s 
111s Calculating upgrade...
111s The following packages will be upgraded:
111s   libc-bin libc-dev-bin libc6 libc6-dev locales
112s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
112s Need to get 9512 kB of archives.
112s After this operation, 8192 B of additional disk space will be used.
112s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB]
112s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB]
112s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB]
113s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB]
113s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB]
114s Preconfiguring packages ...
114s Fetched 9512 kB in 2s (3928 kB/s)
114s (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 ... 56326 files and directories currently installed.)
114s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ...
114s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
114s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ...
114s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
114s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ...
114s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
114s Setting up libc6:s390x (2.41-1ubuntu2) ...
115s (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 ... 56326 files and directories currently installed.)
115s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ...
115s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
115s Setting up libc-bin (2.41-1ubuntu2) ...
115s (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 ... 56326 files and directories currently installed.)
115s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ...
115s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
115s Setting up locales (2.41-1ubuntu2) ...
115s Generating locales (this might take a while)...
116s   en_US.UTF-8... done
116s Generation complete.
116s Setting up libc-dev-bin (2.41-1ubuntu2) ...
116s Setting up libc6-dev:s390x (2.41-1ubuntu2) ...
116s Processing triggers for man-db (2.13.0-1) ...
116s Processing triggers for systemd (257.3-1ubuntu3) ...
117s Reading package lists...
117s Building dependency tree...
117s Reading state information...
117s Starting pkgProblemResolver with broken count: 0
117s Starting 2 pkgProblemResolver with broken count: 0
117s Done
117s Solving dependencies...
118s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
118s autopkgtest [19:17:39]: rebooting testbed after setup commands that affected boot
126s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
135s autopkgtest [19:17:56]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025
138s autopkgtest [19:17:59]: @@@@@@@@@@@@@@@@@@@@ apt-source spoa
140s Get:1 http://ftpmaster.internal/ubuntu plucky/universe spoa 4.1.4-2 (dsc) [2306 B]
140s Get:2 http://ftpmaster.internal/ubuntu plucky/universe spoa 4.1.4-2 (tar) [47.5 kB]
140s Get:3 http://ftpmaster.internal/ubuntu plucky/universe spoa 4.1.4-2 (diff) [8916 B]
140s gpgv: Signature made Wed Jul 24 20:03:27 2024 UTC
140s gpgv:                using RSA key 8F91B227C7D6F2B1948C8236793CF67E8F0D11DA
140s gpgv:                issuer "emollier@debian.org"
140s gpgv: Can't check signature: No public key
140s dpkg-source: warning: cannot verify inline signature for ./spoa_4.1.4-2.dsc: no acceptable signature found
140s autopkgtest [19:18:01]: testing package spoa version 4.1.4-2
141s autopkgtest [19:18:02]: build not needed
141s autopkgtest [19:18:02]: test run-unit-test: preparing testbed
141s Reading package lists...
142s Building dependency tree...
142s Reading state information...
142s Starting pkgProblemResolver with broken count: 0
142s Starting 2 pkgProblemResolver with broken count: 0
142s Done
142s The following NEW packages will be installed:
142s   libcereal-dev libspoa-dev libspoa7.0.0 rapidjson-dev spoa
142s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded.
142s Need to get 448 kB of archives.
142s After this operation, 2081 kB of additional disk space will be used.
142s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x rapidjson-dev all 1.1.0+dfsg2-7.3ubuntu1 [97.3 kB]
142s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x libcereal-dev s390x 1.3.2+dfsg-5 [222 kB]
143s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x libspoa7.0.0 s390x 4.1.4-2 [82.1 kB]
143s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x libspoa-dev s390x 4.1.4-2 [7368 B]
143s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x spoa s390x 4.1.4-2 [38.6 kB]
143s Fetched 448 kB in 1s (747 kB/s)
143s Selecting previously unselected package rapidjson-dev.
143s (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 ... 56326 files and directories currently installed.)
143s Preparing to unpack .../rapidjson-dev_1.1.0+dfsg2-7.3ubuntu1_all.deb ...
143s Unpacking rapidjson-dev (1.1.0+dfsg2-7.3ubuntu1) ...
143s Selecting previously unselected package libcereal-dev.
143s Preparing to unpack .../libcereal-dev_1.3.2+dfsg-5_s390x.deb ...
143s Unpacking libcereal-dev (1.3.2+dfsg-5) ...
143s Selecting previously unselected package libspoa7.0.0:s390x.
143s Preparing to unpack .../libspoa7.0.0_4.1.4-2_s390x.deb ...
143s Unpacking libspoa7.0.0:s390x (4.1.4-2) ...
143s Selecting previously unselected package libspoa-dev:s390x.
143s Preparing to unpack .../libspoa-dev_4.1.4-2_s390x.deb ...
143s Unpacking libspoa-dev:s390x (4.1.4-2) ...
143s Selecting previously unselected package spoa.
143s Preparing to unpack .../spoa_4.1.4-2_s390x.deb ...
143s Unpacking spoa (4.1.4-2) ...
143s Setting up rapidjson-dev (1.1.0+dfsg2-7.3ubuntu1) ...
143s Setting up libspoa7.0.0:s390x (4.1.4-2) ...
143s Setting up spoa (4.1.4-2) ...
143s Setting up libcereal-dev (1.3.2+dfsg-5) ...
143s Setting up libspoa-dev:s390x (4.1.4-2) ...
143s Processing triggers for man-db (2.13.0-1) ...
143s Processing triggers for libc-bin (2.41-1ubuntu2) ...
145s autopkgtest [19:18:06]: test run-unit-test: [-----------------------
146s >Consensus LN:i:495
146s AATGATGCGCTTTGTTGGCGCGGTGGCTTGATGCAGGGGCTAATCGACCTCTGGCAACCACTTTTCCATGACAGGAGTTGAATATGGCATTCAGTAATCCCTTCGATGATCCGCAGGGAGCGTTTTACATATTGCGCAATGCGCAGGGCAATTCAGTCTGTGGCCGCAACAATGCGTCTTACCGGCAGGCTGGGACATTGTGTGTCAGCCGCAGTCACAGGCGTCCTGCCAGCAGTGGCTGGAAGCCCACTGGCGTACTCTGACACCGACGAATTTTACCCAGTTGCAGGAGGCACAATGAGCCAGCATTTACCTTTGGTCGCCGCACAGCCCGGCATCTGGATGGCAGAAAAACTGTCAGAATTACCCTCCGCCTGGAGCGTGGCGCATTACGTTGAGTTAACCGGAGAGGTTGATTCGCCATTACTGGCCCGCGCGGTGGTTGCCGGACTAGCGCAAGCAGATACGCTTTACACGCGCAACCAAGGATTTCGG
146s autopkgtest [19:18:07]: test run-unit-test: -----------------------]
147s autopkgtest [19:18:08]: test run-unit-test:  - - - - - - - - - - results - - - - - - - - - -
147s run-unit-test        PASS
147s autopkgtest [19:18:08]: @@@@@@@@@@@@@@@@@@@@ summary
147s run-unit-test        PASS
165s nova [W] Using flock in prodstack6-s390x
165s Creating nova instance adt-plucky-s390x-spoa-20250315-191541-juju-7f2275-prod-proposed-migration-environment-15-511d6177-d42b-41a6-920b-9936012844ca from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)...
165s nova [W] Timed out waiting for bca61989-3113-484c-9c72-14af4cecd9de to get deleted.