0s autopkgtest [01:12:47]: starting date and time: 2026-02-05 01:12:47+0000 0s autopkgtest [01:12:47]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [01:12:47]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.35cl_d0z/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc,src:chiark-tcl --apt-upgrade at --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=glibc/2.42-2ubuntu5 chiark-tcl/1.3.7build1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-arm64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-arm64-31.secgroup --name adt-resolute-arm64-at-20260205-011247-juju-7f2275-prod-proposed-migration-environment-2-18523563-ae86-4172-93f9-3c7c3b2978dd --image adt/ubuntu-resolute-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-arm64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 4s Creating nova instance adt-resolute-arm64-at-20260205-011247-juju-7f2275-prod-proposed-migration-environment-2-18523563-ae86-4172-93f9-3c7c3b2978dd from image adt/ubuntu-resolute-arm64-server-20260204.img (UUID f58d981d-b271-4157-b9b1-fd704695563c)... 67s autopkgtest [01:13:54]: testbed dpkg architecture: arm64 67s autopkgtest [01:13:54]: testbed apt version: 3.1.14 67s autopkgtest [01:13:54]: @@@@@@@@@@@@@@@@@@@@ test bed setup 68s autopkgtest [01:13:55]: testbed release detected to be: None 68s autopkgtest [01:13:55]: updating testbed package index (apt update) 69s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 69s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 69s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 69s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 69s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [228 kB] 69s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [35.4 kB] 69s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5260 B] 69s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1768 kB] 69s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 Packages [262 kB] 69s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 c-n-f Metadata [7248 B] 69s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 Packages [52.9 kB] 69s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted arm64 c-n-f Metadata [328 B] 69s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 Packages [1540 kB] 69s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/universe arm64 c-n-f Metadata [40.2 kB] 69s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 Packages [26.0 kB] 69s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse arm64 c-n-f Metadata [776 B] 73s Fetched 4091 kB in 1s (4296 kB/s) 74s Reading package lists... 75s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 75s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 75s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 75s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 76s Reading package lists... 76s Reading package lists... 76s Building dependency tree... 76s Reading state information... 76s Calculating upgrade... 77s The following packages will be upgraded: 77s libc-bin libc-gconv-modules-extra libc6 locales python3-linkify-it 77s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 77s Need to get 7881 kB of archives. 77s After this operation, 0 B of additional disk space will be used. 77s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc-gconv-modules-extra arm64 2.42-2ubuntu5 [1413 kB] 77s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc6 arm64 2.42-2ubuntu5 [1594 kB] 77s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 libc-bin arm64 2.42-2ubuntu5 [599 kB] 77s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main arm64 locales all 2.42-2ubuntu5 [4255 kB] 77s Get:5 http://ftpmaster.internal/ubuntu resolute/main arm64 python3-linkify-it all 2.0.3-1ubuntu3 [19.4 kB] 78s dpkg-preconfigure: unable to re-open stdin: No such file or directory 78s Fetched 7881 kB in 0s (18.9 MB/s) 78s (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 ... 89360 files and directories currently installed.) 78s Preparing to unpack .../libc-gconv-modules-extra_2.42-2ubuntu5_arm64.deb ... 78s Unpacking libc-gconv-modules-extra:arm64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 78s Setting up libc-gconv-modules-extra:arm64 (2.42-2ubuntu5) ... 78s (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 ... 89360 files and directories currently installed.) 78s Preparing to unpack .../libc6_2.42-2ubuntu5_arm64.deb ... 78s Unpacking libc6:arm64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 79s Setting up libc6:arm64 (2.42-2ubuntu5) ... 79s (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 ... 89360 files and directories currently installed.) 79s Preparing to unpack .../libc-bin_2.42-2ubuntu5_arm64.deb ... 79s Unpacking libc-bin (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 79s Setting up libc-bin (2.42-2ubuntu5) ... 79s (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 ... 89360 files and directories currently installed.) 79s Preparing to unpack .../locales_2.42-2ubuntu5_all.deb ... 79s Unpacking locales (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 79s Preparing to unpack .../python3-linkify-it_2.0.3-1ubuntu3_all.deb ... 79s Unpacking python3-linkify-it (2.0.3-1ubuntu3) over (2.0.3-1ubuntu2) ... 80s Setting up locales (2.42-2ubuntu5) ... 80s Generating locales (this might take a while)... 82s en_US.UTF-8... done 82s Generation complete. 82s Setting up python3-linkify-it (2.0.3-1ubuntu3) ... 82s Processing triggers for man-db (2.13.1-1) ... 84s Processing triggers for systemd (259-1ubuntu3) ... 85s autopkgtest [01:14:12]: upgrading testbed (apt dist-upgrade and autopurge) 85s Reading package lists... 85s Building dependency tree... 85s Reading state information... 85s Calculating upgrade... 86s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 86s Reading package lists... 86s Building dependency tree... 86s Reading state information... 86s Solving dependencies... 87s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 89s autopkgtest [01:14:16]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:41:39 UTC 2026 90s autopkgtest [01:14:17]: @@@@@@@@@@@@@@@@@@@@ apt-source at 91s Get:1 http://ftpmaster.internal/ubuntu resolute/universe at 3.2.5-2.2ubuntu1 (dsc) [2078 B] 91s Get:2 http://ftpmaster.internal/ubuntu resolute/universe at 3.2.5-2.2ubuntu1 (tar) [133 kB] 91s Get:3 http://ftpmaster.internal/ubuntu resolute/universe at 3.2.5-2.2ubuntu1 (diff) [22.2 kB] 92s gpgv: Signature made Tue Jun 3 20:24:40 2025 UTC 92s gpgv: using RSA key B8340990283D8D9BC1949AC74799A35146D12B35 92s gpgv: Can't check signature: No public key 92s dpkg-source: warning: cannot verify inline signature for ./at_3.2.5-2.2ubuntu1.dsc: no acceptable signature found 92s autopkgtest [01:14:19]: testing package at version 3.2.5-2.2ubuntu1 92s autopkgtest [01:14:19]: build not needed 92s autopkgtest [01:14:19]: test basic-usage: preparing testbed 92s Reading package lists... 93s Building dependency tree... 93s Reading state information... 93s Solving dependencies... 93s The following NEW packages will be installed: 93s at 94s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 94s Need to get 39.7 kB of archives. 94s After this operation, 208 kB of additional disk space will be used. 94s Get:1 http://ftpmaster.internal/ubuntu resolute/universe arm64 at arm64 3.2.5-2.2ubuntu1 [39.7 kB] 94s Fetched 39.7 kB in 0s (129 kB/s) 94s Selecting previously unselected package at. 94s (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 ... 89360 files and directories currently installed.) 94s Preparing to unpack .../at_3.2.5-2.2ubuntu1_arm64.deb ... 94s Unpacking at (3.2.5-2.2ubuntu1) ... 94s Setting up at (3.2.5-2.2ubuntu1) ... 94s Created symlink '/etc/systemd/system/multi-user.target.wants/atd.service' → '/usr/lib/systemd/system/atd.service'. 94s Processing triggers for man-db (2.13.1-1) ... 96s autopkgtest [01:14:23]: test basic-usage: [----------------------- 96s + TMPFILE=at.20464 96s ++ mktemp -d 96s + WORKDIR=/tmp/tmp.IaZ4I2yXF6 96s + trap 'rm -rf /tmp/tmp.IaZ4I2yXF6' 0 INT QUIT ABRT PIPE TERM 96s ++ atq 96s ++ wc -l 96s + JOBS_BEFORE=0 96s + at now + 2 minutes 96s ++ date -u 96s warning: commands will be executed using /bin/sh 96s + echo 'echo Thu Feb 5 01:14:23 UTC 2026 > /tmp/tmp.IaZ4I2yXF6/at.20464' 96s job 1 at Thu Feb 5 01:16:00 2026 96s + sleep 2 98s + test -f /tmp/tmp.IaZ4I2yXF6/at.20464 98s + echo 'OK, /tmp/tmp.IaZ4I2yXF6/at.20464 doesn'\''t exist yet; expected..' 98s ++ atq 98s ++ wc -l 98s + JOBS_AFTER=1 98s + [[ 1 -eq 1 ]] 98s + echo 'OK, 1 new queued job exists..' 98s + sleep 120 98s OK, /tmp/tmp.IaZ4I2yXF6/at.20464 doesn't exist yet; expected.. 98s OK, 1 new queued job exists.. 218s OK, /tmp/tmp.IaZ4I2yXF6/at.20464 exists and everything looks in order.. 218s OK; PASS. 218s + grep -Fq UTC /tmp/tmp.IaZ4I2yXF6/at.20464 218s + echo 'OK, /tmp/tmp.IaZ4I2yXF6/at.20464 exists and everything looks in order..' 218s + echo 'OK; PASS.' 218s + rm -rf /tmp/tmp.IaZ4I2yXF6 218s autopkgtest [01:16:25]: test basic-usage: -----------------------] 219s autopkgtest [01:16:26]: test basic-usage: - - - - - - - - - - results - - - - - - - - - - 219s basic-usage PASS 219s autopkgtest [01:16:26]: @@@@@@@@@@@@@@@@@@@@ summary 219s basic-usage PASS