0s autopkgtest [10:23:44]: starting date and time: 2024-06-26 10:23:44+0000 0s autopkgtest [10:23:44]: git checkout: 85adf9a1 setup-testbed: prevent /tmp from getting a tmpfs mount 0s autopkgtest [10:23:44]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.tsb_mdyr/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-2@bos02-s390x-13.secgroup --name adt-oracular-s390x-htpdate-20240626-102344-juju-7f2275-prod-proposed-migration-environment-2-379ec5dc-6290-440f-aa17-c9e0386090c6 --image adt/ubuntu-oracular-s390x-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --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/ 130s autopkgtest [10:25:54]: testbed dpkg architecture: s390x 130s autopkgtest [10:25:54]: testbed apt version: 2.9.5 130s autopkgtest [10:25:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup 131s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 131s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [7052 B] 131s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [50.5 kB] 131s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [1680 B] 131s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [394 kB] 132s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x Packages [72.9 kB] 132s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted s390x Packages [1860 B] 132s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe s390x Packages [361 kB] 132s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse s390x Packages [1768 B] 132s Fetched 1001 kB in 1s (1279 kB/s) 132s Reading package lists... 158s Reading package lists... 158s Building dependency tree... 158s Reading state information... 158s Calculating upgrade... 158s The following packages will be upgraded: 158s hwdata libssl3t64 openssl wget xfsprogs 159s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 159s Need to get 4286 kB of archives. 159s After this operation, 809 kB of additional disk space will be used. 159s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x libssl3t64 s390x 3.2.1-3ubuntu1 [1834 kB] 159s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main s390x openssl s390x 3.2.1-3ubuntu1 [1123 kB] 159s Get:3 http://ftpmaster.internal/ubuntu oracular/main s390x wget s390x 1.24.5-1ubuntu2 [364 kB] 159s Get:4 http://ftpmaster.internal/ubuntu oracular/main s390x hwdata all 0.383-1 [29.3 kB] 159s Get:5 http://ftpmaster.internal/ubuntu oracular/main s390x xfsprogs s390x 6.8.0-2.2 [935 kB] 160s Fetched 4286 kB in 1s (3649 kB/s) 160s (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 ... 54644 files and directories currently installed.) 160s Preparing to unpack .../libssl3t64_3.2.1-3ubuntu1_s390x.deb ... 160s Unpacking libssl3t64:s390x (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 160s Setting up libssl3t64:s390x (3.2.1-3ubuntu1) ... 160s (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 ... 54645 files and directories currently installed.) 160s Preparing to unpack .../openssl_3.2.1-3ubuntu1_s390x.deb ... 160s Unpacking openssl (3.2.1-3ubuntu1) over (3.0.13-0ubuntu4) ... 160s Preparing to unpack .../wget_1.24.5-1ubuntu2_s390x.deb ... 160s Unpacking wget (1.24.5-1ubuntu2) over (1.24.5-1ubuntu1) ... 160s Preparing to unpack .../hwdata_0.383-1_all.deb ... 160s Unpacking hwdata (0.383-1) over (0.380-1) ... 160s Preparing to unpack .../xfsprogs_6.8.0-2.2_s390x.deb ... 160s Unpacking xfsprogs (6.8.0-2.2) over (6.8.0-2.1) ... 160s Setting up wget (1.24.5-1ubuntu2) ... 160s Setting up hwdata (0.383-1) ... 160s Setting up xfsprogs (6.8.0-2.2) ... 160s update-initramfs: deferring update (trigger activated) 161s Setting up openssl (3.2.1-3ubuntu1) ... 161s Installing new version of config file /etc/ssl/openssl.cnf ... 161s Processing triggers for man-db (2.12.1-2) ... 161s Processing triggers for install-info (7.1-3build2) ... 161s Processing triggers for libc-bin (2.39-0ubuntu9) ... 161s Processing triggers for initramfs-tools (0.142ubuntu28) ... 161s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 161s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 166s Using config file '/etc/zipl.conf' 166s Building bootmap in '/boot' 166s Adding IPL section 'ubuntu' (default) 166s Preparing boot device for LD-IPL: vda (0000). 166s Done. 166s Reading package lists... 166s Building dependency tree... 166s Reading state information... 166s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 168s Hit:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 168s Hit:2 http://ftpmaster.internal/ubuntu oracular InRelease 169s Hit:3 http://ftpmaster.internal/ubuntu oracular-updates InRelease 169s Hit:4 http://ftpmaster.internal/ubuntu oracular-security InRelease 170s Reading package lists... 170s Reading package lists... 170s Building dependency tree... 170s Reading state information... 170s Calculating upgrade... 170s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 170s Reading package lists... 170s Building dependency tree... 170s Reading state information... 170s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 171s autopkgtest [10:26:35]: rebooting testbed after setup commands that affected boot 199s autopkgtest [10:27:03]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP Sat Apr 20 00:14:26 UTC 2024 218s autopkgtest [10:27:22]: @@@@@@@@@@@@@@@@@@@@ apt-source htpdate 220s Get:1 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (dsc) [1954 B] 220s Get:2 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (tar) [16.9 kB] 220s Get:3 http://ftpmaster.internal/ubuntu oracular/universe htpdate 1.3.7-2build2 (diff) [6420 B] 221s gpgv: Signature made Mon Apr 1 05:53:34 2024 UTC 221s gpgv: using RSA key A089FB36AAFBDAD5ACC1325069F790171A210984 221s gpgv: Can't check signature: No public key 221s dpkg-source: warning: cannot verify inline signature for ./htpdate_1.3.7-2build2.dsc: no acceptable signature found 221s autopkgtest [10:27:25]: testing package htpdate version 1.3.7-2build2 221s autopkgtest [10:27:25]: build not needed 221s autopkgtest [10:27:25]: test command1: preparing testbed 222s Reading package lists... 223s Building dependency tree... 223s Reading state information... 223s Starting pkgProblemResolver with broken count: 0 223s Starting 2 pkgProblemResolver with broken count: 0 223s Done 223s The following additional packages will be installed: 223s htpdate 223s The following NEW packages will be installed: 223s autopkgtest-satdep htpdate 223s 0 upgraded, 2 newly installed, 0 to remove and 0 not upgraded. 223s Need to get 19.3 kB/20.0 kB of archives. 223s After this operation, 66.6 kB of additional disk space will be used. 223s Get:1 /tmp/autopkgtest.F8AyB9/1-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [704 B] 223s Get:2 http://ftpmaster.internal/ubuntu oracular/universe s390x htpdate s390x 1.3.7-2build2 [19.3 kB] 223s Fetched 19.3 kB in 0s (87.3 kB/s) 223s Selecting previously unselected package htpdate. 224s (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 ... 54666 files and directories currently installed.) 224s Preparing to unpack .../htpdate_1.3.7-2build2_s390x.deb ... 224s Unpacking htpdate (1.3.7-2build2) ... 224s Selecting previously unselected package autopkgtest-satdep. 224s Preparing to unpack .../1-autopkgtest-satdep.deb ... 224s Unpacking autopkgtest-satdep (0) ... 224s Setting up htpdate (1.3.7-2build2) ... 224s Created symlink /etc/systemd/system/multi-user.target.wants/htpdate.service → /usr/lib/systemd/system/htpdate.service. 224s Setting up autopkgtest-satdep (0) ... 224s Processing triggers for man-db (2.12.1-2) ... 227s (Reading database ... 54678 files and directories currently installed.) 227s Removing autopkgtest-satdep (0) ... 227s autopkgtest [10:27:31]: test command1: htpdate -qd www.debian.org 227s autopkgtest [10:27:31]: test command1: [----------------------- 231s Proxy: http://squid.internal:3128 231s www.debian.org 80, 26 Jun 2024 10:27:33 GMT (215 ms) => 0 231s www.debian.org 80, 26 Jun 2024 10:27:33 GMT (139 ms) => 0 231s www.debian.org 80, 26 Jun 2024 10:27:33 GMT (139 ms) => 0 231s www.debian.org 80, 26 Jun 2024 10:27:35 GMT (140 ms) => 0 231s when: 1000000000, nap: 62500000 231s offset: 0.000000 231s No time correction needed 231s autopkgtest [10:27:35]: test command1: -----------------------] 231s autopkgtest [10:27:35]: test command1: - - - - - - - - - - results - - - - - - - - - - 231s command1 PASS 232s autopkgtest [10:27:36]: test command2: preparing testbed 233s Reading package lists... 233s Building dependency tree... 233s Reading state information... 234s Starting pkgProblemResolver with broken count: 0 234s Starting 2 pkgProblemResolver with broken count: 0 234s Done 234s The following NEW packages will be installed: 234s autopkgtest-satdep 234s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 234s Need to get 0 B/704 B of archives. 234s After this operation, 0 B of additional disk space will be used. 234s Get:1 /tmp/autopkgtest.F8AyB9/2-autopkgtest-satdep.deb autopkgtest-satdep s390x 0 [704 B] 234s Selecting previously unselected package autopkgtest-satdep. 234s (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 ... 54678 files and directories currently installed.) 234s Preparing to unpack .../2-autopkgtest-satdep.deb ... 234s Unpacking autopkgtest-satdep (0) ... 234s Setting up autopkgtest-satdep (0) ... 236s (Reading database ... 54678 files and directories currently installed.) 236s Removing autopkgtest-satdep (0) ... 236s autopkgtest [10:27:40]: test command2: htpdate -qd https://www.debian.org 236s autopkgtest [10:27:40]: test command2: [----------------------- 240s Proxy: http://squid.internal:3128 240s www.debian.org 443, 26 Jun 2024 10:27:42 GMT (145 ms) => 0 240s www.debian.org 443, 26 Jun 2024 10:27:42 GMT (155 ms) => 0 240s www.debian.org 443, 26 Jun 2024 10:27:42 GMT (138 ms) => 0 240s www.debian.org 443, 26 Jun 2024 10:27:44 GMT (140 ms) => 0 240s when: 1000000000, nap: 62500000 240s offset: 0.000000 240s No time correction needed 240s autopkgtest [10:27:44]: test command2: -----------------------] 240s command2 PASS 240s autopkgtest [10:27:44]: test command2: - - - - - - - - - - results - - - - - - - - - - 241s autopkgtest [10:27:45]: @@@@@@@@@@@@@@@@@@@@ summary 241s command1 PASS 241s command2 PASS 284s nova [W] Using flock in scalingstack-bos02-s390x 284s Creating nova instance adt-oracular-s390x-htpdate-20240626-102344-juju-7f2275-prod-proposed-migration-environment-2-379ec5dc-6290-440f-aa17-c9e0386090c6 from image adt/ubuntu-oracular-s390x-server-20240625.img (UUID f029f818-16e1-4f96-ad01-3182fd7f5948)...