0s autopkgtest [16:26:31]: starting date and time: 2025-03-15 16:26:31+0000 0s autopkgtest [16:26:31]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [16:26:31]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.7t8h16pj/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade ots --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-18.secgroup --name adt-plucky-s390x-ots-20250315-162630-juju-7f2275-prod-proposed-migration-environment-15-cd43e54d-1902-4a6f-9f2f-37bfa089ca42 --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/ 89s autopkgtest [16:28:00]: testbed dpkg architecture: s390x 89s autopkgtest [16:28:00]: testbed apt version: 2.9.33 90s autopkgtest [16:28:01]: @@@@@@@@@@@@@@@@@@@@ test bed setup 90s autopkgtest [16:28:01]: testbed release detected to be: None 90s autopkgtest [16:28:01]: updating testbed package index (apt update) 91s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 91s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 91s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 91s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 91s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 91s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 92s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 92s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [113 kB] 92s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 92s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 92s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [320 kB] 95s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.4 kB] 95s + Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3776 B] 95s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 95s Fetched 1073 kB in 2s (593 kB/s) 95s Reading package lists... 95s Reading package lists... 95s Building dependency tree... 95s Reading state information... 95s Calculating upgrade... 95s Calculating upgrade... 95s The following packages were automatically installed and are no longer required: 95s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 95s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 95s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 95s linux-tools-6.11.0-8-generic 95s Use 'sudo apt autoremove' to remove them. 95s The following packages will be upgraded: 95s pinentry-curses python3-jinja2 strace 95s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 95s Need to get 652 kB of archives. 95s After this operation, 27.6 kB of additional disk space will be used. 95s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 95s lsb_release --codename --short 95s + RELEASE=plucky 95s + cat 95s + [ plucky != trusty ] 95s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 95s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 95s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 96s Fetched 652 kB in 1s (571 kB/s) 96s (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.) 96s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 96s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 96s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 96s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 96s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 96s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 96s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 96s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 96s Setting up strace (6.13+ds-1ubuntu1) ... 96s Processing triggers for man-db (2.13.0-1) ... 96s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 96s + /usr/lib/apt/apt-helper analyze-pattern ?true 96s + uname -r 96s + sed s/\./\\./g 96s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 96s + apt list ?obsolete 97s + + tail -n+2 97s cut -d/ -f1 97s + grep -v ^linux-.*6\.14\.0-10-generic.* 97s + obsolete_pkgs=linux-headers-6.11.0-8-generic 97s linux-headers-6.11.0-8 97s linux-modules-6.11.0-8-generic 97s linux-tools-6.11.0-8-generic 97s linux-tools-6.11.0-8 97s + 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 97s Reading package lists... 97s Building dependency tree... 97s Reading state information... 97s Solving dependencies... 97s The following packages will be REMOVED: 97s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 97s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 97s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 97s linux-tools-6.11.0-8-generic* 97s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 97s After this operation, 167 MB disk space will be freed. 97s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81428 files and directories currently installed.) 97s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 97s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 97s Removing libpython3.12t64:s390x (3.12.9-1) ... 97s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 97s Removing libnsl2:s390x (1.3.0-3build3) ... 97s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 97s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 97s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 98s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 98s Processing triggers for libc-bin (2.41-1ubuntu1) ... 98s (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.) 98s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 98s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 98s + grep -q trusty /etc/lsb-release 98s + [ ! -d /usr/share/doc/unattended-upgrades ] 98s + [ ! -d /usr/share/doc/lxd ] 98s + [ ! -d /usr/share/doc/lxd-client ] 98s + [ ! -d /usr/share/doc/snapd ] 98s + type iptables 98s + cat 98s + chmod 755 /etc/rc.local 98s + . /etc/rc.local 98s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 98s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 98s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 98s + uname -m 98s + [ s390x = ppc64le ] 98s + [ -d /run/systemd/system ] 98s + systemd-detect-virt --quiet --vm 98s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 98s + cat 98s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 98s + echo COMPRESS=lz4 98s autopkgtest [16:28:09]: upgrading testbed (apt dist-upgrade and autopurge) 99s Reading package lists... 99s Building dependency tree... 99s Reading state information... 99s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 99s Starting 2 pkgProblemResolver with broken count: 0 99s Done 99s Entering ResolveByKeep 99s 99s Calculating upgrade... 99s The following packages will be upgraded: 99s libc-bin libc-dev-bin libc6 libc6-dev locales 100s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 100s Need to get 9512 kB of archives. 100s After this operation, 8192 B of additional disk space will be used. 100s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 102s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 102s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 105s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 106s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 111s Preconfiguring packages ... 111s Fetched 9512 kB in 11s (859 kB/s) 111s (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.) 111s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 111s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 111s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 111s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 111s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 111s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 111s Setting up libc6:s390x (2.41-1ubuntu2) ... 111s (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.) 111s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 111s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 111s Setting up libc-bin (2.41-1ubuntu2) ... 111s (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.) 111s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 111s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 111s Setting up locales (2.41-1ubuntu2) ... 112s Generating locales (this might take a while)... 112s en_US.UTF-8... done 112s Generation complete. 112s Setting up libc-dev-bin (2.41-1ubuntu2) ... 112s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 112s Processing triggers for man-db (2.13.0-1) ... 113s Processing triggers for systemd (257.3-1ubuntu3) ... 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 114s Solving dependencies... 115s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s autopkgtest [16:28:26]: rebooting testbed after setup commands that affected boot 133s autopkgtest [16:28:44]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 135s autopkgtest [16:28:46]: @@@@@@@@@@@@@@@@@@@@ apt-source ots 138s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (dsc) [1989 B] 138s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (tar) [371 kB] 138s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (diff) [7544 B] 138s gpgv: Signature made Sat Mar 16 14:41:15 2024 UTC 138s gpgv: using RSA key A2520FEA0A8670A661DD8C553362F7031A4992E1 138s gpgv: Can't check signature: No public key 138s dpkg-source: warning: cannot verify inline signature for ./ots_0.5.0-9.dsc: no acceptable signature found 138s autopkgtest [16:28:49]: testing package ots version 0.5.0-9 139s autopkgtest [16:28:50]: build not needed 141s autopkgtest [16:28:52]: test command1: preparing testbed 141s Reading package lists... 141s Building dependency tree... 141s Reading state information... 141s Starting pkgProblemResolver with broken count: 0 141s Starting 2 pkgProblemResolver with broken count: 0 141s Done 141s The following NEW packages will be installed: 141s libots-dev libots0 ots 142s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 142s Need to get 53.5 kB of archives. 142s After this operation, 295 kB of additional disk space will be used. 142s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x libots0 s390x 0.5.0-9 [37.2 kB] 142s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x libots-dev s390x 0.5.0-9 [10.2 kB] 142s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x ots s390x 0.5.0-9 [5976 B] 142s Fetched 53.5 kB in 0s (150 kB/s) 142s Selecting previously unselected package libots0:s390x. 142s (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.) 142s Preparing to unpack .../libots0_0.5.0-9_s390x.deb ... 142s Unpacking libots0:s390x (0.5.0-9) ... 142s Selecting previously unselected package libots-dev:s390x. 142s Preparing to unpack .../libots-dev_0.5.0-9_s390x.deb ... 142s Unpacking libots-dev:s390x (0.5.0-9) ... 142s Selecting previously unselected package ots. 142s Preparing to unpack .../archives/ots_0.5.0-9_s390x.deb ... 142s Unpacking ots (0.5.0-9) ... 142s Setting up libots0:s390x (0.5.0-9) ... 142s Setting up libots-dev:s390x (0.5.0-9) ... 142s Setting up ots (0.5.0-9) ... 142s Processing triggers for libc-bin (2.41-1ubuntu2) ... 142s Processing triggers for man-db (2.13.0-1) ... 144s autopkgtest [16:28:55]: test command1: ots -v | grep ots 144s autopkgtest [16:28:55]: test command1: [----------------------- 144s ots 0.4.2 145s autopkgtest [16:28:56]: test command1: -----------------------] 145s autopkgtest [16:28:56]: test command1: - - - - - - - - - - results - - - - - - - - - - 145s command1 PASS (superficial) 146s autopkgtest [16:28:57]: test command2: preparing testbed 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 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 148s autopkgtest [16:28:59]: test command2: cp articles/linus1.txt $AUTOPKGTEST_TMP; cd $AUTOPKGTEST_TMP; ots -a linus1.txt 148s autopkgtest [16:28:59]: test command2: [----------------------- 148s Article talks about "sign,kernel,key,binary," 149s autopkgtest [16:29:00]: test command2: -----------------------] 149s autopkgtest [16:29:00]: test command2: - - - - - - - - - - results - - - - - - - - - - 149s command2 PASS 150s autopkgtest [16:29:01]: test command3: preparing testbed 150s Reading package lists... 150s Building dependency tree... 150s Reading state information... 150s Starting pkgProblemResolver with broken count: 0 150s Starting 2 pkgProblemResolver with broken count: 0 150s Done 150s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 152s autopkgtest [16:29:03]: test command3: cp articles/washingtonpost1.txt $AUTOPKGTEST_TMP; cd $AUTOPKGTEST_TMP; ots --ratio 40 --html --out=washpost1.html washingtonpost1.txt; file --mime-type washpost1.html | grep 'text/html' 152s autopkgtest [16:29:03]: test command3: [----------------------- 152s washpost1.html: text/html 152s autopkgtest [16:29:03]: test command3: -----------------------] 153s command3 PASSautopkgtest [16:29:04]: test command3: - - - - - - - - - - results - - - - - - - - - - 153s 153s autopkgtest [16:29:04]: @@@@@@@@@@@@@@@@@@@@ summary 153s command1 PASS (superficial) 153s command2 PASS 153s command3 PASS 159s nova [W] Using flock in prodstack6-s390x 159s Creating nova instance adt-plucky-s390x-ots-20250315-162630-juju-7f2275-prod-proposed-migration-environment-15-cd43e54d-1902-4a6f-9f2f-37bfa089ca42 from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 159s nova [W] Timed out waiting for aa5cdf94-cc00-4d7c-8f67-e8ff03481be9 to get deleted.