0s autopkgtest [10:10:31]: starting date and time: 2024-06-26 10:10:31+0000 0s autopkgtest [10:10:31]: git checkout: 85adf9a1 setup-testbed: prevent /tmp from getting a tmpfs mount 0s autopkgtest [10:10:31]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.ec3id5bz/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@lcy02-89.secgroup --name adt-oracular-amd64-htpdate-20240626-101028-juju-7f2275-prod-proposed-migration-environment-3-688b5d54-37ed-40a8-8280-35d846422a4d --image adt/ubuntu-oracular-amd64-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/ 373s autopkgtest [10:16:44]: testbed dpkg architecture: amd64 379s autopkgtest [10:16:50]: testbed apt version: 2.9.5 379s autopkgtest [10:16:50]: @@@@@@@@@@@@@@@@@@@@ test bed setup 380s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 380s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [394 kB] 380s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [1680 B] 380s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [50.5 kB] 380s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 380s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 Packages [88.8 kB] 380s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main i386 Packages [69.5 kB] 380s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/restricted amd64 Packages [28.9 kB] 380s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/restricted i386 Packages [6732 B] 380s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/universe amd64 Packages [385 kB] 380s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/universe i386 Packages [183 kB] 380s Get:12 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse i386 Packages [3368 B] 380s Get:13 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse amd64 Packages [7628 B] 380s Fetched 1336 kB in 0s (4496 kB/s) 380s Reading package lists... 389s Reading package lists... 389s Building dependency tree... 389s Reading state information... 390s Calculating upgrade... 390s The following packages will be upgraded: 390s hwdata libssl3t64 openssl wget xfsprogs 390s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 390s Need to get 4544 kB of archives. 390s After this operation, 791 kB of additional disk space will be used. 390s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 libssl3t64 amd64 3.2.1-3ubuntu1 [2135 kB] 391s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main amd64 openssl amd64 3.2.1-3ubuntu1 [1119 kB] 391s Get:3 http://ftpmaster.internal/ubuntu oracular/main amd64 wget amd64 1.24.5-1ubuntu2 [349 kB] 391s Get:4 http://ftpmaster.internal/ubuntu oracular/main amd64 hwdata all 0.383-1 [29.3 kB] 391s Get:5 http://ftpmaster.internal/ubuntu oracular/main amd64 xfsprogs amd64 6.8.0-2.2 [911 kB] 391s Fetched 4544 kB in 0s (11.3 MB/s) 392s (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 ... 74417 files and directories currently installed.) 392s Preparing to unpack .../libssl3t64_3.2.1-3ubuntu1_amd64.deb ... 392s Unpacking libssl3t64:amd64 (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 392s Setting up libssl3t64:amd64 (3.2.1-3ubuntu1) ... 392s (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 ... 74418 files and directories currently installed.) 392s Preparing to unpack .../openssl_3.2.1-3ubuntu1_amd64.deb ... 392s Unpacking openssl (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 392s Preparing to unpack .../wget_1.24.5-1ubuntu2_amd64.deb ... 392s Unpacking wget (1.24.5-1ubuntu2) over (1.24.5-1ubuntu1) ... 392s Preparing to unpack .../hwdata_0.383-1_all.deb ... 392s Unpacking hwdata (0.383-1) over (0.380-1) ... 392s Preparing to unpack .../xfsprogs_6.8.0-2.2_amd64.deb ... 392s Unpacking xfsprogs (6.8.0-2.2) over (6.8.0-2.1) ... 392s Setting up wget (1.24.5-1ubuntu2) ... 392s Setting up hwdata (0.383-1) ... 392s Setting up xfsprogs (6.8.0-2.2) ... 392s update-initramfs: deferring update (trigger activated) 393s Setting up openssl (3.2.1-3ubuntu1) ... 393s Installing new version of config file /etc/ssl/openssl.cnf ... 393s Processing triggers for man-db (2.12.1-2) ... 394s Processing triggers for install-info (7.1-3build2) ... 395s Processing triggers for libc-bin (2.39-0ubuntu9) ... 395s Processing triggers for initramfs-tools (0.142ubuntu28) ... 395s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 395s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 407s Reading package lists... 407s Building dependency tree... 407s Reading state information... 407s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 413s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 413s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 413s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 413s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 415s Reading package lists... 415s Reading package lists... 416s Building dependency tree... 416s Reading state information... 416s Calculating upgrade... 417s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 417s Reading package lists... 417s Building dependency tree... 417s Reading state information... 418s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 418s autopkgtest [10:17:29]: rebooting testbed after setup commands that affected boot 435s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 444s autopkgtest [10:17:55]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 00:40:06 UTC 2024 447s autopkgtest [10:17:58]: @@@@@@@@@@@@@@@@@@@@ apt-source htpdate 450s Get:1 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (dsc) [1954 B] 450s Get:2 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (tar) [16.9 kB] 450s Get:3 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (diff) [6420 B] 450s gpgv: Signature made Mon Apr 1 05:53:34 2024 UTC 450s gpgv: using RSA key A089FB36AAFBDAD5ACC1325069F790171A210984 450s gpgv: Can't check signature: No public key 450s dpkg-source: warning: cannot verify inline signature for ./htpdate_1.3.7-2build2.dsc: no acceptable signature found 450s autopkgtest [10:18:01]: testing package htpdate version 1.3.7-2build2 450s autopkgtest [10:18:01]: build not needed 451s autopkgtest [10:18:02]: test command1: preparing testbed 453s Reading package lists... 453s Building dependency tree... 453s Reading state information... 454s Starting pkgProblemResolver with broken count: 0 454s Starting 2 pkgProblemResolver with broken count: 0 454s Done 455s The following additional packages will be installed: 455s htpdate 455s The following NEW packages will be installed: 455s autopkgtest-satdep htpdate 455s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 455s Need to get 18.9 kB/19.6 kB of archives. 455s After this operation, 71.7 kB of additional disk space will be used. 455s Get:1 /tmp/autopkgtest.7OuFzT/1-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [704 B] 455s Get:2 http://ftpmaster.internal/ubuntu oracular/universe amd64 htpdate amd64 1.3.7-2build2 [18.9 kB] 455s Fetched 18.9 kB in 0s (466 kB/s) 456s Selecting previously unselected package htpdate. 456s (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 ... 74439 files and directories currently installed.) 456s Preparing to unpack .../htpdate_1.3.7-2build2_amd64.deb ... 456s Unpacking htpdate (1.3.7-2build2) ... 456s Selecting previously unselected package autopkgtest-satdep. 456s Preparing to unpack .../1-autopkgtest-satdep.deb ... 456s Unpacking autopkgtest-satdep (0) ... 456s Setting up htpdate (1.3.7-2build2) ... 456s Created symlink /etc/systemd/system/multi-user.target.wants/htpdate.service → /usr/lib/systemd/system/htpdate.service. 457s Setting up autopkgtest-satdep (0) ... 457s Processing triggers for man-db (2.12.1-2) ... 461s (Reading database ... 74451 files and directories currently installed.) 461s Removing autopkgtest-satdep (0) ... 462s autopkgtest [10:18:13]: test command1: htpdate -qd www.debian.org 462s autopkgtest [10:18:13]: test command1: [----------------------- 465s Proxy: http://squid.internal:3128 465s www.debian.org 80, 26 Jun 2024 10:18:14 GMT (153 ms) => 0 465s www.debian.org 80, 26 Jun 2024 10:18:14 GMT (73 ms) => 0 465s www.debian.org 80, 26 Jun 2024 10:18:15 GMT (78 ms) => -1 465s www.debian.org 80, 26 Jun 2024 10:18:15 GMT (76 ms) => 0 465s when: 750000000, nap: 62500000 465s offset: 0.250000 465s Offset 0.125 seconds 465s autopkgtest [10:18:16]: test command1: -----------------------] 465s autopkgtest [10:18:16]: test command1: - - - - - - - - - - results - - - - - - - - - - 465s command1 PASS 465s autopkgtest [10:18:16]: test command2: preparing testbed 467s Reading package lists... 467s Building dependency tree... 467s Reading state information... 467s Starting pkgProblemResolver with broken count: 0 467s Starting 2 pkgProblemResolver with broken count: 0 467s Done 468s The following NEW packages will be installed: 468s autopkgtest-satdep 468s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 468s Need to get 0 B/708 B of archives. 468s After this operation, 0 B of additional disk space will be used. 468s Get:1 /tmp/autopkgtest.7OuFzT/2-autopkgtest-satdep.deb autopkgtest-satdep amd64 0 [708 B] 469s Selecting previously unselected package autopkgtest-satdep. 469s (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 ... 74451 files and directories currently installed.) 469s Preparing to unpack .../2-autopkgtest-satdep.deb ... 469s Unpacking autopkgtest-satdep (0) ... 469s Setting up autopkgtest-satdep (0) ... 471s (Reading database ... 74451 files and directories currently installed.) 471s Removing autopkgtest-satdep (0) ... 472s autopkgtest [10:18:23]: test command2: htpdate -qd https://www.debian.org 472s autopkgtest [10:18:23]: test command2: [----------------------- 474s Proxy: http://squid.internal:3128 474s www.debian.org 443, 26 Jun 2024 10:18:24 GMT (77 ms) => 0 474s www.debian.org 443, 26 Jun 2024 10:18:24 GMT (90 ms) => 0 474s www.debian.org 443, 26 Jun 2024 10:18:24 GMT (75 ms) => 0 474s www.debian.org 443, 26 Jun 2024 10:18:25 GMT (74 ms) => 0 474s when: 1000000000, nap: 62500000 474s offset: 0.000000 474s No time correction needed 474s autopkgtest [10:18:25]: test command2: -----------------------] 474s autopkgtest [10:18:25]: test command2: - - - - - - - - - - results - - - - - - - - - - 474s command2 PASS 474s autopkgtest [10:18:25]: @@@@@@@@@@@@@@@@@@@@ summary 474s command1 PASS 474s command2 PASS 494s nova [W] Skipping flock for amd64 494s Creating nova instance adt-oracular-amd64-htpdate-20240626-101028-juju-7f2275-prod-proposed-migration-environment-3-688b5d54-37ed-40a8-8280-35d846422a4d from image adt/ubuntu-oracular-amd64-server-20240626.img (UUID 54cc919f-9ac3-413d-b63d-89c2f18d44d3)...