0s autopkgtest: DBG: testbed init
  0s autopkgtest [01:14:39]: starting date and time: 2025-02-16 01:14:39+0000
  0s autopkgtest [01:14:39]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [01:14:39]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.en8heocz/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc,src:iproute2,src:php-twig,src:postgresql-17,src:postgresql-common,src:roundcube --apt-upgrade ocaml-mem-usage --debug --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-5.secgroup --name adt-plucky-s390x-ocaml-mem-usage-20250216-011439-juju-7f2275-prod-proposed-migration-environment-15-b00d7a8e-9aa6-45a0-802c-87076eeaadf8 --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
124s autopkgtest: DBG: got reply from testbed: ok /tmp/autopkgtest.CU6MM2
124s autopkgtest: DBG: sending command to testbed: print-execute-command
124s autopkgtest: DBG: got reply from testbed: ok /tmp/autopkgtest-ssh.rr_2s568/runcmd
124s autopkgtest: DBG: sending command to testbed: capabilities
124s autopkgtest: DBG: got reply from testbed: ok reboot revert revert-full-system suggested-normal-user=ubuntu isolation-machine root-on-testbed
124s autopkgtest: DBG: testbed capabilities: ['reboot', 'revert', 'revert-full-system', 'suggested-normal-user=ubuntu', 'isolation-machine', 'root-on-testbed', 'has_internet']
124s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.CU6MM2'], kind short, sout raw, serr pipe, env []
125s autopkgtest: DBG: testbed command exited with code 0
125s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/wrapper.sh /tmp/autopkgtest.CU6MM2/wrapper.sh
125s autopkgtest: DBG: got reply from testbed: ok
125s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.CU6MM2/wrapper.sh'], kind short, sout raw, serr pipe, env []
125s autopkgtest: DBG: testbed command exited with code 0
125s autopkgtest: DBG: testbed command ['dpkg', '--print-architecture'], kind short, sout pipe, serr pipe, env []
125s autopkgtest: DBG: testbed command exited with code 0
125s autopkgtest [01:16:44]: testbed dpkg architecture: s390x
125s autopkgtest: DBG: testbed command ['dpkg-query', '-W', '-f', '${Version}', 'apt'], kind short, sout pipe, serr pipe, env []
125s autopkgtest: DBG: testbed command exited with code 0
125s autopkgtest [01:16:44]: testbed apt version: 2.9.28
125s autopkgtest: DBG: testbed command ['sh', '-ec', 'command -v eatmydata'], kind short, sout pipe, serr pipe, env []
125s autopkgtest: DBG: testbed command exited with code 0
125s autopkgtest: DBG: testbed has eatmydata
125s autopkgtest: DBG: testbed command ['mkdir', '-p', '/etc/apt/preferences.d'], kind short, sout raw, serr pipe, env []
126s autopkgtest: DBG: testbed command exited with code 0
126s autopkgtest [01:16:45]: @@@@@@@@@@@@@@@@@@@@ test bed setup
126s 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# <distro>.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 []
126s autopkgtest: DBG: testbed command exited with code 0
126s autopkgtest [01:16:45]: testbed release detected to be: None
126s 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 []
126s autopkgtest: DBG: testbed command exited with code 0
126s 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 []
126s autopkgtest: DBG: testbed command exited with code 0
126s autopkgtest: DBG: adding APT source: Types: deb deb-src
126s URIs: http://ftpmaster.internal/ubuntu/
126s Suites: plucky-proposed
126s Components: main restricted universe multiverse
126s Signed-By: /usr/share/keyrings/ubuntu-archive-keyring.gpg
126s 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 []
126s autopkgtest: DBG: testbed command exited with code 0
126s autopkgtest: DBG: adding APT preference to autopkgtest-zz-plucky-proposed-baseline.pref:
126s Package: *
126s Pin: release plucky-proposed
126s Pin-Priority: 500
126s 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 []
126s autopkgtest: DBG: testbed command exited with code 0
126s autopkgtest [01:16:45]: updating testbed package index (apt update)
126s 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']
127s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB]
127s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
127s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
127s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
127s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B]
127s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [73.1 kB]
127s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [823 kB]
127s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.1 kB]
127s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [164 kB]
127s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x Packages [760 B]
127s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [871 kB]
127s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3740 B]
128s Fetched 2062 kB in 1s (2080 kB/s)
128s Reading package lists...
128s autopkgtest: DBG: testbed command exited with code 0
128s autopkgtest: DBG: adding APT preference to autopkgtest-plucky-proposed.pref:
128s Package: *
128s Pin: release plucky-proposed
128s Pin-Priority: 100
128s 
128s Package: src:glibc:any src:iproute2:any src:php-twig:any src:postgresql-17:any src:postgresql-common:any src:roundcube:any
128s Pin: release plucky-proposed
128s Pin-Priority: 995
128s 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:glibc:any src:iproute2:any src:php-twig:any src:postgresql-17:any src:postgresql-common:any src:roundcube:any\nPin: release plucky-proposed\nPin-Priority: 995'], kind short, sout raw, serr pipe, env []
128s autopkgtest: DBG: testbed command exited with code 0
128s 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.CU6MM2/${d//\\//_}.stamp; done'], kind short, sout raw, serr pipe, env []
129s autopkgtest: DBG: testbed command exited with code 0
129s 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 <<EOF\nPackage: *\nPin: release a=$RELEASE\nPin-Priority: 1001\n\nPackage: *\nPin: release a=$RELEASE-updates\nPin-Priority: 1001\n\nPackage: *\nPin: release n=$RELEASE-security\nPin-Priority: 1001\nEOF\n# This is going to be a downgrade-only (or no-op) dist-upgrade, as setup-testbed\n# already dist-upgraded the system. Force the usage of the conf files of the\n# package being installed (--force-confnew), as conf files "from the future"\n# may not be supported by the older package version we\'re downgrading to.\nif [ "${RELEASE}" != "trusty" ]; then\n    DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::="--force-confnew" dist-upgrade\nfi\nrm /etc/apt/preferences.d/force-downgrade-to-release.pref\n\n# Remove packages not available from any configured repository, e.g.\n# packages fully removed from the archive. This requires the analyze-pattern\n# feature, which has been introduced in apt 2.0.1 (>= 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 <<EOF > /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 <<EOF > /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']
129s + lsb_release --codename --short
129s + RELEASE=plucky
129s + cat
129s + [ plucky != trusty ]
129s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade
129s Reading package lists...
129s Building dependency tree...
129s Reading state information...
129s Calculating upgrade...
129s The following packages were automatically installed and are no longer required:
129s   libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64
129s   linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic
129s   linux-modules-6.11.0-8-generic linux-tools-6.11.0-8
129s   linux-tools-6.11.0-8-generic
129s Use 'sudo apt autoremove' to remove them.
129s The following packages will be upgraded:
129s   dash gcc-14-base libatomic1 libgcc-s1 libstdc++6 libtasn1-6 libxdmcp6
129s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
129s Need to get 1155 kB of archives.
129s After this operation, 16.4 kB of additional disk space will be used.
129s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x dash s390x 0.5.12-12ubuntu1 [100 kB]
130s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libatomic1 s390x 14.2.0-17ubuntu1 [9430 B]
130s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-14-base s390x 14.2.0-17ubuntu1 [53.5 kB]
130s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x libstdc++6 s390x 14.2.0-17ubuntu1 [896 kB]
130s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x libgcc-s1 s390x 14.2.0-17ubuntu1 [35.9 kB]
130s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x libtasn1-6 s390x 4.20.0-2 [48.6 kB]
130s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libxdmcp6 s390x 1:1.1.5-1 [11.0 kB]
130s Preconfiguring packages ...
130s Fetched 1155 kB in 1s (1852 kB/s)
130s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
130s Preparing to unpack .../dash_0.5.12-12ubuntu1_s390x.deb ...
130s Unpacking dash (0.5.12-12ubuntu1) over (0.5.12-9ubuntu1) ...
130s Setting up dash (0.5.12-12ubuntu1) ...
130s (Reading database ... 
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 80969 files and directories currently installed.)
130s Preparing to unpack .../libatomic1_14.2.0-17ubuntu1_s390x.deb ...
130s Unpacking libatomic1:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
130s Preparing to unpack .../gcc-14-base_14.2.0-17ubuntu1_s390x.deb ...
130s Unpacking gcc-14-base:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
130s Setting up gcc-14-base:s390x (14.2.0-17ubuntu1) ...
131s (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 ... 80969 files and directories currently installed.)
131s Preparing to unpack .../libstdc++6_14.2.0-17ubuntu1_s390x.deb ...
131s Unpacking libstdc++6:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
131s Setting up libstdc++6:s390x (14.2.0-17ubuntu1) ...
131s (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 ... 80969 files and directories currently installed.)
131s Preparing to unpack .../libgcc-s1_14.2.0-17ubuntu1_s390x.deb ...
131s Unpacking libgcc-s1:s390x (14.2.0-17ubuntu1) over (14.2.0-16ubuntu1) ...
131s Setting up libgcc-s1:s390x (14.2.0-17ubuntu1) ...
131s (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 ... 80969 files and directories currently installed.)
131s Preparing to unpack .../libtasn1-6_4.20.0-2_s390x.deb ...
131s Unpacking libtasn1-6:s390x (4.20.0-2) over (4.19.0-3build1) ...
131s Preparing to unpack .../libxdmcp6_1%3a1.1.5-1_s390x.deb ...
131s Unpacking libxdmcp6:s390x (1:1.1.5-1) over (1:1.1.3-0ubuntu6) ...
131s Setting up libxdmcp6:s390x (1:1.1.5-1) ...
131s Setting up libatomic1:s390x (14.2.0-17ubuntu1) ...
131s Setting up libtasn1-6:s390x (4.20.0-2) ...
131s Processing triggers for libc-bin (2.40-4ubuntu1) ...
131s Processing triggers for man-db (2.13.0-1) ...
131s Processing triggers for debianutils (5.21) ...
131s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref
131s + /usr/lib/apt/apt-helper analyze-pattern ?true
131s + uname -r
131s + sed s/\./\\./g
131s + running_kernel_pattern=^linux-.*6\.12\.0-15-generic.*
131s + apt list ?obsolete
131s + tail -n+2
131s + cut -d/ -f1
131s + grep -v ^linux-.*6\.12\.0-15-generic.*
132s + true
132s + obsolete_pkgs=
132s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove
132s Reading package lists...
132s Building dependency tree...
132s Reading state information...
132s The following packages will be REMOVED:
132s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
132s   linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
132s   linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8*
132s   linux-tools-6.11.0-8-generic*
132s 0 upgraded, 0 newly installed, 9 to remove and 6 not upgraded.
132s After this operation, 167 MB disk space will be freed.
132s (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 ... 80969 files and directories currently installed.)
132s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
132s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
132s Removing libpython3.12t64:s390x (3.12.9-1) ...
132s Removing libpython3.12-stdlib:s390x (3.12.9-1) ...
132s Removing libnsl2:s390x (1.3.0-3build3) ...
132s Removing libpython3.12-minimal:s390x (3.12.9-1) ...
132s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
132s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
134s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
134s Processing triggers for libc-bin (2.40-4ubuntu1) ...
134s (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 ... 55869 files and directories currently installed.)
134s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ...
134s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
134s + grep -q trusty /etc/lsb-release
134s + [ ! -d /usr/share/doc/unattended-upgrades ]
134s + [ ! -d /usr/share/doc/lxd ]
134s + [ ! -d /usr/share/doc/lxd-client ]
134s + [ ! -d /usr/share/doc/snapd ]
134s + type iptables
134s + cat
134s + chmod 755 /etc/rc.local
134s + . /etc/rc.local
134s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu
134s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP
134s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP
134s + uname -m
134s + [ s390x = ppc64le ]
134s + [ -d /run/systemd/system ]
134s + systemd-detect-virt --quiet --vm
134s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/
134s + cat
134s + grep -q lz4 /etc/initramfs-tools/initramfs.conf
134s + echo COMPRESS=lz4
134s autopkgtest: DBG: testbed command exited with code 0
134s autopkgtest [01:16:53]: upgrading testbed (apt dist-upgrade and autopurge)
134s 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']
134s Reading package lists...
134s Building dependency tree...
134s Reading state information...
134s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
134s Starting 2 pkgProblemResolver with broken count: 0
134s Done
135s Entering ResolveByKeep
135s 
135s The following packages will be upgraded:
135s   iproute2 libc-bin libc-dev-bin libc6 libc6-dev locales
135s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
135s Need to get 10.7 MB of archives.
135s After this operation, 305 kB of additional disk space will be used.
135s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu1 [24.3 kB]
135s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu1 [1679 kB]
136s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu1 [4246 kB]
136s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu1 [2891 kB]
136s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu1 [672 kB]
136s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x iproute2 s390x 6.13.0-1ubuntu1 [1174 kB]
136s Preconfiguring packages ...
136s Fetched 10.7 MB in 1s (9813 kB/s)
136s (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 ... 55867 files and directories currently installed.)
136s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu1_s390x.deb ...
136s Unpacking libc-dev-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
136s Preparing to unpack .../libc6-dev_2.41-1ubuntu1_s390x.deb ...
136s Unpacking libc6-dev:s390x (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
137s Preparing to unpack .../locales_2.41-1ubuntu1_all.deb ...
137s Unpacking locales (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
137s Preparing to unpack .../libc6_2.41-1ubuntu1_s390x.deb ...
137s Checking for services that may need to be restarted...
137s Checking init scripts...
137s Checking for services that may need to be restarted...
137s Checking init scripts...
137s Stopping some services possibly affected by the upgrade (will be restarted later):
137s   cron: stopping...done.
137s 
137s Unpacking libc6:s390x (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
137s Setting up libc6:s390x (2.41-1ubuntu1) ...
137s Checking for services that may need to be restarted...
137s Checking init scripts...
137s Restarting services possibly affected by the upgrade:
137s   cron: restarting...done.
137s 
137s Services restarted successfully.
137s (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 ... 55868 files and directories currently installed.)
137s Preparing to unpack .../libc-bin_2.41-1ubuntu1_s390x.deb ...
137s Unpacking libc-bin (2.41-1ubuntu1) over (2.40-4ubuntu1) ...
137s Setting up libc-bin (2.41-1ubuntu1) ...
137s (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 ... 55868 files and directories currently installed.)
137s Preparing to unpack .../iproute2_6.13.0-1ubuntu1_s390x.deb ...
137s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ...
137s Setting up iproute2 (6.13.0-1ubuntu1) ...
137s Setting up locales (2.41-1ubuntu1) ...
137s Installing new version of config file /etc/locale.alias ...
138s Generating locales (this might take a while)...
139s   en_US.UTF-8... done
139s Generation complete.
139s Setting up libc-dev-bin (2.41-1ubuntu1) ...
139s Setting up libc6-dev:s390x (2.41-1ubuntu1) ...
139s Processing triggers for man-db (2.13.0-1) ...
140s Processing triggers for systemd (257.2-3ubuntu1) ...
141s autopkgtest: DBG: testbed command exited with code 0
141s Reading package lists...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']
141s 
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 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
141s autopkgtest: DBG: testbed command exited with code 0
141s 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.CU6MM2/${d//\\//_}.stamp;  [ ! -d $d ] || [ `stat -c %Y $d` = `stat -c %Y $s` ]; done'], kind short, sout raw, serr raw, env []
141s autopkgtest: DBG: testbed command exited with code 1
141s autopkgtest [01:17:00]: rebooting testbed after setup commands that affected boot
141s autopkgtest: DBG: sending command to testbed: reboot
162s autopkgtest: DBG: got reply from testbed: ok
162s autopkgtest: DBG: testbed supports reboot, creating /tmp/autopkgtest-reboot
162s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.CU6MM2'], kind short, sout raw, serr pipe, env []
162s autopkgtest: DBG: testbed command exited with code 0
162s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot.sh /tmp/autopkgtest.CU6MM2/autopkgtest-reboot
162s autopkgtest: DBG: got reply from testbed: ok
162s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
163s autopkgtest: DBG: testbed command exited with code 0
163s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot', '/tmp/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
163s autopkgtest: DBG: testbed command exited with code 0
163s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot', '/sbin/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
163s autopkgtest: DBG: testbed command exited with code 0
163s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.CU6MM2'], kind short, sout raw, serr pipe, env []
163s autopkgtest: DBG: testbed command exited with code 0
163s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot-prepare.sh /tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare
163s autopkgtest: DBG: got reply from testbed: ok
163s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env []
163s autopkgtest: DBG: testbed command exited with code 0
163s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare', '/tmp/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env []
164s autopkgtest: DBG: testbed command exited with code 0
164s autopkgtest: DBG: testbed command ['uname', '-srv'], kind short, sout pipe, serr pipe, env []
164s autopkgtest: DBG: testbed command exited with code 0
164s autopkgtest [01:17:23]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP Tue Feb  4 15:05:57 UTC 2025
164s autopkgtest: DBG: testbed command ['sh', '-c', 'nproc; cat /proc/cpuinfo 2>/dev/null || true'], kind short, sout pipe, serr pipe, env []
164s autopkgtest: DBG: testbed command exited with code 0
164s autopkgtest: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f '${Package}\\t${Version}\\n' > /tmp/autopkgtest.CU6MM2/testbed-packages"], kind short, sout raw, serr pipe, env []
164s autopkgtest: DBG: testbed command exited with code 0
164s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/testbed-packages /tmp/autopkgtest-work.en8heocz/out/testbed-packages
164s autopkgtest: DBG: got reply from testbed: ok
164s autopkgtest: DBG: testbed supports reboot, creating /tmp/autopkgtest-reboot
164s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.CU6MM2'], kind short, sout raw, serr pipe, env []
164s autopkgtest: DBG: testbed command exited with code 0
164s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot.sh /tmp/autopkgtest.CU6MM2/autopkgtest-reboot
165s autopkgtest: DBG: got reply from testbed: ok
165s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
165s autopkgtest: DBG: testbed command exited with code 0
165s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot', '/tmp/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
165s autopkgtest: DBG: testbed command exited with code 0
165s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot', '/sbin/autopkgtest-reboot'], kind short, sout raw, serr pipe, env []
165s autopkgtest: DBG: testbed command exited with code 0
165s autopkgtest: DBG: testbed command ['mkdir', '-p', '/tmp/autopkgtest.CU6MM2'], kind short, sout raw, serr pipe, env []
165s autopkgtest: DBG: testbed command exited with code 0
165s autopkgtest: DBG: sending command to testbed: copydown /home/ubuntu/autopkgtest/lib/in-testbed/reboot-prepare.sh /tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare
166s autopkgtest: DBG: got reply from testbed: ok
166s autopkgtest: DBG: testbed command ['chmod', '-R', '0755', '--', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env []
166s autopkgtest: DBG: testbed command exited with code 0
166s autopkgtest: DBG: testbed command ['ln', '-fns', '/tmp/autopkgtest.CU6MM2/autopkgtest-reboot-prepare', '/tmp/autopkgtest-reboot-prepare'], kind short, sout raw, serr pipe, env []
166s autopkgtest: DBG: testbed command exited with code 0
166s autopkgtest: DBG: testbed command ['uname', '-srv'], kind short, sout pipe, serr pipe, env []
166s autopkgtest: DBG: testbed command exited with code 0
166s autopkgtest: DBG: Binaries: initialising
166s autopkgtest [01:17:25]: @@@@@@@@@@@@@@@@@@@@ apt-source ocaml-mem-usage
166s autopkgtest: DBG: blame += ocaml-mem-usage
166s autopkgtest: DBG: testbed reset: modified=False, deps_installed=[], deps_new=[]
166s autopkgtest: DBG: testbed command ['apt-cache', 'showsrc', '--only-source', 'ocaml-mem-usage'], kind short, sout pipe, serr pipe, env []
166s autopkgtest: DBG: testbed command exited with code 0
166s autopkgtest: DBG: testbed command ['apt-cache', 'policy', '^libmem-usage-ocaml$'], kind short, sout pipe, serr raw, env []
167s autopkgtest: DBG: testbed command exited with code 0
167s autopkgtest: DBG: testbed command ['apt-cache', 'show', 'libmem-usage-ocaml=0.1.1-2'], kind short, sout pipe, serr raw, env []
167s autopkgtest: DBG: testbed command exited with code 0
167s autopkgtest: DBG: testbed command ['apt-cache', 'policy', '^libmem-usage-ocaml-dev$'], kind short, sout pipe, serr raw, env []
167s autopkgtest: DBG: testbed command exited with code 0
167s autopkgtest: DBG: testbed command ['apt-cache', 'show', 'libmem-usage-ocaml-dev=0.1.1-2'], kind short, sout pipe, serr raw, env []
167s autopkgtest: DBG: testbed command exited with code 0
167s autopkgtest: DBG: install_deps: deps_new=[]
167s autopkgtest: DBG: testbed command ['sh', '-ec', 'command -v dpkg-source'], kind short, sout pipe, serr pipe, env []
167s autopkgtest: DBG: testbed command exited with code 0
167s 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.CU6MM2/build.XXX); cd $builddir; OUT=$(apt-get source -d -q --only-source ocaml-mem-usage=0.1.1-2 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 ocaml-mem-usage_*.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=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1']
168s + cd /
168s + mktemp -d /tmp/autopkgtest.CU6MM2/build.XXX
168s + builddir=/tmp/autopkgtest.CU6MM2/build.UhI
168s + cd /tmp/autopkgtest.CU6MM2/build.UhI
168s + apt-get source -d -q --only-source ocaml-mem-usage=0.1.1-2
168s + OUT=Reading package lists...
168s NOTICE: 'ocaml-mem-usage' packaging is maintained in the 'Git' version control system at:
168s https://salsa.debian.org/ocaml-team/ocaml-mem-usage.git
168s Please use:
168s git clone https://salsa.debian.org/ocaml-team/ocaml-mem-usage.git
168s to retrieve the latest (possibly unreleased) updates to the package.
168s Need to get 10.5 kB of source archives.
168s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (dsc) [2192 B]
168s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (tar) [5852 B]
168s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (diff) [2444 B]
168s Fetched 10.5 kB in 0s (48.4 kB/s)
168s Download complete and in download only mode
168s + [ -n  ]
168s + grep ^Get:
168s + echo Reading package lists...
168s NOTICE: 'ocaml-mem-usage' packaging is maintained in the 'Git' version control system at:
168s https://salsa.debian.org/ocaml-team/ocaml-mem-usage.git
168s Please use:
168s git clone https://salsa.debian.org/ocaml-team/ocaml-mem-usage.git
168s to retrieve the latest (possibly unreleased) updates to the package.
168s Need to get 10.5 kB of source archives.
168s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (dsc) [2192 B]
168s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (tar) [5852 B]
168s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (diff) [2444 B]
168s Fetched 10.5 kB in 0s (48.4 kB/s)
168s Download complete and in download only mode
168s Get:1 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (dsc) [2192 B]
168s Get:2 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (tar) [5852 B]
168s Get:3 http://ftpmaster.internal/ubuntu plucky/universe ocaml-mem-usage 0.1.1-2 (diff) [2444 B]
168s + dpkg-source -x ocaml-mem-usage_0.1.1-2.dsc src
168s gpgv: Signature made Sun Oct 13 07:43:40 2024 UTC
168s gpgv:                using RSA key 96A58F182BB8F9B81C5F2733854F07BE082DF14F
168s gpgv: Can't check signature: No public key
168s dpkg-source: warning: cannot verify inline signature for ./ocaml-mem-usage_0.1.1-2.dsc: no acceptable signature found
168s + chmod -R a+rX .
168s + cd src/.
168s + pwd
168s + sed -n 1 {s/).*//; s/ (/\n/; p} debian/changelog
168s autopkgtest: DBG: testbed command exited with code 0
168s autopkgtest [01:17:27]: testing package ocaml-mem-usage version 0.1.1-2
168s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/build.UhI/src/debian/ /tmp/autopkgtest-work.en8heocz/out/pkg/debian/
168s autopkgtest: DBG: got reply from testbed: ok
168s autopkgtest: DBG: processing dependency @
168s autopkgtest: DBG: synthesised dependency libmem-usage-ocaml
168s autopkgtest: DBG: synthesised dependency libmem-usage-ocaml-dev
168s autopkgtest: DBG: processing dependency ocaml-dune
168s autopkgtest: DBG: Test defined: name upstream path debian/tests/upstream command "None" restrictions ['allow-stderr'] features [] depends ['libmem-usage-ocaml', 'libmem-usage-ocaml-dev', 'ocaml-dune'] 
168s autopkgtest [01:17:27]: build not needed
168s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/build.UhI/src/ /tmp/autopkgtest-work.en8heocz/out/tests-tree/
169s autopkgtest: DBG: got reply from testbed: ok
169s autopkgtest: DBG: processing dependency @
169s autopkgtest: DBG: synthesised dependency libmem-usage-ocaml
169s autopkgtest: DBG: synthesised dependency libmem-usage-ocaml-dev
169s autopkgtest: DBG: processing dependency ocaml-dune
169s autopkgtest: DBG: Test defined: name upstream path debian/tests/upstream command "None" restrictions ['allow-stderr'] features [] depends ['libmem-usage-ocaml', 'libmem-usage-ocaml-dev', 'ocaml-dune'] 
169s autopkgtest [01:17:28]: test upstream: preparing testbed
169s autopkgtest: DBG: testbed reset: modified=False, deps_installed=[], deps_new=['libmem-usage-ocaml', 'libmem-usage-ocaml-dev', 'ocaml-dune']
169s autopkgtest: DBG: Binaries: no registered binaries, not publishing anything
169s autopkgtest: DBG: install_deps: deps_new=['libmem-usage-ocaml', 'libmem-usage-ocaml-dev', 'ocaml-dune']
169s autopkgtest: DBG: install-deps: satisfying libmem-usage-ocaml, libmem-usage-ocaml-dev, ocaml-dune
169s autopkgtest: DBG: can use apt-get on testbed: True
169s 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', 'libmem-usage-ocaml, libmem-usage-ocaml-dev, ocaml-dune'], kind install, sout raw, serr pipe, env ['DEBIAN_FRONTEND=noninteractive', 'APT_LISTBUGS_FRONTEND=none', 'APT_LISTCHANGES_FRONTEND=none']
169s Reading package lists...
169s Building dependency tree...
169s Reading state information...
169s Starting pkgProblemResolver with broken count: 0
169s Starting 2 pkgProblemResolver with broken count: 0
169s Done
169s The following NEW packages will be installed:
169s   cpp cpp-14 cpp-14-s390x-linux-gnu cpp-s390x-linux-gnu gcc gcc-14
169s   gcc-14-s390x-linux-gnu gcc-s390x-linux-gnu libasan8 libcc1-0
169s   libcompiler-libs-ocaml-dev libfindlib-ocaml libgcc-14-dev libgomp1 libisl23
169s   libitm1 libmem-usage-ocaml libmem-usage-ocaml-dev libmpc3 libncurses-dev
169s   libstdlib-ocaml libstdlib-ocaml-dev libubsan1 libzstd-dev ocaml ocaml-base
169s   ocaml-dune ocaml-findlib ocaml-interp
170s 0 upgraded, 29 newly installed, 0 to remove and 0 not upgraded.
170s Need to get 127 MB of archives.
170s After this operation, 370 MB of additional disk space will be used.
170s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x libisl23 s390x 0.27-1 [704 kB]
170s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x libmpc3 s390x 1.3.1-1build2 [57.8 kB]
170s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x cpp-14-s390x-linux-gnu s390x 14.2.0-17ubuntu1 [9571 kB]
170s Get:4 http://ftpmaster.internal/ubuntu plucky/main s390x cpp-14 s390x 14.2.0-17ubuntu1 [1030 B]
170s Get:5 http://ftpmaster.internal/ubuntu plucky/main s390x cpp-s390x-linux-gnu s390x 4:14.2.0-1ubuntu1 [5556 B]
170s Get:6 http://ftpmaster.internal/ubuntu plucky/main s390x cpp s390x 4:14.2.0-1ubuntu1 [22.4 kB]
170s Get:7 http://ftpmaster.internal/ubuntu plucky/main s390x libcc1-0 s390x 14.2.0-17ubuntu1 [50.7 kB]
170s Get:8 http://ftpmaster.internal/ubuntu plucky/main s390x libgomp1 s390x 14.2.0-17ubuntu1 [151 kB]
170s Get:9 http://ftpmaster.internal/ubuntu plucky/main s390x libitm1 s390x 14.2.0-17ubuntu1 [30.9 kB]
170s Get:10 http://ftpmaster.internal/ubuntu plucky/main s390x libasan8 s390x 14.2.0-17ubuntu1 [2964 kB]
171s Get:11 http://ftpmaster.internal/ubuntu plucky/main s390x libubsan1 s390x 14.2.0-17ubuntu1 [1184 kB]
171s Get:12 http://ftpmaster.internal/ubuntu plucky/main s390x libgcc-14-dev s390x 14.2.0-17ubuntu1 [1037 kB]
171s Get:13 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-14-s390x-linux-gnu s390x 14.2.0-17ubuntu1 [18.7 MB]
172s Get:14 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-14 s390x 14.2.0-17ubuntu1 [526 kB]
172s Get:15 http://ftpmaster.internal/ubuntu plucky/main s390x gcc-s390x-linux-gnu s390x 4:14.2.0-1ubuntu1 [1204 B]
172s Get:16 http://ftpmaster.internal/ubuntu plucky/main s390x gcc s390x 4:14.2.0-1ubuntu1 [5004 B]
172s Get:17 http://ftpmaster.internal/ubuntu plucky/universe s390x libstdlib-ocaml s390x 5.2.0-3 [426 kB]
172s Get:18 http://ftpmaster.internal/ubuntu plucky/universe s390x libstdlib-ocaml-dev s390x 5.2.0-3 [10.9 MB]
172s Get:19 http://ftpmaster.internal/ubuntu plucky/universe s390x libcompiler-libs-ocaml-dev s390x 5.2.0-3 [45.1 MB]
175s Get:20 http://ftpmaster.internal/ubuntu plucky/universe s390x ocaml-base s390x 5.2.0-3 [300 kB]
175s Get:21 http://ftpmaster.internal/ubuntu plucky/universe s390x libfindlib-ocaml s390x 1.9.6-3build1 [189 kB]
175s Get:22 http://ftpmaster.internal/ubuntu plucky/universe s390x libmem-usage-ocaml s390x 0.1.1-2 [4800 B]
175s Get:23 http://ftpmaster.internal/ubuntu plucky/universe s390x ocaml-findlib s390x 1.9.6-3build1 [658 kB]
175s Get:24 http://ftpmaster.internal/ubuntu plucky/universe s390x ocaml-interp s390x 5.2.0-3 [8077 kB]
175s Get:25 http://ftpmaster.internal/ubuntu plucky/main s390x libncurses-dev s390x 6.5+20250125-2 [407 kB]
175s Get:26 http://ftpmaster.internal/ubuntu plucky/main s390x libzstd-dev s390x 1.5.6+dfsg-2 [408 kB]
175s Get:27 http://ftpmaster.internal/ubuntu plucky/universe s390x ocaml s390x 5.2.0-3 [20.0 MB]
176s Get:28 http://ftpmaster.internal/ubuntu plucky/universe s390x libmem-usage-ocaml-dev s390x 0.1.1-2 [33.2 kB]
176s Get:29 http://ftpmaster.internal/ubuntu plucky/universe s390x ocaml-dune s390x 3.16.0-2build1 [5585 kB]
176s Fetched 127 MB in 6s (20.1 MB/s)
176s Selecting previously unselected package libisl23:s390x.
176s (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 ... 55869 files and directories currently installed.)
176s Preparing to unpack .../00-libisl23_0.27-1_s390x.deb ...
176s Unpacking libisl23:s390x (0.27-1) ...
176s Selecting previously unselected package libmpc3:s390x.
176s Preparing to unpack .../01-libmpc3_1.3.1-1build2_s390x.deb ...
176s Unpacking libmpc3:s390x (1.3.1-1build2) ...
176s Selecting previously unselected package cpp-14-s390x-linux-gnu.
176s Preparing to unpack .../02-cpp-14-s390x-linux-gnu_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking cpp-14-s390x-linux-gnu (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package cpp-14.
176s Preparing to unpack .../03-cpp-14_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking cpp-14 (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package cpp-s390x-linux-gnu.
176s Preparing to unpack .../04-cpp-s390x-linux-gnu_4%3a14.2.0-1ubuntu1_s390x.deb ...
176s Unpacking cpp-s390x-linux-gnu (4:14.2.0-1ubuntu1) ...
176s Selecting previously unselected package cpp.
176s Preparing to unpack .../05-cpp_4%3a14.2.0-1ubuntu1_s390x.deb ...
176s Unpacking cpp (4:14.2.0-1ubuntu1) ...
176s Selecting previously unselected package libcc1-0:s390x.
176s Preparing to unpack .../06-libcc1-0_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking libcc1-0:s390x (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package libgomp1:s390x.
176s Preparing to unpack .../07-libgomp1_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking libgomp1:s390x (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package libitm1:s390x.
176s Preparing to unpack .../08-libitm1_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking libitm1:s390x (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package libasan8:s390x.
176s Preparing to unpack .../09-libasan8_14.2.0-17ubuntu1_s390x.deb ...
176s Unpacking libasan8:s390x (14.2.0-17ubuntu1) ...
176s Selecting previously unselected package libubsan1:s390x.
177s Preparing to unpack .../10-libubsan1_14.2.0-17ubuntu1_s390x.deb ...
177s Unpacking libubsan1:s390x (14.2.0-17ubuntu1) ...
177s Selecting previously unselected package libgcc-14-dev:s390x.
177s Preparing to unpack .../11-libgcc-14-dev_14.2.0-17ubuntu1_s390x.deb ...
177s Unpacking libgcc-14-dev:s390x (14.2.0-17ubuntu1) ...
177s Selecting previously unselected package gcc-14-s390x-linux-gnu.
177s Preparing to unpack .../12-gcc-14-s390x-linux-gnu_14.2.0-17ubuntu1_s390x.deb ...
177s Unpacking gcc-14-s390x-linux-gnu (14.2.0-17ubuntu1) ...
177s Selecting previously unselected package gcc-14.
177s Preparing to unpack .../13-gcc-14_14.2.0-17ubuntu1_s390x.deb ...
177s Unpacking gcc-14 (14.2.0-17ubuntu1) ...
177s Selecting previously unselected package gcc-s390x-linux-gnu.
177s Preparing to unpack .../14-gcc-s390x-linux-gnu_4%3a14.2.0-1ubuntu1_s390x.deb ...
177s Unpacking gcc-s390x-linux-gnu (4:14.2.0-1ubuntu1) ...
177s Selecting previously unselected package gcc.
177s Preparing to unpack .../15-gcc_4%3a14.2.0-1ubuntu1_s390x.deb ...
177s Unpacking gcc (4:14.2.0-1ubuntu1) ...
177s Selecting previously unselected package libstdlib-ocaml.
177s Preparing to unpack .../16-libstdlib-ocaml_5.2.0-3_s390x.deb ...
177s Unpacking libstdlib-ocaml (5.2.0-3) ...
177s Selecting previously unselected package libstdlib-ocaml-dev.
177s Preparing to unpack .../17-libstdlib-ocaml-dev_5.2.0-3_s390x.deb ...
177s Unpacking libstdlib-ocaml-dev (5.2.0-3) ...
177s Selecting previously unselected package libcompiler-libs-ocaml-dev.
177s Preparing to unpack .../18-libcompiler-libs-ocaml-dev_5.2.0-3_s390x.deb ...
177s Unpacking libcompiler-libs-ocaml-dev (5.2.0-3) ...
177s Selecting previously unselected package ocaml-base.
177s Preparing to unpack .../19-ocaml-base_5.2.0-3_s390x.deb ...
177s Unpacking ocaml-base (5.2.0-3) ...
177s Selecting previously unselected package libfindlib-ocaml.
177s Preparing to unpack .../20-libfindlib-ocaml_1.9.6-3build1_s390x.deb ...
177s Unpacking libfindlib-ocaml (1.9.6-3build1) ...
177s Selecting previously unselected package libmem-usage-ocaml.
177s Preparing to unpack .../21-libmem-usage-ocaml_0.1.1-2_s390x.deb ...
177s Unpacking libmem-usage-ocaml (0.1.1-2) ...
177s Selecting previously unselected package ocaml-findlib.
177s Preparing to unpack .../22-ocaml-findlib_1.9.6-3build1_s390x.deb ...
177s Unpacking ocaml-findlib (1.9.6-3build1) ...
177s Selecting previously unselected package ocaml-interp.
177s Preparing to unpack .../23-ocaml-interp_5.2.0-3_s390x.deb ...
177s Unpacking ocaml-interp (5.2.0-3) ...
178s Selecting previously unselected package libncurses-dev:s390x.
178s Preparing to unpack .../24-libncurses-dev_6.5+20250125-2_s390x.deb ...
178s Unpacking libncurses-dev:s390x (6.5+20250125-2) ...
178s Selecting previously unselected package libzstd-dev:s390x.
178s Preparing to unpack .../25-libzstd-dev_1.5.6+dfsg-2_s390x.deb ...
178s Unpacking libzstd-dev:s390x (1.5.6+dfsg-2) ...
178s Selecting previously unselected package ocaml.
178s Preparing to unpack .../26-ocaml_5.2.0-3_s390x.deb ...
178s Unpacking ocaml (5.2.0-3) ...
178s Selecting previously unselected package libmem-usage-ocaml-dev.
178s Preparing to unpack .../27-libmem-usage-ocaml-dev_0.1.1-2_s390x.deb ...
178s Unpacking libmem-usage-ocaml-dev (0.1.1-2) ...
178s Selecting previously unselected package ocaml-dune.
178s Preparing to unpack .../28-ocaml-dune_3.16.0-2build1_s390x.deb ...
178s Unpacking ocaml-dune (3.16.0-2build1) ...
178s Setting up libncurses-dev:s390x (6.5+20250125-2) ...
178s Setting up libzstd-dev:s390x (1.5.6+dfsg-2) ...
178s Setting up libgomp1:s390x (14.2.0-17ubuntu1) ...
178s Setting up ocaml-dune (3.16.0-2build1) ...
178s Setting up libstdlib-ocaml (5.2.0-3) ...
178s Setting up libmpc3:s390x (1.3.1-1build2) ...
178s Setting up ocaml-base (5.2.0-3) ...
178s Setting up libubsan1:s390x (14.2.0-17ubuntu1) ...
178s Setting up libasan8:s390x (14.2.0-17ubuntu1) ...
178s Setting up libisl23:s390x (0.27-1) ...
178s Setting up libcc1-0:s390x (14.2.0-17ubuntu1) ...
178s Setting up libitm1:s390x (14.2.0-17ubuntu1) ...
178s Setting up libstdlib-ocaml-dev (5.2.0-3) ...
178s Setting up libfindlib-ocaml (1.9.6-3build1) ...
178s Setting up libmem-usage-ocaml (0.1.1-2) ...
178s Setting up libcompiler-libs-ocaml-dev (5.2.0-3) ...
178s Setting up ocaml-interp (5.2.0-3) ...
178s Setting up ocaml-findlib (1.9.6-3build1) ...
178s Setting up cpp-14-s390x-linux-gnu (14.2.0-17ubuntu1) ...
178s Setting up cpp-14 (14.2.0-17ubuntu1) ...
178s Setting up libgcc-14-dev:s390x (14.2.0-17ubuntu1) ...
178s Setting up cpp-s390x-linux-gnu (4:14.2.0-1ubuntu1) ...
178s Setting up gcc-14-s390x-linux-gnu (14.2.0-17ubuntu1) ...
178s Setting up gcc-s390x-linux-gnu (4:14.2.0-1ubuntu1) ...
178s Setting up cpp (4:14.2.0-1ubuntu1) ...
178s Setting up gcc-14 (14.2.0-17ubuntu1) ...
178s Setting up gcc (4:14.2.0-1ubuntu1) ...
178s Setting up ocaml (5.2.0-3) ...
178s Setting up libmem-usage-ocaml-dev (0.1.1-2) ...
178s Processing triggers for man-db (2.13.0-1) ...
179s Processing triggers for libc-bin (2.41-1ubuntu1) ...
179s autopkgtest: DBG: testbed command exited with code 0
179s autopkgtest: DBG: testbed command ['dpkg-query', '--show', '-f', '${Status}', 'libmem-usage-ocaml'], kind short, sout pipe, serr pipe, env []
179s autopkgtest: DBG: testbed command exited with code 0
179s autopkgtest: DBG: testbed command ['dpkg-query', '--show', '-f', '${Status}', 'libmem-usage-ocaml-dev'], kind short, sout pipe, serr pipe, env []
179s autopkgtest: DBG: testbed command exited with code 0
179s autopkgtest: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f '${Package}\\t${Version}\\n' > /tmp/autopkgtest.CU6MM2/upstream-packages.all"], kind short, sout raw, serr pipe, env []
180s autopkgtest: DBG: testbed command exited with code 0
180s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/upstream-packages.all /tmp/autopkgtest-work.en8heocz/out/upstream-packages.all
180s autopkgtest: DBG: got reply from testbed: ok
180s autopkgtest: DBG: testbed command ['test', '-e', '/tmp/autopkgtest.CU6MM2/build.UhI/src'], kind short, sout raw, serr raw, env []
180s autopkgtest: DBG: testbed command exited with code 0
180s autopkgtest: DBG: copydown: tb path /tmp/autopkgtest.CU6MM2/build.UhI/src already exists
180s autopkgtest [01:17:39]: test upstream: [-----------------------
180s autopkgtest: DBG: testbed command ['su', '-s', '/bin/bash', 'ubuntu', '-c', "set -e; exec /tmp/autopkgtest.CU6MM2/wrapper.sh --debug --artifacts=/tmp/autopkgtest.CU6MM2/upstream-artifacts --chdir=/tmp/autopkgtest.CU6MM2/build.UhI/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.CU6MM2/upstream-stderr --stdout=/tmp/autopkgtest.CU6MM2/upstream-stdout --tmp=/tmp/autopkgtest.CU6MM2/autopkgtest_tmp '--env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1' --make-executable=/tmp/autopkgtest.CU6MM2/build.UhI/src/debian/tests/upstream -- /tmp/autopkgtest.CU6MM2/build.UhI/src/debian/tests/upstream"], kind test, sout raw, serr raw, env []
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: creating AUTOPKGTEST_ARTIFACTS: /tmp/autopkgtest.CU6MM2/upstream-artifacts
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: changing to directory: /tmp/autopkgtest.CU6MM2/build.UhI/src
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: AUTOPKGTEST_TESTBED_ARCH=s390x
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: AUTOPKGTEST_TEST_ARCH=s390x
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: DEB_BUILD_OPTIONS=parallel=2
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: DEBIAN_FRONTEND=noninteractive
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: LANG=C.UTF-8
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LANGUAGE
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_ADDRESS
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_ALL
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_COLLATE
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_CTYPE
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_IDENTIFICATION
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_MEASUREMENT
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_MESSAGES
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_MONETARY
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_NAME
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_NUMERIC
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_PAPER
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_TELEPHONE
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: unsetting environment: LC_TIME
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: will create pid file: /tmp/autopkgtest_script_pid
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: pretending to be a login shell
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: will write standard error to /tmp/autopkgtest.CU6MM2/upstream-stderr
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: will write stdout to /tmp/autopkgtest.CU6MM2/upstream-stdout
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: creating AUTOPKGTEST_TMP: /tmp/autopkgtest.CU6MM2/autopkgtest_tmp
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: setting environment: ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu1 iproute2/6.13.0-1ubuntu1 php-twig/3.19.0-1 postgresql-17/17.3-2 postgresql-common/273 roundcube/1.6.10+dfsg-1
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: marking as executable: /tmp/autopkgtest.CU6MM2/build.UhI/src/debian/tests/upstream
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: command to run: /tmp/autopkgtest.CU6MM2/build.UhI/src/debian/tests/upstream
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: copying /tmp/tmp.OYW5cjx86w/out to stdout and file: /tmp/autopkgtest.CU6MM2/upstream-stdout
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: copying /tmp/tmp.OYW5cjx86w/err to standard error and file: /tmp/autopkgtest.CU6MM2/upstream-stdout
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: writing script pid 1641 to /tmp/autopkgtest_script_pid
180s (cd _build/default/test && ./test.exe)
180s 
180s Total virtual memory:    4.19 GB
180s Total physical memory:   4.19 GB
180s Used virtual memory:     1.13 GB
180s Used physical memory:    1.13 GB
180s Process virtual memory:  274.26 MB
180s Process physical memory: 2.68 MB
180s Process private memory:  1.32 MB
180s Process swapped memory:  0 B
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: checking for leaked background processes...
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: waiting for tee/cat subprocesses...
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: cleaning up...
180s /tmp/autopkgtest.CU6MM2/wrapper.sh: Exit status: 0
180s autopkgtest: DBG: testbed command exited with code 0
181s autopkgtest [01:17:40]: test upstream: -----------------------]
181s autopkgtest: DBG: testbed executing test finished with exit status 0
181s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/upstream-stdout /tmp/autopkgtest-work.en8heocz/out/upstream-stdout
181s autopkgtest: DBG: got reply from testbed: ok
181s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/upstream-stderr /tmp/autopkgtest-work.en8heocz/out/upstream-stderr
181s autopkgtest: DBG: got reply from testbed: ok
181s upstream             PASS
181s autopkgtest [01:17:40]: test upstream:  - - - - - - - - - - results - - - - - - - - - -
181s autopkgtest: DBG: sending command to testbed: copyup /tmp/autopkgtest.CU6MM2/upstream-artifacts/ /tmp/autopkgtest-work.en8heocz/out/artifacts/
181s autopkgtest: DBG: got reply from testbed: ok
181s autopkgtest: DBG: testbed command ['rm', '-rf', '/tmp/autopkgtest.CU6MM2/upstream-artifacts', '/tmp/autopkgtest.CU6MM2/autopkgtest_tmp'], kind short, sout raw, serr pipe, env []
181s autopkgtest: DBG: testbed command exited with code 0
181s autopkgtest: DBG: needs_reset, previously=False, requested by run_tests() line 230
181s autopkgtest [01:17:40]: @@@@@@@@@@@@@@@@@@@@ summary
181s upstream             PASS
181s autopkgtest: DBG: testbed stop
181s autopkgtest: DBG: testbed close, scratch=/tmp/autopkgtest.CU6MM2
181s autopkgtest: DBG: sending command to testbed: close
198s autopkgtest: DBG: got reply from testbed: ok
198s autopkgtest: DBG: sending command to testbed: quit
198s nova [W] Using flock in prodstack6-s390x
198s Creating nova instance adt-plucky-s390x-ocaml-mem-usage-20250216-011439-juju-7f2275-prod-proposed-migration-environment-15-b00d7a8e-9aa6-45a0-802c-87076eeaadf8 from image adt/ubuntu-plucky-s390x-server-20250215.img (UUID 099dc609-2061-4009-a65b-d554466baca0)...
198s nova [W] Timed out waiting for f33aa09a-08ec-486c-abb3-f56622d20a5c to get deleted.