0s autopkgtest [22:17:37]: starting date and time: 2024-12-17 22:17:37+0000 0s autopkgtest [22:17:37]: git checkout: c2a78735 Merge branch 'timeout-nova-boot' into 'ubuntu/production' 0s autopkgtest [22:17:37]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.o5sd5f23/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:dpkg --apt-upgrade bind-dyndb-ldap --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=dpkg/1.22.6ubuntu6.2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-ppc64el-24.secgroup --name adt-noble-ppc64el-bind-dyndb-ldap-20241217-221737-juju-7f2275-prod-proposed-migration-environment-20-8a607ab5-c962-44fb-b018-e8760e00f399 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-ppc64el -e TERM=linux -e ''"'"'http_proxy=http://squid.internal:3128'"'"'' -e ''"'"'https_proxy=http://squid.internal:3128'"'"'' -e ''"'"'no_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 72s autopkgtest [22:18:49]: testbed dpkg architecture: ppc64el 72s autopkgtest [22:18:49]: testbed apt version: 2.7.14build2 73s autopkgtest [22:18:50]: @@@@@@@@@@@@@@@@@@@@ test bed setup 73s autopkgtest [22:18:50]: testbed release detected to be: None 74s autopkgtest [22:18:51]: updating testbed package index (apt update) 74s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 74s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 74s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 74s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 74s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [76.5 kB] 74s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [4008 B] 74s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [75.5 kB] 74s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [109 kB] 74s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3752 B] 74s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1176 B] 74s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 74s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [450 kB] 75s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [9704 B] 75s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 79s Fetched 995 kB in 1s (1163 kB/s) 80s Reading package lists... 81s Reading package lists... 81s Building dependency tree... 81s Reading state information... 81s Calculating upgrade... 81s The following packages will be upgraded: 81s cloud-init fwupd libfwupd2 linux-firmware 82s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 82s Need to get 503 MB of archives. 82s After this operation, 1005 kB of additional disk space will be used. 82s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libfwupd2 ppc64el 1.9.27-0ubuntu1~24.04.1 [138 kB] 82s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el fwupd ppc64el 1.9.27-0ubuntu1~24.04.1 [4690 kB] 82s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el linux-firmware ppc64el 20240318.git3b128b60-0ubuntu2.6 [498 MB] 96s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el cloud-init all 24.4-0ubuntu1~24.04.2 [602 kB] 96s Preconfiguring packages ... 96s Fetched 503 MB in 14s (35.7 MB/s) 96s (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 ... 103294 files and directories currently installed.) 96s Preparing to unpack .../libfwupd2_1.9.27-0ubuntu1~24.04.1_ppc64el.deb ... 96s Unpacking libfwupd2:ppc64el (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 96s Preparing to unpack .../fwupd_1.9.27-0ubuntu1~24.04.1_ppc64el.deb ... 96s Unpacking fwupd (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 96s Preparing to unpack .../linux-firmware_20240318.git3b128b60-0ubuntu2.6_ppc64el.deb ... 96s Unpacking linux-firmware (20240318.git3b128b60-0ubuntu2.6) over (20240318.git3b128b60-0ubuntu2.5) ... 100s Preparing to unpack .../cloud-init_24.4-0ubuntu1~24.04.2_all.deb ... 100s Unpacking cloud-init (24.4-0ubuntu1~24.04.2) over (24.3.1-0ubuntu0~24.04.2) ... 100s Setting up cloud-init (24.4-0ubuntu1~24.04.2) ... 102s Setting up linux-firmware (20240318.git3b128b60-0ubuntu2.6) ... 102s Setting up libfwupd2:ppc64el (1.9.27-0ubuntu1~24.04.1) ... 102s Setting up fwupd (1.9.27-0ubuntu1~24.04.1) ... 102s fwupd-offline-update.service is a disabled or a static unit not running, not starting it. 103s fwupd-refresh.service is a disabled or a static unit not running, not starting it. 103s fwupd.service is a disabled or a static unit not running, not starting it. 103s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 103s Processing triggers for man-db (2.12.0-4build2) ... 104s Processing triggers for dbus (1.14.10-4ubuntu4.1) ... 104s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 104s Processing triggers for initramfs-tools (0.142ubuntu25.4) ... 104s update-initramfs: Generating /boot/initrd.img-6.8.0-51-generic 104s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 113s 0 upgraded, 0 newly installed, 0 to remove and 3 not upgraded. 113s autopkgtest [22:19:30]: upgrading testbed (apt dist-upgrade and autopurge) 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 114s Starting 2 pkgProblemResolver with broken count: 0 114s Done 115s Entering ResolveByKeep 115s 115s The following packages will be upgraded: 115s dpkg dpkg-dev libdpkg-perl 115s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 115s Need to get 2683 kB of archives. 115s After this operation, 0 B of additional disk space will be used. 115s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el dpkg ppc64el 1.22.6ubuntu6.2 [1340 kB] 116s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el dpkg-dev all 1.22.6ubuntu6.2 [1074 kB] 116s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libdpkg-perl all 1.22.6ubuntu6.2 [269 kB] 116s Fetched 2683 kB in 1s (3917 kB/s) 116s (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 ... 103399 files and directories currently installed.) 116s Preparing to unpack .../dpkg_1.22.6ubuntu6.2_ppc64el.deb ... 116s Unpacking dpkg (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 116s Setting up dpkg (1.22.6ubuntu6.2) ... 117s (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 ... 103399 files and directories currently installed.) 117s Preparing to unpack .../dpkg-dev_1.22.6ubuntu6.2_all.deb ... 117s Unpacking dpkg-dev (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 117s Preparing to unpack .../libdpkg-perl_1.22.6ubuntu6.2_all.deb ... 117s Unpacking libdpkg-perl (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 117s Setting up libdpkg-perl (1.22.6ubuntu6.2) ... 117s Setting up dpkg-dev (1.22.6ubuntu6.2) ... 117s Processing triggers for man-db (2.12.0-4build2) ... 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Starting pkgProblemResolver with broken count: 0 119s Starting 2 pkgProblemResolver with broken count: 0 119s Done 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s autopkgtest [22:19:37]: rebooting testbed after setup commands that affected boot 124s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 157s autopkgtest [22:20:14]: testbed running kernel: Linux 6.8.0-51-generic #52-Ubuntu SMP Thu Dec 5 14:46:44 UTC 2024 159s autopkgtest [22:20:16]: @@@@@@@@@@@@@@@@@@@@ apt-source bind-dyndb-ldap 161s Get:1 http://ftpmaster.internal/ubuntu noble-updates/universe bind-dyndb-ldap 11.10-6ubuntu11 (dsc) [2271 B] 161s Get:2 http://ftpmaster.internal/ubuntu noble-updates/universe bind-dyndb-ldap 11.10-6ubuntu11 (tar) [355 kB] 161s Get:3 http://ftpmaster.internal/ubuntu noble-updates/universe bind-dyndb-ldap 11.10-6ubuntu11 (diff) [13.7 kB] 161s gpgv: Signature made Thu Jul 18 15:25:07 2024 UTC 161s gpgv: using RSA key 50C4A0DDCF31E452CEB19B516569D855A744BE93 161s gpgv: Can't check signature: No public key 161s dpkg-source: warning: cannot verify inline signature for ./bind-dyndb-ldap_11.10-6ubuntu11.dsc: no acceptable signature found 161s autopkgtest [22:20:18]: testing package bind-dyndb-ldap version 11.10-6ubuntu11 162s autopkgtest [22:20:19]: build not needed 162s autopkgtest [22:20:19]: test dyndb-ldap: preparing testbed 163s Reading package lists... 163s Building dependency tree... 163s Reading state information... 163s Starting pkgProblemResolver with broken count: 0 163s Starting 2 pkgProblemResolver with broken count: 0 163s Done 164s The following NEW packages will be installed: 164s bind9 bind9-dyndb-ldap bind9-utils dns-root-data ldap-utils libltdl7 164s libodbc2 slapd 164s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded. 164s Need to get 2730 kB of archives. 164s After this operation, 12.3 MB of additional disk space will be used. 164s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el bind9-utils ppc64el 1:9.18.28-0ubuntu0.24.04.1 [169 kB] 164s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el dns-root-data all 2023112702~willsync1 [4450 B] 164s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el bind9 ppc64el 1:9.18.28-0ubuntu0.24.04.1 [289 kB] 164s Get:4 http://ftpmaster.internal/ubuntu noble/main ppc64el libltdl7 ppc64el 2.4.7-7build1 [48.2 kB] 164s Get:5 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el libodbc2 ppc64el 2.3.12-1ubuntu0.24.04.1 [188 kB] 164s Get:6 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el slapd ppc64el 2.6.7+dfsg-1~exp1ubuntu8.1 [1760 kB] 164s Get:7 http://ftpmaster.internal/ubuntu noble-updates/universe ppc64el bind9-dyndb-ldap ppc64el 11.10-6ubuntu11 [116 kB] 164s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el ldap-utils ppc64el 2.6.7+dfsg-1~exp1ubuntu8.1 [155 kB] 165s Preconfiguring packages ... 165s Fetched 2730 kB in 1s (3969 kB/s) 165s Selecting previously unselected package bind9-utils. 165s (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 ... 103399 files and directories currently installed.) 165s Preparing to unpack .../0-bind9-utils_1%3a9.18.28-0ubuntu0.24.04.1_ppc64el.deb ... 165s Unpacking bind9-utils (1:9.18.28-0ubuntu0.24.04.1) ... 165s Selecting previously unselected package dns-root-data. 165s Preparing to unpack .../1-dns-root-data_2023112702~willsync1_all.deb ... 165s Unpacking dns-root-data (2023112702~willsync1) ... 165s Selecting previously unselected package bind9. 165s Preparing to unpack .../2-bind9_1%3a9.18.28-0ubuntu0.24.04.1_ppc64el.deb ... 165s Unpacking bind9 (1:9.18.28-0ubuntu0.24.04.1) ... 165s Selecting previously unselected package libltdl7:ppc64el. 165s Preparing to unpack .../3-libltdl7_2.4.7-7build1_ppc64el.deb ... 165s Unpacking libltdl7:ppc64el (2.4.7-7build1) ... 165s Selecting previously unselected package libodbc2:ppc64el. 165s Preparing to unpack .../4-libodbc2_2.3.12-1ubuntu0.24.04.1_ppc64el.deb ... 165s Unpacking libodbc2:ppc64el (2.3.12-1ubuntu0.24.04.1) ... 165s Selecting previously unselected package slapd. 165s Preparing to unpack .../5-slapd_2.6.7+dfsg-1~exp1ubuntu8.1_ppc64el.deb ... 166s Unpacking slapd (2.6.7+dfsg-1~exp1ubuntu8.1) ... 166s Selecting previously unselected package bind9-dyndb-ldap. 166s Preparing to unpack .../6-bind9-dyndb-ldap_11.10-6ubuntu11_ppc64el.deb ... 166s Unpacking bind9-dyndb-ldap (11.10-6ubuntu11) ... 166s Selecting previously unselected package ldap-utils. 166s Preparing to unpack .../7-ldap-utils_2.6.7+dfsg-1~exp1ubuntu8.1_ppc64el.deb ... 166s Unpacking ldap-utils (2.6.7+dfsg-1~exp1ubuntu8.1) ... 166s Setting up ldap-utils (2.6.7+dfsg-1~exp1ubuntu8.1) ... 166s Setting up dns-root-data (2023112702~willsync1) ... 166s Setting up bind9-utils (1:9.18.28-0ubuntu0.24.04.1) ... 166s Setting up libltdl7:ppc64el (2.4.7-7build1) ... 166s Setting up libodbc2:ppc64el (2.3.12-1ubuntu0.24.04.1) ... 166s Setting up bind9 (1:9.18.28-0ubuntu0.24.04.1) ... 166s info: Selecting GID from range 100 to 999 ... 166s info: Adding group `bind' (GID 108) ... 166s info: Selecting UID from range 100 to 999 ... 166s 166s info: Adding system user `bind' (UID 107) ... 166s info: Adding new user `bind' (UID 107) with group `bind' ... 166s info: Not creating home directory `/var/cache/bind'. 166s wrote key file "/etc/bind/rndc.key" 167s named-resolvconf.service is a disabled or a static unit, not starting it. 167s Created symlink /etc/systemd/system/bind9.service → /usr/lib/systemd/system/named.service. 167s Created symlink /etc/systemd/system/multi-user.target.wants/named.service → /usr/lib/systemd/system/named.service. 167s Setting up slapd (2.6.7+dfsg-1~exp1ubuntu8.1) ... 168s Creating new user openldap... done. 168s Creating initial configuration... done. 168s Creating LDAP directory... done. 168s Setting up bind9-dyndb-ldap (11.10-6ubuntu11) ... 168s Processing triggers for ufw (0.36.2-6) ... 168s Processing triggers for man-db (2.12.0-4build2) ... 170s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 171s autopkgtest [22:20:28]: test dyndb-ldap: [----------------------- 171s ## Adjust bind9's apparmor profile if needed 171s ## Setting up slapd 172s Backing up /etc/ldap/slapd.d in /var/backups/slapd-2.6.7+dfsg-1~exp1ubuntu8.1... done. 172s Moving old database directory to /var/backups: 172s - directory unknown... done. 172s Creating initial configuration... done. 172s Creating LDAP directory... done. 173s Waiting for slapd to be ready . 173s 173s ## Configuring slapd logging 173s SASL/EXTERNAL authentication started 173s SASL username: gidNumber=0+uidNumber=0,cn=peercred,cn=external,cn=auth 173s SASL SSF: 0 173s modifying entry "cn=config" 173s 173s 173s ## Creating bind9 ldap uid 173s adding new entry "uid=bind9,dc=example,dc=internal" 173s 173s modifying entry "olcDatabase={1}mdb,cn=config" 173s 173s 173s ## Loading bind9-dyndb-ldap schema 173s adding new entry "cn=dns,cn=schema,cn=config" 173s 173s 173s ## Loading syncproc module 173s modifying entry "cn=module{0},cn=config" 173s 173s adding new entry "olcOverlay=syncprov,olcDatabase={1}mdb,cn=config" 173s 173s 173s ## Loading DNS sample data 173s adding new entry "ou=dns,dc=example,dc=internal" 173s 173s adding new entry "idnsName=example.internal,ou=dns,dc=example,dc=internal" 173s 173s adding new entry "idnsName=dep8,idnsName=example.internal,ou=dns,dc=example,dc=internal" 173s 173s adding new entry "idnsName=_ldap._tcp,idnsName=example.internal,ou=dns,dc=example,dc=internal" 173s 173s adding new entry "idnsName=somehost,idnsName=example.internal,ou=dns,dc=example,dc=internal" 173s 173s 173s ## Configuring bind9 to use bind9-dyndb-ldap 173s ## Restarting bind9 173s 173s ## Checking DNS records 173s Using domain server: 173s Name: 127.0.0.1 173s Address: 127.0.0.1#53 173s Aliases: 173s 173s somehost.example.internal has address 192.168.141.6 173s 173s Using domain server: 173s Name: 127.0.0.1 173s Address: 127.0.0.1#53 173s Aliases: 173s 173s dep8.example.internal is an alias for example.internal. 173s example.internal has address 192.168.141.5 173s 173s Using domain server: 173s Name: 127.0.0.1 173s Address: 127.0.0.1#53 173s Aliases: 173s 173s _ldap._tcp.example.internal has SRV record 0 100 389 dep8.example.internal. 173s 173s Using domain server: 173s Name: 127.0.0.1 173s Address: 127.0.0.1#53 173s Aliases: 173s 173s example.internal has SOA record dep8.example.internal.example.internal. root.dep8.example.internal.example.internal. 1734474030 10800 900 604800 86400 173s autopkgtest [22:20:30]: test dyndb-ldap: -----------------------] 174s autopkgtest [22:20:31]: test dyndb-ldap: - - - - - - - - - - results - - - - - - - - - - 174s dyndb-ldap PASS 174s autopkgtest [22:20:31]: @@@@@@@@@@@@@@@@@@@@ summary 174s dyndb-ldap PASS 191s nova [W] Using flock in prodstack6-ppc64el 191s Creating nova instance adt-noble-ppc64el-bind-dyndb-ldap-20241217-221737-juju-7f2275-prod-proposed-migration-environment-20-8a607ab5-c962-44fb-b018-e8760e00f399 from image adt/ubuntu-noble-ppc64el-server-20241217.img (UUID c05ba098-b366-4390-91d1-1c665f2b9c85)... 191s nova [W] Timed out waiting for d4368633-ccbf-46d0-8129-507194a10455 to get deleted.