0s autopkgtest [04:11:10]: starting date and time: 2024-07-01 04:11:10+0000 0s autopkgtest [04:11:10]: git checkout: 85adf9a1 setup-testbed: prevent /tmp from getting a tmpfs mount 0s autopkgtest [04:11:10]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.192yub1s/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:openssl --apt-upgrade htpdate --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=openssl/3.2.1-3ubuntu1 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-ppc64el-18.secgroup --name adt-oracular-ppc64el-htpdate-20240701-041110-juju-7f2275-prod-proposed-migration-environment-3-7f312192-b562-4370-8496-4de18f81eab3 --image adt/ubuntu-oracular-ppc64el-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://ftpmaster.internal/ubuntu/ 105s autopkgtest [04:12:55]: testbed dpkg architecture: ppc64el 106s autopkgtest [04:12:56]: testbed apt version: 2.9.5 106s autopkgtest [04:12:56]: @@@@@@@@@@@@@@@@@@@@ test bed setup 107s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 107s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [43.2 kB] 107s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [2576 B] 107s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [379 kB] 107s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 107s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el Packages [68.7 kB] 107s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted ppc64el Packages [1368 B] 107s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe ppc64el Packages [334 kB] 107s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse ppc64el Packages [1768 B] 107s Fetched 949 kB in 1s (1100 kB/s) 107s Reading package lists... 110s Reading package lists... 110s Building dependency tree... 110s Reading state information... 110s Calculating upgrade... 110s The following packages will be upgraded: 110s dpkg dpkg-dev libdpkg-perl libssl3t64 lto-disabled-list openssl 110s 6 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 110s Need to get 6180 kB of archives. 110s After this operation, 996 kB of additional disk space will be used. 110s Get:1 http://ftpmaster.internal/ubuntu oracular/main ppc64el dpkg ppc64el 1.22.6ubuntu14 [1337 kB] 111s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el libssl3t64 ppc64el 3.2.1-3ubuntu1 [2341 kB] 111s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main ppc64el openssl ppc64el 3.2.1-3ubuntu1 [1144 kB] 111s Get:4 http://ftpmaster.internal/ubuntu oracular/main ppc64el dpkg-dev all 1.22.6ubuntu14 [1075 kB] 111s Get:5 http://ftpmaster.internal/ubuntu oracular/main ppc64el libdpkg-perl all 1.22.6ubuntu14 [270 kB] 111s Get:6 http://ftpmaster.internal/ubuntu oracular/main ppc64el lto-disabled-list all 50 [12.3 kB] 111s Fetched 6180 kB in 1s (7454 kB/s) 112s (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 ... 72692 files and directories currently installed.) 112s Preparing to unpack .../dpkg_1.22.6ubuntu14_ppc64el.deb ... 112s Unpacking dpkg (1.22.6ubuntu14) over (1.22.6ubuntu10) ... 112s Setting up dpkg (1.22.6ubuntu14) ... 113s (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 ... 72692 files and directories currently installed.) 113s Preparing to unpack .../libssl3t64_3.2.1-3ubuntu1_ppc64el.deb ... 113s Unpacking libssl3t64:ppc64el (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 113s Setting up libssl3t64:ppc64el (3.2.1-3ubuntu1) ... 113s (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 ... 72693 files and directories currently installed.) 113s Preparing to unpack .../openssl_3.2.1-3ubuntu1_ppc64el.deb ... 113s Unpacking openssl (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 113s Preparing to unpack .../dpkg-dev_1.22.6ubuntu14_all.deb ... 113s Unpacking dpkg-dev (1.22.6ubuntu14) over (1.22.6ubuntu10) ... 113s Preparing to unpack .../libdpkg-perl_1.22.6ubuntu14_all.deb ... 113s Unpacking libdpkg-perl (1.22.6ubuntu14) over (1.22.6ubuntu10) ... 113s Preparing to unpack .../lto-disabled-list_50_all.deb ... 113s Unpacking lto-disabled-list (50) over (49) ... 113s Setting up lto-disabled-list (50) ... 113s Setting up libdpkg-perl (1.22.6ubuntu14) ... 113s Setting up openssl (3.2.1-3ubuntu1) ... 113s Installing new version of config file /etc/ssl/openssl.cnf ... 113s Setting up dpkg-dev (1.22.6ubuntu14) ... 113s Processing triggers for man-db (2.12.1-2) ... 117s Processing triggers for libc-bin (2.39-0ubuntu9) ... 117s Reading package lists... 117s Building dependency tree... 117s Reading state information... 117s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 117s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 117s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 118s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 118s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 119s Reading package lists... 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Calculating upgrade... 119s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 119s Reading package lists... 119s Building dependency tree... 119s Reading state information... 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s autopkgtest [04:13:10]: rebooting testbed after setup commands that affected boot 154s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 184s autopkgtest [04:14:14]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:05:55 UTC 2024 186s autopkgtest [04:14:16]: @@@@@@@@@@@@@@@@@@@@ apt-source htpdate 189s Get:1 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (dsc) [1954 B] 189s Get:2 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (tar) [16.9 kB] 189s Get:3 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (diff) [6420 B] 189s gpgv: Signature made Mon Apr 1 05:53:34 2024 UTC 189s gpgv: using RSA key A089FB36AAFBDAD5ACC1325069F790171A210984 189s gpgv: Can't check signature: No public key 189s dpkg-source: warning: cannot verify inline signature for ./htpdate_1.3.7-2build2.dsc: no acceptable signature found 189s autopkgtest [04:14:19]: testing package htpdate version 1.3.7-2build2 189s autopkgtest [04:14:19]: build not needed 190s autopkgtest [04:14:20]: test command1: preparing testbed 191s Reading package lists... 192s Building dependency tree... 192s Reading state information... 192s Starting pkgProblemResolver with broken count: 0 192s Starting 2 pkgProblemResolver with broken count: 0 192s Done 192s The following additional packages will be installed: 192s htpdate 192s The following NEW packages will be installed: 192s autopkgtest-satdep htpdate 192s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 192s Need to get 20.4 kB/21.1 kB of archives. 192s After this operation, 109 kB of additional disk space will be used. 192s Get:1 /tmp/autopkgtest.nGzAUx/1-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [704 B] 192s Get:2 http://ftpmaster.internal/ubuntu oracular/universe ppc64el htpdate ppc64el 1.3.7-2build2 [20.4 kB] 193s Fetched 20.4 kB in 0s (42.2 kB/s) 193s Selecting previously unselected package htpdate. 193s (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 ... 72716 files and directories currently installed.) 193s Preparing to unpack .../htpdate_1.3.7-2build2_ppc64el.deb ... 193s Unpacking htpdate (1.3.7-2build2) ... 193s Selecting previously unselected package autopkgtest-satdep. 193s Preparing to unpack .../1-autopkgtest-satdep.deb ... 193s Unpacking autopkgtest-satdep (0) ... 193s Setting up htpdate (1.3.7-2build2) ... 194s Created symlink /etc/systemd/system/multi-user.target.wants/htpdate.service → /usr/lib/systemd/system/htpdate.service. 194s Setting up autopkgtest-satdep (0) ... 194s Processing triggers for man-db (2.12.1-2) ... 197s (Reading database ... 72728 files and directories currently installed.) 197s Removing autopkgtest-satdep (0) ... 197s autopkgtest [04:14:27]: test command1: htpdate -qd www.debian.org 197s autopkgtest [04:14:27]: test command1: [----------------------- 200s Proxy: http://squid.internal:3128 200s www.debian.org 80, 01 Jul 2024 04:14:28 GMT (347 ms) => 0 200s www.debian.org 80, 01 Jul 2024 04:14:28 GMT (137 ms) => 0 200s www.debian.org 80, 01 Jul 2024 04:14:28 GMT (139 ms) => 0 200s www.debian.org 80, 01 Jul 2024 04:14:30 GMT (139 ms) => 0 200s when: 1000000000, nap: 62500000 200s offset: 0.000000 200s No time correction needed 200s autopkgtest [04:14:30]: test command1: -----------------------] 200s autopkgtest [04:14:30]: test command1: - - - - - - - - - - results - - - - - - - - - - 200s command1 PASS 201s autopkgtest [04:14:31]: test command2: preparing testbed 202s Reading package lists... 202s Building dependency tree... 202s Reading state information... 202s Starting pkgProblemResolver with broken count: 0 202s Starting 2 pkgProblemResolver with broken count: 0 202s Done 203s The following NEW packages will be installed: 203s autopkgtest-satdep 203s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 203s Need to get 0 B/708 B of archives. 203s After this operation, 0 B of additional disk space will be used. 203s Get:1 /tmp/autopkgtest.nGzAUx/2-autopkgtest-satdep.deb autopkgtest-satdep ppc64el 0 [708 B] 203s Selecting previously unselected package autopkgtest-satdep. 203s (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 ... 72728 files and directories currently installed.) 203s Preparing to unpack .../2-autopkgtest-satdep.deb ... 203s Unpacking autopkgtest-satdep (0) ... 203s Setting up autopkgtest-satdep (0) ... 204s (Reading database ... 72728 files and directories currently installed.) 204s Removing autopkgtest-satdep (0) ... 205s autopkgtest [04:14:35]: test command2: htpdate -qd https://www.debian.org 205s autopkgtest [04:14:35]: test command2: [----------------------- 209s No server suitable for synchronization found 209s Proxy: http://squid.internal:3128 209s www.debian.org 443, 01 Jul 2024 04:14:37 GMT (143 ms) => 0 209s www.debian.org 443, 01 Jul 2024 04:14:37 GMT (139 ms) => 0 209s www.debian.org 443, 01 Jul 2024 04:14:37 GMT (140 ms) => 0 209s www.debian.org 443, 01 Jul 2024 04:14:39 GMT (142 ms) => 0 209s when: 1000000000, nap: 62500000 209s offset: 0.000000 209s autopkgtest [04:14:39]: test command2: -----------------------] 209s command2 FAIL non-zero exit status 1 209s autopkgtest [04:14:39]: test command2: - - - - - - - - - - results - - - - - - - - - - 210s autopkgtest [04:14:40]: test command2: - - - - - - - - - - stderr - - - - - - - - - - 210s No server suitable for synchronization found 210s autopkgtest [04:14:40]: @@@@@@@@@@@@@@@@@@@@ summary 210s command1 PASS 210s command2 FAIL non-zero exit status 1 221s nova [W] Using flock in scalingstack-bos02-ppc64el 221s Creating nova instance adt-oracular-ppc64el-htpdate-20240701-041110-juju-7f2275-prod-proposed-migration-environment-3-7f312192-b562-4370-8496-4de18f81eab3 from image adt/ubuntu-oracular-ppc64el-server-20240630.img (UUID f2401da1-4d2c-472d-96ec-bc4cf39cad92)...