0s autopkgtest [14:08:16]: starting date and time: 2025-03-15 14:08:16+0000 0s autopkgtest [14:08:16]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [14:08:16]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.gahd78mb/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade pandoc-citeproc-preamble --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-33.secgroup --name adt-plucky-arm64-pandoc-citeproc-preamble-20250315-140816-juju-7f2275-prod-proposed-migration-environment-15-9ddff3c2-01fa-4dbd-856e-1ba65c164f78 --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/ 158s autopkgtest [14:10:54]: testbed dpkg architecture: arm64 159s autopkgtest [14:10:55]: testbed apt version: 2.9.33 159s autopkgtest [14:10:55]: @@@@@@@@@@@@@@@@@@@@ test bed setup 159s autopkgtest [14:10:55]: testbed release detected to be: None 160s autopkgtest [14:10:56]: updating testbed package index (apt update) 160s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 161s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 161s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 161s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 161s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 161s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [101 kB] 161s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [404 kB] 161s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [78.2 kB] 161s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1976 B] 161s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 161s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [346 kB] 161s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [15.8 kB] 161s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B] 161s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [572 B] 162s Fetched 1094 kB in 1s (863 kB/s) 163s Reading package lists... 163s + lsb_release --codename --short 163s + RELEASE=plucky 163s + cat 163s + [ plucky != trusty ] 163s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 163s Reading package lists... 164s Building dependency tree... 164s Reading state information... 164s Calculating upgrade... 164s Calculating upgrade... 165s The following packages will be upgraded: 165s python3-jinja2 strace 165s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 165s Need to get 608 kB of archives. 165s After this operation, 11.3 kB of additional disk space will be used. 165s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 165s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 166s Fetched 608 kB in 1s (758 kB/s) 166s (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.) 166s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 166s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 166s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 166s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 166s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 167s Setting up strace (6.13+ds-1ubuntu1) ... 167s Processing triggers for man-db (2.13.0-1) ... 167s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 167s + /usr/lib/apt/apt-helper analyze-pattern ?true 167s + uname -r 167s + sed s/\./\\./g 167s + running_kernel_pattern=^linux-.*6\.14\.0-10-generic.* 167s + apt list ?obsolete 167s + tail -n+2 167s + grep -v ^linux-.*6\.14\.0-10-generic.* 167s + cut -d/ -f1 168s Reading package lists... 168s + obsolete_pkgs=linux-headers-6.11.0-8-generic 168s linux-headers-6.11.0-8 168s linux-image-6.11.0-8-generic 168s linux-modules-6.11.0-8-generic 168s linux-tools-6.11.0-8-generic 168s linux-tools-6.11.0-8 168s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y purge --autoremove linux-headers-6.11.0-8-generic 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 168s Building dependency tree... 168s Reading state information... 168s Solving dependencies... 169s The following packages will be REMOVED: 169s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 169s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 169s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 169s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 169s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded. 169s After this operation, 267 MB disk space will be freed. 169s (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.) 169s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 169s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 169s Removing libpython3.12t64:arm64 (3.12.9-1) ... 169s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 169s Removing libnsl2:arm64 (1.3.0-3build3) ... 169s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 169s Removing libunwind8:arm64 (1.6.2-3.1) ... 169s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 170s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 171s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 171s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 171s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 171s /etc/kernel/postrm.d/initramfs-tools: 171s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 172s /etc/kernel/postrm.d/zz-flash-kernel: 172s flash-kernel: Kernel 6.11.0-8-generic has been removed. 172s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 172s /etc/kernel/postrm.d/zz-update-grub: 172s Sourcing file `/etc/default/grub' 172s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 172s Generating grub configuration file ... 172s Found linux image: /boot/vmlinuz-6.14.0-10-generic 172s Found initrd image: /boot/initrd.img-6.14.0-10-generic 172s Warning: os-prober will not be executed to detect other bootable partitions. 172s Systems on them will not be added to the GRUB boot configuration. 172s Check GRUB_DISABLE_OS_PROBER documentation entry. 172s Adding boot menu entry for UEFI Firmware Settings ... 173s done 173s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 173s Processing triggers for libc-bin (2.41-1ubuntu1) ... 173s (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.) 173s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 173s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 173s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 173s + grep -q trusty /etc/lsb-release 173s + [ ! -d /usr/share/doc/unattended-upgrades ] 173s + [ ! -d /usr/share/doc/lxd ] 173s + [ ! -d /usr/share/doc/lxd-client ] 173s + [ ! -d /usr/share/doc/snapd ] 173s + type iptables 173s + cat 173s + chmod 755 /etc/rc.local 173s + . /etc/rc.local 173s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 173s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 173s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 173s + uname -m 173s + [ aarch64 = ppc64le ] 173s + [ -d /run/systemd/system ] 173s + systemd-detect-virt --quiet --vm 173s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 173s + cat 173s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 173s + echo COMPRESS=lz4 173s autopkgtest [14:11:09]: upgrading testbed (apt dist-upgrade and autopurge) 173s Reading package lists... 174s Building dependency tree... 174s Reading state information... 174s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 174s Starting 2 pkgProblemResolver with broken count: 0 174s Done 175s Entering ResolveByKeep 175s 175s Calculating upgrade... 176s The following packages will be upgraded: 176s libc-bin libc-dev-bin libc6 libc6-dev locales 176s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 176s Need to get 9530 kB of archives. 176s After this operation, 0 B of additional disk space will be used. 176s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB] 178s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB] 178s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB] 180s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB] 180s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB] 184s Preconfiguring packages ... 184s Fetched 9530 kB in 8s (1256 kB/s) 184s (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.) 184s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ... 184s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 184s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ... 184s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 184s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ... 184s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 184s Setting up libc6:arm64 (2.41-1ubuntu2) ... 185s (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.) 185s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ... 185s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 185s Setting up libc-bin (2.41-1ubuntu2) ... 185s (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.) 185s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 185s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 185s Setting up locales (2.41-1ubuntu2) ... 186s Generating locales (this might take a while)... 188s en_US.UTF-8... done 188s Generation complete. 188s Setting up libc-dev-bin (2.41-1ubuntu2) ... 188s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ... 188s Processing triggers for man-db (2.13.0-1) ... 189s Processing triggers for systemd (257.3-1ubuntu3) ... 189s Reading package lists... 190s Building dependency tree... 190s Reading state information... 190s Starting pkgProblemResolver with broken count: 0 190s Starting 2 pkgProblemResolver with broken count: 0 190s Done 191s Solving dependencies... 191s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 191s autopkgtest [14:11:27]: rebooting testbed after setup commands that affected boot 214s autopkgtest [14:11:50]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 217s autopkgtest [14:11:53]: @@@@@@@@@@@@@@@@@@@@ apt-source pandoc-citeproc-preamble 219s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pandoc-citeproc-preamble 1.7-2 (dsc) [2317 B] 219s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pandoc-citeproc-preamble 1.7-2 (tar) [18.8 kB] 219s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pandoc-citeproc-preamble 1.7-2 (diff) [3516 B] 220s gpgv: Signature made Thu Mar 21 11:14:45 2024 UTC 220s gpgv: using RSA key 9B917007AE030E36E4FC248B695B7AE4BF066240 220s gpgv: Can't check signature: No public key 220s dpkg-source: warning: cannot verify inline signature for ./pandoc-citeproc-preamble_1.7-2.dsc: no acceptable signature found 220s autopkgtest [14:11:56]: testing package pandoc-citeproc-preamble version 1.7-2 220s autopkgtest [14:11:56]: build not needed 220s autopkgtest [14:11:56]: test command1: preparing testbed 221s Reading package lists... 221s Building dependency tree... 221s Reading state information... 221s Starting pkgProblemResolver with broken count: 0 221s Starting 2 pkgProblemResolver with broken count: 0 221s Done 222s The following NEW packages will be installed: 222s liblua5.4-0 pandoc pandoc-citeproc-preamble pandoc-data 222s 0 upgraded, 4 newly installed, 0 to remove and 0 not upgraded. 222s Need to get 33.2 MB of archives. 222s After this operation, 250 MB of additional disk space will be used. 222s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 liblua5.4-0 arm64 5.4.7-1 [158 kB] 223s Get:2 http://ftpmaster.internal/ubuntu plucky/universe arm64 pandoc-data all 3.1.11.1-3build1 [78.8 kB] 223s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 pandoc arm64 3.1.11.1+ds-2 [28.1 MB] 241s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 pandoc-citeproc-preamble arm64 1.7-2 [4883 kB] 245s Fetched 33.2 MB in 23s (1441 kB/s) 245s Selecting previously unselected package liblua5.4-0:arm64. 246s (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.) 246s Preparing to unpack .../liblua5.4-0_5.4.7-1_arm64.deb ... 246s Unpacking liblua5.4-0:arm64 (5.4.7-1) ... 246s Selecting previously unselected package pandoc-data. 246s Preparing to unpack .../pandoc-data_3.1.11.1-3build1_all.deb ... 246s Unpacking pandoc-data (3.1.11.1-3build1) ... 246s Selecting previously unselected package pandoc. 246s Preparing to unpack .../pandoc_3.1.11.1+ds-2_arm64.deb ... 246s Unpacking pandoc (3.1.11.1+ds-2) ... 247s Selecting previously unselected package pandoc-citeproc-preamble. 247s Preparing to unpack .../pandoc-citeproc-preamble_1.7-2_arm64.deb ... 247s Unpacking pandoc-citeproc-preamble (1.7-2) ... 247s Setting up pandoc-citeproc-preamble (1.7-2) ... 247s Setting up liblua5.4-0:arm64 (5.4.7-1) ... 247s Setting up pandoc-data (3.1.11.1-3build1) ... 247s Setting up pandoc (3.1.11.1+ds-2) ... 247s Processing triggers for man-db (2.13.0-1) ... 247s Processing triggers for libc-bin (2.41-1ubuntu2) ... 249s autopkgtest [14:12:25]: test command1: test/test 249s autopkgtest [14:12:25]: test command1: [----------------------- 249s testing with pandoc 3.1.11.1 250s success: citeproc preamble inserted as expected 250s autopkgtest [14:12:26]: test command1: -----------------------] 250s autopkgtest [14:12:26]: test command1: - - - - - - - - - - results - - - - - - - - - - 250s command1 PASS 251s autopkgtest [14:12:27]: @@@@@@@@@@@@@@@@@@@@ summary 251s command1 PASS 269s nova [W] Using flock in prodstack6-arm64 269s flock: timeout while waiting to get lock 269s Creating nova instance adt-plucky-arm64-pandoc-citeproc-preamble-20250315-140816-juju-7f2275-prod-proposed-migration-environment-15-9ddff3c2-01fa-4dbd-856e-1ba65c164f78 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 269s nova [W] Timed out waiting for fc6f516e-0262-447e-9fab-0379a938d7c3 to get deleted.