0s autopkgtest [20:24:48]: starting date and time: 2025-10-20 20:24:48+0000 0s autopkgtest [20:24:48]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [20:24:48]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.cink93br/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:node-jquery --apt-upgrade knot --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=node-jquery/3.7.1+dfsg+~3.5.33-1build1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-ppc64el-3.secgroup --name adt-resolute-ppc64el-knot-20251020-202447-juju-7f2275-prod-proposed-migration-environment-15-9b9ac60c-b885-4ccb-a35d-c152f1bfa93e --image adt/ubuntu-resolute-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-ppc64el-knot-20251020-202447-juju-7f2275-prod-proposed-migration-environment-15-9b9ac60c-b885-4ccb-a35d-c152f1bfa93e from image adt/ubuntu-resolute-ppc64el-server-20251020.img (UUID 243ad32c-1bbf-485e-924d-1d24001cd7a1)... 49s autopkgtest [20:25:37]: testbed dpkg architecture: ppc64el 49s autopkgtest [20:25:37]: testbed apt version: 3.1.8ubuntu1 49s autopkgtest [20:25:37]: @@@@@@@@@@@@@@@@@@@@ test bed setup 49s autopkgtest [20:25:37]: testbed release detected to be: None 50s autopkgtest [20:25:38]: updating testbed package index (apt update) 51s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 51s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 51s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 51s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 51s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [59.3 kB] 51s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 51s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [14.3 kB] 51s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [646 kB] 52s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [108 kB] 52s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted ppc64el Packages [940 B] 52s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [407 kB] 52s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [3808 B] 52s Fetched 1328 kB in 1s (987 kB/s) 53s Reading package lists... 53s Failed to check for VM: Permission denied 54s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 54s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 54s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 54s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 55s Reading package lists... 55s Reading package lists... 55s Building dependency tree... 55s Reading state information... 55s Calculating upgrade... 55s The following packages will be upgraded: 55s libbrotli1 55s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 55s Need to get 422 kB of archives. 55s After this operation, 0 B of additional disk space will be used. 55s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el libbrotli1 ppc64el 1.1.0-2build6 [422 kB] 56s dpkg-preconfigure: unable to re-open stdin: No such file or directory 56s Fetched 422 kB in 1s (732 kB/s) 56s (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 ... 76476 files and directories currently installed.) 56s Preparing to unpack .../libbrotli1_1.1.0-2build6_ppc64el.deb ... 56s Unpacking libbrotli1:ppc64el (1.1.0-2build6) over (1.1.0-2build5) ... 56s Setting up libbrotli1:ppc64el (1.1.0-2build6) ... 56s Processing triggers for libc-bin (2.42-0ubuntu3) ... 56s autopkgtest [20:25:44]: upgrading testbed (apt dist-upgrade and autopurge) 56s Reading package lists... 56s Building dependency tree... 56s Reading state information... 57s Calculating upgrade... 57s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 57s Reading package lists... 57s Building dependency tree... 57s Reading state information... 57s Solving dependencies... 57s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 60s autopkgtest [20:25:48]: testbed running kernel: Linux 6.17.0-5-generic #5-Ubuntu SMP PREEMPT_DYNAMIC Mon Sep 22 10:02:41 UTC 2025 60s autopkgtest [20:25:48]: @@@@@@@@@@@@@@@@@@@@ apt-source knot 67s Get:1 http://ftpmaster.internal/ubuntu resolute/universe knot 3.4.6-2 (dsc) [4246 B] 67s Get:2 http://ftpmaster.internal/ubuntu resolute/universe knot 3.4.6-2 (tar) [1611 kB] 67s Get:3 http://ftpmaster.internal/ubuntu resolute/universe knot 3.4.6-2 (asc) [833 B] 67s Get:4 http://ftpmaster.internal/ubuntu resolute/universe knot 3.4.6-2 (diff) [30.5 kB] 68s gpgv: Signature made Fri May 2 15:31:36 2025 UTC 68s gpgv: using RSA key 23EBCF7E8FC47556787100DFA4254072E373042C 68s gpgv: Can't check signature: No public key 68s dpkg-source: warning: cannot verify inline signature for ./knot_3.4.6-2.dsc: no acceptable signature found 68s autopkgtest [20:25:56]: testing package knot version 3.4.6-2 69s autopkgtest [20:25:57]: build not needed 71s autopkgtest [20:25:59]: test kdig: preparing testbed 71s Reading package lists... 71s Building dependency tree... 71s Reading state information... 72s Solving dependencies... 72s The following NEW packages will be installed: 72s iputils-ping knot-dnsutils libdnssec9t64 libfstrm0 libknot15 libngtcp2-16 72s libngtcp2-crypto-gnutls8 libprotobuf-c1 libxdp1 libzscanner4t64 72s 0 upgraded, 10 newly installed, 0 to remove and 0 not upgraded. 72s Need to get 829 kB of archives. 72s After this operation, 3245 kB of additional disk space will be used. 72s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el iputils-ping ppc64el 3:20240905-3ubuntu3 [51.0 kB] 72s Get:2 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libdnssec9t64 ppc64el 3.4.6-2 [37.6 kB] 72s Get:3 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libngtcp2-16 ppc64el 1.11.0-1 [165 kB] 72s Get:4 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libngtcp2-crypto-gnutls8 ppc64el 1.11.0-1 [18.3 kB] 72s Get:5 http://ftpmaster.internal/ubuntu resolute/main ppc64el libxdp1 ppc64el 1.5.6-1 [69.4 kB] 72s Get:6 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libknot15 ppc64el 3.4.6-2 [148 kB] 72s Get:7 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libzscanner4t64 ppc64el 3.4.6-2 [153 kB] 72s Get:8 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libfstrm0 ppc64el 0.6.1-1build4 [23.5 kB] 72s Get:9 http://ftpmaster.internal/ubuntu resolute/main ppc64el libprotobuf-c1 ppc64el 1.5.1-1ubuntu1 [25.9 kB] 72s Get:10 http://ftpmaster.internal/ubuntu resolute/universe ppc64el knot-dnsutils ppc64el 3.4.6-2 [138 kB] 73s Fetched 829 kB in 1s (1015 kB/s) 73s Selecting previously unselected package iputils-ping. 73s (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 ... 76476 files and directories currently installed.) 73s Preparing to unpack .../0-iputils-ping_3%3a20240905-3ubuntu3_ppc64el.deb ... 73s Unpacking iputils-ping (3:20240905-3ubuntu3) ... 73s Selecting previously unselected package libdnssec9t64. 73s Preparing to unpack .../1-libdnssec9t64_3.4.6-2_ppc64el.deb ... 73s Unpacking libdnssec9t64 (3.4.6-2) ... 73s Selecting previously unselected package libngtcp2-16:ppc64el. 73s Preparing to unpack .../2-libngtcp2-16_1.11.0-1_ppc64el.deb ... 73s Unpacking libngtcp2-16:ppc64el (1.11.0-1) ... 73s Selecting previously unselected package libngtcp2-crypto-gnutls8:ppc64el. 73s Preparing to unpack .../3-libngtcp2-crypto-gnutls8_1.11.0-1_ppc64el.deb ... 73s Unpacking libngtcp2-crypto-gnutls8:ppc64el (1.11.0-1) ... 73s Selecting previously unselected package libxdp1:ppc64el. 73s Preparing to unpack .../4-libxdp1_1.5.6-1_ppc64el.deb ... 73s Unpacking libxdp1:ppc64el (1.5.6-1) ... 73s Selecting previously unselected package libknot15. 73s Preparing to unpack .../5-libknot15_3.4.6-2_ppc64el.deb ... 73s Unpacking libknot15 (3.4.6-2) ... 73s Selecting previously unselected package libzscanner4t64. 73s Preparing to unpack .../6-libzscanner4t64_3.4.6-2_ppc64el.deb ... 73s Unpacking libzscanner4t64 (3.4.6-2) ... 73s Selecting previously unselected package libfstrm0:ppc64el. 73s Preparing to unpack .../7-libfstrm0_0.6.1-1build4_ppc64el.deb ... 73s Unpacking libfstrm0:ppc64el (0.6.1-1build4) ... 73s Selecting previously unselected package libprotobuf-c1:ppc64el. 73s Preparing to unpack .../8-libprotobuf-c1_1.5.1-1ubuntu1_ppc64el.deb ... 73s Unpacking libprotobuf-c1:ppc64el (1.5.1-1ubuntu1) ... 73s Selecting previously unselected package knot-dnsutils. 73s Preparing to unpack .../9-knot-dnsutils_3.4.6-2_ppc64el.deb ... 73s Unpacking knot-dnsutils (3.4.6-2) ... 73s Setting up libzscanner4t64 (3.4.6-2) ... 73s Setting up libfstrm0:ppc64el (0.6.1-1build4) ... 73s Setting up libprotobuf-c1:ppc64el (1.5.1-1ubuntu1) ... 73s Setting up libxdp1:ppc64el (1.5.6-1) ... 73s Setting up libdnssec9t64 (3.4.6-2) ... 73s Setting up libngtcp2-16:ppc64el (1.11.0-1) ... 73s Setting up iputils-ping (3:20240905-3ubuntu3) ... 73s Setting up libngtcp2-crypto-gnutls8:ppc64el (1.11.0-1) ... 73s Setting up libknot15 (3.4.6-2) ... 73s Setting up knot-dnsutils (3.4.6-2) ... 73s Processing triggers for man-db (2.13.1-1) ... 74s Processing triggers for libc-bin (2.42-0ubuntu3) ... 75s autopkgtest [20:26:03]: test kdig: [----------------------- 75s PING 1.1.1.1 (1.1.1.1) 56(84) bytes of data. 75s From 10.145.255.2 icmp_seq=1 Destination Port Unreachable 75s 75s --- 1.1.1.1 ping statistics --- 75s 1 packets transmitted, 0 received, +1 errors, 100% packet loss, time 0ms 75s 76s autopkgtest [20:26:04]: test kdig: -----------------------] 76s kdig SKIP exit status 77 and marked as skippable 76s autopkgtest [20:26:04]: test kdig: - - - - - - - - - - results - - - - - - - - - - 77s autopkgtest [20:26:05]: test authoritative-server: preparing testbed 97s Creating nova instance adt-resolute-ppc64el-knot-20251020-202447-juju-7f2275-prod-proposed-migration-environment-15-9b9ac60c-b885-4ccb-a35d-c152f1bfa93e from image adt/ubuntu-resolute-ppc64el-server-20251020.img (UUID 243ad32c-1bbf-485e-924d-1d24001cd7a1)... 147s autopkgtest [20:27:15]: testbed dpkg architecture: ppc64el 147s autopkgtest [20:27:15]: testbed apt version: 3.1.8ubuntu1 147s autopkgtest [20:27:15]: @@@@@@@@@@@@@@@@@@@@ test bed setup 147s autopkgtest [20:27:15]: testbed release detected to be: resolute 148s autopkgtest [20:27:16]: updating testbed package index (apt update) 148s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [83.3 kB] 149s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 149s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 149s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 149s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5028 B] 149s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [14.3 kB] 149s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [59.3 kB] 149s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [646 kB] 149s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [108 kB] 149s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/restricted ppc64el Packages [940 B] 149s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [407 kB] 149s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [3808 B] 149s Fetched 1328 kB in 1s (1220 kB/s) 150s Reading package lists... 151s Failed to check for VM: Permission denied 151s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 151s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 151s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 151s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 152s Reading package lists... 152s Reading package lists... 152s Building dependency tree... 152s Reading state information... 152s Calculating upgrade... 153s The following packages will be upgraded: 153s libbrotli1 153s 1 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 153s Need to get 422 kB of archives. 153s After this operation, 0 B of additional disk space will be used. 153s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el libbrotli1 ppc64el 1.1.0-2build6 [422 kB] 153s dpkg-preconfigure: unable to re-open stdin: No such file or directory 153s Fetched 422 kB in 1s (710 kB/s) 154s (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 ... 76476 files and directories currently installed.) 154s Preparing to unpack .../libbrotli1_1.1.0-2build6_ppc64el.deb ... 154s Unpacking libbrotli1:ppc64el (1.1.0-2build6) over (1.1.0-2build5) ... 154s Setting up libbrotli1:ppc64el (1.1.0-2build6) ... 154s Processing triggers for libc-bin (2.42-0ubuntu3) ... 154s autopkgtest [20:27:22]: upgrading testbed (apt dist-upgrade and autopurge) 154s Reading package lists... 154s Building dependency tree... 154s Reading state information... 155s Calculating upgrade... 155s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 155s Reading package lists... 155s Building dependency tree... 155s Reading state information... 155s Solving dependencies... 155s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 158s Reading package lists... 159s Building dependency tree... 159s Reading state information... 159s Solving dependencies... 159s The following NEW packages will be installed: 159s knot knot-dnssecutils knot-dnsutils libdnssec9t64 libfstrm0 libknot15 159s libngtcp2-16 libngtcp2-crypto-gnutls8 libprotobuf-c1 libxdp1 libzscanner4t64 159s 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded. 159s Need to get 1995 kB of archives. 159s After this operation, 8344 kB of additional disk space will be used. 159s Get:1 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libdnssec9t64 ppc64el 3.4.6-2 [37.6 kB] 159s Get:2 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libngtcp2-16 ppc64el 1.11.0-1 [165 kB] 159s Get:3 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libngtcp2-crypto-gnutls8 ppc64el 1.11.0-1 [18.3 kB] 159s Get:4 http://ftpmaster.internal/ubuntu resolute/main ppc64el libxdp1 ppc64el 1.5.6-1 [69.4 kB] 159s Get:5 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libknot15 ppc64el 3.4.6-2 [148 kB] 159s Get:6 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libzscanner4t64 ppc64el 3.4.6-2 [153 kB] 159s Get:7 http://ftpmaster.internal/ubuntu resolute/universe ppc64el knot ppc64el 3.4.6-2 [825 kB] 160s Get:8 http://ftpmaster.internal/ubuntu resolute/universe ppc64el knot-dnssecutils ppc64el 3.4.6-2 [392 kB] 160s Get:9 http://ftpmaster.internal/ubuntu resolute/universe ppc64el libfstrm0 ppc64el 0.6.1-1build4 [23.5 kB] 160s Get:10 http://ftpmaster.internal/ubuntu resolute/main ppc64el libprotobuf-c1 ppc64el 1.5.1-1ubuntu1 [25.9 kB] 160s Get:11 http://ftpmaster.internal/ubuntu resolute/universe ppc64el knot-dnsutils ppc64el 3.4.6-2 [138 kB] 160s Fetched 1995 kB in 1s (1998 kB/s) 160s Selecting previously unselected package libdnssec9t64. 160s (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 ... 76476 files and directories currently installed.) 160s Preparing to unpack .../00-libdnssec9t64_3.4.6-2_ppc64el.deb ... 160s Unpacking libdnssec9t64 (3.4.6-2) ... 160s Selecting previously unselected package libngtcp2-16:ppc64el. 160s Preparing to unpack .../01-libngtcp2-16_1.11.0-1_ppc64el.deb ... 160s Unpacking libngtcp2-16:ppc64el (1.11.0-1) ... 160s Selecting previously unselected package libngtcp2-crypto-gnutls8:ppc64el. 160s Preparing to unpack .../02-libngtcp2-crypto-gnutls8_1.11.0-1_ppc64el.deb ... 160s Unpacking libngtcp2-crypto-gnutls8:ppc64el (1.11.0-1) ... 160s Selecting previously unselected package libxdp1:ppc64el. 160s Preparing to unpack .../03-libxdp1_1.5.6-1_ppc64el.deb ... 160s Unpacking libxdp1:ppc64el (1.5.6-1) ... 160s Selecting previously unselected package libknot15. 160s Preparing to unpack .../04-libknot15_3.4.6-2_ppc64el.deb ... 160s Unpacking libknot15 (3.4.6-2) ... 160s Selecting previously unselected package libzscanner4t64. 160s Preparing to unpack .../05-libzscanner4t64_3.4.6-2_ppc64el.deb ... 160s Unpacking libzscanner4t64 (3.4.6-2) ... 160s Selecting previously unselected package knot. 160s Preparing to unpack .../06-knot_3.4.6-2_ppc64el.deb ... 160s Unpacking knot (3.4.6-2) ... 160s Selecting previously unselected package knot-dnssecutils. 160s Preparing to unpack .../07-knot-dnssecutils_3.4.6-2_ppc64el.deb ... 160s Unpacking knot-dnssecutils (3.4.6-2) ... 160s Selecting previously unselected package libfstrm0:ppc64el. 160s Preparing to unpack .../08-libfstrm0_0.6.1-1build4_ppc64el.deb ... 160s Unpacking libfstrm0:ppc64el (0.6.1-1build4) ... 160s Selecting previously unselected package libprotobuf-c1:ppc64el. 160s Preparing to unpack .../09-libprotobuf-c1_1.5.1-1ubuntu1_ppc64el.deb ... 160s Unpacking libprotobuf-c1:ppc64el (1.5.1-1ubuntu1) ... 160s Selecting previously unselected package knot-dnsutils. 160s Preparing to unpack .../10-knot-dnsutils_3.4.6-2_ppc64el.deb ... 160s Unpacking knot-dnsutils (3.4.6-2) ... 160s Setting up libzscanner4t64 (3.4.6-2) ... 160s Setting up libfstrm0:ppc64el (0.6.1-1build4) ... 160s Setting up libprotobuf-c1:ppc64el (1.5.1-1ubuntu1) ... 160s Setting up libxdp1:ppc64el (1.5.6-1) ... 160s Setting up libdnssec9t64 (3.4.6-2) ... 160s Setting up libngtcp2-16:ppc64el (1.11.0-1) ... 160s Setting up libngtcp2-crypto-gnutls8:ppc64el (1.11.0-1) ... 160s Setting up libknot15 (3.4.6-2) ... 160s Setting up knot (3.4.6-2) ... 161s Created symlink '/etc/systemd/system/multi-user.target.wants/knot.service' → '/usr/lib/systemd/system/knot.service'. 161s Setting up knot-dnsutils (3.4.6-2) ... 161s Setting up knot-dnssecutils (3.4.6-2) ... 161s Processing triggers for man-db (2.13.1-1) ... 162s Processing triggers for dbus (1.16.2-2ubuntu2) ... 162s Processing triggers for libc-bin (2.42-0ubuntu3) ... 166s autopkgtest [20:27:34]: test authoritative-server: [----------------------- 166s /usr/sbin/knotd + /usr/bin/kdig roundtrip tests 166s ------------ 166s workdir: /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts 166s IP addr: 127.2.250.15 166s knot args: --config=/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf --verbose 166s 166s set up config file and zonefile 166s ------------------------------- 166s ==> /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/example.net.zone <== 166s @ 1D IN SOA a.ns hostmaster 2018103100 3h 15m 1w 1d 166s @ 1D IN NS a.ns.example.net. 166s @ 1D IN NS b.ns.example.net. 166s a.ns 1D IN A 192.0.2.1 166s b.ns 1D IN A 192.0.2.2 166s test 1D IN A 192.0.2.199 166s 166s ==> /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf <== 166s server: 166s rundir: "/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts" 166s listen: 127.2.250.15@8123 166s user: ubuntu:ubuntu 166s database: 166s storage: "/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts" 166s template: 166s - id: default 166s storage: "/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts" 166s file: "%s.zone" 166s zone: 166s - domain: example.net 166s dnssec-signing: on 166s 166s kzonecheck'ing zonefile 166s ----------------------- 166s No error found 166s 166s launching knot 166s -------------- 166s debug: config '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf' 166s debug: module 'mod-authsignal', loaded static 166s debug: module 'mod-cookies', loaded static 166s debug: module 'mod-dnsproxy', loaded static 166s debug: module 'mod-noudp', loaded static 166s debug: module 'mod-onlinesign', loaded static 166s debug: module 'mod-probe', loaded static 166s debug: module 'mod-queryacl', loaded static 166s debug: module 'mod-rrl', loaded static 166s debug: module 'mod-stats', loaded static 166s debug: module 'mod-synthrecord', loaded static 166s debug: module 'mod-whoami', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-authsignal', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-cookies', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-dnsproxy', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-noudp', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-onlinesign', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-probe', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-queryacl', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-rrl', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-stats', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-synthrecord', loaded static 166s 2025-10-20T20:27:34+0000 debug: module 'mod-whoami', loaded static 166s debug: socket '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' 166s error: failed to connect to socket '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' (not exists) 166s 2025-10-20T20:27:34+0000 info: Knot DNS 3.4.6 starting 166s 2025-10-20T20:27:34+0000 info: loaded configuration file '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf', mapsize 500 MiB 166s 2025-10-20T20:27:34+0000 info: using UDP reuseport, incoming TCP Fast Open 166s 2025-10-20T20:27:34+0000 info: binding to interface 127.2.250.15@8123 166s 2025-10-20T20:27:34+0000 info: process not allowed to set capabilities, skipping 166s 2025-10-20T20:27:34+0000 info: loading 1 zones 166s 2025-10-20T20:27:34+0000 info: [example.net.] zone will be loaded 166s 2025-10-20T20:27:34+0000 info: starting server 166s 2025-10-20T20:27:34+0000 info: [example.net.] zone file parsed, serial 2018103100 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, next key action, ZSK, generate at 2025-11-19T20:27:34+0000 166s 2025-10-20T20:27:34+0000 notice: [example.net.] DNSSEC, KSK submission, waiting for confirmation 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, key, tag 42780, algorithm ECDSAP256SHA256, KSK, public, ready, active+ 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, key, tag 36952, algorithm ECDSAP256SHA256, public, active 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, signing started 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, successfully signed, serial 2018103101, new RRSIGs 13 166s 2025-10-20T20:27:34+0000 info: [example.net.] loaded, serial none -> 2018103100 -> 2018103101, 2249 bytes 166s 2025-10-20T20:27:34+0000 info: [example.net.] DNSSEC, next signing at 2025-11-01T09:51:34+0000 166s 2025-10-20T20:27:34+0000 info: [example.net.] zone file updated, serial 2018103100 -> 2018103101 166s 2025-10-20T20:27:34+0000 info: control, binding to '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' 166s 2025-10-20T20:27:34+0000 info: server started in the foreground, PID 2051 167s debug: config '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf' 167s debug: module 'mod-authsignal', loaded static 167s debug: module 'mod-cookies', loaded static 167s debug: module 'mod-dnsproxy', loaded static 167s debug: module 'mod-noudp', loaded static 167s debug: module 'mod-onlinesign', loaded static 167s debug: module 'mod-probe', loaded static 167s debug: module 'mod-queryacl', loaded static 167s debug: module 'mod-rrl', loaded static 167s debug: module 'mod-stats', loaded static 167s debug: module 'mod-synthrecord', loaded static 167s debug: module 'mod-whoami', loaded static 167s debug: socket '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' 167s 2025-10-20T20:27:35+0000 info: control, received command 'status' 167s Running 167s 167s querying knot 167s ------------- 167s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 12133 167s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 1 167s 167s ;; EDNS PSEUDOSECTION: 167s ;; Version: 0; flags: ; UDP size: 1232 B; ext-rcode: NOERROR 167s 167s ;; QUESTION SECTION: 167s ;; test.example.net. IN A 167s 167s ;; ANSWER SECTION: 167s test.example.net. 86400 IN A 192.0.2.199 167s 167s ;; Received 61 B 167s ;; Time 2025-10-20 20:27:35 UTC 167s ;; From 127.2.250.15@8123(UDP) in 0.2 ms 167s 167s ;; ->>HEADER<<- opcode: QUERY; status: NXDOMAIN; id: 8907 167s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 0; AUTHORITY: 1; ADDITIONAL: 1 167s 167s ;; EDNS PSEUDOSECTION: 167s ;; Version: 0; flags: ; UDP size: 1232 B; ext-rcode: NOERROR 167s 167s ;; QUESTION SECTION: 167s ;; test2.example.net. IN A 167s 167s ;; AUTHORITY SECTION: 167s example.net. 86400 IN SOA a.ns.example.net. hostmaster.example.net. 2018103101 10800 900 604800 86400 167s 167s ;; Received 98 B 167s ;; Time 2025-10-20 20:27:35 UTC 167s ;; From 127.2.250.15@8123(UDP) in 0.1 ms 167s 167s modifying zone 167s -------------- 167s debug: config '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf' 167s debug: module 'mod-authsignal', loaded static 167s debug: module 'mod-cookies', loaded static 167s debug: module 'mod-dnsproxy', loaded static 167s debug: module 'mod-noudp', loaded static 167s debug: module 'mod-onlinesign', loaded static 167s debug: module 'mod-probe', loaded static 167s debug: module 'mod-queryacl', loaded static 167s debug: module 'mod-rrl', loaded static 167s debug: module 'mod-stats', loaded static 167s debug: module 'mod-synthrecord', loaded static 167s debug: module 'mod-whoami', loaded static 167s debug: socket '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' 167s 2025-10-20T20:27:35+0000 info: control, received command 'reload' 167s 2025-10-20T20:27:35+0000 info: reloading configuration file '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf' 167s 2025-10-20T20:27:35+0000 info: configuration reloaded 167s Reloaded 167s 2025-10-20T20:27:35+0000 info: [example.net.] zone file parsed, serial 2018103101 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, next key action, ZSK, generate at 2025-11-19T20:27:34+0000 167s 2025-10-20T20:27:35+0000 notice: [example.net.] DNSSEC, KSK submission, waiting for confirmation 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, key, tag 36952, algorithm ECDSAP256SHA256, public, active 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, key, tag 42780, algorithm ECDSAP256SHA256, KSK, public, ready, active+ 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, signing started 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, successfully signed, serial 2018103102, new RRSIGs 4 167s 2025-10-20T20:27:35+0000 info: [example.net.] loaded, serial 2018103101 -> 2018103101 -> 2018103102, 2586 bytes 167s 2025-10-20T20:27:35+0000 info: [example.net.] DNSSEC, next signing at 2025-11-01T09:51:34+0000 167s 2025-10-20T20:27:35+0000 info: [example.net.] zone file updated, serial 2018103101 -> 2018103102 168s 168s querying again 168s -------------- 168s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 37346 168s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 1 168s 168s ;; EDNS PSEUDOSECTION: 168s ;; Version: 0; flags: ; UDP size: 1232 B; ext-rcode: NOERROR 168s 168s ;; QUESTION SECTION: 168s ;; test.example.net. IN A 168s 168s ;; ANSWER SECTION: 168s test.example.net. 86400 IN A 192.0.2.199 168s 168s ;; Received 61 B 168s ;; Time 2025-10-20 20:27:36 UTC 168s ;; From 127.2.250.15@8123(UDP) in 0.3 ms 168s 168s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 11772 168s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 1 168s 168s ;; EDNS PSEUDOSECTION: 168s ;; Version: 0; flags: ; UDP size: 1232 B; ext-rcode: NOERROR 168s 168s ;; QUESTION SECTION: 168s ;; test2.example.net. IN A 168s 168s ;; ANSWER SECTION: 168s test2.example.net. 86400 IN A 192.0.2.199 168s 168s ;; Received 62 B 168s ;; Time 2025-10-20 20:27:36 UTC 168s ;; From 127.2.250.15@8123(UDP) in 0.1 ms 168s 168s querying DNSSEC 168s --------------- 168s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 49011 168s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 3; AUTHORITY: 0; ADDITIONAL: 1 168s 168s ;; EDNS PSEUDOSECTION: 168s ;; Version: 0; flags: do; UDP size: 1232 B; ext-rcode: NOERROR 168s 168s ;; QUESTION SECTION: 168s ;; example.net. IN DNSKEY 168s 168s ;; ANSWER SECTION: 168s example.net. 86400 IN DNSKEY 256 3 13 0N2DN9xl3iY1CGu9dnxvxsRgiKkG2Trx8J2UerFkIXuUIOpios/BeVSVK8T2yTO5jmktzZjUw93BadXqz9oCEg== 168s example.net. 86400 IN DNSKEY 257 3 13 18zSPkvE5MuuW8kAhCW3Yns/tfiHWvjHxNHw3q3TvF/E5x/rQ5KcPtmM14TmKN6V5toxJhMWhtfr6jzrhE6qxw== 168s example.net. 86400 IN RRSIG DNSKEY 13 2 86400 20251103202734 20251020185734 42780 example.net. y2CVs2XXPzvgAJBPHpsHJwsqMyQJC8X4xCjaLWTHGdAb7MEoJLQe4thJmkVOrqE96pzW7ClBRT/M6b64AtwxxQ== 168s 168s ;; Received 307 B 168s ;; Time 2025-10-20 20:27:36 UTC 168s ;; From 127.2.250.15@8123(UDP) in 0.2 ms 168s 168s listing keys with keymgr 168s ------------------------ 168s 02e55e4b36f823954515683023222ddd6b662f7b ksk=no zsk=yes tag=36952 algorithm=13 size=256 public-only=no missing=no created=1760992054 pre-active=0 publish=1760992054 ready=0 active=1760992054 retire-active=0 retire=0 post-active=0 revoke=0 remove=0 168s 90cd45438e34a7211b69eca6220db236cc3f171d ksk=yes zsk=no tag=42780 algorithm=13 size=256 public-only=no missing=no created=1760992054 pre-active=0 publish=1760992054 ready=1760992054 active=0 retire-active=0 retire=0 post-active=0 revoke=0 remove=0 168s 168s cleaning up 168s ----------- 168s 253117 4 drwxr-xr-x 4 ubuntu ubuntu 4096 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts 168s 253125 0 s-w--w---- 1 ubuntu ubuntu 0 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock 168s 253140 4 -rw-rw---- 1 ubuntu ubuntu 3911 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/example.net.zone 168s 253130 4 -rw-r----- 1 ubuntu ubuntu 4 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.pid 168s 253131 4 drwxrwx--- 3 ubuntu ubuntu 4096 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys 168s 253134 4 drwxr-x--- 2 ubuntu ubuntu 4096 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys/keys 168s 253136 4 -rw-r----- 1 ubuntu ubuntu 262 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys/keys/02e55e4b36f823954515683023222ddd6b662f7b.pem 168s 253135 4 -rw-r----- 1 ubuntu ubuntu 262 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys/keys/90cd45438e34a7211b69eca6220db236cc3f171d.pem 168s 253133 352 -rw-rw---- 1 ubuntu ubuntu 360448 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys/data.mdb 168s 253132 4 -rw-rw---- 1 ubuntu ubuntu 1152 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/keys/lock.mdb 168s 253137 4 drwxrwx--- 2 ubuntu ubuntu 4096 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/journal 168s 253139 256 -rw-rw---- 1 ubuntu ubuntu 262144 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/journal/data.mdb 168s 253138 4 -rw-rw---- 1 ubuntu ubuntu 1152 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/journal/lock.mdb 168s 253124 4 -rw-rw-r-- 1 ubuntu ubuntu 363 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf 168s 253126 0 -rw-rw-r-- 1 ubuntu ubuntu 0 Oct 20 20:27 /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knotd.err 168s debug: config '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.conf' 168s debug: module 'mod-authsignal', loaded static 168s debug: module 'mod-cookies', loaded static 168s debug: module 'mod-dnsproxy', loaded static 168s debug: module 'mod-noudp', loaded static 168s debug: module 'mod-onlinesign', loaded static 168s debug: module 'mod-probe', loaded static 168s debug: module 'mod-queryacl', loaded static 168s debug: module 'mod-rrl', loaded static 168s debug: module 'mod-stats', loaded static 168s debug: module 'mod-synthrecord', loaded static 168s debug: module 'mod-whoami', loaded static 168s debug: socket '/tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knot.sock' 168s 2025-10-20T20:27:36+0000 info: control, received command 'stop' 168s Stopped 173s 2025-10-20T20:27:41+0000 info: stopping server 173s 2025-10-20T20:27:41+0000 info: updating persistent timer DB 173s 2025-10-20T20:27:41+0000 info: shutting down 173s ==> /tmp/autopkgtest.WnEFYh/authoritative-server-artifacts/knotd.err <== 173s autopkgtest [20:27:41]: test authoritative-server: -----------------------] 174s authoritative-server PASS 174s autopkgtest [20:27:42]: test authoritative-server: - - - - - - - - - - results - - - - - - - - - - 176s autopkgtest [20:27:44]: @@@@@@@@@@@@@@@@@@@@ summary 176s kdig SKIP exit status 77 and marked as skippable 176s authoritative-server PASS