0s autopkgtest [16:32:41]: starting date and time: 2025-03-15 16:32:41+0000 0s autopkgtest [16:32:41]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:32:41]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.4hcmexch/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade pbzip2 --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-9.secgroup --name adt-plucky-s390x-pbzip2-20250315-163240-juju-7f2275-prod-proposed-migration-environment-15-6e7aea42-7d30-499f-8ffe-d68c5942a920 --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/ 121s autopkgtest [16:34:42]: testbed dpkg architecture: s390x 121s autopkgtest [16:34:42]: testbed apt version: 2.9.33 121s autopkgtest [16:34:42]: @@@@@@@@@@@@@@@@@@@@ test bed setup 121s autopkgtest [16:34:42]: testbed release detected to be: None 122s autopkgtest [16:34:43]: updating testbed package index (apt update) 122s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 123s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 123s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 123s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 123s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 123s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 123s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 124s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [113 kB] 124s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 124s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 124s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [320 kB] 125s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.4 kB] 125s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3776 B] 125s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 125s Fetched 1073 kB in 2s (471 kB/s) 125s Reading package lists... 126s + lsb_release --codename --short 126s + RELEASE=plucky 126s + cat 126s + [ plucky != trusty ] 126s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 126s Reading package lists... 126s Building dependency tree... 126s Reading state information... 126s Calculating upgrade... 126s Calculating upgrade... 126s The following packages were automatically installed and are no longer required: 126s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 126s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 126s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 126s linux-tools-6.11.0-8-generic 126s Use 'sudo apt autoremove' to remove them. 126s The following packages will be upgraded: 126s pinentry-curses python3-jinja2 strace 126s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 126s Need to get 652 kB of archives. 126s After this operation, 27.6 kB of additional disk space will be used. 126s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 127s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 127s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 128s Fetched 652 kB in 1s (649 kB/s) 128s (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.) 128s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 128s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 128s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 128s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 128s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 128s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 128s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 128s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 128s Setting up strace (6.13+ds-1ubuntu1) ... 128s Processing triggers for man-db (2.13.0-1) ... 128s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 128s + /usr/lib/apt/apt-helper analyze-pattern ?true 128s + uname -r 128s + sed s/\./\\./g 129s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 129s + apt list ?obsolete 129s + tail -n+2 129s + cut+ grep -v ^linux-.*6\.14\.0-10-generic.* 129s -d/ -f1 129s + obsolete_pkgs=linux-headers-6.11.0-8-generic 129s linux-headers-6.11.0-8 129s linux-modules-6.11.0-8-generic 129s linux-tools-6.11.0-8-generic 129s linux-tools-6.11.0-8 129s + 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 129s Reading package lists... 129s Building dependency tree... 129s Reading state information... 129s Solving dependencies... 129s The following packages will be REMOVED: 129s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 129s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 129s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 129s linux-tools-6.11.0-8-generic* 129s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 129s After this operation, 167 MB disk space will be freed. 129s (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.) 129s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 129s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 129s Removing libpython3.12t64:s390x (3.12.9-1) ... 129s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 129s Removing libnsl2:s390x (1.3.0-3build3) ... 129s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 129s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 129s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 130s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 130s Processing triggers for libc-bin (2.41-1ubuntu1) ... 130s (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.) 130s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 130s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 130s + grep -q trusty /etc/lsb-release 130s + [ ! -d /usr/share/doc/unattended-upgrades ] 130s + [ ! -d /usr/share/doc/lxd ] 130s + [ ! -d /usr/share/doc/lxd-client ] 130s + [ ! -d /usr/share/doc/snapd ] 130s + type iptables 130s + cat 130s + chmod 755 /etc/rc.local 130s + . /etc/rc.local 130s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 130s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 130s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 130s + uname -m 130s + [ s390x = ppc64le ] 130s + [ -d /run/systemd/system ] 130s + systemd-detect-virt --quiet --vm 130s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 130s + cat 130s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 130s + echo COMPRESS=lz4 130s autopkgtest [16:34:51]: upgrading testbed (apt dist-upgrade and autopurge) 131s Reading package lists... 131s Building dependency tree... 131s Reading state information... 131s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 131s Starting 2 pkgProblemResolver with broken count: 0 131s Done 131s Entering ResolveByKeep 131s 131s Calculating upgrade... 131s The following packages will be upgraded: 131s libc-bin libc-dev-bin libc6 libc6-dev locales 132s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 132s Need to get 9512 kB of archives. 132s After this operation, 8192 B of additional disk space will be used. 132s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 134s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 134s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 137s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 138s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 143s Preconfiguring packages ... 143s Fetched 9512 kB in 11s (843 kB/s) 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 .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Setting up libc6:s390x (2.41-1ubuntu2) ... 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 .../libc-bin_2.41-1ubuntu2_s390x.deb ... 143s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 143s Setting up libc-bin (2.41-1ubuntu2) ... 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 .../locales_2.41-1ubuntu2_all.deb ... 143s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 144s Setting up locales (2.41-1ubuntu2) ... 144s Generating locales (this might take a while)... 145s en_US.UTF-8... done 145s Generation complete. 145s Setting up libc-dev-bin (2.41-1ubuntu2) ... 145s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 145s Processing triggers for man-db (2.13.0-1) ... 145s Processing triggers for systemd (257.3-1ubuntu3) ... 146s Reading package lists... 146s Building dependency tree... 146s Reading state information... 147s Starting pkgProblemResolver with broken count: 0 147s Starting 2 pkgProblemResolver with broken count: 0 147s Done 147s Solving dependencies... 147s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 147s autopkgtest [16:35:08]: rebooting testbed after setup commands that affected boot 167s autopkgtest [16:35:28]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 169s autopkgtest [16:35:30]: @@@@@@@@@@@@@@@@@@@@ apt-source pbzip2 171s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pbzip2 1.1.13-1build1 (dsc) [1891 B] 171s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pbzip2 1.1.13-1build1 (tar) [48.2 kB] 171s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pbzip2 1.1.13-1build1 (diff) [5900 B] 171s gpgv: Signature made Sun Mar 22 16:26:28 2020 UTC 171s gpgv: using RSA key D56571B88A8BBAF140BF63D6BD7EAA60778FA6F5 171s gpgv: issuer "doko@ubuntu.com" 171s gpgv: Can't check signature: No public key 171s dpkg-source: warning: cannot verify inline signature for ./pbzip2_1.1.13-1build1.dsc: no acceptable signature found 171s autopkgtest [16:35:32]: testing package pbzip2 version 1.1.13-1build1 172s autopkgtest [16:35:33]: build not needed 172s autopkgtest [16:35:33]: test command1: preparing testbed 172s Reading package lists... 172s Building dependency tree... 172s Reading state information... 173s Starting pkgProblemResolver with broken count: 0 173s Starting 2 pkgProblemResolver with broken count: 0 173s Done 173s The following NEW packages will be installed: 173s pbzip2 173s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 173s Need to get 37.9 kB of archives. 173s After this operation, 103 kB of additional disk space will be used. 173s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x pbzip2 s390x 1.1.13-1build1 [37.9 kB] 173s Fetched 37.9 kB in 0s (152 kB/s) 173s Selecting previously unselected package pbzip2. 173s (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.) 173s Preparing to unpack .../pbzip2_1.1.13-1build1_s390x.deb ... 173s Unpacking pbzip2 (1.1.13-1build1) ... 173s Setting up pbzip2 (1.1.13-1build1) ... 173s Processing triggers for man-db (2.13.0-1) ... 175s autopkgtest [16:35:36]: test command1: pbzip2 -h 2>&1 | grep Example: 175s autopkgtest [16:35:36]: test command1: [----------------------- 175s Example: pbzip2 -b15vk myfile.tar 175s Example: pbzip2 -p4 -r -5 myfile.tar second*.txt 175s Example: tar cf myfile.tar.bz2 --use-compress-prog=pbzip2 dir_to_compress/ 175s Example: pbzip2 -d -m500 myfile.tar.bz2 175s Example: pbzip2 -dc myfile.tar.bz2 | tar x 175s Example: pbzip2 -c < myfile.txt > myfile.txt.bz2 175s autopkgtest [16:35:36]: test command1: -----------------------] 176s autopkgtest [16:35:37]: test command1: - - - - - - - - - - results - - - - - - - - - - 176s command1 PASS 176s autopkgtest [16:35:37]: test command2: preparing testbed 176s Reading package lists... 176s Building dependency tree... 176s Reading state information... 176s Starting pkgProblemResolver with broken count: 0 176s Starting 2 pkgProblemResolver with broken count: 0 176s Done 177s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 177s autopkgtest [16:35:38]: test command2: test "$(pbzip2 -c -d debian/tests/stuff/random10K.gz | sha1sum | cut -d" " -f1)" = "$(sha1sum debian/tests/stuff/random10K | cut -d" " -f1)" 177s autopkgtest [16:35:38]: test command2: [----------------------- 178s autopkgtest [16:35:39]: test command2: -----------------------] 178s autopkgtest [16:35:39]: test command2: - - - - - - - - - - results - - - - - - - - - - 178s command2 PASS 179s autopkgtest [16:35:40]: test command3: preparing testbed 179s Reading package lists... 179s Building dependency tree... 179s Reading state information... 179s Starting pkgProblemResolver with broken count: 0 179s Starting 2 pkgProblemResolver with broken count: 0 179s Done 179s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 180s autopkgtest [16:35:41]: test command3: test "$(pbzip2 -c -z debian/tests/stuff/random10K | sha1sum | cut -d" " -f1)" = "$(sha1sum debian/tests/stuff/random10K.gz | cut -d" " -f1)" 180s autopkgtest [16:35:41]: test command3: [----------------------- 181s autopkgtest [16:35:42]: test command3: -----------------------] 181s command3 PASS 181s autopkgtest [16:35:42]: test command3: - - - - - - - - - - results - - - - - - - - - - 181s autopkgtest [16:35:42]: @@@@@@@@@@@@@@@@@@@@ summary 181s command1 PASS 181s command2 PASS 181s command3 PASS 189s nova [W] Using flock in prodstack6-s390x 189s Creating nova instance adt-plucky-s390x-pbzip2-20250315-163240-juju-7f2275-prod-proposed-migration-environment-15-6e7aea42-7d30-499f-8ffe-d68c5942a920 from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 189s nova [W] Timed out waiting for 16e2e8dd-c53f-4b63-b73e-ea7c7f9dc853 to get deleted.