0s autopkgtest [13:37:53]: starting date and time: 2025-03-15 13:37:53+0000
  1s autopkgtest [13:37:54]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  1s autopkgtest [13:37:54]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.mgpfnrns/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade nq --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 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-32.secgroup --name adt-plucky-arm64-nq-20250315-133752-juju-7f2275-prod-proposed-migration-environment-15-5c017321-6146-49d2-a90a-be1c9cb00f98 --image adt/ubuntu-plucky-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration -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/
181s autopkgtest [13:40:54]: testbed dpkg architecture: arm64
181s autopkgtest [13:40:54]: testbed apt version: 2.9.33
181s autopkgtest [13:40:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup
182s autopkgtest [13:40:55]: testbed release detected to be: None
182s autopkgtest [13:40:55]: updating testbed package index (apt update)
183s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB]
183s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
183s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
183s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
183s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB]
183s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [101 kB]
184s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [404 kB]
184s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [78.2 kB]
184s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1976 B]
184s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B]
184s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [346 kB]
185s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [15.8 kB]
185s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B]
185s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [572 B]
185s Fetched 1094 kB in 2s (549 kB/s)
186s Reading package lists...
187s + lsb_release --codename --short
187s + RELEASE=plucky
187s + cat
187s + [ plucky != trusty ]
187s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade
187s Reading package lists...
188s Building dependency tree...
188s Reading state information...
189s Calculating upgrade...
189s Calculating upgrade...
190s The following packages will be upgraded:
190s   python3-jinja2 strace
190s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
190s Need to get 608 kB of archives.
190s After this operation, 11.3 kB of additional disk space will be used.
190s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB]
191s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB]
192s Fetched 608 kB in 1s (562 kB/s)
192s (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 ... 117701 files and directories currently installed.)
192s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ...
192s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ...
192s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ...
192s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ...
192s Setting up python3-jinja2 (3.1.5-2ubuntu1) ...
193s Setting up strace (6.13+ds-1ubuntu1) ...
193s Processing triggers for man-db (2.13.0-1) ...
194s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref
194s + /usr/lib/apt/apt-helper analyze-pattern ?true
194s + uname -r
194s + sed s/\./\\./g
194s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.*
194s + apt list ?obsolete
194s + tail -n+2
194s + cut -d/ -f1
194s + grep -v ^linux-.*6\.14\.0-10-generic.*
194s + obsolete_pkgs=linux-headers-6.11.0-8-generic
194s linux-headers-6.11.0-8
194s linux-image-6.11.0-8-generic
194s linux-modules-6.11.0-8-generic
194s linux-tools-6.11.0-8-generic
194s linux-tools-6.11.0-8
194s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-genericReading package lists...
194s Building dependency tree... linux-headers-6.11.0-8 linux-image-6.11.0-8-generic linux-modules-6.11.0-8-generic linux-tools-6.11.0-8-generic linux-tools-6.11.0-8
195s 
195s Reading state information...
195s Solving dependencies...
196s The following packages will be REMOVED:
196s   libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64*
196s   libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic*
196s   linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic*
196s   linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic*
197s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded.
197s After this operation, 267 MB disk space will be freed.
197s (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 ... 117701 files and directories currently installed.)
197s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ...
197s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ...
197s Removing libpython3.12t64:arm64 (3.12.9-1) ...
197s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ...
197s Removing libnsl2:arm64 (1.3.0-3build3) ...
197s Removing libpython3.12-minimal:arm64 (3.12.9-1) ...
198s Removing libunwind8:arm64 (1.6.2-3.1) ...
198s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ...
198s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ...
200s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ...
200s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic
200s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic
200s /etc/kernel/postrm.d/initramfs-tools:
200s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic
201s /etc/kernel/postrm.d/zz-flash-kernel:
201s flash-kernel: Kernel 6.11.0-8-generic has been removed.
201s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required.
201s /etc/kernel/postrm.d/zz-update-grub:
201s Sourcing file `/etc/default/grub'
201s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg'
201s Generating grub configuration file ...
201s Found linux image: /boot/vmlinuz-6.14.0-10-generic
201s Found initrd image: /boot/initrd.img-6.14.0-10-generic
202s Warning: os-prober will not be executed to detect other bootable partitions.
202s Systems on them will not be added to the GRUB boot configuration.
202s Check GRUB_DISABLE_OS_PROBER documentation entry.
202s Adding boot menu entry for UEFI Firmware Settings ...
202s done
202s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
202s Processing triggers for libc-bin (2.41-1ubuntu1) ...
202s (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 ... 81650 files and directories currently installed.)
202s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ...
203s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ...
203s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ...
203s + grep -q trusty /etc/lsb-release
203s + [ ! -d /usr/share/doc/unattended-upgrades ]
203s + [ ! -d /usr/share/doc/lxd ]
203s + [ ! -d /usr/share/doc/lxd-client ]
203s + [ ! -d /usr/share/doc/snapd ]
203s + type iptables
203s + cat
203s + chmod 755 /etc/rc.local
203s + . /etc/rc.local
203s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu
203s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP
203s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP
203s + uname -m
203s + [ aarch64 = ppc64le ]
203s + [ -d /run/systemd/system ]
203s + systemd-detect-virt --quiet --vm
203s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/
203s + cat
203s + grep -q lz4 /etc/initramfs-tools/initramfs.conf
203s + echo COMPRESS=lz4
203s autopkgtest [13:41:16]: upgrading testbed (apt dist-upgrade and autopurge)
203s Reading package lists...
204s Building dependency tree...
204s Reading state information...
205s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
205s Starting 2 pkgProblemResolver with broken count: 0
205s Done
207s Entering ResolveByKeep
207s 
208s Calculating upgrade...
208s The following packages will be upgraded:
208s   libc-bin libc-dev-bin libc6 libc6-dev locales
209s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
209s Need to get 9530 kB of archives.
209s After this operation, 0 B of additional disk space will be used.
209s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB]
211s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB]
211s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB]
214s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB]
215s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB]
220s Preconfiguring packages ...
220s Fetched 9530 kB in 11s (857 kB/s)
220s (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 ... 81647 files and directories currently installed.)
220s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ...
220s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
221s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ...
221s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
221s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ...
221s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
221s Setting up libc6:arm64 (2.41-1ubuntu2) ...
221s (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 ... 81647 files and directories currently installed.)
221s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ...
221s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
222s Setting up libc-bin (2.41-1ubuntu2) ...
222s (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 ... 81647 files and directories currently installed.)
222s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ...
222s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ...
222s Setting up locales (2.41-1ubuntu2) ...
223s Generating locales (this might take a while)...
226s   en_US.UTF-8... done
226s Generation complete.
226s Setting up libc-dev-bin (2.41-1ubuntu2) ...
226s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ...
226s Processing triggers for man-db (2.13.0-1) ...
227s Processing triggers for systemd (257.3-1ubuntu3) ...
228s Reading package lists...
229s Building dependency tree...
229s Reading state information...
230s Starting pkgProblemResolver with broken count: 0
230s Starting 2 pkgProblemResolver with broken count: 0
230s Done
231s Solving dependencies...
232s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
232s autopkgtest [13:41:45]: rebooting testbed after setup commands that affected boot
258s autopkgtest [13:42:11]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025
263s autopkgtest [13:42:16]: @@@@@@@@@@@@@@@@@@@@ apt-source nq
265s Get:1 http://ftpmaster.internal/ubuntu plucky/universe nq 1.0-0.2 (dsc) [1912 B]
265s Get:2 http://ftpmaster.internal/ubuntu plucky/universe nq 1.0-0.2 (tar) [11.6 kB]
265s Get:3 http://ftpmaster.internal/ubuntu plucky/universe nq 1.0-0.2 (diff) [4200 B]
265s gpgv: Signature made Mon Jul 22 10:33:21 2024 UTC
265s gpgv:                using RSA key 6971A60BF9E46C88717F5EA4C6265846ABE02C8B
265s gpgv: Can't check signature: No public key
265s dpkg-source: warning: cannot verify inline signature for ./nq_1.0-0.2.dsc: no acceptable signature found
265s autopkgtest [13:42:18]: testing package nq version 1.0-0.2
266s autopkgtest [13:42:19]: build not needed
266s autopkgtest [13:42:19]: test run-testsuite: preparing testbed
266s Reading package lists...
267s Building dependency tree...
267s Reading state information...
267s Starting pkgProblemResolver with broken count: 0
267s Starting 2 pkgProblemResolver with broken count: 0
267s Done
268s The following NEW packages will be installed:
268s   nq
268s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
268s Need to get 13.3 kB of archives.
268s After this operation, 157 kB of additional disk space will be used.
268s Get:1 http://ftpmaster.internal/ubuntu plucky/universe arm64 nq arm64 1.0-0.2 [13.3 kB]
269s Fetched 13.3 kB in 0s (64.5 kB/s)
269s Selecting previously unselected package nq.
269s (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 ... 81647 files and directories currently installed.)
269s Preparing to unpack .../archives/nq_1.0-0.2_arm64.deb ...
269s Unpacking nq (1.0-0.2) ...
269s Setting up nq (1.0-0.2) ...
269s Processing triggers for man-db (2.13.0-1) ...
271s autopkgtest [13:42:24]: test run-testsuite: [-----------------------
280s ./tests .. 
280s 1..36
280s # nq tests
280s ok - fails with no arguments
280s ok - succeeds enqueuing true
280s ok - generated a lockfile
280s ok - lockfile contains exec line
280s ok - lockfile contains status line
280s ok - lockfile is not executable
280s # queue tests
280s ok - enqueing true
280s ok - enqueing sleep 500
280s ok - first job is done already
280s ok - not all jobs are done already
280s ok - running job is executable
280s ok - running job not done already
280s ok - can kill running job
280s ok - killed job is not executable anymore
280s ok - killed job contains status line
280s # env tests
280s ok - enqueing env
280s ok - NQJOBID is set
280s # killing tests
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - killing first job
280s ok - killing third job
280s ok - second job is running
280s ok - fourth job is running
280s ok - all jobs are done
280s # nqtail tests
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - spawning four jobs
280s ok - nqtail tracks first job
280s ok - killing first job
280s ok - killing fourth job
280s ok - nqtail tracks third job
280s ok - killing third job
280s ok - nqtail outputs last job when no job running
280s ok
280s All tests successful.
280s Files=1, Tests=36,  8 wallclock secs ( 0.06 usr  0.01 sys +  0.01 cusr  0.11 csys =  0.19 CPU)
280s Result: PASS
280s autopkgtest [13:42:33]: test run-testsuite: -----------------------]
281s run-testsuite        PASS
281s autopkgtest [13:42:34]: test run-testsuite:  - - - - - - - - - - results - - - - - - - - - -
281s autopkgtest [13:42:34]: @@@@@@@@@@@@@@@@@@@@ summary
281s run-testsuite        PASS
299s nova [W] Using flock in prodstack6-arm64
299s flock: timeout while waiting to get lock
299s Creating nova instance adt-plucky-arm64-nq-20250315-133752-juju-7f2275-prod-proposed-migration-environment-15-5c017321-6146-49d2-a90a-be1c9cb00f98 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)...
299s nova [W] Timed out waiting for 7bf9e1fc-1387-4f07-922d-e42627dd083b to get deleted.