0s autopkgtest [01:01:40]: starting date and time: 2024-07-21 01:01:40+0000 0s autopkgtest [01:01:40]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [01:01:40]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vmuxck8o/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:python3-defaults,src:python3-stdlib-extensions --apt-upgrade knot --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=python3-defaults/3.12.4-1 python3-stdlib-extensions/3.12.4-2' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos01-s390x-19.secgroup --name adt-oracular-s390x-knot-20240721-010140-juju-7f2275-prod-proposed-migration-environment-3-5f88df24-d5e6-458d-b57a-da383964deb9 --image adt/ubuntu-oracular-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --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'"'"'' --mirror=http://us.ports.ubuntu.com/ubuntu-ports/ 263s autopkgtest [01:06:03]: testbed dpkg architecture: s390x 271s autopkgtest [01:06:11]: testbed apt version: 2.9.6 271s autopkgtest [01:06:11]: @@@@@@@@@@@@@@@@@@@@ test bed setup 273s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 273s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [62.2 kB] 273s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 273s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [410 kB] 273s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [4724 B] 273s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [101 kB] 273s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x c-n-f Metadata [2112 B] 273s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1368 B] 273s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x c-n-f Metadata [120 B] 273s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [464 kB] 273s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x c-n-f Metadata [8372 B] 273s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [2744 B] 273s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x c-n-f Metadata [120 B] 274s Fetched 1191 kB in 1s (1467 kB/s) 274s Reading package lists... 284s Reading package lists... 284s Building dependency tree... 284s Reading state information... 285s Calculating upgrade... 285s The following packages will be upgraded: 285s libbpf1 libpython3-stdlib python3 python3-gdbm python3-minimal 285s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 285s Need to get 259 kB of archives. 285s After this operation, 26.6 kB of additional disk space will be used. 285s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-minimal s390x 3.12.4-1 [27.1 kB] 285s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3 s390x 3.12.4-1 [24.0 kB] 285s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x libpython3-stdlib s390x 3.12.4-1 [9826 B] 285s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x libbpf1 s390x 1:1.4.5-1 [180 kB] 285s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-gdbm s390x 3.12.4-2 [18.5 kB] 286s Fetched 259 kB in 0s (640 kB/s) 286s (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 ... 54753 files and directories currently installed.) 286s Preparing to unpack .../python3-minimal_3.12.4-1_s390x.deb ... 286s Unpacking python3-minimal (3.12.4-1) over (3.12.3-0ubuntu1) ... 286s Setting up python3-minimal (3.12.4-1) ... 286s (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 ... 54753 files and directories currently installed.) 286s Preparing to unpack .../python3_3.12.4-1_s390x.deb ... 286s Unpacking python3 (3.12.4-1) over (3.12.3-0ubuntu1) ... 286s Preparing to unpack .../libpython3-stdlib_3.12.4-1_s390x.deb ... 286s Unpacking libpython3-stdlib:s390x (3.12.4-1) over (3.12.3-0ubuntu1) ... 286s Preparing to unpack .../libbpf1_1%3a1.4.5-1_s390x.deb ... 286s Unpacking libbpf1:s390x (1:1.4.5-1) over (1:1.4.3-1) ... 286s Preparing to unpack .../python3-gdbm_3.12.4-2_s390x.deb ... 286s Unpacking python3-gdbm:s390x (3.12.4-2) over (3.12.3-0ubuntu1) ... 286s Setting up libbpf1:s390x (1:1.4.5-1) ... 286s Setting up libpython3-stdlib:s390x (3.12.4-1) ... 286s Setting up python3 (3.12.4-1) ... 286s Setting up python3-gdbm:s390x (3.12.4-2) ... 286s Processing triggers for man-db (2.12.1-2) ... 287s Processing triggers for libc-bin (2.39-0ubuntu9) ... 287s Reading package lists... 287s Building dependency tree... 287s Reading state information... 287s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 288s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 288s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 288s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 288s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 289s Reading package lists... 289s Reading package lists... 289s Building dependency tree... 289s Reading state information... 290s Calculating upgrade... 290s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 290s Reading package lists... 290s Building dependency tree... 290s Reading state information... 290s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 314s autopkgtest [01:06:54]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:14:26 UTC 2024 323s autopkgtest [01:07:03]: @@@@@@@@@@@@@@@@@@@@ apt-source knot 348s Get:1 http://ftpmaster.internal/ubuntu oracular/universe knot 3.3.7-1 (dsc) [4074 B] 348s Get:2 http://ftpmaster.internal/ubuntu oracular/universe knot 3.3.7-1 (tar) [1565 kB] 348s Get:3 http://ftpmaster.internal/ubuntu oracular/universe knot 3.3.7-1 (asc) [833 B] 348s Get:4 http://ftpmaster.internal/ubuntu oracular/universe knot 3.3.7-1 (diff) [29.6 kB] 348s gpgv: Signature made Tue Jun 25 16:02:56 2024 UTC 348s gpgv: using RSA key 23EBCF7E8FC47556787100DFA4254072E373042C 348s gpgv: Can't check signature: No public key 348s dpkg-source: warning: cannot verify inline signature for ./knot_3.3.7-1.dsc: no acceptable signature found 348s autopkgtest [01:07:28]: testing package knot version 3.3.7-1 349s autopkgtest [01:07:29]: build not needed 350s autopkgtest [01:07:30]: test kdig: preparing testbed 353s Reading package lists... 354s Building dependency tree... 354s Reading state information... 354s Starting pkgProblemResolver with broken count: 0 354s Starting 2 pkgProblemResolver with broken count: 0 354s Done 354s The following additional packages will be installed: 354s knot-dnsutils libdnssec9t64 libfstrm0 libknot14t64 libxdp1 libzscanner4t64 354s The following NEW packages will be installed: 354s autopkgtest-satdep knot-dnsutils libdnssec9t64 libfstrm0 libknot14t64 354s libxdp1 libzscanner4t64 354s 0 upgraded, 7 newly installed, 0 to remove and 0 not upgraded. 354s Need to get 712 kB/712 kB of archives. 354s After this operation, 2577 kB of additional disk space will be used. 354s Get:1 /tmp/autopkgtest.IrGy9d/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [736 B] 354s Get:2 http://ftpmaster.internal/ubuntu oracular/universe s390x libdnssec9t64 s390x 3.3.7-1 [31.1 kB] 355s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x libxdp1 s390x 1.4.2-1ubuntu4 [62.9 kB] 355s Get:4 http://ftpmaster.internal/ubuntu oracular/universe s390x libknot14t64 s390x 3.3.7-1 [209 kB] 355s Get:5 http://ftpmaster.internal/ubuntu oracular/universe s390x libzscanner4t64 s390x 3.3.7-1 [161 kB] 355s Get:6 http://ftpmaster.internal/ubuntu oracular/universe s390x libfstrm0 s390x 0.6.1-1build4 [21.0 kB] 355s Get:7 http://ftpmaster.internal/ubuntu oracular/universe s390x knot-dnsutils s390x 3.3.7-1 [227 kB] 355s Fetched 712 kB in 1s (1238 kB/s) 355s Selecting previously unselected package libdnssec9t64. 355s (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 ... 54756 files and directories currently installed.) 355s Preparing to unpack .../0-libdnssec9t64_3.3.7-1_s390x.deb ... 355s Unpacking libdnssec9t64 (3.3.7-1) ... 355s Selecting previously unselected package libxdp1:s390x. 355s Preparing to unpack .../1-libxdp1_1.4.2-1ubuntu4_s390x.deb ... 355s Unpacking libxdp1:s390x (1.4.2-1ubuntu4) ... 355s Selecting previously unselected package libknot14t64. 355s Preparing to unpack .../2-libknot14t64_3.3.7-1_s390x.deb ... 355s Unpacking libknot14t64 (3.3.7-1) ... 355s Selecting previously unselected package libzscanner4t64. 355s Preparing to unpack .../3-libzscanner4t64_3.3.7-1_s390x.deb ... 355s Unpacking libzscanner4t64 (3.3.7-1) ... 355s Selecting previously unselected package libfstrm0:s390x. 355s Preparing to unpack .../4-libfstrm0_0.6.1-1build4_s390x.deb ... 355s Unpacking libfstrm0:s390x (0.6.1-1build4) ... 355s Selecting previously unselected package knot-dnsutils. 355s Preparing to unpack .../5-knot-dnsutils_3.3.7-1_s390x.deb ... 355s Unpacking knot-dnsutils (3.3.7-1) ... 355s Selecting previously unselected package autopkgtest-satdep. 355s Preparing to unpack .../6-1-autopkgtest-satdep.deb ... 355s Unpacking autopkgtest-satdep (0) ... 355s Setting up libzscanner4t64 (3.3.7-1) ... 355s Setting up libfstrm0:s390x (0.6.1-1build4) ... 355s Setting up libxdp1:s390x (1.4.2-1ubuntu4) ... 355s Setting up libdnssec9t64 (3.3.7-1) ... 355s Setting up libknot14t64 (3.3.7-1) ... 355s Setting up knot-dnsutils (3.3.7-1) ... 355s Setting up autopkgtest-satdep (0) ... 355s Processing triggers for man-db (2.12.1-2) ... 356s Processing triggers for libc-bin (2.39-0ubuntu9) ... 359s (Reading database ... 54811 files and directories currently installed.) 359s Removing autopkgtest-satdep (0) ... 361s autopkgtest [01:07:41]: test kdig: [----------------------- 371s PING 1.1.1.1 (1.1.1.1) 56(84) bytes of data. 371s 371s --- 1.1.1.1 ping statistics --- 371s 1 packets transmitted, 0 received, 100% packet loss, time 0ms 371s 371s autopkgtest [01:07:51]: test kdig: -----------------------] 372s autopkgtest [01:07:52]: test kdig: - - - - - - - - - - results - - - - - - - - - - 372s kdig SKIP exit status 77 and marked as skippable 373s autopkgtest [01:07:53]: test authoritative-server: preparing testbed 551s autopkgtest [01:10:51]: testbed dpkg architecture: s390x 552s autopkgtest [01:10:52]: testbed apt version: 2.9.6 552s autopkgtest [01:10:52]: @@@@@@@@@@@@@@@@@@@@ test bed setup 553s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [126 kB] 554s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [410 kB] 554s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [4724 B] 554s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [8548 B] 554s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [62.2 kB] 554s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [101 kB] 554s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x c-n-f Metadata [2112 B] 554s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1368 B] 554s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x c-n-f Metadata [120 B] 554s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [464 kB] 554s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x c-n-f Metadata [8372 B] 554s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [2744 B] 554s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x c-n-f Metadata [120 B] 554s Fetched 1191 kB in 1s (1487 kB/s) 554s Reading package lists... 568s Reading package lists... 569s Building dependency tree... 569s Reading state information... 569s Calculating upgrade... 569s The following packages will be upgraded: 569s libbpf1 libpython3-stdlib python3 python3-gdbm python3-minimal 569s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 569s Need to get 259 kB of archives. 569s After this operation, 26.6 kB of additional disk space will be used. 569s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-minimal s390x 3.12.4-1 [27.1 kB] 569s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3 s390x 3.12.4-1 [24.0 kB] 569s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x libpython3-stdlib s390x 3.12.4-1 [9826 B] 569s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x libbpf1 s390x 1:1.4.5-1 [180 kB] 569s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x python3-gdbm s390x 3.12.4-2 [18.5 kB] 570s Fetched 259 kB in 0s (623 kB/s) 570s (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 ... 54753 files and directories currently installed.) 570s Preparing to unpack .../python3-minimal_3.12.4-1_s390x.deb ... 570s Unpacking python3-minimal (3.12.4-1) over (3.12.3-0ubuntu1) ... 570s Setting up python3-minimal (3.12.4-1) ... 570s (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 ... 54753 files and directories currently installed.) 570s Preparing to unpack .../python3_3.12.4-1_s390x.deb ... 570s Unpacking python3 (3.12.4-1) over (3.12.3-0ubuntu1) ... 570s Preparing to unpack .../libpython3-stdlib_3.12.4-1_s390x.deb ... 570s Unpacking libpython3-stdlib:s390x (3.12.4-1) over (3.12.3-0ubuntu1) ... 570s Preparing to unpack .../libbpf1_1%3a1.4.5-1_s390x.deb ... 570s Unpacking libbpf1:s390x (1:1.4.5-1) over (1:1.4.3-1) ... 570s Preparing to unpack .../python3-gdbm_3.12.4-2_s390x.deb ... 570s Unpacking python3-gdbm:s390x (3.12.4-2) over (3.12.3-0ubuntu1) ... 570s Setting up libbpf1:s390x (1:1.4.5-1) ... 570s Setting up libpython3-stdlib:s390x (3.12.4-1) ... 570s Setting up python3 (3.12.4-1) ... 570s Setting up python3-gdbm:s390x (3.12.4-2) ... 570s Processing triggers for man-db (2.12.1-2) ... 571s Processing triggers for libc-bin (2.39-0ubuntu9) ... 571s Reading package lists... 571s Building dependency tree... 571s Reading state information... 571s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 587s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 587s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 587s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 587s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 588s Reading package lists... 588s Reading package lists... 588s Building dependency tree... 588s Reading state information... 588s Calculating upgrade... 589s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 589s Reading package lists... 589s Building dependency tree... 589s Reading state information... 589s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 597s Reading package lists... 597s Building dependency tree... 597s Reading state information... 598s Starting pkgProblemResolver with broken count: 0 598s Starting 2 pkgProblemResolver with broken count: 0 598s Done 598s The following additional packages will be installed: 598s knot knot-dnssecutils knot-dnsutils libdnssec9t64 libfstrm0 libknot14t64 598s libxdp1 libzscanner4t64 598s The following NEW packages will be installed: 598s autopkgtest-satdep knot knot-dnssecutils knot-dnsutils libdnssec9t64 598s libfstrm0 libknot14t64 libxdp1 libzscanner4t64 598s 0 upgraded, 9 newly installed, 0 to remove and 0 not upgraded. 598s Need to get 1586 kB/1587 kB of archives. 598s After this operation, 6049 kB of additional disk space will be used. 598s Get:1 /tmp/autopkgtest.IrGy9d/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [724 B] 598s Get:2 http://ftpmaster.internal/ubuntu oracular/universe s390x libdnssec9t64 s390x 3.3.7-1 [31.1 kB] 598s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x libxdp1 s390x 1.4.2-1ubuntu4 [62.9 kB] 598s Get:4 http://ftpmaster.internal/ubuntu oracular/universe s390x libknot14t64 s390x 3.3.7-1 [209 kB] 598s Get:5 http://ftpmaster.internal/ubuntu oracular/universe s390x libzscanner4t64 s390x 3.3.7-1 [161 kB] 598s Get:6 http://ftpmaster.internal/ubuntu oracular/universe s390x knot s390x 3.3.7-1 [590 kB] 598s Get:7 http://ftpmaster.internal/ubuntu oracular/universe s390x knot-dnssecutils s390x 3.3.7-1 [285 kB] 599s Get:8 http://ftpmaster.internal/ubuntu oracular/universe s390x libfstrm0 s390x 0.6.1-1build4 [21.0 kB] 599s Get:9 http://ftpmaster.internal/ubuntu oracular/universe s390x knot-dnsutils s390x 3.3.7-1 [227 kB] 599s Fetched 1586 kB in 1s (2519 kB/s) 599s Selecting previously unselected package libdnssec9t64. 599s (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 ... 54756 files and directories currently installed.) 599s Preparing to unpack .../0-libdnssec9t64_3.3.7-1_s390x.deb ... 599s Unpacking libdnssec9t64 (3.3.7-1) ... 599s Selecting previously unselected package libxdp1:s390x. 599s Preparing to unpack .../1-libxdp1_1.4.2-1ubuntu4_s390x.deb ... 599s Unpacking libxdp1:s390x (1.4.2-1ubuntu4) ... 599s Selecting previously unselected package libknot14t64. 599s Preparing to unpack .../2-libknot14t64_3.3.7-1_s390x.deb ... 599s Unpacking libknot14t64 (3.3.7-1) ... 599s Selecting previously unselected package libzscanner4t64. 599s Preparing to unpack .../3-libzscanner4t64_3.3.7-1_s390x.deb ... 599s Unpacking libzscanner4t64 (3.3.7-1) ... 599s Selecting previously unselected package knot. 599s Preparing to unpack .../4-knot_3.3.7-1_s390x.deb ... 599s Unpacking knot (3.3.7-1) ... 599s Selecting previously unselected package knot-dnssecutils. 599s Preparing to unpack .../5-knot-dnssecutils_3.3.7-1_s390x.deb ... 599s Unpacking knot-dnssecutils (3.3.7-1) ... 599s Selecting previously unselected package libfstrm0:s390x. 599s Preparing to unpack .../6-libfstrm0_0.6.1-1build4_s390x.deb ... 599s Unpacking libfstrm0:s390x (0.6.1-1build4) ... 599s Selecting previously unselected package knot-dnsutils. 599s Preparing to unpack .../7-knot-dnsutils_3.3.7-1_s390x.deb ... 599s Unpacking knot-dnsutils (3.3.7-1) ... 599s Selecting previously unselected package autopkgtest-satdep. 599s Preparing to unpack .../8-2-autopkgtest-satdep.deb ... 599s Unpacking autopkgtest-satdep (0) ... 599s Setting up libzscanner4t64 (3.3.7-1) ... 599s Setting up libfstrm0:s390x (0.6.1-1build4) ... 599s Setting up libxdp1:s390x (1.4.2-1ubuntu4) ... 599s Setting up libdnssec9t64 (3.3.7-1) ... 599s Setting up libknot14t64 (3.3.7-1) ... 599s Setting up knot-dnsutils (3.3.7-1) ... 599s Setting up knot-dnssecutils (3.3.7-1) ... 599s Setting up knot (3.3.7-1) ... 600s Created symlink '/etc/systemd/system/multi-user.target.wants/knot.service' → '/usr/lib/systemd/system/knot.service'. 600s Setting up autopkgtest-satdep (0) ... 600s Processing triggers for ufw (0.36.2-6) ... 600s Processing triggers for man-db (2.12.1-2) ... 601s Processing triggers for dbus (1.14.10-4ubuntu4) ... 601s Processing triggers for libc-bin (2.39-0ubuntu9) ... 618s (Reading database ... 54844 files and directories currently installed.) 618s Removing autopkgtest-satdep (0) ... 628s autopkgtest [01:12:08]: test authoritative-server: [----------------------- 628s /usr/sbin/knotd + /usr/bin/kdig roundtrip tests 628s ------------ 628s workdir: /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts 628s IP addr: 127.199.171.163 628s knot args: --config=/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf --verbose 628s 628s set up config file and zonefile 628s ------------------------------- 628s ==> /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf <== 628s server: 628s rundir: "/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts" 628s listen: 127.199.171.163@8123 628s user: ubuntu:ubuntu 628s database: 628s storage: "/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts" 628s template: 628s - id: default 628s storage: "/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts" 628s file: "%s.zone" 628s zone: 628s - domain: example.net 628s dnssec-signing: on 628s 628s ==> /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/example.net.zone <== 628s @ 1D IN SOA a.ns hostmaster 2018103100 3h 15m 1w 1d 628s @ 1D IN NS a.ns.example.net. 628s @ 1D IN NS b.ns.example.net. 628s a.ns 1D IN A 192.0.2.1 628s b.ns 1D IN A 192.0.2.2 628s test 1D IN A 192.0.2.199 628s 628s kzonecheck'ing zonefile 628s ----------------------- 628s No error found 628s 628s launching knot 628s -------------- 628s debug: config '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf' 628s 2024-07-21T01:12:08+0000 debug: module 'mod-authsignal', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-cookies', loaded static 628s debug: module 'mod-authsignal', loaded static 628s debug: module 'mod-cookies', loaded static 628s debug: module 'mod-dnsproxy', loaded static 628s debug: module 'mod-noudp', loaded static 628s debug: module 'mod-onlinesign', loaded static 628s debug: module 'mod-probe', loaded static 628s debug: module 'mod-queryacl', loaded static 628s debug: module 'mod-rrl', loaded static 628s debug: module 'mod-stats', loaded static 628s debug: module 'mod-synthrecord', loaded static 628s debug: module 'mod-whoami', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-dnsproxy', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-noudp', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-onlinesign', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-probe', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-queryacl', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-rrl', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-stats', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-synthrecord', loaded static 628s 2024-07-21T01:12:08+0000 debug: module 'mod-whoami', loaded static 628s debug: socket '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' 628s error: failed to connect to socket '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' (not exists) 628s 2024-07-21T01:12:08+0000 info: Knot DNS 3.3.7 starting 628s 2024-07-21T01:12:08+0000 info: loaded configuration file '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf', mapsize 500 MiB 628s 2024-07-21T01:12:08+0000 info: using UDP reuseport, incoming TCP Fast Open 628s 2024-07-21T01:12:08+0000 info: binding to interface 127.199.171.163@8123 628s 2024-07-21T01:12:08+0000 info: process not allowed to set capabilities, skipping 628s 2024-07-21T01:12:08+0000 info: loading 1 zones 628s 2024-07-21T01:12:08+0000 info: [example.net.] zone will be loaded 628s 2024-07-21T01:12:08+0000 info: starting server 628s 2024-07-21T01:12:08+0000 info: [example.net.] zone file parsed, serial 2018103100 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, next key action, ZSK, generate at 2024-08-20T01:12:08+0000 628s 2024-07-21T01:12:08+0000 notice: [example.net.] DNSSEC, KSK submission, waiting for confirmation 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, key, tag 40794, algorithm ECDSAP256SHA256, KSK, public, ready, active+ 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, key, tag 32576, algorithm ECDSAP256SHA256, public, active 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, signing started 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, successfully signed, serial 2018103101 628s 2024-07-21T01:12:08+0000 info: [example.net.] loaded, serial none -> 2018103100 -> 2018103101, 2249 bytes 628s 2024-07-21T01:12:08+0000 info: [example.net.] DNSSEC, next signing at 2024-08-01T14:36:08+0000 628s 2024-07-21T01:12:08+0000 info: control, binding to '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' 628s 2024-07-21T01:12:08+0000 info: server started in the foreground, PID 2305 628s 2024-07-21T01:12:08+0000 info: [example.net.] zone file updated, serial 2018103100 -> 2018103101 629s debug: config '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf' 629s debug: module 'mod-authsignal', loaded static 629s debug: module 'mod-cookies', loaded static 629s debug: module 'mod-dnsproxy', loaded static 629s debug: module 'mod-noudp', loaded static 629s debug: module 'mod-onlinesign', loaded static 629s debug: module 'mod-probe', loaded static 629s debug: module 'mod-queryacl', loaded static 629s debug: module 'mod-rrl', loaded static 629s debug: module 'mod-stats', loaded static 629s debug: module 'mod-synthrecord', loaded static 629s debug: module 'mod-whoami', loaded static 629s debug: socket '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' 629s 2024-07-21T01:12:09+0000 info: control, received command 'status' 629s Running 629s 629s querying knot 629s ------------- 629s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 13945 629s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 0 629s 629s ;; QUESTION SECTION: 629s ;; test.example.net. IN A 629s 629s ;; ANSWER SECTION: 629s test.example.net. 86400 IN A 192.0.2.199 629s 629s ;; Received 50 B 629s ;; Time 2024-07-21 01:12:09 UTC 629s ;; From 127.199.171.163@8123(UDP) in 0.2 ms 629s 629s ;; ->>HEADER<<- opcode: QUERY; status: NXDOMAIN; id: 44055 629s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 0; AUTHORITY: 1; ADDITIONAL: 0 629s 629s ;; QUESTION SECTION: 629s ;; test2.example.net. IN A 629s 629s ;; AUTHORITY SECTION: 629s example.net. 86400 IN SOA a.ns.example.net. hostmaster.example.net. 2018103101 10800 900 604800 86400 629s 629s ;; Received 87 B 629s ;; Time 2024-07-21 01:12:09 UTC 629s ;; From 127.199.171.163@8123(UDP) in 0.0 ms 629s 629s modifying zone 629s -------------- 629s debug: config '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf' 629s debug: module 'mod-authsignal', loaded static 629s debug: module 'mod-cookies', loaded static 629s debug: module 'mod-dnsproxy', loaded static 629s debug: module 'mod-noudp', loaded static 629s debug: module 'mod-onlinesign', loaded static 629s debug: module 'mod-probe', loaded static 629s debug: module 'mod-queryacl', loaded static 629s debug: module 'mod-rrl', loaded static 629s debug: module 'mod-stats', loaded static 629s debug: module 'mod-synthrecord', loaded static 629s debug: module 'mod-whoami', loaded static 629s debug: socket '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' 629s 2024-07-21T01:12:09+0000 info: control, received command 'reload' 629s 2024-07-21T01:12:09+0000 info: reloading configuration file '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf' 629s 2024-07-21T01:12:09+0000 info: [example.net.] zone file parsed, serial 2018103101 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, next key action, ZSK, generate at 2024-08-20T01:12:08+0000 629s 2024-07-21T01:12:09+0000 notice: [example.net.] DNSSEC, KSK submission, waiting for confirmation 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, key, tag 40794, algorithm ECDSAP256SHA256, KSK, public, ready, active+ 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, key, tag 32576, algorithm ECDSAP256SHA256, public, active 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, signing started 629s 2024-07-21T01:12:09+0000 info: configuration reloaded 629s Reloaded 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, successfully signed, serial 2018103102 629s 2024-07-21T01:12:09+0000 info: [example.net.] loaded, serial 2018103101 -> 2018103101 -> 2018103102, 2586 bytes 629s 2024-07-21T01:12:09+0000 info: [example.net.] DNSSEC, next signing at 2024-08-01T14:36:08+0000 629s 2024-07-21T01:12:09+0000 info: [example.net.] zone file updated, serial 2018103101 -> 2018103102 630s 630s querying again 630s -------------- 630s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 61098 630s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 0 630s 630s ;; QUESTION SECTION: 630s ;; test.example.net. IN A 630s 630s ;; ANSWER SECTION: 630s test.example.net. 86400 IN A 192.0.2.199 630s 630s ;; Received 50 B 630s ;; Time 2024-07-21 01:12:10 UTC 630s ;; From 127.199.171.163@8123(UDP) in 0.1 ms 630s 630s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 40980 630s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 1; AUTHORITY: 0; ADDITIONAL: 0 630s 630s ;; QUESTION SECTION: 630s ;; test2.example.net. IN A 630s 630s ;; ANSWER SECTION: 630s test2.example.net. 86400 IN A 192.0.2.199 630s 630s ;; Received 51 B 630s ;; Time 2024-07-21 01:12:10 UTC 630s ;; From 127.199.171.163@8123(UDP) in 0.0 ms 630s 630s querying DNSSEC 630s --------------- 630s ;; ->>HEADER<<- opcode: QUERY; status: NOERROR; id: 52450 630s ;; Flags: qr aa rd; QUERY: 1; ANSWER: 3; AUTHORITY: 0; ADDITIONAL: 1 630s 630s ;; EDNS PSEUDOSECTION: 630s ;; Version: 0; flags: do; UDP size: 1232 B; ext-rcode: NOERROR 630s 630s ;; QUESTION SECTION: 630s ;; example.net. IN DNSKEY 630s 630s ;; ANSWER SECTION: 630s example.net. 86400 IN DNSKEY 256 3 13 Urmvr8Uc+mGVELmUdjBVpr7YIpc3hc88g4hnH5JleVZSCv2R0JOb9/RYBDEYzSB9Rm3yVqpFD8fEfKB/uz+/MA== 630s example.net. 86400 IN DNSKEY 257 3 13 sUdXd59mQm89+pdeVWET0YKfveFVKeFjFzZuwyPuQztuN/k1r+zHm21L0Ig6GuT7qP7UnOuTB03Vf/t3UENAYw== 630s example.net. 86400 IN RRSIG DNSKEY 13 2 86400 20240804011208 20240720234208 40794 example.net. DzFt6JEu9dx8zb1w+tAWvPCZFYoqhMPnpSnblEcm8i7+vKclN6n1fnmvq/TT9L/OjHApw0V2g1ggEj7R4zqdbQ== 630s 630s ;; Received 307 B 630s ;; Time 2024-07-21 01:12:10 UTC 630s ;; From 127.199.171.163@8123(UDP) in 0.0 ms 630s 630s listing keys with keymgr 630s ------------------------ 630s 253dbc52f4ed968d8c938b919944f58bddb49c06 ksk=yes zsk=no tag=40794 algorithm=13 size=256 public-only=no created=1721524328 pre-active=0 publish=1721524328 ready=1721524328 active=0 retire-active=0 retire=0 post-active=0 revoke=0 remove=0 630s 7e8e9b95921eacd3f4765fe9866e1ce96daebefe ksk=no zsk=yes tag=32576 algorithm=13 size=256 public-only=no created=1721524328 pre-active=0 publish=1721524328 ready=0 active=1721524328 retire-active=0 retire=0 post-active=0 revoke=0 remove=0 630s 630s cleaning up 630s ----------- 630s 260690 4 drwxrwxrwt 4 ubuntu ubuntu 4096 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts 630s 260703 4 -rw-r----- 1 ubuntu ubuntu 4 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.pid 630s 260713 0 s-w--w---- 1 ubuntu ubuntu 0 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock 630s 260697 4 -rw-rw-r-- 1 ubuntu ubuntu 366 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf 630s 260704 4 drwxrwx--- 3 ubuntu ubuntu 4096 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys 630s 260705 4 -rw-rw---- 1 ubuntu ubuntu 1152 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys/lock.mdb 630s 260707 4 drwxr-x--- 2 ubuntu ubuntu 4096 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys/keys 630s 260708 4 -rw-r----- 1 ubuntu ubuntu 262 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys/keys/253dbc52f4ed968d8c938b919944f58bddb49c06.pem 630s 260709 4 -rw-r----- 1 ubuntu ubuntu 258 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys/keys/7e8e9b95921eacd3f4765fe9866e1ce96daebefe.pem 630s 260706 44 -rw-rw---- 1 ubuntu ubuntu 45056 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/keys/data.mdb 630s 260714 4 -rw-rw---- 1 ubuntu ubuntu 3911 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/example.net.zone 630s 260710 4 drwxrwx--- 2 ubuntu ubuntu 4096 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/journal 630s 260711 4 -rw-rw---- 1 ubuntu ubuntu 1152 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/journal/lock.mdb 630s 260712 36 -rw-rw---- 1 ubuntu ubuntu 36864 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/journal/data.mdb 630s 260699 0 -rw-rw-r-- 1 ubuntu ubuntu 0 Jul 21 01:12 /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knotd.err 630s debug: config '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.conf' 630s debug: module 'mod-authsignal', loaded static 630s debug: module 'mod-cookies', loaded static 630s debug: module 'mod-dnsproxy', loaded static 630s debug: module 'mod-noudp', loaded static 630s debug: module 'mod-onlinesign', loaded static 630s debug: module 'mod-probe', loaded static 630s debug: module 'mod-queryacl', loaded static 630s debug: module 'mod-rrl', loaded static 630s debug: module 'mod-stats', loaded static 630s debug: module 'mod-synthrecord', loaded static 630s debug: module 'mod-whoami', loaded static 630s debug: socket '/tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knot.sock' 630s 2024-07-21T01:12:10+0000 info: control, received command 'stop' 630s 2024-07-21T01:12:10+0000 info: stopping server 630s Stopped 630s 2024-07-21T01:12:10+0000 info: updating persistent timer DB 630s 2024-07-21T01:12:10+0000 info: shutting down 630s ==> /tmp/autopkgtest.IrGy9d/authoritative-server-artifacts/knotd.err <== 630s autopkgtest [01:12:10]: test authoritative-server: -----------------------] 638s autopkgtest [01:12:18]: test authoritative-server: - - - - - - - - - - results - - - - - - - - - - 638s authoritative-server PASS 658s autopkgtest [01:12:38]: @@@@@@@@@@@@@@@@@@@@ summary 658s kdig SKIP exit status 77 and marked as skippable 658s authoritative-server PASS 699s nova [W] Using flock in scalingstack-bos01-s390x 699s flock: timeout while waiting to get lock 699s Creating nova instance adt-oracular-s390x-knot-20240721-010140-juju-7f2275-prod-proposed-migration-environment-3-5f88df24-d5e6-458d-b57a-da383964deb9 from image adt/ubuntu-oracular-s390x-server-20240720.img (UUID c4813fc9-ab2b-41de-947e-4df7311c6440)... 699s nova [W] Using flock in scalingstack-bos01-s390x 699s Creating nova instance adt-oracular-s390x-knot-20240721-010140-juju-7f2275-prod-proposed-migration-environment-3-5f88df24-d5e6-458d-b57a-da383964deb9 from image adt/ubuntu-oracular-s390x-server-20240720.img (UUID c4813fc9-ab2b-41de-947e-4df7311c6440)...