67s autopkgtest [10:13:37]: starting date and time: 2024-06-26 10:13:37+0000 67s autopkgtest [10:13:37]: git checkout: 85adf9a1 setup-testbed: prevent /tmp from getting a tmpfs mount 67s autopkgtest [10:13:37]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.avm67j2k/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@bos03-arm64-12.secgroup --name adt-oracular-arm64-htpdate-20240626-101131-juju-7f2275-prod-proposed-migration-environment-3-b4354657-b310-479c-a640-1715b16d032a --image adt/ubuntu-oracular-arm64-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/ 586s autopkgtest [10:22:16]: testbed dpkg architecture: arm64 593s autopkgtest [10:22:23]: testbed apt version: 2.9.5 593s autopkgtest [10:22:23]: @@@@@@@@@@@@@@@@@@@@ test bed setup 594s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 595s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [1680 B] 595s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [394 kB] 595s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [50.5 kB] 595s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 595s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [79.3 kB] 595s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [33.3 kB] 595s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [347 kB] 595s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [7576 B] 595s Fetched 1031 kB in 1s (1127 kB/s) 595s Reading package lists... 613s Reading package lists... 613s Building dependency tree... 613s Reading state information... 613s Calculating upgrade... 614s The following packages will be upgraded: 614s hwdata libssl3t64 openssl wget xfsprogs 614s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 614s Need to get 4911 kB of archives. 614s After this operation, 1437 kB of additional disk space will be used. 614s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libssl3t64 arm64 3.2.1-3ubuntu1 [2533 kB] 614s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 openssl arm64 3.2.1-3ubuntu1 [1101 kB] 614s Get:3 http://ftpmaster.internal/ubuntu oracular/main arm64 wget arm64 1.24.5-1ubuntu2 [345 kB] 614s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 hwdata all 0.383-1 [29.3 kB] 614s Get:5 http://ftpmaster.internal/ubuntu oracular/main arm64 xfsprogs arm64 6.8.0-2.2 [902 kB] 615s Fetched 4911 kB in 1s (6229 kB/s) 615s (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 ... 78321 files and directories currently installed.) 615s Preparing to unpack .../libssl3t64_3.2.1-3ubuntu1_arm64.deb ... 615s Unpacking libssl3t64:arm64 (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 615s Setting up libssl3t64:arm64 (3.2.1-3ubuntu1) ... 615s (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 ... 78322 files and directories currently installed.) 615s Preparing to unpack .../openssl_3.2.1-3ubuntu1_arm64.deb ... 615s Unpacking openssl (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 615s Preparing to unpack .../wget_1.24.5-1ubuntu2_arm64.deb ... 615s Unpacking wget (1.24.5-1ubuntu2) over (1.24.5-1ubuntu1) ... 615s Preparing to unpack .../hwdata_0.383-1_all.deb ... 615s Unpacking hwdata (0.383-1) over (0.380-1) ... 615s Preparing to unpack .../xfsprogs_6.8.0-2.2_arm64.deb ... 615s Unpacking xfsprogs (6.8.0-2.2) over (6.8.0-2.1) ... 616s Setting up wget (1.24.5-1ubuntu2) ... 616s Setting up hwdata (0.383-1) ... 616s Setting up xfsprogs (6.8.0-2.2) ... 616s update-initramfs: deferring update (trigger activated) 616s Setting up openssl (3.2.1-3ubuntu1) ... 616s Installing new version of config file /etc/ssl/openssl.cnf ... 616s Processing triggers for man-db (2.12.1-2) ... 617s Processing triggers for install-info (7.1-3build2) ... 617s Processing triggers for libc-bin (2.39-0ubuntu9) ... 617s Processing triggers for initramfs-tools (0.142ubuntu28) ... 617s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 617s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 630s System running in EFI mode, skipping. 631s Reading package lists... 631s Building dependency tree... 631s Reading state information... 631s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 632s Hit:1 http://ftpmaster.internal/ubuntu oracular InRelease 632s Hit:2 http://ftpmaster.internal/ubuntu oracular-updates InRelease 633s Hit:3 http://ftpmaster.internal/ubuntu oracular-security InRelease 633s Hit:4 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 634s Reading package lists... 634s Reading package lists... 635s Building dependency tree... 635s Reading state information... 635s Calculating upgrade... 635s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 635s Reading package lists... 636s Building dependency tree... 636s Reading state information... 636s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 636s autopkgtest [10:23:06]: rebooting testbed after setup commands that affected boot 656s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 664s autopkgtest [10:23:34]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 671s autopkgtest [10:23:41]: @@@@@@@@@@@@@@@@@@@@ apt-source htpdate 675s Get:1 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (dsc) [1954 B] 675s Get:2 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (tar) [16.9 kB] 675s Get:3 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (diff) [6420 B] 675s gpgv: Signature made Mon Apr 1 05:53:34 2024 UTC 675s gpgv: using RSA key A089FB36AAFBDAD5ACC1325069F790171A210984 675s gpgv: Can't check signature: No public key 675s dpkg-source: warning: cannot verify inline signature for ./htpdate_1.3.7-2build2.dsc: no acceptable signature found 675s autopkgtest [10:23:45]: testing package htpdate version 1.3.7-2build2 676s autopkgtest [10:23:46]: build not needed 676s autopkgtest [10:23:46]: test command1: preparing testbed 679s Reading package lists... 680s Building dependency tree... 680s Reading state information... 680s Starting pkgProblemResolver with broken count: 0 680s Starting 2 pkgProblemResolver with broken count: 0 680s Done 680s The following additional packages will be installed: 680s htpdate 681s The following NEW packages will be installed: 681s autopkgtest-satdep htpdate 681s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 681s Need to get 25.1 kB/25.8 kB of archives. 681s After this operation, 108 kB of additional disk space will be used. 681s Get:1 /tmp/autopkgtest.55kzr7/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [708 B] 681s Get:2 http://ftpmaster.internal/ubuntu oracular/universe arm64 htpdate arm64 1.3.7-2build2 [25.1 kB] 681s Fetched 25.1 kB in 0s (103 kB/s) 682s Selecting previously unselected package htpdate. 682s (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 ... 78343 files and directories currently installed.) 682s Preparing to unpack .../htpdate_1.3.7-2build2_arm64.deb ... 682s Unpacking htpdate (1.3.7-2build2) ... 682s Selecting previously unselected package autopkgtest-satdep. 682s Preparing to unpack .../1-autopkgtest-satdep.deb ... 682s Unpacking autopkgtest-satdep (0) ... 682s Setting up htpdate (1.3.7-2build2) ... 682s Created symlink /etc/systemd/system/multi-user.target.wants/htpdate.service → /usr/lib/systemd/system/htpdate.service. 683s Setting up autopkgtest-satdep (0) ... 683s Processing triggers for man-db (2.12.1-2) ... 687s (Reading database ... 78355 files and directories currently installed.) 687s Removing autopkgtest-satdep (0) ... 689s autopkgtest [10:23:59]: test command1: htpdate -qd www.debian.org 689s autopkgtest [10:23:59]: test command1: [----------------------- 692s Proxy: http://squid.internal:3128 692s www.debian.org 80, 26 Jun 2024 10:24:00 GMT (271 ms) => 0 692s www.debian.org 80, 26 Jun 2024 10:24:00 GMT (140 ms) => 0 692s www.debian.org 80, 26 Jun 2024 10:24:00 GMT (144 ms) => 0 692s www.debian.org 80, 26 Jun 2024 10:24:02 GMT (140 ms) => 0 692s when: 1000000000, nap: 62500000 692s offset: 0.000000 692s No time correction needed 692s autopkgtest [10:24:02]: test command1: -----------------------] 693s autopkgtest [10:24:03]: test command1: - - - - - - - - - - results - - - - - - - - - - 693s command1 PASS 694s autopkgtest [10:24:04]: test command2: preparing testbed 696s Reading package lists... 697s Building dependency tree... 697s Reading state information... 697s Starting pkgProblemResolver with broken count: 0 697s Starting 2 pkgProblemResolver with broken count: 0 697s Done 697s The following NEW packages will be installed: 697s autopkgtest-satdep 697s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 697s Need to get 0 B/700 B of archives. 697s After this operation, 0 B of additional disk space will be used. 697s Get:1 /tmp/autopkgtest.55kzr7/2-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [700 B] 698s Selecting previously unselected package autopkgtest-satdep. 698s (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 ... 78355 files and directories currently installed.) 698s Preparing to unpack .../2-autopkgtest-satdep.deb ... 698s Unpacking autopkgtest-satdep (0) ... 698s Setting up autopkgtest-satdep (0) ... 701s (Reading database ... 78355 files and directories currently installed.) 701s Removing autopkgtest-satdep (0) ... 702s autopkgtest [10:24:12]: test command2: htpdate -qd https://www.debian.org 702s autopkgtest [10:24:12]: test command2: [----------------------- 706s Proxy: http://squid.internal:3128 706s www.debian.org 443, 26 Jun 2024 10:24:14 GMT (142 ms) => 0 706s www.debian.org 443, 26 Jun 2024 10:24:14 GMT (141 ms) => 0 706s www.debian.org 443, 26 Jun 2024 10:24:14 GMT (140 ms) => 0 706s www.debian.org 443, 26 Jun 2024 10:24:16 GMT (150 ms) => 0 706s when: 1000000000, nap: 62500000 706s offset: 0.000000 706s No time correction needed 706s autopkgtest [10:24:16]: test command2: -----------------------] 707s autopkgtest [10:24:17]: test command2: - - - - - - - - - - results - - - - - - - - - - 707s command2 PASS 707s autopkgtest [10:24:17]: @@@@@@@@@@@@@@@@@@@@ summary 707s command1 PASS 707s command2 PASS 714s nova [W] Skipping flock in bos03-arm64 714s Creating nova instance adt-oracular-arm64-htpdate-20240626-101131-juju-7f2275-prod-proposed-migration-environment-3-b4354657-b310-479c-a640-1715b16d032a from image adt/ubuntu-oracular-arm64-server-20240625.img (UUID acc6a354-b762-4649-b52e-eeffeb25d069)...