0s autopkgtest [11:46:59]: starting date and time: 2025-02-19 11:46:59+0000
  0s autopkgtest [11:46:59]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production'
  0s autopkgtest [11:46:59]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.vy_f84eb/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:sphinx --apt-upgrade pyhamtools --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=sphinx/8.1.3-5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-2.secgroup --name adt-plucky-amd64-pyhamtools-20250219-114658-juju-7f2275-prod-proposed-migration-environment-20-03adbc2c-9bc9-48d4-8c1b-c1b6be9d5af0 --image adt/ubuntu-plucky-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-amd64 -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/
247s autopkgtest [11:51:06]: testbed dpkg architecture: amd64
248s autopkgtest [11:51:06]: testbed apt version: 2.9.29
248s autopkgtest [11:51:07]: @@@@@@@@@@@@@@@@@@@@ test bed setup
248s autopkgtest [11:51:07]: testbed release detected to be: None
249s autopkgtest [11:51:08]: updating testbed package index (apt update)
249s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [110 kB]
250s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease
250s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease
250s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease
250s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [750 kB]
251s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/restricted Sources [3120 B]
251s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [76.1 kB]
251s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [13.9 kB]
251s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main i386 Packages [81.8 kB]
251s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 Packages [101 kB]
251s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/restricted amd64 Packages [7984 B]
251s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/restricted i386 Packages [2412 B]
251s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/universe amd64 Packages [697 kB]
251s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/universe i386 Packages [265 kB]
251s Get:15 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse amd64 Packages [11.5 kB]
251s Get:16 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse i386 Packages [3128 B]
251s Fetched 2124 kB in 2s (1032 kB/s)
252s Reading package lists...
253s Reading package lists...
253s Building dependency tree...
253s Reading state information...
254s Calculating upgrade...
254s The following NEW packages will be installed:
254s   libapt-pkg7.0
254s The following packages will be upgraded:
254s   apt apt-utils iproute2 liblsof0 libp11-kit0 lsof rsyslog
254s 7 upgraded, 1 newly installed, 0 to remove and 0 not upgraded.
254s Need to get 5234 kB of archives.
254s After this operation, 4074 kB of additional disk space will be used.
254s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 libapt-pkg7.0 amd64 2.9.30 [1131 kB]
255s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 apt amd64 2.9.30 [1434 kB]
255s Get:3 http://ftpmaster.internal/ubuntu plucky/main amd64 apt-utils amd64 2.9.30 [222 kB]
255s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 iproute2 amd64 6.13.0-1ubuntu1 [1277 kB]
256s Get:5 http://ftpmaster.internal/ubuntu plucky/main amd64 libp11-kit0 amd64 0.25.5-2ubuntu3 [311 kB]
256s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 rsyslog amd64 8.2412.0-2ubuntu1 [555 kB]
256s Get:7 http://ftpmaster.internal/ubuntu plucky/main amd64 lsof amd64 4.99.4+dfsg-1 [245 kB]
256s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 liblsof0 amd64 4.99.4+dfsg-1 [59.6 kB]
256s Preconfiguring packages ...
257s Fetched 5234 kB in 2s (2279 kB/s)
257s Selecting previously unselected package libapt-pkg7.0:amd64.
257s (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 ... 108925 files and directories currently installed.)
257s Preparing to unpack .../libapt-pkg7.0_2.9.30_amd64.deb ...
257s Unpacking libapt-pkg7.0:amd64 (2.9.30) ...
257s Setting up libapt-pkg7.0:amd64 (2.9.30) ...
257s (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 ... 108974 files and directories currently installed.)
257s Preparing to unpack .../archives/apt_2.9.30_amd64.deb ...
257s Unpacking apt (2.9.30) over (2.9.29) ...
257s Setting up apt (2.9.30) ...
258s (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 ... 108974 files and directories currently installed.)
258s Preparing to unpack .../0-apt-utils_2.9.30_amd64.deb ...
258s Unpacking apt-utils (2.9.30) over (2.9.29) ...
258s Preparing to unpack .../1-iproute2_6.13.0-1ubuntu1_amd64.deb ...
258s Unpacking iproute2 (6.13.0-1ubuntu1) over (6.10.0-2ubuntu1) ...
258s Preparing to unpack .../2-libp11-kit0_0.25.5-2ubuntu3_amd64.deb ...
258s Unpacking libp11-kit0:amd64 (0.25.5-2ubuntu3) over (0.25.5-2ubuntu2) ...
258s Preparing to unpack .../3-rsyslog_8.2412.0-2ubuntu1_amd64.deb ...
258s Unpacking rsyslog (8.2412.0-2ubuntu1) over (8.2412.0-1ubuntu1) ...
258s Preparing to unpack .../4-lsof_4.99.4+dfsg-1_amd64.deb ...
258s Unpacking lsof (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ...
259s Preparing to unpack .../5-liblsof0_4.99.4+dfsg-1_amd64.deb ...
259s Unpacking liblsof0 (4.99.4+dfsg-1) over (4.99.3+dfsg-2) ...
259s Setting up apt-utils (2.9.30) ...
259s Setting up liblsof0 (4.99.4+dfsg-1) ...
259s Setting up iproute2 (6.13.0-1ubuntu1) ...
259s Setting up rsyslog (8.2412.0-2ubuntu1) ...
259s info: The user `syslog' is already a member of `adm'.
260s Setting up libp11-kit0:amd64 (0.25.5-2ubuntu3) ...
260s Setting up lsof (4.99.4+dfsg-1) ...
260s Processing triggers for man-db (2.13.0-1) ...
262s Processing triggers for libc-bin (2.40-4ubuntu1) ...
263s Reading package lists...
263s Building dependency tree...
263s Reading state information...
264s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
264s autopkgtest [11:51:23]: upgrading testbed (apt dist-upgrade and autopurge)
264s Reading package lists...
264s Building dependency tree...
264s Reading state information...
265s Calculating upgrade...Starting pkgProblemResolver with broken count: 0
265s Starting 2 pkgProblemResolver with broken count: 0
265s Done
265s Entering ResolveByKeep
266s 
266s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
266s Reading package lists...
267s Building dependency tree...
267s Reading state information...
267s Starting pkgProblemResolver with broken count: 0
267s Starting 2 pkgProblemResolver with broken count: 0
267s Done
267s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded.
268s autopkgtest [11:51:27]: rebooting testbed after setup commands that affected boot
290s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds...
297s autopkgtest [11:51:56]: testbed running kernel: Linux 6.12.0-15-generic #15-Ubuntu SMP PREEMPT_DYNAMIC Tue Feb  4 16:02:16 UTC 2025
299s autopkgtest [11:51:58]: @@@@@@@@@@@@@@@@@@@@ apt-source pyhamtools
303s Get:1 http://ftpmaster.internal/ubuntu plucky/universe pyhamtools 0.10.0-1 (dsc) [2121 B]
303s Get:2 http://ftpmaster.internal/ubuntu plucky/universe pyhamtools 0.10.0-1 (tar) [5507 kB]
303s Get:3 http://ftpmaster.internal/ubuntu plucky/universe pyhamtools 0.10.0-1 (diff) [3564 B]
303s gpgv: Signature made Tue Jun  4 20:30:07 2024 UTC
303s gpgv:                using RSA key 5C48FE6157F49179597087C64C5A6BAB12D2A7AE
303s gpgv: Can't check signature: No public key
303s dpkg-source: warning: cannot verify inline signature for ./pyhamtools_0.10.0-1.dsc: no acceptable signature found
303s autopkgtest [11:52:02]: testing package pyhamtools version 0.10.0-1
304s autopkgtest [11:52:03]: build not needed
305s autopkgtest [11:52:04]: test test: preparing testbed
306s Reading package lists...
306s Building dependency tree...
306s Reading state information...
306s Starting pkgProblemResolver with broken count: 0
306s Starting 2 pkgProblemResolver with broken count: 0
306s Done
307s The following NEW packages will be installed:
307s   libjs-jquery libjs-sphinxdoc libjs-underscore libxslt1.1
307s   python3-async-timeout python3-bs4 python3-deprecated python3-ephem
307s   python3-lxml python3-packaging python3-pyhamtools python3-pytz python3-redis
307s   python3-soupsieve python3-tz python3-wrapt
307s 0 upgraded, 16 newly installed, 0 to remove and 0 not upgraded.
307s Need to get 4466 kB of archives.
307s After this operation, 19.4 MB of additional disk space will be used.
307s Get:1 http://ftpmaster.internal/ubuntu plucky/main amd64 libjs-jquery all 3.6.1+dfsg+~3.5.14-1 [328 kB]
307s Get:2 http://ftpmaster.internal/ubuntu plucky/main amd64 libjs-underscore all 1.13.4~dfsg+~1.11.4-3 [118 kB]
307s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main amd64 libjs-sphinxdoc all 8.1.3-5 [31.0 kB]
307s Get:4 http://ftpmaster.internal/ubuntu plucky/main amd64 libxslt1.1 amd64 1.1.39-0exp1ubuntu2 [175 kB]
308s Get:5 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-async-timeout all 5.0.1-1 [6830 B]
308s Get:6 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-soupsieve all 2.6-1 [33.0 kB]
308s Get:7 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-bs4 all 4.13.3-1 [136 kB]
308s Get:8 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-wrapt amd64 1.15.0-4 [34.8 kB]
308s Get:9 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-deprecated all 1.2.18-1 [10.6 kB]
308s Get:10 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-ephem amd64 4.1.6-1build1 [1331 kB]
308s Get:11 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-lxml amd64 5.3.1-1 [1831 kB]
308s Get:12 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-packaging all 24.2-1 [51.5 kB]
308s Get:13 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-pytz all 2025.1-3 [162 kB]
308s Get:14 http://ftpmaster.internal/ubuntu plucky/main amd64 python3-tz all 2025.1-3 [1866 B]
308s Get:15 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-redis all 4.3.4-4 [166 kB]
308s Get:16 http://ftpmaster.internal/ubuntu plucky/universe amd64 python3-pyhamtools all 0.10.0-1 [49.5 kB]
309s Fetched 4466 kB in 1s (3176 kB/s)
309s Selecting previously unselected package libjs-jquery.
309s (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 ... 108975 files and directories currently installed.)
309s Preparing to unpack .../00-libjs-jquery_3.6.1+dfsg+~3.5.14-1_all.deb ...
309s Unpacking libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
309s Selecting previously unselected package libjs-underscore.
309s Preparing to unpack .../01-libjs-underscore_1.13.4~dfsg+~1.11.4-3_all.deb ...
309s Unpacking libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
309s Selecting previously unselected package libjs-sphinxdoc.
309s Preparing to unpack .../02-libjs-sphinxdoc_8.1.3-5_all.deb ...
309s Unpacking libjs-sphinxdoc (8.1.3-5) ...
309s Selecting previously unselected package libxslt1.1:amd64.
309s Preparing to unpack .../03-libxslt1.1_1.1.39-0exp1ubuntu2_amd64.deb ...
309s Unpacking libxslt1.1:amd64 (1.1.39-0exp1ubuntu2) ...
309s Selecting previously unselected package python3-async-timeout.
309s Preparing to unpack .../04-python3-async-timeout_5.0.1-1_all.deb ...
309s Unpacking python3-async-timeout (5.0.1-1) ...
309s Selecting previously unselected package python3-soupsieve.
309s Preparing to unpack .../05-python3-soupsieve_2.6-1_all.deb ...
309s Unpacking python3-soupsieve (2.6-1) ...
309s Selecting previously unselected package python3-bs4.
309s Preparing to unpack .../06-python3-bs4_4.13.3-1_all.deb ...
309s Unpacking python3-bs4 (4.13.3-1) ...
309s Selecting previously unselected package python3-wrapt.
309s Preparing to unpack .../07-python3-wrapt_1.15.0-4_amd64.deb ...
309s Unpacking python3-wrapt (1.15.0-4) ...
309s Selecting previously unselected package python3-deprecated.
309s Preparing to unpack .../08-python3-deprecated_1.2.18-1_all.deb ...
309s Unpacking python3-deprecated (1.2.18-1) ...
309s Selecting previously unselected package python3-ephem.
309s Preparing to unpack .../09-python3-ephem_4.1.6-1build1_amd64.deb ...
309s Unpacking python3-ephem (4.1.6-1build1) ...
309s Selecting previously unselected package python3-lxml:amd64.
309s Preparing to unpack .../10-python3-lxml_5.3.1-1_amd64.deb ...
309s Unpacking python3-lxml:amd64 (5.3.1-1) ...
309s Selecting previously unselected package python3-packaging.
309s Preparing to unpack .../11-python3-packaging_24.2-1_all.deb ...
309s Unpacking python3-packaging (24.2-1) ...
309s Selecting previously unselected package python3-pytz.
309s Preparing to unpack .../12-python3-pytz_2025.1-3_all.deb ...
309s Unpacking python3-pytz (2025.1-3) ...
309s Selecting previously unselected package python3-tz.
310s Preparing to unpack .../13-python3-tz_2025.1-3_all.deb ...
310s Unpacking python3-tz (2025.1-3) ...
310s Selecting previously unselected package python3-redis.
310s Preparing to unpack .../14-python3-redis_4.3.4-4_all.deb ...
310s Unpacking python3-redis (4.3.4-4) ...
310s Selecting previously unselected package python3-pyhamtools.
310s Preparing to unpack .../15-python3-pyhamtools_0.10.0-1_all.deb ...
310s Unpacking python3-pyhamtools (0.10.0-1) ...
310s Setting up python3-ephem (4.1.6-1build1) ...
310s Setting up python3-pytz (2025.1-3) ...
310s Setting up python3-tz (2025.1-3) ...
310s Setting up python3-async-timeout (5.0.1-1) ...
310s Setting up python3-packaging (24.2-1) ...
310s Setting up python3-wrapt (1.15.0-4) ...
310s Setting up libxslt1.1:amd64 (1.1.39-0exp1ubuntu2) ...
310s Setting up libjs-jquery (3.6.1+dfsg+~3.5.14-1) ...
310s Setting up python3-soupsieve (2.6-1) ...
310s Setting up python3-deprecated (1.2.18-1) ...
310s Setting up libjs-underscore (1.13.4~dfsg+~1.11.4-3) ...
310s Setting up python3-bs4 (4.13.3-1) ...
311s Setting up python3-redis (4.3.4-4) ...
311s Setting up libjs-sphinxdoc (8.1.3-5) ...
311s Setting up python3-lxml:amd64 (5.3.1-1) ...
311s Setting up python3-pyhamtools (0.10.0-1) ...
311s Processing triggers for libc-bin (2.40-4ubuntu1) ...
312s autopkgtest [11:52:11]: test test: [-----------------------
315s 240.98586185281698
315s {'morning_dawn': datetime.datetime(2025, 2, 20, 6, 1, 57, 523969, tzinfo=datetime.timezone.utc), 'sunrise': datetime.datetime(2025, 2, 20, 6, 36, 28, 923804, tzinfo=datetime.timezone.utc), 'evening_dawn': datetime.datetime(2025, 2, 19, 16, 56, 50, 187167, tzinfo=datetime.timezone.utc), 'sunset': datetime.datetime(2025, 2, 19, 17, 31, 29, 624445, tzinfo=datetime.timezone.utc)}
315s {'band': 20, 'mode': 'CW'}
315s {'country': 'Fed. Rep. of Germany', 'adif': 230, 'cqz': 14, 'ituz': 28, 'continent': 'EU', 'latitude': 51.0, 'longitude': 10.0}
315s autopkgtest [11:52:14]: test test: -----------------------]
316s autopkgtest [11:52:15]: test test:  - - - - - - - - - - results - - - - - - - - - -
316s test                 PASS
316s autopkgtest [11:52:15]: @@@@@@@@@@@@@@@@@@@@ summary
316s test                 PASS
371s nova [W] Skipping flock for amd64
371s Creating nova instance adt-plucky-amd64-pyhamtools-20250219-114658-juju-7f2275-prod-proposed-migration-environment-20-03adbc2c-9bc9-48d4-8c1b-c1b6be9d5af0 from image adt/ubuntu-plucky-amd64-server-20250219.img (UUID 90711abf-916f-4a80-845a-825250a78697)...
371s nova [W] Timed out waiting for 0238e95b-d5eb-4a58-921b-90f3ee880abc to get deleted.