0s autopkgtest [19:24:06]: starting date and time: 2025-03-15 19:24:06+0000 0s autopkgtest [19:24:06]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [19:24:06]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.44simfam/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade systemd-bootchart --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-s390x-5.secgroup --name adt-plucky-s390x-systemd-bootchart-20250315-192406-juju-7f2275-prod-proposed-migration-environment-15-a5796fad-b1c0-43ae-a1ee-5991d5f66041 --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/ 118s autopkgtest [19:26:04]: testbed dpkg architecture: s390x 118s autopkgtest [19:26:04]: testbed apt version: 2.9.33 118s autopkgtest [19:26:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup 119s autopkgtest [19:26:05]: testbed release detected to be: None 119s autopkgtest [19:26:05]: updating testbed package index (apt update) 120s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 120s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 120s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 120s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 120s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 120s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB] 120s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [45.1 kB] 120s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x Packages [77.3 kB] 121s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x c-n-f Metadata [1824 B] 121s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted s390x c-n-f Metadata [116 B] 121s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x Packages [314 kB] 121s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe s390x c-n-f Metadata [13.3 kB] 121s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x Packages [3532 B] 121s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse s390x c-n-f Metadata [240 B] 121s Fetched 965 kB in 1s (808 kB/s) 122s Reading package lists... 122s + lsb_release --codename --short 122s + RELEASE=plucky 122s + cat 122s + [ plucky != trusty ] 122s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 122s Reading package lists... 122s Building dependency tree... 122s Reading state information... 122s Calculating upgrade... 122s Calculating upgrade... 122s The following packages were automatically installed and are no longer required: 122s libnsl2 libpython3.12-minimal libpython3.12-stdlib libpython3.12t64 122s linux-headers-6.11.0-8 linux-headers-6.11.0-8-generic 122s linux-modules-6.11.0-8-generic linux-tools-6.11.0-8 122s linux-tools-6.11.0-8-generic 122s Use 'sudo apt autoremove' to remove them. 122s The following packages will be upgraded: 122s pinentry-curses python3-jinja2 strace 123s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 123s Need to get 652 kB of archives. 123s After this operation, 27.6 kB of additional disk space will be used. 123s Get:1 http://ftpmaster.internal/ubuntu plucky/main s390x strace s390x 6.13+ds-1ubuntu1 [500 kB] 123s Get:2 http://ftpmaster.internal/ubuntu plucky/main s390x pinentry-curses s390x 1.3.1-2ubuntu3 [42.9 kB] 123s Get:3 http://ftpmaster.internal/ubuntu plucky/main s390x python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 123s Fetched 652 kB in 1s (911 kB/s) 124s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81428 files and directories currently installed.) 124s Preparing to unpack .../strace_6.13+ds-1ubuntu1_s390x.deb ... 124s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 124s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_s390x.deb ... 124s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 124s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 124s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 124s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 124s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 124s Setting up strace (6.13+ds-1ubuntu1) ... 124s Processing triggers for man-db (2.13.0-1) ... 124s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 124s + /usr/lib/apt/apt-helper analyze-pattern ?true 124s + uname -r 124s + sed s/\./\\./g 124s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 124s + apt list ?obsolete 124s + tail -n+2 124s + cut -d/ -f1 124s + grep -v ^linux-.*6\.14\.0-10-generic.* 125s + obsolete_pkgs=linux-headers-6.11.0-8-generic 125s linux-headers-6.11.0-8 125s linux-modules-6.11.0-8-generic 125s linux-tools-6.11.0-8-generic 125s linux-tools-6.11.0-8 125s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-generic linux-headers-6.11.0-8 linux-modules-6.11.0-8-generic linux-tools-6.11.0-8-generic linux-tools-6.11.0-8 125s Reading package lists... 125s Building dependency tree... 125s Reading state information... 125s Solving dependencies... 125s The following packages will be REMOVED: 125s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 125s linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 125s linux-modules-6.11.0-8-generic* linux-tools-6.11.0-8* 125s linux-tools-6.11.0-8-generic* 125s 0 upgraded, 0 newly installed, 9 to remove and 5 not upgraded. 125s After this operation, 167 MB disk space will be freed. 125s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 81428 files and directories currently installed.) 125s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 125s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 125s Removing libpython3.12t64:s390x (3.12.9-1) ... 125s Removing libpython3.12-stdlib:s390x (3.12.9-1) ... 125s Removing libnsl2:s390x (1.3.0-3build3) ... 125s Removing libpython3.12-minimal:s390x (3.12.9-1) ... 125s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 125s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 126s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 126s Processing triggers for libc-bin (2.41-1ubuntu1) ... 126s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 56328 files and directories currently installed.) 126s Purging configuration files for libpython3.12-minimal:s390x (3.12.9-1) ... 126s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 126s + grep -q trusty /etc/lsb-release 126s + [ ! -d /usr/share/doc/unattended-upgrades ] 126s + [ ! -d /usr/share/doc/lxd ] 126s + [ ! -d /usr/share/doc/lxd-client ] 126s + [ ! -d /usr/share/doc/snapd ] 126s + type iptables 126s + cat 126s + chmod 755 /etc/rc.local 126s + . /etc/rc.local 126s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 126s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 126s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 126s + uname -m 126s + [ s390x = ppc64le ] 126s + [ -d /run/systemd/system ] 126s + systemd-detect-virt --quiet --vm 126s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 126s + cat 126s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 126s + echo COMPRESS=lz4 126s autopkgtest [19:26:12]: upgrading testbed (apt dist-upgrade and autopurge) 126s Reading package lists... 127s Building dependency tree... 127s Reading state information... 127s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 127s Starting 2 pkgProblemResolver with broken count: 0 127s Done 127s Entering ResolveByKeep 127s 127s Calculating upgrade... 127s The following packages will be upgraded: 127s libc-bin libc-dev-bin libc6 libc6-dev locales 127s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 127s Need to get 9512 kB of archives. 127s After this operation, 8192 B of additional disk space will be used. 127s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6-dev s390x 2.41-1ubuntu2 [1678 kB] 129s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-dev-bin s390x 2.41-1ubuntu2 [24.3 kB] 129s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc6 s390x 2.41-1ubuntu2 [2892 kB] 130s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x libc-bin s390x 2.41-1ubuntu2 [671 kB] 130s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main s390x locales all 2.41-1ubuntu2 [4246 kB] 133s Preconfiguring packages ... 133s Fetched 9512 kB in 6s (1728 kB/s) 133s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 56326 files and directories currently installed.) 133s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_s390x.deb ... 133s Unpacking libc6-dev:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 133s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_s390x.deb ... 133s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 133s Preparing to unpack .../libc6_2.41-1ubuntu2_s390x.deb ... 133s Unpacking libc6:s390x (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 133s Setting up libc6:s390x (2.41-1ubuntu2) ... 133s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 56326 files and directories currently installed.) 133s Preparing to unpack .../libc-bin_2.41-1ubuntu2_s390x.deb ... 133s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 133s Setting up libc-bin (2.41-1ubuntu2) ... 133s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 56326 files and directories currently installed.) 133s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 133s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 134s Setting up locales (2.41-1ubuntu2) ... 134s Generating locales (this might take a while)... 135s en_US.UTF-8... done 135s Generation complete. 135s Setting up libc-dev-bin (2.41-1ubuntu2) ... 135s Setting up libc6-dev:s390x (2.41-1ubuntu2) ... 135s Processing triggers for man-db (2.13.0-1) ... 135s Processing triggers for systemd (257.3-1ubuntu3) ... 136s Reading package lists... 136s Building dependency tree... 136s Reading state information... 137s Starting pkgProblemResolver with broken count: 0 137s Starting 2 pkgProblemResolver with broken count: 0 137s Done 137s Solving dependencies... 137s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 137s autopkgtest [19:26:23]: rebooting testbed after setup commands that affected boot 156s autopkgtest [19:26:42]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP Wed Mar 12 14:53:49 UTC 2025 158s autopkgtest [19:26:44]: @@@@@@@@@@@@@@@@@@@@ apt-source systemd-bootchart 160s Get:1 http://ftpmaster.internal/ubuntu plucky/universe systemd-bootchart 235-2 (dsc) [2255 B] 160s Get:2 http://ftpmaster.internal/ubuntu plucky/universe systemd-bootchart 235-2 (tar) [111 kB] 160s Get:3 http://ftpmaster.internal/ubuntu plucky/universe systemd-bootchart 235-2 (diff) [4476 B] 160s gpgv: Signature made Wed Jan 10 00:16:33 2024 UTC 160s gpgv: using RSA key 09B3AC2ECB169C904345CC546AE1DF0D608F22DC 160s gpgv: Can't check signature: No public key 160s dpkg-source: warning: cannot verify inline signature for ./systemd-bootchart_235-2.dsc: no acceptable signature found 160s autopkgtest [19:26:46]: testing package systemd-bootchart version 235-2 160s autopkgtest [19:26:46]: build not needed 161s autopkgtest [19:26:47]: test bootchart: preparing testbed 161s Reading package lists... 161s Building dependency tree... 161s Reading state information... 161s Starting pkgProblemResolver with broken count: 0 161s Starting 2 pkgProblemResolver with broken count: 0 161s Done 161s The following NEW packages will be installed: 161s systemd-bootchart 162s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 162s Need to get 48.9 kB of archives. 162s After this operation, 130 kB of additional disk space will be used. 162s Get:1 http://ftpmaster.internal/ubuntu plucky/universe s390x systemd-bootchart s390x 235-2 [48.9 kB] 162s Fetched 48.9 kB in 0s (170 kB/s) 162s Selecting previously unselected package systemd-bootchart. 162s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 56326 files and directories currently installed.) 162s Preparing to unpack .../systemd-bootchart_235-2_s390x.deb ... 162s Unpacking systemd-bootchart (235-2) ... 162s Setting up systemd-bootchart (235-2) ... 162s systemd-bootchart.service is a disabled or a static unit, not starting it. 162s Processing triggers for man-db (2.13.0-1) ... 164s autopkgtest [19:26:50]: test bootchart: [----------------------- 164s Not using grub, skipping 164s autopkgtest [19:26:50]: test bootchart: -----------------------] 165s bootchart PASS 165s autopkgtest [19:26:51]: test bootchart: - - - - - - - - - - results - - - - - - - - - - 165s autopkgtest [19:26:51]: @@@@@@@@@@@@@@@@@@@@ summary 165s bootchart PASS 183s nova [W] Using flock in prodstack6-s390x 183s flock: timeout while waiting to get lock 183s Creating nova instance adt-plucky-s390x-systemd-bootchart-20250315-192406-juju-7f2275-prod-proposed-migration-environment-15-a5796fad-b1c0-43ae-a1ee-5991d5f66041 from image adt/ubuntu-plucky-s390x-server-20250315.img (UUID 3d3557fa-fd0f-4bba-9b89-8d5964e09f61)... 183s nova [W] Timed out waiting for 9b09d3fe-d3e7-477e-836b-759ce1b22963 to get deleted.