0s autopkgtest [21:28:34]: starting date and time: 2025-02-05 21:28:34+0000 0s autopkgtest [21:28:34]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [21:28:34]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vlohfc2b/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:libuv1 --apt-upgrade bind9 --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=libuv1/1.50.0-2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-arm64-5.secgroup --name adt-plucky-arm64-bind9-20250205-212834-juju-7f2275-prod-proposed-migration-environment-15-01404c70-0c6d-4d84-bf7d-3d7f04afd8d7 --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/ 103s autopkgtest [21:30:17]: testbed dpkg architecture: arm64 103s autopkgtest [21:30:17]: testbed apt version: 2.9.18 104s autopkgtest [21:30:18]: @@@@@@@@@@@@@@@@@@@@ test bed setup 104s autopkgtest [21:30:18]: testbed release detected to be: None 106s autopkgtest [21:30:20]: updating testbed package index (apt update) 107s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB] 108s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 109s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 109s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 109s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [794 kB] 122s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.0 kB] 122s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [65.9 kB] 123s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [95.1 kB] 123s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [763 kB] 130s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4156 B] 130s Fetched 1846 kB in 24s (77.0 kB/s) 131s Reading package lists... 133s + lsb_release --codename --short 133s + RELEASE=plucky 133s + cat 133s + [ plucky != trusty ] 133s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -y --allow-downgrades -o Dpkg::Options::=--force-confnew dist-upgrade 133s Reading package lists... 133s Building dependency tree... 133s Reading state information... 134s Calculating upgrade... 135s The following packages will be upgraded: 135s cloud-init cloud-init-base hwdata kpartx libpng16-16t64 libusb-1.0-0 mawk 135s multipath-tools python-apt-common python3-apt 136s 10 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 136s Need to get 1583 kB of archives. 136s After this operation, 17.4 kB of additional disk space will be used. 136s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 mawk arm64 1.3.4.20250131-1 [127 kB] 138s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 python-apt-common all 2.9.8 [21.1 kB] 138s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-apt arm64 2.9.8 [191 kB] 140s Get:4 http://ftpmaster.internal/ubuntu plucky/main arm64 libpng16-16t64 arm64 1.6.46-4 [190 kB] 142s Get:5 http://ftpmaster.internal/ubuntu plucky/main arm64 libusb-1.0-0 arm64 2:1.0.27-2 [54.1 kB] 142s Get:6 http://ftpmaster.internal/ubuntu plucky/main arm64 cloud-init-base all 25.1~3geb1965a4-0ubuntu1 [615 kB] 149s Get:7 http://ftpmaster.internal/ubuntu plucky/main arm64 hwdata all 0.392-1 [29.5 kB] 149s Get:8 http://ftpmaster.internal/ubuntu plucky/main arm64 cloud-init all 25.1~3geb1965a4-0ubuntu1 [2102 B] 149s Get:9 http://ftpmaster.internal/ubuntu plucky/main arm64 kpartx arm64 0.9.9-1ubuntu4 [35.2 kB] 150s Get:10 http://ftpmaster.internal/ubuntu plucky/main arm64 multipath-tools arm64 0.9.9-1ubuntu4 [319 kB] 160s Preconfiguring packages ... 160s Fetched 1583 kB in 24s (66.3 kB/s) 161s (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 ... 116621 files and directories currently installed.) 161s Preparing to unpack .../0-mawk_1.3.4.20250131-1_arm64.deb ... 161s Unpacking mawk (1.3.4.20250131-1) over (1.3.4.20240905-1) ... 161s Preparing to unpack .../1-python-apt-common_2.9.8_all.deb ... 161s Unpacking python-apt-common (2.9.8) over (2.9.6build1) ... 161s Preparing to unpack .../2-python3-apt_2.9.8_arm64.deb ... 161s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 161s for fn in glob1(directory, "%s.*" % fname): 161s Unpacking python3-apt (2.9.8) over (2.9.6build1) ... 161s Preparing to unpack .../3-libpng16-16t64_1.6.46-4_arm64.deb ... 161s Unpacking libpng16-16t64:arm64 (1.6.46-4) over (1.6.44-3) ... 161s Preparing to unpack .../4-libusb-1.0-0_2%3a1.0.27-2_arm64.deb ... 161s Unpacking libusb-1.0-0:arm64 (2:1.0.27-2) over (2:1.0.27-1) ... 161s Preparing to unpack .../5-cloud-init-base_25.1~3geb1965a4-0ubuntu1_all.deb ... 161s /usr/bin/py3clean:101: DeprecationWarning: glob.glob1 is deprecated and will be removed in Python 3.15. Use glob.glob and pass a directory to its root_dir argument instead. 161s for fn in glob1(directory, "%s.*" % fname): 161s Unpacking cloud-init-base (25.1~3geb1965a4-0ubuntu1) over (25.1~2g4ee65391-0ubuntu1) ... 162s Preparing to unpack .../6-hwdata_0.392-1_all.deb ... 162s Unpacking hwdata (0.392-1) over (0.387-1) ... 162s Preparing to unpack .../7-cloud-init_25.1~3geb1965a4-0ubuntu1_all.deb ... 162s Unpacking cloud-init (25.1~3geb1965a4-0ubuntu1) over (25.1~2g4ee65391-0ubuntu1) ... 163s Preparing to unpack .../8-kpartx_0.9.9-1ubuntu4_arm64.deb ... 163s Unpacking kpartx (0.9.9-1ubuntu4) over (0.9.9-1ubuntu3) ... 163s Preparing to unpack .../9-multipath-tools_0.9.9-1ubuntu4_arm64.deb ... 163s Unpacking multipath-tools (0.9.9-1ubuntu4) over (0.9.9-1ubuntu3) ... 163s Setting up cloud-init-base (25.1~3geb1965a4-0ubuntu1) ... 164s Setting up hwdata (0.392-1) ... 164s Setting up libpng16-16t64:arm64 (1.6.46-4) ... 164s Setting up python-apt-common (2.9.8) ... 164s Setting up kpartx (0.9.9-1ubuntu4) ... 164s Setting up mawk (1.3.4.20250131-1) ... 164s Setting up libusb-1.0-0:arm64 (2:1.0.27-2) ... 164s Setting up cloud-init (25.1~3geb1965a4-0ubuntu1) ... 164s Setting up python3-apt (2.9.8) ... 165s Setting up multipath-tools (0.9.9-1ubuntu4) ... 165s Processing triggers for rsyslog (8.2406.0-1ubuntu2) ... 166s Processing triggers for man-db (2.13.0-1) ... 168s Processing triggers for libc-bin (2.40-4ubuntu1) ... 168s + rm /etc/apt/preferences.d/force-downgrade-to-release.pref 168s + /usr/lib/apt/apt-helper analyze-pattern ?true 168s + uname -r 168s + sed s/\./\\./g 168s + running_kernel_pattern=^linux-.*6\.12\.0-12-generic.* 168s + tail -n+2 168s + apt list ?obsolete 168s + cut -d/ -f1 168s + grep -v ^linux-.*6\.12\.0-12-generic.* 169s + true 169s + obsolete_pkgs= 169s + DEBIAN_FRONTEND=noninteractive eatmydata apt-get -yReading package lists... 169s Building dependency tree... purge --autoremove 169s 169s Reading state information... 170s 0 upgraded, 0 newly installed, 0 to remove and 1 not upgraded. 170s + grep -q trusty /etc/lsb-release 170s + [ ! -d /usr/share/doc/unattended-upgrades ] 170s + [ ! -d /usr/share/doc/lxd ] 170s + [ ! -d /usr/share/doc/lxd-client ] 170s + [ ! -d /usr/share/doc/snapd ] 170s + type iptables 170s + cat 170s + chmod 755 /etc/rc.local 170s + . /etc/rc.local 170s + iptables -w -t mangle -A FORWARD -p tcp --tcp-flags SYN,RST SYN -j TCPMSS --clamp-mss-to-pmtu 170s + iptables -A OUTPUT -d 10.255.255.1/32 -p tcp -j DROP 170s + iptables -A OUTPUT -d 10.255.255.2/32 -p tcp -j DROP 170s + uname -m 170s + [ aarch64 = ppc64le ] 170s + [ -d /run/systemd/system ] 170s + systemd-detect-virt --quiet --vm 170s + mkdir -p /etc/systemd/system/systemd-random-seed.service.d/ 170s + cat 170s + grep -q lz4 /etc/initramfs-tools/initramfs.conf 170s + echo COMPRESS=lz4 170s autopkgtest [21:31:24]: upgrading testbed (apt dist-upgrade and autopurge) 171s Reading package lists... 171s Building dependency tree... 171s Reading state information... 172s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 172s Starting 2 pkgProblemResolver with broken count: 0 172s Done 173s Entering ResolveByKeep 173s 174s The following packages will be upgraded: 174s libuv1t64 174s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 174s Need to get 99.8 kB of archives. 174s After this operation, 3072 B disk space will be freed. 174s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libuv1t64 arm64 1.50.0-2 [99.8 kB] 176s Fetched 99.8 kB in 2s (59.5 kB/s) 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 ... 116621 files and directories currently installed.) 176s Preparing to unpack .../libuv1t64_1.50.0-2_arm64.deb ... 176s Unpacking libuv1t64:arm64 (1.50.0-2) over (1.48.0-7) ... 176s Setting up libuv1t64:arm64 (1.50.0-2) ... 176s Processing triggers for libc-bin (2.40-4ubuntu1) ... 177s Reading package lists... 177s Building dependency tree... 177s Reading state information... 178s Starting pkgProblemResolver with broken count: 0 179s Starting 2 pkgProblemResolver with broken count: 0 179s Done 180s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 180s autopkgtest [21:31:34]: rebooting testbed after setup commands that affected boot 207s autopkgtest [21:32:01]: testbed running kernel: Linux 6.12.0-12-generic #12-Ubuntu SMP PREEMPT_DYNAMIC Thu Jan 23 07:24:57 UTC 2025 212s autopkgtest [21:32:06]: @@@@@@@@@@@@@@@@@@@@ apt-source bind9 307s Get:1 http://ftpmaster.internal/ubuntu plucky/main bind9 1:9.20.0-2ubuntu4 (dsc) [3192 B] 307s Get:2 http://ftpmaster.internal/ubuntu plucky/main bind9 1:9.20.0-2ubuntu4 (tar) [5760 kB] 307s Get:3 http://ftpmaster.internal/ubuntu plucky/main bind9 1:9.20.0-2ubuntu4 (asc) [833 B] 307s Get:4 http://ftpmaster.internal/ubuntu plucky/main bind9 1:9.20.0-2ubuntu4 (diff) [82.0 kB] 307s gpgv: Signature made Wed Jan 29 20:08:43 2025 UTC 307s gpgv: using RSA key 50C4A0DDCF31E452CEB19B516569D855A744BE93 307s gpgv: Can't check signature: No public key 307s dpkg-source: warning: cannot verify inline signature for ./bind9_9.20.0-2ubuntu4.dsc: no acceptable signature found 308s autopkgtest [21:33:42]: testing package bind9 version 1:9.20.0-2ubuntu4 309s autopkgtest [21:33:43]: build not needed 319s autopkgtest [21:33:53]: test simpletest: preparing testbed 319s Reading package lists... 320s Building dependency tree... 320s Reading state information... 321s Starting pkgProblemResolver with broken count: 0 321s Starting 2 pkgProblemResolver with broken count: 0 321s Done 322s The following NEW packages will be installed: 322s bind9 bind9-utils dns-root-data 322s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 322s Need to get 434 kB of archives. 322s After this operation, 2511 kB of additional disk space will be used. 322s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 bind9-utils arm64 1:9.20.0-2ubuntu4 [180 kB] 324s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 dns-root-data all 2024071801 [5802 B] 324s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 bind9 arm64 1:9.20.0-2ubuntu4 [248 kB] 328s Fetched 434 kB in 5s (86.1 kB/s) 328s Selecting previously unselected package bind9-utils. 328s (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 ... 116620 files and directories currently installed.) 328s Preparing to unpack .../bind9-utils_1%3a9.20.0-2ubuntu4_arm64.deb ... 328s Unpacking bind9-utils (1:9.20.0-2ubuntu4) ... 328s Selecting previously unselected package dns-root-data. 328s Preparing to unpack .../dns-root-data_2024071801_all.deb ... 328s Unpacking dns-root-data (2024071801) ... 328s Selecting previously unselected package bind9. 328s Preparing to unpack .../bind9_1%3a9.20.0-2ubuntu4_arm64.deb ... 328s Unpacking bind9 (1:9.20.0-2ubuntu4) ... 328s Setting up dns-root-data (2024071801) ... 328s Setting up bind9-utils (1:9.20.0-2ubuntu4) ... 328s Setting up bind9 (1:9.20.0-2ubuntu4) ... 328s info: Selecting GID from range 100 to 999 ... 328s info: Adding group `bind' (GID 108) ... 328s info: Selecting UID from range 100 to 999 ... 328s 328s info: Adding system user `bind' (UID 107) ... 328s info: Adding new user `bind' (UID 107) with group `bind' ... 328s info: Not creating home directory `/var/cache/bind'. 328s wrote key file "/etc/bind/rndc.key" 329s named-resolvconf.service is a disabled or a static unit, not starting it. 329s Created symlink '/etc/systemd/system/bind9.service' → '/usr/lib/systemd/system/named.service'. 329s Created symlink '/etc/systemd/system/multi-user.target.wants/named.service' → '/usr/lib/systemd/system/named.service'. 330s Processing triggers for man-db (2.13.0-1) ... 331s Processing triggers for ufw (0.36.2-9) ... 333s autopkgtest [21:34:07]: test simpletest: [----------------------- 334s 334s ; <<>> DiG 9.20.0-2ubuntu4-Ubuntu <<>> -x 127.0.0.1 @127.0.0.1 334s ;; global options: +cmd 334s ;; Got answer: 334s ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 61205 334s ;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 1 334s 334s ;; OPT PSEUDOSECTION: 334s ; EDNS: version: 0, flags:; udp: 1232 334s ; COOKIE: 394978920c3828c50100000067a3d95082897f34ff4b9956 (good) 334s ;; QUESTION SECTION: 334s ;1.0.0.127.in-addr.arpa. IN PTR 334s 334s ;; ANSWER SECTION: 334s 1.0.0.127.in-addr.arpa. 604800 IN PTR localhost. 334s 334s ;; Query time: 1 msec 334s ;; SERVER: 127.0.0.1#53(127.0.0.1) (UDP) 334s ;; WHEN: Wed Feb 05 21:34:08 UTC 2025 334s ;; MSG SIZE rcvd: 102 334s 335s autopkgtest [21:34:09]: test simpletest: -----------------------] 336s simpletest PASS 336s autopkgtest [21:34:10]: test simpletest: - - - - - - - - - - results - - - - - - - - - - 336s autopkgtest [21:34:10]: test validation: preparing testbed 337s Reading package lists... 337s Building dependency tree... 337s Reading state information... 337s Starting pkgProblemResolver with broken count: 0 338s Starting 2 pkgProblemResolver with broken count: 0 338s Done 338s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 340s autopkgtest [21:34:14]: test validation: [----------------------- 341s Checking for DNSSEC validation status of internetsociety.org 352s Checking for DNSSEC validation status of internetsociety.org 353s Checking for DNSSEC validation status of internetsociety.org 364s Checking for DNSSEC validation status of internetsociety.org 365s Checking for DNSSEC validation status of internetsociety.org 376s Checking for DNSSEC validation status of internetsociety.org 377s Checking for DNSSEC validation status of internetsociety.org 388s Checking for DNSSEC validation status of internetsociety.org 389s Checking for DNSSEC validation status of internetsociety.org 400s Checking for DNSSEC validation status of internetsociety.org 401s autopkgtest [21:35:15]: test validation: -----------------------] 402s validation FLAKY non-zero exit status 1 402s autopkgtest [21:35:16]: test validation: - - - - - - - - - - results - - - - - - - - - - 403s autopkgtest [21:35:17]: test zonetest: preparing testbed 403s Reading package lists... 403s Building dependency tree... 403s Reading state information... 404s Starting pkgProblemResolver with broken count: 0 404s Starting 2 pkgProblemResolver with broken count: 0 404s Done 405s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 407s autopkgtest [21:35:21]: test zonetest: [----------------------- 407s zone localdomain.test/IN: loaded serial 2 407s OK 407s ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 29012 407s autopkgtest [21:35:21]: test zonetest: -----------------------] 408s autopkgtest [21:35:22]: test zonetest: - - - - - - - - - - results - - - - - - - - - - 408s zonetest PASS 408s autopkgtest [21:35:22]: @@@@@@@@@@@@@@@@@@@@ summary 408s simpletest PASS 408s validation FLAKY non-zero exit status 1 408s zonetest PASS 426s nova [W] Using flock in prodstack6-arm64 426s Creating nova instance adt-plucky-arm64-bind9-20250205-212834-juju-7f2275-prod-proposed-migration-environment-15-01404c70-0c6d-4d84-bf7d-3d7f04afd8d7 from image adt/ubuntu-plucky-arm64-server-20250205.img (UUID 650b1626-24f3-4221-8285-745980105c15)... 426s nova [W] Timed out waiting for 50a972db-a1f9-4222-a032-d77fd0a4f7ec to get deleted.