0s autopkgtest [05:18:39]: starting date and time: 2025-02-22 05:18:39+0000 0s autopkgtest [05:18:39]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [05:18:39]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.harwa66e/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glib2.0 --apt-upgrade ots --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glib2.0/2.83.4-1 -- 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-ots-20250222-051117-juju-7f2275-prod-proposed-migration-environment-15-42af4e0b-d76b-4297-9ac2-dad191971a7c --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/ 107s autopkgtest [05:20:26]: testbed dpkg architecture: s390x 107s autopkgtest [05:20:26]: testbed apt version: 2.9.30ubuntu1 107s autopkgtest [05:20:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 107s autopkgtest [05:20:26]: testbed release detected to be: None 108s autopkgtest [05:20:27]: updating testbed package index (apt update) 108s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 108s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 109s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 109s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 109s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [508 kB] 109s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 109s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.5 kB] 109s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [80.1 kB] 109s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [123 kB] 109s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 109s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [423 kB] 109s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [2816 B] 109s Fetched 1265 kB in 1s (1453 kB/s) 110s Reading package lists... 110s + lsb_release --codename --short 110s + RELEASE=plucky 110s + cat 110s + [ plucky != trusty ] 110s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 111s Calculating upgrade... 111s Calculating upgrade... 111s The following packages were automatically installed and are no longer required: 111s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 111s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 111s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 111s linux-tools-6.11.0-8-generic 111s Use 'sudo apt autoremove' to remove them. 111s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 111s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 111s + /usr/lib/apt/apt-helper analyze-pattern ?true 111s + sed s/\./\\./g 111s + uname -r 111s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 111s + apt list ?obsolete 111s + tail -n+2 111s + cut -d/ -f1 111s + grep -v ^linux-.*6\.12\.0-15-generic.* 111s + true 111s + obsolete_pkgs= 111s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 111s Reading package lists... 111s Building dependency tree... 111s Reading state information... 111s Solving dependencies... 111s The following packages will be REMOVED: 111s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 111s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 111s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 111s linux-tools-6.11.0-8-generic* 112s 0 upgraded, 0 newly installed, 9 to remove and 3 not upgraded. 112s After this operation, 167 MB disk space will be freed. 112s (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 ... 81030 files and directories currently installed.) 112s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 112s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 112s Removing libpython3.12t64:s390x (3.12.9-1) ... 112s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 112s Removing libnsl2:s390x (1.3.0-3build3) ... 112s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 112s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 112s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 113s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 113s Processing triggers for libc-bin (2.40-4ubuntu1) ... 113s (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 ... 55930 files and directories currently installed.) 113s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 113s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 113s + grep -q trusty /etc/lsb-release 113s + [ ! -d /usr/share/doc/unattended-upgrades ] 113s + [ ! -d /usr/share/doc/lxd ] 113s + [ ! -d /usr/share/doc/lxd-client ] 113s + [ ! -d /usr/share/doc/snapd ] 113s + type iptables 113s + cat 113s + chmod 755 /etc/rc.local 113s + . /etc/rc.local 113s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 113s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 113s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 113s + uname -m 113s + [ s390x = ppc64le ] 113s + [ -d /run/systemd/system ] 113s + systemd-detect-virt --quiet --vm 113s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 113s + cat 113s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 113s + echo COMPRESS=lz4 113s autopkgtest [05:20:32]: upgrading testbed (apt dist-upgrade and autopurge) 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 114s Entering ResolveByKeep 114s 114s Calculating upgrade... 115s The following packages will be upgraded: 115s gir1.2-glib-2.0 libglib2.0-0t64 libglib2.0-data 115s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s Need to get 1819 kB of archives. 115s After this operation, 1024 B disk space will be freed. 115s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x gir1.2-glib-2.0 s390x 2.83.4-1 [182 kB] 115s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libglib2.0-0t64 s390x 2.83.4-1 [1584 kB] 115s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libglib2.0-data all 2.83.4-1 [52.9 kB] 115s Fetched 1819 kB in 1s (2857 kB/s) 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 ... 55928 files and directories currently installed.) 115s Preparing to unpack .../gir1.2-glib-2.0_2.83.4-1_s390x.deb ... 115s Unpacking gir1.2-glib-2.0:s390x (2.83.4-1) over (2.83.3-2) ... 115s Preparing to unpack .../libglib2.0-0t64_2.83.4-1_s390x.deb ... 115s Unpacking libglib2.0-0t64:s390x (2.83.4-1) over (2.83.3-2) ... 115s Preparing to unpack .../libglib2.0-data_2.83.4-1_all.deb ... 115s Unpacking libglib2.0-data (2.83.4-1) over (2.83.3-2) ... 115s Setting up libglib2.0-0t64:s390x (2.83.4-1) ... 115s No schema files found: doing nothing. 115s Setting up libglib2.0-data (2.83.4-1) ... 115s Setting up gir1.2-glib-2.0:s390x (2.83.4-1) ... 115s Processing triggers for libc-bin (2.40-4ubuntu1) ... 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Starting pkgProblemResolver with broken count: 0 116s Starting 2 pkgProblemResolver with broken count: 0 116s Done 116s Solving dependencies... 116s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s autopkgtest [05:20:36]: rebooting testbed after setup commands that affected boot 138s autopkgtest [05:20:57]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 140s autopkgtest [05:20:59]: @@@@@@@@@@@@@@@@@@@@ apt-source ots 143s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (dsc) [1989 B] 143s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (tar) [371 kB] 143s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ots 0.5.0-9 (diff) [7544 B] 143s gpgv: Signature made Sat Mar 16 14:41:15 2024 UTC 143s gpgv: using RSA key A2520FEA0A8670A661DD8C553362F7031A4992E1 143s gpgv: Can't check signature: No public key 143s dpkg-source: warning: cannot verify inline signature for ./ots_0.5.0-9.dsc: no acceptable signature found 143s autopkgtest [05:21:02]: testing package ots version 0.5.0-9 144s autopkgtest [05:21:03]: build not needed 145s autopkgtest [05:21:04]: test command1: preparing testbed 145s Reading package lists... 145s Building dependency tree... 145s Reading state information... 146s Starting pkgProblemResolver with broken count: 0 146s Starting 2 pkgProblemResolver with broken count: 0 146s Done 146s The following NEW packages will be installed: 146s libots-dev libots0 ots 146s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 146s Need to get 53.5 kB of archives. 146s After this operation, 295 kB of additional disk space will be used. 146s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x libots0 s390x 0.5.0-9 [37.2 kB] 146s Get:2 http://ftpmaster.internal/ubuntu plucky/universe s390x libots-dev s390x 0.5.0-9 [10.2 kB] 146s Get:3 http://ftpmaster.internal/ubuntu plucky/universe s390x ots s390x 0.5.0-9 [5976 B] 146s Fetched 53.5 kB in 0s (165 kB/s) 146s Selecting previously unselected package libots0:s390x. 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 ... 55928 files and directories currently installed.) 146s Preparing to unpack .../libots0_0.5.0-9_s390x.deb ... 146s Unpacking libots0:s390x (0.5.0-9) ... 146s Selecting previously unselected package libots-dev:s390x. 146s Preparing to unpack .../libots-dev_0.5.0-9_s390x.deb ... 146s Unpacking libots-dev:s390x (0.5.0-9) ... 147s Selecting previously unselected package ots. 147s Preparing to unpack .../archives/ots_0.5.0-9_s390x.deb ... 147s Unpacking ots (0.5.0-9) ... 147s Setting up libots0:s390x (0.5.0-9) ... 147s Setting up libots-dev:s390x (0.5.0-9) ... 147s Setting up ots (0.5.0-9) ... 147s Processing triggers for libc-bin (2.40-4ubuntu1) ... 147s Processing triggers for man-db (2.13.0-1) ... 148s autopkgtest [05:21:07]: test command1: ots -v | grep ots 148s autopkgtest [05:21:07]: test command1: [----------------------- 148s ots 0.4.2 149s autopkgtest [05:21:08]: test command1: -----------------------] 149s command1 PASS (superficial) 149s autopkgtest [05:21:08]: test command1: - - - - - - - - - - results - - - - - - - - - - 150s autopkgtest [05:21:09]: test command2: 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 [05:21:11]: test command2: cp articles/linus1.txt $AUTOPKGTEST_TMP; cd $AUTOPKGTEST_TMP; ots -a linus1.txt 152s autopkgtest [05:21:11]: test command2: [----------------------- 152s Article talks about "sign,kernel,key,binary," 152s autopkgtest [05:21:11]: test command2: -----------------------] 153s autopkgtest [05:21:12]: test command2: - - - - - - - - - - results - - - - - - - - - - 153s command2 PASS 153s autopkgtest [05:21:12]: test command3: preparing testbed 153s Reading package lists... 154s Building dependency tree... 154s Reading state information... 154s Starting pkgProblemResolver with broken count: 0 154s Starting 2 pkgProblemResolver with broken count: 0 154s Done 154s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 155s autopkgtest [05:21:14]: 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' 155s autopkgtest [05:21:14]: test command3: [----------------------- 155s washpost1.html: text/html 156s autopkgtest [05:21:15]: test command3: -----------------------] 156s command3 PASS 156s autopkgtest [05:21:15]: test command3: - - - - - - - - - - results - - - - - - - - - - 156s autopkgtest [05:21:15]: @@@@@@@@@@@@@@@@@@@@ summary 156s command1 PASS (superficial) 156s command2 PASS 156s command3 PASS 173s nova [W] Using flock in prodstack6-s390x 173s flock: timeout while waiting to get lock 173s Creating nova instance adt-plucky-s390x-ots-20250222-051117-juju-7f2275-prod-proposed-migration-environment-15-42af4e0b-d76b-4297-9ac2-dad191971a7c from image adt/ubuntu-plucky-s390x-server-20250222.img (UUID ae633cda-0dee-481c-9805-d0ef3f3b5166)... 173s nova [W] Timed out waiting for 2df4c92e-fd9a-40e5-bcf6-93d66e2e959c to get deleted.