0s autopkgtest [20:49:16]: starting date and time: 2025-11-19 20:49:16+0000 0s autopkgtest [20:49:16]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [20:49:16]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.50i0_sas/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:systemd,src:dhcpcd --apt-upgrade pdns-recursor --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/259~rc1-1ubuntu1 dhcpcd/1:10.3.0-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-s390x --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-s390x-13.secgroup --name adt-resolute-s390x-pdns-recursor-20251119-204916-juju-7f2275-prod-proposed-migration-environment-2-7a94d0c9-7f37-485b-8ddf-6e6b9b6db5c8 --image adt/ubuntu-resolute-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-proposed-migration-s390x -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-s390x-pdns-recursor-20251119-204916-juju-7f2275-prod-proposed-migration-environment-2-7a94d0c9-7f37-485b-8ddf-6e6b9b6db5c8 from image adt/ubuntu-resolute-s390x-server-20251119.img (UUID 4c8db693-79bc-4b39-96fd-37c94e575c4f)... 69s autopkgtest [20:50:25]: testbed dpkg architecture: s390x 69s autopkgtest [20:50:25]: testbed apt version: 3.1.12 70s autopkgtest [20:50:26]: @@@@@@@@@@@@@@@@@@@@ test bed setup 70s autopkgtest [20:50:26]: testbed release detected to be: None 71s autopkgtest [20:50:27]: updating testbed package index (apt update) 71s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [87.8 kB] 71s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 71s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 71s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 71s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [9848 B] 71s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [67.2 kB] 72s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [21.4 kB] 72s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [804 kB] 72s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x Packages [126 kB] 72s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted s390x Packages [1276 B] 72s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe s390x Packages [457 kB] 72s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse s390x Packages [6220 B] 72s Fetched 1580 kB in 1s (1128 kB/s) 73s Reading package lists... 74s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 74s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 74s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 74s Reading package lists... 74s Reading package lists... 75s Building dependency tree... 75s Reading state information... 75s Calculating upgrade... 75s The following packages will be upgraded: 75s dhcpcd-base libnss-systemd libpam-systemd libsystemd-shared libsystemd0 75s libudev1 libxml2-16 systemd systemd-cryptsetup systemd-resolved systemd-sysv 75s udev 75s 12 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 75s Need to get 9626 kB of archives. 75s After this operation, 1477 kB of additional disk space will be used. 75s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libsystemd0 s390x 259~rc1-1ubuntu1 [549 kB] 76s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x systemd-sysv s390x 259~rc1-1ubuntu1 [9256 B] 76s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x systemd-resolved s390x 259~rc1-1ubuntu1 [297 kB] 76s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libnss-systemd s390x 259~rc1-1ubuntu1 [188 kB] 76s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libpam-systemd s390x 259~rc1-1ubuntu1 [276 kB] 76s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libsystemd-shared s390x 259~rc1-1ubuntu1 [2519 kB] 77s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x systemd s390x 259~rc1-1ubuntu1 [3126 kB] 78s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x systemd-cryptsetup s390x 259~rc1-1ubuntu1 [127 kB] 78s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x udev s390x 259~rc1-1ubuntu1 [1480 kB] 78s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x libudev1 s390x 259~rc1-1ubuntu1 [214 kB] 78s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main s390x dhcpcd-base s390x 1:10.3.0-1 [225 kB] 78s Get:12 http://ftpmaster.internal/ubuntu resolute/main s390x libxml2-16 s390x 2.15.1+dfsg-0.4 [616 kB] 78s dpkg-preconfigure: unable to re-open stdin: No such file or directory 78s Fetched 9626 kB in 3s (2953 kB/s) 79s (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 ... 61309 files and directories currently installed.) 79s Preparing to unpack .../libsystemd0_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking libsystemd0:s390x (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Setting up libsystemd0:s390x (259~rc1-1ubuntu1) ... 79s (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 ... 61309 files and directories currently installed.) 79s Preparing to unpack .../systemd-sysv_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking systemd-sysv (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../systemd-resolved_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking systemd-resolved (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../libnss-systemd_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking libnss-systemd:s390x (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../libpam-systemd_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking libpam-systemd:s390x (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../libsystemd-shared_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking libsystemd-shared:s390x (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Setting up libsystemd-shared:s390x (259~rc1-1ubuntu1) ... 79s (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 ... 61308 files and directories currently installed.) 79s Preparing to unpack .../systemd_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking systemd (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../systemd-cryptsetup_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking systemd-cryptsetup (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../udev_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking udev (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Preparing to unpack .../libudev1_259~rc1-1ubuntu1_s390x.deb ... 79s Unpacking libudev1:s390x (259~rc1-1ubuntu1) over (257.9-0ubuntu2) ... 79s Setting up libudev1:s390x (259~rc1-1ubuntu1) ... 79s (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 ... 61373 files and directories currently installed.) 79s Preparing to unpack .../dhcpcd-base_1%3a10.3.0-1_s390x.deb ... 79s Unpacking dhcpcd-base (1:10.3.0-1) over (1:10.2.4-4) ... 79s Preparing to unpack .../libxml2-16_2.15.1+dfsg-0.4_s390x.deb ... 79s Unpacking libxml2-16:s390x (2.15.1+dfsg-0.4) over (2.15.1+dfsg-0.3) ... 79s Setting up libxml2-16:s390x (2.15.1+dfsg-0.4) ... 79s Setting up systemd (259~rc1-1ubuntu1) ... 79s Installing new version of config file /etc/systemd/journald.conf ... 79s Installing new version of config file /etc/systemd/logind.conf ... 79s Installing new version of config file /etc/systemd/networkd.conf ... 79s Installing new version of config file /etc/systemd/system.conf ... 79s Installing new version of config file /etc/systemd/user.conf ... 79s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 79s /usr/lib/tmpfiles.d/legacy.conf:14: Duplicate line for path "/run/lock", ignoring. 80s Setting up systemd-cryptsetup (259~rc1-1ubuntu1) ... 80s Setting up udev (259~rc1-1ubuntu1) ... 81s Setting up dhcpcd-base (1:10.3.0-1) ... 81s Installing new version of config file /etc/dhcpcd.conf ... 81s Creating group 'dhcpcd' with GID 986. 81s Setting up systemd-resolved (259~rc1-1ubuntu1) ... 81s Installing new version of config file /etc/systemd/resolved.conf ... 82s Created symlink '/etc/systemd/system/sockets.target.wants/systemd-resolved-monitor.socket' → '/usr/lib/systemd/system/systemd-resolved-monitor.socket'. 82s Created symlink '/etc/systemd/system/sockets.target.wants/systemd-resolved-varlink.socket' → '/usr/lib/systemd/system/systemd-resolved-varlink.socket'. 82s Could not execute systemctl: at /usr/bin/deb-systemd-invoke line 148. 82s Setting up systemd-sysv (259~rc1-1ubuntu1) ... 82s Setting up libnss-systemd:s390x (259~rc1-1ubuntu1) ... 82s Setting up libpam-systemd:s390x (259~rc1-1ubuntu1) ... 82s Processing triggers for libc-bin (2.42-2ubuntu2) ... 82s Processing triggers for man-db (2.13.1-1) ... 83s Processing triggers for dbus (1.16.2-2ubuntu2) ... 83s Processing triggers for shared-mime-info (2.4-5build2) ... 85s Processing triggers for procps (2:4.0.4-8ubuntu3) ... 85s Processing triggers for initramfs-tools (0.150ubuntu5) ... 85s update-initramfs: Generating /boot/initrd.img-6.17.0-5-generic 88s Using config file '/etc/zipl.conf' 88s Building bootmap in '/boot' 88s Adding IPL section 'ubuntu' (default) 88s Preparing boot device for LD-IPL: vda (0000). 88s Done. 88s autopkgtest [20:50:44]: upgrading testbed (apt dist-upgrade and autopurge) 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s Calculating upgrade... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s Solving dependencies... 89s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s autopkgtest [20:50:46]: rebooting testbed after setup commands that affected boot 106s autopkgtest [20:51:02]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP Mon Sep 22 08:56:47 UTC 2025 108s autopkgtest [20:51:04]: @@@@@@@@@@@@@@@@@@@@ apt-source pdns-recursor 110s Get:1 http://ftpmaster.internal/ubuntu resolute/universe pdns-recursor 5.3.1-1 (dsc) [3199 B] 110s Get:2 http://ftpmaster.internal/ubuntu resolute/universe pdns-recursor 5.3.1-1 (tar) [1362 kB] 110s Get:3 http://ftpmaster.internal/ubuntu resolute/universe pdns-recursor 5.3.1-1 (diff) [17.8 kB] 110s gpgv: Signature made Fri Oct 24 22:04:00 2025 UTC 110s gpgv: using RSA key 7D1ACFFAD9E0806C9C4CD3925C13D6DB93052E03 110s gpgv: Can't check signature: No public key 110s dpkg-source: warning: cannot verify inline signature for ./pdns-recursor_5.3.1-1.dsc: no acceptable signature found 111s autopkgtest [20:51:07]: testing package pdns-recursor version 5.3.1-1 111s autopkgtest [20:51:07]: build not needed 112s autopkgtest [20:51:08]: test smoke: preparing testbed 112s Reading package lists... 112s Building dependency tree... 112s Reading state information... 112s Solving dependencies... 112s The following NEW packages will be installed: 112s dns-root-data libboost-context1.88.0 libboost-filesystem1.88.0 libfstrm0 112s liblua5.3-0 libsnmp-base libsnmp40t64 libsodium23 pdns-recursor 112s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 112s Need to get 7862 kB of archives. 112s After this operation, 30.0 MB of additional disk space will be used. 112s Get:1 http://ftpmaster.internal/ubuntu resolute/main s390x dns-root-data all 2025080400 [5908 B] 113s Get:2 http://ftpmaster.internal/ubuntu resolute/main s390x libboost-context1.88.0 s390x 1.88.0-1.4ubuntu2 [240 kB] 113s Get:3 http://ftpmaster.internal/ubuntu resolute/main s390x libboost-filesystem1.88.0 s390x 1.88.0-1.4ubuntu2 [293 kB] 113s Get:4 http://ftpmaster.internal/ubuntu resolute/universe s390x libfstrm0 s390x 0.6.1-1build4 [21.0 kB] 113s Get:5 http://ftpmaster.internal/ubuntu resolute/universe s390x liblua5.3-0 s390x 5.3.6-2build2 [155 kB] 113s Get:6 http://ftpmaster.internal/ubuntu resolute/main s390x libsnmp-base all 5.9.4+dfsg-2ubuntu2 [207 kB] 113s Get:7 http://ftpmaster.internal/ubuntu resolute/main s390x libsnmp40t64 s390x 5.9.4+dfsg-2ubuntu2 [1051 kB] 113s Get:8 http://ftpmaster.internal/ubuntu resolute/main s390x libsodium23 s390x 1.0.18-1build3 [138 kB] 113s Get:9 http://ftpmaster.internal/ubuntu resolute/universe s390x pdns-recursor s390x 5.3.1-1 [5753 kB] 114s Fetched 7862 kB in 2s (4488 kB/s) 114s Selecting previously unselected package dns-root-data. 114s (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 ... 61374 files and directories currently installed.) 114s Preparing to unpack .../0-dns-root-data_2025080400_all.deb ... 114s Unpacking dns-root-data (2025080400) ... 114s Selecting previously unselected package libboost-context1.88.0:s390x. 115s Preparing to unpack .../1-libboost-context1.88.0_1.88.0-1.4ubuntu2_s390x.deb ... 115s Unpacking libboost-context1.88.0:s390x (1.88.0-1.4ubuntu2) ... 115s Selecting previously unselected package libboost-filesystem1.88.0:s390x. 115s Preparing to unpack .../2-libboost-filesystem1.88.0_1.88.0-1.4ubuntu2_s390x.deb ... 115s Unpacking libboost-filesystem1.88.0:s390x (1.88.0-1.4ubuntu2) ... 115s Selecting previously unselected package libfstrm0:s390x. 115s Preparing to unpack .../3-libfstrm0_0.6.1-1build4_s390x.deb ... 115s Unpacking libfstrm0:s390x (0.6.1-1build4) ... 115s Selecting previously unselected package liblua5.3-0:s390x. 115s Preparing to unpack .../4-liblua5.3-0_5.3.6-2build2_s390x.deb ... 115s Unpacking liblua5.3-0:s390x (5.3.6-2build2) ... 115s Selecting previously unselected package libsnmp-base. 115s Preparing to unpack .../5-libsnmp-base_5.9.4+dfsg-2ubuntu2_all.deb ... 115s Unpacking libsnmp-base (5.9.4+dfsg-2ubuntu2) ... 115s Selecting previously unselected package libsnmp40t64:s390x. 115s Preparing to unpack .../6-libsnmp40t64_5.9.4+dfsg-2ubuntu2_s390x.deb ... 115s Unpacking libsnmp40t64:s390x (5.9.4+dfsg-2ubuntu2) ... 115s Selecting previously unselected package libsodium23:s390x. 115s Preparing to unpack .../7-libsodium23_1.0.18-1build3_s390x.deb ... 115s Unpacking libsodium23:s390x (1.0.18-1build3) ... 115s Selecting previously unselected package pdns-recursor. 115s Preparing to unpack .../8-pdns-recursor_5.3.1-1_s390x.deb ... 115s Unpacking pdns-recursor (5.3.1-1) ... 115s Setting up libsodium23:s390x (1.0.18-1build3) ... 115s Setting up libboost-context1.88.0:s390x (1.88.0-1.4ubuntu2) ... 115s Setting up libsnmp-base (5.9.4+dfsg-2ubuntu2) ... 115s Setting up libfstrm0:s390x (0.6.1-1build4) ... 115s Setting up libboost-filesystem1.88.0:s390x (1.88.0-1.4ubuntu2) ... 115s Setting up dns-root-data (2025080400) ... 115s Setting up liblua5.3-0:s390x (5.3.6-2build2) ... 115s Setting up libsnmp40t64:s390x (5.9.4+dfsg-2ubuntu2) ... 115s Setting up pdns-recursor (5.3.1-1) ... 115s Created symlink '/etc/systemd/system/multi-user.target.wants/pdns-recursor.service' → '/usr/lib/systemd/system/pdns-recursor.service'. 115s Processing triggers for man-db (2.13.1-1) ... 116s Processing triggers for libc-bin (2.42-2ubuntu2) ... 117s autopkgtest [20:51:13]: test smoke: [----------------------- 117s + sed -e '/recursor:/a \ auth_zones: [{zone: "example.org", file: "/etc/powerdns/example.org.zone"}]' -i /etc/powerdns/recursor.conf 117s + cat 117s + service pdns-recursor restart 117s ++ mktemp 117s + TMPFILE=/tmp/tmp.K4Ql1r2sRu 117s + trap cleanup EXIT 117s + dig @127.0.0.1 smoke.example.org 117s + tee /tmp/tmp.K4Ql1r2sRu 117s 117s ; <<>> DiG 9.20.11-1ubuntu3-Ubuntu <<>> @127.0.0.1 smoke.example.org 117s ; (1 server found) 117s ;; global options: +cmd 117s ;; Got answer: 117s ;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 43380 117s ;; flags: qr rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 0, ADDITIONAL: 1 117s 117s ;; OPT PSEUDOSECTION: 117s ; EDNS: version: 0, flags:; udp: 512 117s ;; QUESTION SECTION: 117s ;smoke.example.org. IN A 117s 117s ;; ANSWER SECTION: 117s smoke.example.org. 86400 IN A 127.0.0.123 117s 117s ;; Query time: 10 msec 117s ;; SERVER: 127.0.0.1#53(127.0.0.1) (UDP) 117s ;; WHEN: Wed Nov 19 20:51:13 UTC 2025 117s ;; MSG SIZE rcvd: 62 117s 117s + grep -c '127\.0\.0\.123' /tmp/tmp.K4Ql1r2sRu 117s 1 117s + echo success 117s success 117s + cleanup 117s + rm -f /tmp/tmp.K4Ql1r2sRu 118s autopkgtest [20:51:14]: test smoke: -----------------------] 118s autopkgtest [20:51:14]: test smoke: - - - - - - - - - - results - - - - - - - - - - 118s smoke PASS 119s autopkgtest [20:51:15]: @@@@@@@@@@@@@@@@@@@@ summary 119s smoke PASS