0s autopkgtest: DBG: testbed init 0s autopkgtest [12:59:38]: starting date and time: 2025-02-19 12:59:38+0000 0s autopkgtest [12:59:38]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [12:59:38]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.r88535kh/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sphinx --apt-upgrade simplejson --debug --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-30.secgroup --name adt-plucky-s390x-simplejson-20250219-125938-juju-7f2275-prod-proposed-migration-environment-15-7fc92051-4330-4589-bda6-139ed30ce40e --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/ 0s autopkgtest: DBG: got reply from testbed: ok 0s autopkgtest: DBG: testbed open, scratch=None 0s autopkgtest: DBG: sending command to testbed: open 112s autopkgtest: DBG: got reply from testbed: ok /tmp/autopkgtest.5GWNq1 112s autopkgtest: DBG: sending command to testbed: print-execute-command 112s autopkgtest: DBG: got reply from testbed: ok /tmp/autopkgtest-ssh.fzgjvrxl/runcmd 112s autopkgtest: DBG: sending command to testbed: capabilities 112s autopkgtest: DBG: got reply from testbed: ok revert revert-full-system isolation-machine reboot suggested-normal-user=ubuntu root-on-testbed 112s autopkgtest: DBG: testbed capabilities: ['revert', 'revert-full-system', 'isolation-machine', 'reboot', 'suggested-normal-user=ubuntu', 'root-on-testbed', 'has_internet'] 112s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.5GWNq1'], kind short, sout raw, serr pipe, env [] 112s autopkgtest: DBG: testbed command exited with code 0 112s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/wrapper.sh /tmp/autopkgtest.5GWNq1/wrapper.sh 112s autopkgtest: DBG: got reply from testbed: ok 112s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.5GWNq1/wrapper.sh'], kind short, sout raw, serr pipe, env [] 112s autopkgtest: DBG: testbed command exited with code 0 112s autopkgtest: DBG: testbed command ['dpkg', '--print-architecture'], kind short, sout pipe, serr pipe, env [] 112s autopkgtest: DBG: testbed command exited with code 0 112s autopkgtest [13:01:30]: testbed dpkg architecture: s390x 112s autopkgtest: DBG: testbed command ['dpkg-query', '-W', '-f', '${Version}', 'apt'], kind short, sout pipe, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest [13:01:31]: testbed apt version: 2.9.30 113s autopkgtest: DBG: testbed command ['sh', '-ec', 'command -v eatmydata'], kind short, sout pipe, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest: DBG: testbed has eatmydata 113s autopkgtest: DBG: testbed command ['mkdir', '-p', '/etc/apt/preferences.d'], kind short, sout raw, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest [13:01:31]: @@@@@@@@@@@@@@@@@@@@ test bed setup 113s autopkgtest: DBG: testbed command ['sh', '-ec', '#!/bin/sh\n# Copyright © 2006-2018 Canonical Ltd.\n# Copyright © 2015-2017 Martin Pitt\n# Copyright © 2017 Steve Langasek\n# Copyright © 2017-2022 Paul Gevers\n# Copyright © 2018 Simon McVittie\n# SPDX-License-Identifier: GPL-2.0-or-later\n\n# This script returns the first suite found in apt sources. We can\'t just rely\n# on /etc/os-release because it doesn\'t allow to distinguish between Debian\n# unstable and testing.\n#\n# This release detection logic should be kept in sync with similar code in the\n# setup-testbed script.\n#\n# For more information on APT data sources see sources.list(5).\n\n# Usage $0\n\nset -eux\n\ndistro=UNKNOWN\nif [ -r /etc/os-release ]; then\n # shellcheck disable=SC1091\n distro=$(. /etc/os-release && echo "${ID:-$distro}")\nfi\n\n# Try guessing the default release from deb822-style format sources.\n#\n# While not mandatory, APT upstream expects distros to follow the\n# .sources naming pattern for the default deb822 sources.\napt_sources="/etc/apt/sources.list.d/$distro.sources"\nif [ -r "$apt_sources" ]; then\n release=$(sed -En \'s/^Suites:\\s*(\\w+).*/\\1/Ip\' "$apt_sources" | head -n1)\n [ -n "$release" ] && echo "$release" && exit\nfi\n\n# Try guessing the default release from one-line-style format sources.\napt_sources=/etc/apt/sources.list\nif [ -r "$apt_sources" ]; then\n release=$(sed -En \'/^(deb|deb-src) +(\\[.*\\] *)?(http|https|file):/ { s/\\[.*\\] +//; s/^[^ ]+ +[^ ]* +([^ ]+) +.*$/\\1/p }\' "$apt_sources" | head -n1)\n [ -n "$release" ] && echo "$release" && exit\nfi\n\n# Could not guess the default release\necho "Could not guess the default release from the APT sources." >&2\nexit 1\n'], kind short, sout pipe, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest [13:01:31]: testbed release detected to be: None 113s autopkgtest: DBG: testbed command ['sh', '-ec', '#!/bin/sh\n# SPDX-License-Identifier: GPL-2.0-or-later\n\n# This script returns the list of configured "deb" sources in one-line-style\n# source lists (/etc/apt/sources.list, /etc/apt/sources.list.d/*.list).\n# See sources.list(5) for more information on the APT source list formats.\n#\n# This script takes no arguments.\n\nset -eu\n\n# grep(1) returns 1 if no lines were selected from the input files, which\n# can happen if there are .list files, but they contain no "deb" entries.\n# We don\'t want to fail in this case, hence the "|| true", which we put\n# in a subshell because we want it to affect only the grep invocation.\n{\n if [ -f /etc/apt/sources.list ]; then\n printf \'%s\\0\' /etc/apt/sources.list\n fi\n if [ -d /etc/apt/sources.list.d ]; then\n find /etc/apt/sources.list.d -maxdepth 1 -type f -regex \'.*/[a-zA-Z0-9_.-]+\\.list\' -print0 \\\n | LC_ALL=C sort --zero-terminated\n fi\n} | xargs -0 --no-run-if-empty -- sh -c \'grep -h "^deb " "$@" || true\' "$(basename "$0")"\n'], kind short, sout pipe, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest: DBG: testbed command ['sh', '-ec', '#!/bin/sh\n# SPDX-License-Identifier: GPL-2.0-or-later\n\n# This script returns the list of configured sources in deb822-style source\n# lists (/etc/apt/sources.list.d/*.sources). Sources are not stripped out of\n# comments, extra blank lines or similar: the output of this script is meant to\n# be consumed by a deb822 parser that is able to correctly handle those.\n# See sources.list(5) for more information on the APT source list formats.\n#\n# This script takes no arguments.\n\nset -eu\n\n# Awk concatenates files making sure stanzas from separate files are separated\n# by a blank line, even if there are no newlines at EOF in the .sources files.\nif [ -d /etc/apt/sources.list.d ]; then\n find /etc/apt/sources.list.d -maxdepth 1 -type f -regex \'.*/[a-zA-Z0-9_.-]+\\.sources\' -print0 \\\n | LC_ALL=C sort --zero-terminated \\\n | xargs -0 --no-run-if-empty -- awk \'FNR == 1 && NR != 1 { print "" } { print }\'\nfi\n'], kind short, sout pipe, serr pipe, env [] 113s autopkgtest: DBG: testbed command exited with code 0 113s autopkgtest: DBG: adding APT source: Types: deb deb-src 113s URIs: http://ftpmaster.internal/ubuntu/ 113s Suites: plucky-proposed 113s Components: main restricted universe multiverse 113s Signed-By: /usr/share/keyrings/ubuntu-archive-keyring.gpg 113s autopkgtest: DBG: testbed command ['sh', '-ec', '"$@" >> "/etc/apt/sources.list.d/autopkgtest-add-apt-release-plucky-proposed.sources"', 'add_apt_source', 'printf', '%s\\n', 'Types: deb deb-src\nURIs: http://ftpmaster.internal/ubuntu/\nSuites: plucky-proposed\nComponents: main restricted universe multiverse\nSigned-By: /usr/share/keyrings/ubuntu-archive-keyring.gpg\n'], kind short, sout raw, serr pipe, env [] 114s autopkgtest: DBG: testbed command exited with code 0 114s autopkgtest: DBG: adding APT preference to autopkgtest-zz-plucky-proposed-baseline.pref: 114s Package: * 114s Pin: release plucky-proposed 114s Pin-Priority: 500 114s autopkgtest: DBG: testbed command ['sh', '-ec', '"$@" > "/etc/apt/preferences.d/autopkgtest-zz-plucky-proposed-baseline.pref"', 'add_apt_preference', 'printf', '%s\\n', 'Package: *\nPin: release plucky-proposed\nPin-Priority: 500'], kind short, sout raw, serr pipe, env [] 114s autopkgtest: DBG: testbed command exited with code 0 114s autopkgtest [13:01:32]: updating testbed package index (apt update) 114s autopkgtest: DBG: testbed command ['/bin/sh', '-ec', '"$@" 3>&2 2>&1', 'run_apt_command', '/usr/bin/eatmydata', 'apt-get', '--quiet', '--assume-yes', '-o=APT::Status-Fd=3', '-o=APT::Install-Recommends=false', '-o=Dpkg::Options::=--force-confnew', '-o=Debug::pkgProblemResolver=true', 'update'], kind install, sout raw, serr pipe, env ['DEBIAN_FRONTEND=noninteractive', 'APT_LISTBUGS_FRONTEND=none', 'APT_LISTCHANGES_FRONTEND=none'] 114s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 114s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 114s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 115s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 115s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.1 kB] 115s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B] 115s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [750 kB] 115s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.9 kB] 115s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [95.1 kB] 115s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B] 115s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [646 kB] 115s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [4900 B] 115s Fetched 1700 kB in 1s (1761 kB/s) 116s Reading package lists... 116s autopkgtest: DBG: testbed command exited with code 0 116s autopkgtest: DBG: adding APT preference to autopkgtest-plucky-proposed.pref: 116s Package: * 116s Pin: release plucky-proposed 116s Pin-Priority: 100 116s 116s Package: src:sphinx:any 116s Pin: release plucky-proposed 116s Pin-Priority: 995 116s autopkgtest: DBG: testbed command ['sh', '-ec', '"$@" > "/etc/apt/preferences.d/autopkgtest-plucky-proposed.pref"', 'add_apt_preference', 'printf', '%s\\n', 'Package: *\nPin: release plucky-proposed\nPin-Priority: 100\n\nPackage: src:sphinx:any\nPin: release plucky-proposed\nPin-Priority: 995'], kind short, sout raw, serr pipe, env [] 116s autopkgtest: DBG: testbed command exited with code 0 116s autopkgtest: DBG: testbed command ['bash', '-ec', 'for d in /boot /boot/efi /boot/grub /etc/init /etc/init.d /etc/systemd/system /lib/systemd/system; do [ ! -d $d ] || touch -r $d /tmp/autopkgtest.5GWNq1/${d//\\//_}.stamp; done'], kind short, sout raw, serr pipe, env [] 116s autopkgtest: DBG: testbed command exited with code 0 116s autopkgtest: DBG: testbed command ['sh', '-ec', '#!/bin/sh\n# Canonical/Ubuntu specific testbed setup\n\nset -x\n\nRELEASE=$(lsb_release --codename --short 2>/dev/null)\n\n# Make the installed package versions match what is available from the configured\n# repositories, even if a downgrade is required.\n#\n# We may end up with images with packages newer than those available from the\n# repositories when opening a new release (images are created using the\n# previous release dailies as a base, which may include 0-day SRUs, or\n# Launchpad may fail to copy packages, see openssl 3.0.8-1ubuntu2), or when\n# package versions are pulled from the archive.\n#\n# Note: \'release a=\' matches the Suite field in the repository Release file.\ncat >/etc/apt/preferences.d/force-downgrade-to-release.pref <= Focal).\n#\n# Note: autoremove/--autoremove always runs on the entire set of installed\n# packages. Together with --autopurge/purge each removal becomes a purge.\n#\n# Removing \'?obsolete\' packages may remove the running kernel. This is not\n# expected to be an issue.\nif /usr/lib/apt/apt-helper analyze-pattern \'?true\' >/dev/null 2>&1; then\n # DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove \'?obsolete\'\n # Avoid removing the running kernel\n running_kernel_pattern="^linux-.*$(uname -r | sed \'s/\\./\\\\./g\').*"\n obsolete_pkgs="$(apt list \'?obsolete\' 2>/dev/null \\\n | tail -n+2 \\\n | cut -d\'/\' -f1 \\\n | grep -v "${running_kernel_pattern}" || true)"\n DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove ${obsolete_pkgs}\nelse\n # We\'re on an older release (analyze-pattern is not available).\n # Still do an autopurge to get rid of packages that got orphaned\n # by downgrades.\n eatmydata apt-get -y autoremove --purge\nfi\n\n# compatibility with old Jenkins testbeds for trusty\nif grep -q trusty /etc/lsb-release; then apt-get update || (sleep 10; apt-get update); apt-get install -y build-essential; fi\n\n# these packages really break tests, purge them if we use standard cloud images\n# (on lcy01)\nfor p in unattended-upgrades lxd lxd-client snapd; do\n [ ! -d /usr/share/doc/$p ] || $(which eatmydata || true) apt-get purge --auto-remove -y $p\ndone\n\nif type iptables >/dev/null 2>&1; then\n cat < /etc/rc.local\n#!/bin/sh\n\n# work around broken PTMU; LP: #1572026, RT#90771\niptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu || true\n\n# These addresses are used at least by rust-reqwest and should not be reachable\n# See https://bugs.launchpad.net/ubuntu/+source/rust-reqwest/+bug/2080346\niptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP || true\niptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP || true\nEOF\n chmod 755 /etc/rc.local\n # shellcheck disable=SC1091\n . /etc/rc.local\nfi\n\n# work around broken tty on ppc64el instances (LP: #1607075)\nif [ "$(uname -m)" = ppc64le ] && [ "$(systemctl is-active keyboard-setup.service 2>/dev/null|| true)" = failed ]; then\n systemctl reset-failed keyboard-setup.service\n systemctl mask keyboard-setup.service\nfi\n\n# work around late urandom pool initialization (LP: #1622893)\nif [ -d /run/systemd/system ] && systemd-detect-virt --quiet --vm; then\n mkdir -p /etc/systemd/system/systemd-random-seed.service.d/\n cat < /etc/systemd/system/systemd-random-seed.service.d/fakeentropy.conf\n[Service]\nExecStart=/usr/bin/perl -E \'open \\$\\$f, "/bin/bash" or die; open \\$\\$rnd, ">/dev/random" or die; for (\\$\\$i = 0; \\$\\$i < 10; ++\\$\\$i) {read \\$\\$f, \\$\\$d, 64; ioctl \\$\\$rnd, 0x40085203, pack("ii", 64*8, 64) . \\$\\$d}\'\nEOF\nfi\n\n# set compressor to lz4 where supported, we care about compression speed\nif grep -q lz4 /etc/initramfs-tools/initramfs.conf; then\n echo COMPRESS=lz4 > /etc/initramfs-tools/conf.d/lz4\nfi'], kind install, sout raw, serr raw, env ['AUTOPKGTEST_IS_SETUP_COMMAND=1', 'AUTOPKGTEST_NORMAL_USER=ubuntu', 'ADT_NORMAL_USER=ubuntu'] 116s + lsb_release --codename --short 116s + RELEASE=plucky 116s + cat 116s + [ plucky != trusty ] 116s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 116s Reading package lists... 116s Building dependency tree... 116s Reading state information... 116s Calculating upgrade... 117s The following packages were automatically installed and are no longer required: 117s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 117s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 117s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 117s linux-tools-6.11.0-8-generic 117s Use 'sudo apt autoremove' to remove them. 117s The following packages will be upgraded: 117s iproute2 liblsof0 libp11-kit0 lsof 117s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Need to get 1791 kB of archives. 117s After this operation, 17.4 kB of additional disk space will be used. 117s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x iproute2 s390x 6.13.0-1ubuntu1 [1174 kB] 117s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libp11-kit0 s390x 0.25.5-2ubuntu3 [316 kB] 117s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x lsof s390x 4.99.4+dfsg-1 [243 kB] 117s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x liblsof0 s390x 4.99.4+dfsg-1 [58.5 kB] 117s Preconfiguring packages ... 118s Fetched 1791 kB in 1s (2823 kB/s) 118s (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.) 118s Preparing to unpack .../iproute2_6.13.0-1ubuntu1_s390x.deb ... 118s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ... 118s Preparing to unpack .../libp11-kit0_0.25.5-2ubuntu3_s390x.deb ... 118s Unpacking libp11-kit0:s390x (0.25.5-2ubuntu3) over (0.25.5-2ubuntu2) ... 118s Preparing to unpack .../lsof_4.99.4+dfsg-1_s390x.deb ... 118s Unpacking lsof (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 118s Preparing to unpack .../liblsof0_4.99.4+dfsg-1_s390x.deb ... 118s Unpacking liblsof0 (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ... 118s Setting up liblsof0 (4.99.4+dfsg-1) ... 118s Setting up iproute2 (6.13.0-1ubuntu1) ... 118s Setting up libp11-kit0:s390x (0.25.5-2ubuntu3) ... 118s Setting up lsof (4.99.4+dfsg-1) ... 118s Processing triggers for man-db (2.13.0-1) ... 118s Processing triggers for libc-bin (2.40-4ubuntu1) ... 119s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 119s + /usr/lib/apt/apt-helper analyze-pattern ?true 119s + uname -r 119s + sed s/\./\\./g 119s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.* 119s + apt list ?obsolete 119s + + cut -d/ -f1 119s tail -n+2 119s + grep -v ^linux-.*6\.12\.0-15-generic.* 119s + true 119s + obsolete_pkgs= 119s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s The following packages will be REMOVED: 119s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 119s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 119s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 119s linux-tools-6.11.0-8-generic* 119s 0 upgraded, 0 newly installed, 9 to remove and 0 not upgraded. 119s After this operation, 167 MB disk space will be freed. 119s (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 ... 81031 files and directories currently installed.) 119s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 119s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 119s Removing libpython3.12t64:s390x (3.12.9-1) ... 119s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 119s Removing libnsl2:s390x (1.3.0-3build3) ... 119s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 119s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 120s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 120s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 121s Processing triggers for libc-bin (2.40-4ubuntu1) ... 121s (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 ... 55931 files and directories currently installed.) 121s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 121s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 121s + grep -q trusty /etc/lsb-release 121s + [ ! -d /usr/share/doc/unattended-upgrades ] 121s + [ ! -d /usr/share/doc/lxd ] 121s + [ ! -d /usr/share/doc/lxd-client ] 121s + [ ! -d /usr/share/doc/snapd ] 121s + type iptables 121s + cat 121s + chmod 755 /etc/rc.local 121s + . /etc/rc.local 121s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 121s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 121s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 121s + uname -m 121s + [ s390x = ppc64le ] 121s + [ -d /run/systemd/system ] 121s + systemd-detect-virt --quiet --vm 121s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 121s + cat 121s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 121s + echo COMPRESS=lz4 121s autopkgtest: DBG: testbed command exited with code 0 121s autopkgtest [13:01:39]: upgrading testbed (apt dist-upgrade and autopurge) 121s autopkgtest: DBG: testbed command ['/bin/sh', '-ec', '"$@" 3>&2 2>&1', 'run_apt_command', '/usr/bin/eatmydata', 'apt-get', '--quiet', '--assume-yes', '-o=APT::Status-Fd=3', '-o=APT::Install-Recommends=false', '-o=Dpkg::Options::=--force-confnew', '-o=Debug::pkgProblemResolver=true', 'dist-upgrade'], kind install, sout raw, serr pipe, env ['DEBIAN_FRONTEND=noninteractive', 'APT_LISTBUGS_FRONTEND=none', 'APT_LISTCHANGES_FRONTEND=none'] 121s Reading package lists... 121s Building dependency tree... 121s Reading state information... 121s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 121s Starting 2 pkgProblemResolver with broken count: 0 121s Done 122s Entering ResolveByKeep 122s 122s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 122s autopkgtest: DBG: testbed command exited with code 0 122s autopkgtest: DBG: testbed command ['/bin/sh', '-ec', '"$@" 3>&2 2>&1', 'run_apt_command', '/usr/bin/eatmydata', 'apt-get', '--quiet', '--assume-yes', '-o=APT::Status-Fd=3', '-o=APT::Install-Recommends=false', '-o=Dpkg::Options::=--force-confnew', '-o=Debug::pkgProblemResolver=true', '--purge', 'autoremove'], kind install, sout raw, serr pipe, env ['DEBIAN_FRONTEND=noninteractive', 'APT_LISTBUGS_FRONTEND=none', 'APT_LISTCHANGES_FRONTEND=none'] 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Starting pkgProblemResolver with broken count: 0 122s Starting 2 pkgProblemResolver with broken count: 0 122s Done 123s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s autopkgtest: DBG: testbed command exited with code 0 123s autopkgtest: DBG: testbed command ['bash', '-ec', '[ ! -e /run/autopkgtest_no_reboot.stamp ] || exit 0;for d in /boot /boot/efi /boot/grub /etc/init /etc/init.d /etc/systemd/system /lib/systemd/system; do s=/tmp/autopkgtest.5GWNq1/${d//\\//_}.stamp; [ ! -d $d ] || [ `stat -c %Y $d` = `stat -c %Y $s` ]; done'], kind short, sout raw, serr raw, env [] 123s autopkgtest: DBG: testbed command exited with code 1 123s autopkgtest [13:01:41]: rebooting testbed after setup commands that affected boot 123s autopkgtest: DBG: sending command to testbed: reboot 139s autopkgtest: DBG: got reply from testbed: ok 139s autopkgtest: DBG: testbed supports reboot, creating /tmp/autopkgtest-reboot 139s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.5GWNq1'], kind short, sout raw, serr pipe, env [] 140s autopkgtest: DBG: testbed command exited with code 0 140s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot.sh /tmp/autopkgtest.5GWNq1/autopkgtest-reboot 140s autopkgtest: DBG: got reply from testbed: ok 140s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 140s autopkgtest: DBG: testbed command exited with code 0 140s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot', '/tmp/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 140s autopkgtest: DBG: testbed command exited with code 0 140s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot', '/sbin/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 140s autopkgtest: DBG: testbed command exited with code 0 140s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.5GWNq1'], kind short, sout raw, serr pipe, env [] 140s autopkgtest: DBG: testbed command exited with code 0 140s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot-prepare.sh /tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare 141s autopkgtest: DBG: got reply from testbed: ok 141s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env [] 141s autopkgtest: DBG: testbed command exited with code 0 141s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare', '/tmp/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env [] 141s autopkgtest: DBG: testbed command exited with code 0 141s autopkgtest: DBG: testbed command ['uname', '-srv'], kind short, sout pipe, serr pipe, env [] 141s autopkgtest: DBG: testbed command exited with code 0 141s autopkgtest [13:01:59]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb 4 15:05:57 UTC 2025 141s autopkgtest: DBG: testbed command ['sh', '-c', 'nproc; cat /proc/cpuinfo 2>/dev/null || true'], kind short, sout pipe, serr pipe, env [] 141s autopkgtest: DBG: testbed command exited with code 0 141s autopkgtest: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f '${Package}\\t${Version}\\n' > /tmp/autopkgtest.5GWNq1/testbed-packages"], kind short, sout raw, serr pipe, env [] 141s autopkgtest: DBG: testbed command exited with code 0 141s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/testbed-packages /tmp/autopkgtest-work.r88535kh/out/testbed-packages 142s autopkgtest: DBG: got reply from testbed: ok 142s autopkgtest: DBG: testbed supports reboot, creating /tmp/autopkgtest-reboot 142s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.5GWNq1'], kind short, sout raw, serr pipe, env [] 142s autopkgtest: DBG: testbed command exited with code 0 142s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot.sh /tmp/autopkgtest.5GWNq1/autopkgtest-reboot 142s autopkgtest: DBG: got reply from testbed: ok 142s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 142s autopkgtest: DBG: testbed command exited with code 0 142s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot', '/tmp/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 142s autopkgtest: DBG: testbed command exited with code 0 142s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot', '/sbin/autopkgtest-reboot'], kind short, sout raw, serr pipe, env [] 142s autopkgtest: DBG: testbed command exited with code 0 142s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.5GWNq1'], kind short, sout raw, serr pipe, env [] 143s autopkgtest: DBG: testbed command exited with code 0 143s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot-prepare.sh /tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare 143s autopkgtest: DBG: got reply from testbed: ok 143s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env [] 143s autopkgtest: DBG: testbed command exited with code 0 143s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.5GWNq1/autopkgtest-reboot-prepare', '/tmp/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env [] 143s autopkgtest: DBG: testbed command exited with code 0 143s autopkgtest: DBG: testbed command ['uname', '-srv'], kind short, sout pipe, serr pipe, env [] 143s autopkgtest: DBG: testbed command exited with code 0 143s autopkgtest: DBG: Binaries: initialising 143s autopkgtest [13:02:01]: @@@@@@@@@@@@@@@@@@@@ apt-source simplejson 143s autopkgtest: DBG: blame += simplejson 143s autopkgtest: DBG: testbed reset: modified=False, deps_installed=[], deps_new=[] 143s autopkgtest: DBG: testbed command ['apt-cache', 'showsrc', '--only-source', 'simplejson'], kind short, sout pipe, serr pipe, env [] 144s autopkgtest: DBG: testbed command exited with code 0 144s autopkgtest: DBG: testbed command ['apt-cache', 'policy', '^python-simplejson-doc$'], kind short, sout pipe, serr raw, env [] 144s autopkgtest: DBG: testbed command exited with code 0 144s autopkgtest: DBG: testbed command ['apt-cache', 'show', 'python-simplejson-doc=3.19.3-1build1'], kind short, sout pipe, serr raw, env [] 144s autopkgtest: DBG: testbed command exited with code 0 144s autopkgtest: DBG: testbed command ['apt-cache', 'policy', '^python3-simplejson$'], kind short, sout pipe, serr raw, env [] 144s autopkgtest: DBG: testbed command exited with code 0 144s autopkgtest: DBG: testbed command ['apt-cache', 'show', 'python3-simplejson=3.19.3-1build1'], kind short, sout pipe, serr raw, env [] 144s autopkgtest: DBG: testbed command exited with code 0 144s autopkgtest: DBG: install_deps: deps_new=[] 144s autopkgtest: DBG: testbed command ['sh', '-ec', 'command -v dpkg-source'], kind short, sout pipe, serr pipe, env [] 145s autopkgtest: DBG: testbed command exited with code 0 145s autopkgtest: DBG: testbed command ['sh', '-ec', 'su --shell=/bin/sh ubuntu -c \'set -e; exec 3>&1 >&2; set -x; cd /; builddir=$(mktemp -d /tmp/autopkgtest.5GWNq1/build.XXX); cd $builddir; OUT=$(apt-get source -d -q --only-source simplejson=3.19.3-1build1 2>&1) || RC=$?;if [ -n "$RC" ]; then if echo "$OUT" | grep -q "Unable to find a source package"; then exit 1; else exit $RC; fi;fi;echo "$OUT" | grep ^Get: || true;dpkg-source -x simplejson_*.dsc src >/dev/null; chmod -R a+rX .; cd [a-z0-9]*/.; pwd >&3; sed -n "1 {s/).*//; s/ (/\\n/; p}" debian/changelog >&3\''], kind build, sout pipe, serr raw, env ['ADT_TEST_TRIGGERS=sphinx/8.1.3-5'] 145s + cd / 145s + mktemp -d /tmp/autopkgtest.5GWNq1/build.XXX 145s + builddir=/tmp/autopkgtest.5GWNq1/build.7iM 145s + cd /tmp/autopkgtest.5GWNq1/build.7iM 145s + apt-get source -d -q --only-source simplejson=3.19.3-1build1 145s + OUT=Reading package lists... 145s NOTICE: 'simplejson' packaging is maintained in the 'Git' version control system at: 145s https://salsa.debian.org/python-team/packages/simplejson.git 145s Please use: 145s git clone https://salsa.debian.org/python-team/packages/simplejson.git 145s to retrieve the latest (possibly unreleased) updates to the package. 145s Need to get 94.4 kB of source archives. 145s Get:1 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (dsc) [2226 B] 145s Get:2 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (tar) [85.2 kB] 145s Get:3 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (diff) [6912 B] 145s Fetched 94.4 kB in 0s (203 kB/s) 145s Download complete and in download only mode 145s + [ -n ] 145s + + grep ^Get: 145s echo Reading package lists... 145s NOTICE: 'simplejson' packaging is maintained in the 'Git' version control system at: 145s https://salsa.debian.org/python-team/packages/simplejson.git 145s Please use: 145s git clone https://salsa.debian.org/python-team/packages/simplejson.git 145s to retrieve the latest (possibly unreleased) updates to the package. 145s Need to get 94.4 kB of source archives. 145s Get:1 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (dsc) [2226 B] 145s Get:2 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (tar) [85.2 kB] 145s Get:3 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (diff) [6912 B] 145s Fetched 94.4 kB in 0s (203 kB/s) 145s Download complete and in download only mode 145s Get:1 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (dsc) [2226 B] 145s Get:2 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (tar) [85.2 kB] 145s Get:3 http://ftpmaster.internal/ubuntu plucky/main simplejson 3.19.3-1build1 (diff) [6912 B] 145s + dpkg-source -x simplejson_3.19.3-1build1.dsc src 145s gpgv: Signature made Wed Nov 13 09:00:40 2024 UTC 145s gpgv: using RSA key 568BF22A66337CBFC9A6B9B72C83DBC8E9BD0E37 145s gpgv: Can't check signature: No public key 145s dpkg-source: warning: cannot verify inline signature for ./simplejson_3.19.3-1build1.dsc: no acceptable signature found 145s + chmod -R a+rX . 145s + cd src/. 145s + pwd 145s + sed -n 1 {s/).*//; s/ (/\n/; p} debian/changelog 145s autopkgtest: DBG: testbed command exited with code 0 145s autopkgtest [13:02:03]: testing package simplejson version 3.19.3-1build1 145s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/build.7iM/src/debian/ /tmp/autopkgtest-work.r88535kh/out/pkg/debian/ 146s autopkgtest: DBG: got reply from testbed: ok 146s autopkgtest: DBG: processing dependency python3-pytest 146s autopkgtest: DBG: processing dependency @ 146s autopkgtest: DBG: synthesised dependency python-simplejson-doc 146s autopkgtest: DBG: synthesised dependency python3-simplejson 146s autopkgtest: DBG: Test defined: name upstream-3 path debian/tests/upstream-3 command "None" restrictions [] features [] depends ['python3-pytest', 'python-simplejson-doc', 'python3-simplejson'] 146s autopkgtest [13:02:04]: build not needed 146s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/build.7iM/src/ /tmp/autopkgtest-work.r88535kh/out/tests-tree/ 146s autopkgtest: DBG: got reply from testbed: ok 146s autopkgtest: DBG: processing dependency python3-pytest 146s autopkgtest: DBG: processing dependency @ 146s autopkgtest: DBG: synthesised dependency python-simplejson-doc 146s autopkgtest: DBG: synthesised dependency python3-simplejson 146s autopkgtest: DBG: Test defined: name upstream-3 path debian/tests/upstream-3 command "None" restrictions [] features [] depends ['python3-pytest', 'python-simplejson-doc', 'python3-simplejson'] 146s autopkgtest [13:02:04]: test upstream-3: preparing testbed 146s autopkgtest: DBG: testbed reset: modified=False, deps_installed=[], deps_new=['python3-pytest', 'python-simplejson-doc', 'python3-simplejson'] 146s autopkgtest: DBG: Binaries: no registered binaries, not publishing anything 146s autopkgtest: DBG: install_deps: deps_new=['python3-pytest', 'python-simplejson-doc', 'python3-simplejson'] 146s autopkgtest: DBG: install-deps: satisfying python3-pytest, python-simplejson-doc, python3-simplejson 146s autopkgtest: DBG: can use apt-get on testbed: True 146s autopkgtest: DBG: testbed command ['/bin/sh', '-ec', '"$@" 3>&2 2>&1', 'run_apt_command', '/usr/bin/eatmydata', 'apt-get', '--quiet', '--assume-yes', '-o=APT::Status-Fd=3', '-o=APT::Install-Recommends=false', '-o=Dpkg::Options::=--force-confnew', '-o=Debug::pkgProblemResolver=true', 'satisfy', 'python3-pytest, python-simplejson-doc, python3-simplejson'], kind install, sout raw, serr pipe, env ['DEBIAN_FRONTEND=noninteractive', 'APT_LISTBUGS_FRONTEND=none', 'APT_LISTCHANGES_FRONTEND=none'] 146s Reading package lists... 147s Building dependency tree... 147s Reading state information... 147s Starting pkgProblemResolver with broken count: 0 147s Starting 2 pkgProblemResolver with broken count: 0 147s Done 147s The following NEW packages will be installed: 147s libjs-jquery libjs-sphinxdoc libjs-underscore python-simplejson-doc 147s python3-iniconfig python3-packaging python3-pluggy python3-pytest 147s python3-simplejson 147s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 147s Need to get 914 kB of archives. 147s After this operation, 3402 kB of additional disk space will be used. 147s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB] 147s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB] 147s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libjs-sphinxdoc all 8.1.3-5 [31.0 kB] 147s Get:4 http://ftpmaster.internal/ubuntu plucky/universe s390x python-simplejson-doc all 3.19.3-1build1 [51.4 kB] 147s Get:5 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-iniconfig all 1.1.1-2 [6024 B] 147s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x python3-packaging all 24.2-1 [51.5 kB] 148s Get:7 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pluggy all 1.5.0-1 [21.0 kB] 148s Get:8 http://ftpmaster.internal/ubuntu plucky/universe s390x python3-pytest all 8.3.4-1 [252 kB] 148s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x python3-simplejson s390x 3.19.3-1build1 [55.6 kB] 148s Fetched 914 kB in 1s (1562 kB/s) 148s Selecting previously unselected package libjs-jquery. 148s (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 ... 55929 files and directories currently installed.) 148s Preparing to unpack .../0-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ... 148s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 148s Selecting previously unselected package libjs-underscore. 148s Preparing to unpack .../1-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ... 148s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 148s Selecting previously unselected package libjs-sphinxdoc. 148s Preparing to unpack .../2-libjs-sphinxdoc_8.1.3-5_all.deb ... 148s Unpacking libjs-sphinxdoc (8.1.3-5) ... 148s Selecting previously unselected package python-simplejson-doc. 148s Preparing to unpack .../3-python-simplejson-doc_3.19.3-1build1_all.deb ... 148s Unpacking python-simplejson-doc (3.19.3-1build1) ... 148s Selecting previously unselected package python3-iniconfig. 148s Preparing to unpack .../4-python3-iniconfig_1.1.1-2_all.deb ... 148s Unpacking python3-iniconfig (1.1.1-2) ... 148s Selecting previously unselected package python3-packaging. 148s Preparing to unpack .../5-python3-packaging_24.2-1_all.deb ... 148s Unpacking python3-packaging (24.2-1) ... 148s Selecting previously unselected package python3-pluggy. 148s Preparing to unpack .../6-python3-pluggy_1.5.0-1_all.deb ... 148s Unpacking python3-pluggy (1.5.0-1) ... 148s Selecting previously unselected package python3-pytest. 148s Preparing to unpack .../7-python3-pytest_8.3.4-1_all.deb ... 148s Unpacking python3-pytest (8.3.4-1) ... 148s Selecting previously unselected package python3-simplejson. 148s Preparing to unpack .../8-python3-simplejson_3.19.3-1build1_s390x.deb ... 148s Unpacking python3-simplejson (3.19.3-1build1) ... 148s Setting up python3-iniconfig (1.1.1-2) ... 148s Setting up python3-simplejson (3.19.3-1build1) ... 148s Setting up python3-packaging (24.2-1) ... 148s Setting up python3-pluggy (1.5.0-1) ... 148s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ... 148s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ... 148s Setting up python3-pytest (8.3.4-1) ... 149s Setting up libjs-sphinxdoc (8.1.3-5) ... 149s Setting up python-simplejson-doc (3.19.3-1build1) ... 149s Processing triggers for man-db (2.13.0-1) ... 149s autopkgtest: DBG: testbed command exited with code 0 149s autopkgtest: DBG: testbed command ['dpkg-query', '--show', '-f', '${Status}', 'python-simplejson-doc'], kind short, sout pipe, serr pipe, env [] 149s autopkgtest: DBG: testbed command exited with code 0 149s autopkgtest: DBG: testbed command ['dpkg-query', '--show', '-f', '${Status}', 'python3-simplejson'], kind short, sout pipe, serr pipe, env [] 150s autopkgtest: DBG: testbed command exited with code 0 150s autopkgtest: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f '${Package}\\t${Version}\\n' > /tmp/autopkgtest.5GWNq1/upstream-3-packages.all"], kind short, sout raw, serr pipe, env [] 150s autopkgtest: DBG: testbed command exited with code 0 150s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/upstream-3-packages.all /tmp/autopkgtest-work.r88535kh/out/upstream-3-packages.all 150s autopkgtest: DBG: got reply from testbed: ok 150s autopkgtest: DBG: testbed command ['test', '-e', '/tmp/autopkgtest.5GWNq1/build.7iM/src'], kind short, sout raw, serr raw, env [] 150s autopkgtest: DBG: testbed command exited with code 0 150s autopkgtest: DBG: copydown: tb path /tmp/autopkgtest.5GWNq1/build.7iM/src already exists 150s autopkgtest [13:02:08]: test upstream-3: [----------------------- 150s autopkgtest: DBG: testbed command ['su', '-s', '/bin/bash', 'ubuntu', '-c', 'set -e; exec /tmp/autopkgtest.5GWNq1/wrapper.sh --debug --artifacts=/tmp/autopkgtest.5GWNq1/upstream-3-artifacts --chdir=/tmp/autopkgtest.5GWNq1/build.7iM/src --env=AUTOPKGTEST_TESTBED_ARCH=s390x --env=AUTOPKGTEST_TEST_ARCH=s390x --env=DEB_BUILD_OPTIONS=parallel=2 --env=DEBIAN_FRONTEND=noninteractive --env=LANG=C.UTF-8 --unset-env=LANGUAGE --unset-env=LC_ADDRESS --unset-env=LC_ALL --unset-env=LC_COLLATE --unset-env=LC_CTYPE --unset-env=LC_IDENTIFICATION --unset-env=LC_MEASUREMENT --unset-env=LC_MESSAGES --unset-env=LC_MONETARY --unset-env=LC_NAME --unset-env=LC_NUMERIC --unset-env=LC_PAPER --unset-env=LC_TELEPHONE --unset-env=LC_TIME --script-pid-file=/tmp/autopkgtest_script_pid --source-profile --stderr=/tmp/autopkgtest.5GWNq1/upstream-3-stderr --stdout=/tmp/autopkgtest.5GWNq1/upstream-3-stdout --tmp=/tmp/autopkgtest.5GWNq1/autopkgtest_tmp --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-5 --make-executable=/tmp/autopkgtest.5GWNq1/build.7iM/src/debian/tests/upstream-3 -- /tmp/autopkgtest.5GWNq1/build.7iM/src/debian/tests/upstream-3'], kind test, sout raw, serr raw, env [] 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: creating AUTOPKGTEST_ARTIFACTS: /tmp/autopkgtest.5GWNq1/upstream-3-artifacts 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: changing to directory: /tmp/autopkgtest.5GWNq1/build.7iM/src 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: AUTOPKGTEST_TESTBED_ARCH=s390x 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: AUTOPKGTEST_TEST_ARCH=s390x 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: DEB_BUILD_OPTIONS=parallel=2 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: DEBIAN_FRONTEND=noninteractive 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: LANG=C.UTF-8 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LANGUAGE 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_ADDRESS 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_ALL 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_COLLATE 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_CTYPE 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_IDENTIFICATION 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_MEASUREMENT 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_MESSAGES 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_MONETARY 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_NAME 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_NUMERIC 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_PAPER 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_TELEPHONE 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: unsetting environment: LC_TIME 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: will create pid file: /tmp/autopkgtest_script_pid 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: pretending to be a login shell 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: will write standard error to /tmp/autopkgtest.5GWNq1/upstream-3-stderr 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: will write stdout to /tmp/autopkgtest.5GWNq1/upstream-3-stdout 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: creating AUTOPKGTEST_TMP: /tmp/autopkgtest.5GWNq1/autopkgtest_tmp 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: setting environment: ADT_TEST_TRIGGERS=sphinx/8.1.3-5 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: marking as executable: /tmp/autopkgtest.5GWNq1/build.7iM/src/debian/tests/upstream-3 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: command to run: /tmp/autopkgtest.5GWNq1/build.7iM/src/debian/tests/upstream-3 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: copying /tmp/tmp.nT6rf4GU7B/out to stdout and file: /tmp/autopkgtest.5GWNq1/upstream-3-stdout 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: copying /tmp/tmp.nT6rf4GU7B/err to standard error and file: /tmp/autopkgtest.5GWNq1/upstream-3-stdout 150s /tmp/autopkgtest.5GWNq1/wrapper.sh: writing script pid 1436 to /tmp/autopkgtest_script_pid 150s ============================= test session starts ============================== 150s platform linux -- Python 3.13.2, pytest-8.3.4, pluggy-1.5.0 -- /usr/bin/python3 150s cachedir: .pytest_cache 150s rootdir: /tmp/autopkgtest.5GWNq1/autopkgtest_tmp 150s plugins: typeguard-4.4.1 150s collecting ... collected 143 items 150s 150s tests/test_bigint_as_string.py::TestBigintAsString::test_dict_keys PASSED 150s tests/test_bigint_as_string.py::TestBigintAsString::test_dicts PASSED 150s tests/test_bigint_as_string.py::TestBigintAsString::test_ints PASSED 150s tests/test_bigint_as_string.py::TestBigintAsString::test_lists PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_dict_keys PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_dicts PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_ints PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_ints_outside_range_fails PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_invalid_counts PASSED 150s tests/test_bitsize_int_as_string.py::TestBitSizeIntAsString::test_lists PASSED 150s tests/test_check_circular.py::TestCheckCircular::test_circular_composite PASSED 150s tests/test_check_circular.py::TestCheckCircular::test_circular_default PASSED 151s tests/test_check_circular.py::TestCheckCircular::test_circular_dict PASSED 151s tests/test_check_circular.py::TestCheckCircular::test_circular_list PASSED 151s tests/test_check_circular.py::TestCheckCircular::test_circular_off_default PASSED 151s tests/test_decimal.py::TestDecimal::test_decimal_decode PASSED 151s tests/test_decimal.py::TestDecimal::test_decimal_defaults PASSED 151s tests/test_decimal.py::TestDecimal::test_decimal_encode PASSED 151s tests/test_decimal.py::TestDecimal::test_decimal_reload PASSED 151s tests/test_decimal.py::TestDecimal::test_decimal_roundtrip PASSED 151s tests/test_decimal.py::TestDecimal::test_stringify_key PASSED 151s tests/test_decode.py::TestDecode::test_bounded_int PASSED 151s tests/test_decode.py::TestDecode::test_bounds_checking PASSED 151s tests/test_decode.py::TestDecode::test_bytes_decode PASSED 151s tests/test_decode.py::TestDecode::test_decimal PASSED 151s tests/test_decode.py::TestDecode::test_decoder_optimizations PASSED 151s tests/test_decode.py::TestDecode::test_empty_objects PASSED 151s tests/test_decode.py::TestDecode::test_empty_strings PASSED 151s tests/test_decode.py::TestDecode::test_float PASSED 151s tests/test_decode.py::TestDecode::test_keys_reuse_str PASSED 151s tests/test_decode.py::TestDecode::test_keys_reuse_unicode PASSED 151s tests/test_decode.py::TestDecode::test_object_pairs_hook PASSED 151s tests/test_decode.py::TestDecode::test_raw_decode PASSED 151s tests/test_default.py::TestDefault::test_default PASSED 151s tests/test_dump.py::TestDump::test_accumulator PASSED 151s tests/test_dump.py::TestDump::test_bytes_key PASSED 151s tests/test_dump.py::TestDump::test_bytes_nested PASSED 151s tests/test_dump.py::TestDump::test_bytes_toplevel PASSED 151s tests/test_dump.py::TestDump::test_constants PASSED 151s tests/test_dump.py::TestDump::test_dump PASSED 151s tests/test_dump.py::TestDump::test_dumps PASSED 151s tests/test_dump.py::TestDump::test_encode_truefalse PASSED 151s tests/test_dump.py::TestDump::test_indent_unknown_type_acceptance PASSED 151s tests/test_dump.py::TestDump::test_misbehaving_bytes_subtype PASSED 151s tests/test_dump.py::TestDump::test_misbehaving_text_subtype PASSED 151s tests/test_dump.py::TestDump::test_ordered_dict PASSED 151s tests/test_dump.py::TestDump::test_sort_keys PASSED 151s tests/test_dump.py::TestDump::test_stringify_key PASSED 151s tests/test_encode_basestring_ascii.py::TestEncodeBaseStringAscii::test_c_encode_basestring_ascii PASSED 151s tests/test_encode_basestring_ascii.py::TestEncodeBaseStringAscii::test_py_encode_basestring_ascii PASSED 151s tests/test_encode_basestring_ascii.py::TestEncodeBaseStringAscii::test_sorted_dict PASSED 151s tests/test_encode_for_html.py::TestEncodeForHTML::test_basic_encode PASSED 151s tests/test_encode_for_html.py::TestEncodeForHTML::test_basic_roundtrip PASSED 151s tests/test_encode_for_html.py::TestEncodeForHTML::test_non_ascii_basic_encode PASSED 151s tests/test_encode_for_html.py::TestEncodeForHTML::test_prevent_script_breakout PASSED 151s tests/test_errors.py::TestErrors::test_decode_error PASSED 151s tests/test_errors.py::TestErrors::test_error_is_pickable PASSED 151s tests/test_errors.py::TestErrors::test_not_serializable PASSED 151s tests/test_errors.py::TestErrors::test_scan_error PASSED 151s tests/test_errors.py::TestErrors::test_string_keys_error PASSED 151s tests/test_fail.py::TestFail::test_array_decoder_issue46 PASSED 151s tests/test_fail.py::TestFail::test_failures PASSED 151s tests/test_fail.py::TestFail::test_truncated_input PASSED 151s tests/test_float.py::TestFloat::test_degenerates_allow PASSED 151s tests/test_float.py::TestFloat::test_degenerates_deny PASSED 151s tests/test_float.py::TestFloat::test_degenerates_ignore PASSED 151s tests/test_float.py::TestFloat::test_floats PASSED 151s tests/test_float.py::TestFloat::test_ints PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_dict_subclass PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_list PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_list_subclass PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_list_within_object PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_object_nested_in_dict PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_object_nested_in_list_within_dict PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_object_nested_within_object PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_encodes_stand_alone_object PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_ignored_if_not_true_with_dict_subclass PASSED 151s tests/test_for_json.py::TestForJson::test_for_json_ignored_if_not_true_with_list_subclass PASSED 151s tests/test_for_json.py::TestForJson::test_raises_typeerror_if_for_json_not_true_with_object PASSED 151s tests/test_indent.py::TestIndent::test_indent PASSED 151s tests/test_indent.py::TestIndent::test_indent0 PASSED 151s tests/test_indent.py::TestIndent::test_separators PASSED 151s tests/test_item_sort_key.py::TestItemSortKey::test_case PASSED 151s tests/test_item_sort_key.py::TestItemSortKey::test_item_sort_key_value PASSED 151s tests/test_item_sort_key.py::TestItemSortKey::test_simple_first PASSED 151s tests/test_iterable.py::TestIterable::test_iterable PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_asdict_does_not_return_dict PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_asdict_not_callable_dump PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_asdict_not_callable_dumps PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_asdict_unbound_method_dumps PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_namedtuple_dump PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_namedtuple_dump_false PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_namedtuple_dumps PASSED 151s tests/test_namedtuple.py::TestNamedTuple::test_namedtuple_dumps_false PASSED 151s tests/test_pass1.py::TestPass1::test_parse PASSED 151s tests/test_pass2.py::TestPass2::test_parse PASSED 151s tests/test_pass3.py::TestPass3::test_parse PASSED 151s tests/test_raw_json.py::TestRawJson::test_direct PASSED 151s tests/test_raw_json.py::TestRawJson::test_list PASSED 151s tests/test_raw_json.py::TestRawJson::test_normal_str PASSED 151s tests/test_raw_json.py::TestRawJson::test_raw_json_str PASSED 151s tests/test_recursion.py::TestRecursion::test_defaultrecursion PASSED 151s tests/test_recursion.py::TestRecursion::test_dictrecursion PASSED 151s tests/test_recursion.py::TestRecursion::test_listrecursion PASSED 151s tests/test_scanstring.py::TestScanString::test_c_scanstring PASSED 151s tests/test_scanstring.py::TestScanString::test_issue3623 PASSED 151s tests/test_scanstring.py::TestScanString::test_overflow PASSED 151s tests/test_scanstring.py::TestScanString::test_py_scanstring PASSED 151s tests/test_scanstring.py::TestScanString::test_surrogates PASSED 151s tests/test_separators.py::TestSeparators::test_separators PASSED 151s tests/test_speedups.py::TestDecode::test_bad_bool_args PASSED 151s tests/test_speedups.py::TestDecode::test_make_scanner PASSED 151s tests/test_speedups.py::TestEncode::test_bad_bool_args PASSED 151s tests/test_speedups.py::TestEncode::test_bad_encoding PASSED 151s tests/test_speedups.py::TestEncode::test_bad_str_encoder PASSED 151s tests/test_speedups.py::TestEncode::test_int_as_string_bitcount_overflow PASSED 151s tests/test_speedups.py::TestEncode::test_make_encoder PASSED 151s tests/test_str_subclass.py::TestStrSubclass::test_dump_load PASSED 151s tests/test_subclass.py::TestSubclass::test_float PASSED 151s tests/test_subclass.py::TestSubclass::test_int PASSED 151s tests/test_tool.py::TestTool::test_infile_outfile PASSED 151s tests/test_tool.py::TestTool::test_infile_stdout PASSED 151s tests/test_tool.py::TestTool::test_stdin_stdout PASSED 151s tests/test_tuple.py::TestTuples::test_tuple_array_dump PASSED 151s tests/test_tuple.py::TestTuples::test_tuple_array_dumps PASSED 151s tests/test_unicode.py::TestUnicode::test_big_unicode_decode PASSED 151s tests/test_unicode.py::TestUnicode::test_big_unicode_encode PASSED 151s tests/test_unicode.py::TestUnicode::test_default_encoding PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding1 PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding2 PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding3 PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding4 PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding5 PASSED 151s tests/test_unicode.py::TestUnicode::test_encoding6 PASSED 151s tests/test_unicode.py::TestUnicode::test_ensure_ascii_false_bytestring_encoding PASSED 151s tests/test_unicode.py::TestUnicode::test_ensure_ascii_false_returns_unicode PASSED 151s tests/test_unicode.py::TestUnicode::test_ensure_ascii_linebreak_encoding PASSED 151s tests/test_unicode.py::TestUnicode::test_ensure_ascii_still_works PASSED 151s tests/test_unicode.py::TestUnicode::test_invalid_escape_sequences PASSED 151s tests/test_unicode.py::TestUnicode::test_object_pairs_hook_with_unicode PASSED 151s tests/test_unicode.py::TestUnicode::test_strip_bom PASSED 151s tests/test_unicode.py::TestUnicode::test_unicode_decode PASSED 151s tests/test_unicode.py::TestUnicode::test_unicode_preservation PASSED 151s 151s ============================= 143 passed in 0.33s ============================== 151s /tmp/autopkgtest.5GWNq1/wrapper.sh: checking for leaked background processes... 151s /tmp/autopkgtest.5GWNq1/wrapper.sh: waiting for tee/cat subprocesses... 151s /tmp/autopkgtest.5GWNq1/wrapper.sh: cleaning up... 151s /tmp/autopkgtest.5GWNq1/wrapper.sh: Exit status: 0 151s autopkgtest: DBG: testbed command exited with code 0 151s autopkgtest [13:02:09]: test upstream-3: -----------------------] 151s autopkgtest: DBG: testbed executing test finished with exit status 0 151s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/upstream-3-stdout /tmp/autopkgtest-work.r88535kh/out/upstream-3-stdout 151s autopkgtest: DBG: got reply from testbed: ok 151s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/upstream-3-stderr /tmp/autopkgtest-work.r88535kh/out/upstream-3-stderr 151s autopkgtest: DBG: got reply from testbed: ok 151s upstream-3 PASS 151s autopkgtest [13:02:09]: test upstream-3: - - - - - - - - - - results - - - - - - - - - - 151s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.5GWNq1/upstream-3-artifacts/ /tmp/autopkgtest-work.r88535kh/out/artifacts/ 152s autopkgtest: DBG: got reply from testbed: ok 152s autopkgtest: DBG: testbed command ['rm', '-rf', '/tmp/autopkgtest.5GWNq1/upstream-3-artifacts', '/tmp/autopkgtest.5GWNq1/autopkgtest_tmp'], kind short, sout raw, serr pipe, env [] 152s autopkgtest: DBG: testbed command exited with code 0 152s autopkgtest: DBG: needs_reset, previously=False, requested by run_tests() line 230 152s autopkgtest [13:02:10]: @@@@@@@@@@@@@@@@@@@@ summary 152s upstream-3 PASS 152s autopkgtest: DBG: testbed stop 152s autopkgtest: DBG: testbed close, scratch=/tmp/autopkgtest.5GWNq1 152s autopkgtest: DBG: sending command to testbed: close 173s autopkgtest: DBG: got reply from testbed: ok 173s autopkgtest: DBG: sending command to testbed: quit 173s nova [W] Using flock in prodstack6-s390x 173s flock: timeout while waiting to get lock 173s Creating nova instance adt-plucky-s390x-simplejson-20250219-125938-juju-7f2275-prod-proposed-migration-environment-15-7fc92051-4330-4589-bda6-139ed30ce40e from image adt/ubuntu-plucky-s390x-server-20250219.img (UUID 7af5aa59-4155-4177-a560-02c7dd963d23)... 173s nova [W] Timed out waiting for 56a72171-dd99-4d5d-a86b-bf2fec70749e to get deleted.