0s autopkgtest [17:33:50]: starting date and time: 2025-03-15 17:33:50+0000 0s autopkgtest [17:33:50]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [17:33:50]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.kt50gwll/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade wyrd --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-43.secgroup --name adt-plucky-arm64-wyrd-20250315-173350-juju-7f2275-prod-proposed-migration-environment-2-7b88ef01-6669-49bb-9d78-e7316e297f89 --image adt/ubuntu-plucky-arm64-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,radosgw.ps5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 197s autopkgtest [17:37:07]: testbed dpkg architecture: arm64 198s autopkgtest [17:37:08]: testbed apt version: 2.9.33 198s autopkgtest [17:37:08]: @@@@@@@@@@@@@@@@@@@@ test bed setup 198s autopkgtest [17:37:08]: testbed release detected to be: None 199s autopkgtest [17:37:09]: updating testbed package index (apt update) 200s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 200s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 200s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 200s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 200s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 200s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 200s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 201s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 Packages [111 kB] 201s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 c-n-f Metadata [1856 B] 201s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted arm64 c-n-f Metadata [116 B] 201s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 Packages [324 kB] 201s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe arm64 c-n-f Metadata [14.7 kB] 201s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 Packages [4948 B] 201s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse arm64 c-n-f Metadata [268 B] 202s Fetched 1078 kB in 2s (574 kB/s) 204s Reading package lists... 205s Reading package lists... 205s Building dependency tree... 205s Reading state information... 207s Calculating upgrade... 208s Calculating upgrade... 209s The following packages will be upgraded: 209s pinentry-curses python3-jinja2 strace 210s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 210s Need to get 647 kB of archives. 210s After this operation, 11.3 kB of additional disk space will be used. 210s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 strace arm64 6.13+ds-1ubuntu1 [499 kB] 210s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 pinentry-curses arm64 1.3.1-2ubuntu3 [39.2 kB] 210s Get:3 http://ftpmaster.internal/ubuntu plucky/main arm64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 212s Fetched 647 kB in 1s (589 kB/s) 212s (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 ... 117701 files and directories currently installed.) 212s Preparing to unpack .../strace_6.13+ds-1ubuntu1_arm64.deb ... 212s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 212s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_arm64.deb ... 212s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 212s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 213s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 213s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 213s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 213s Setting up strace (6.13+ds-1ubuntu1) ... 213s Processing triggers for man-db (2.13.0-1) ... 214s Reading package lists... 215s Building dependency tree... 215s Reading state information... 215s Solving dependencies... 216s The following packages will be REMOVED: 216s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 216s libunwind8* linux-headers-6.11.0-8* linux-headers-6.11.0-8-generic* 216s linux-image-6.11.0-8-generic* linux-modules-6.11.0-8-generic* 216s linux-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 217s 0 upgraded, 0 newly installed, 11 to remove and 5 not upgraded. 217s After this operation, 267 MB disk space will be freed. 217s (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 ... 117701 files and directories currently installed.) 217s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8) ... 217s Removing linux-tools-6.11.0-8 (6.11.0-8.8) ... 217s Removing libpython3.12t64:arm64 (3.12.9-1) ... 217s Removing libpython3.12-stdlib:arm64 (3.12.9-1) ... 217s Removing libnsl2:arm64 (1.3.0-3build3) ... 217s Removing libpython3.12-minimal:arm64 (3.12.9-1) ... 217s Removing libunwind8:arm64 (1.6.2-3.1) ... 218s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8) ... 218s Removing linux-headers-6.11.0-8 (6.11.0-8.8) ... 222s Removing linux-image-6.11.0-8-generic (6.11.0-8.8) ... 222s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-10-generic 222s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-10-generic 222s /etc/kernel/postrm.d/initramfs-tools: 222s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 222s /etc/kernel/postrm.d/zz-flash-kernel: 222s flash-kernel: Kernel 6.11.0-8-generic has been removed. 222s flash-kernel: A higher version (6.14.0-10-generic) is still installed, no reflashing required. 223s /etc/kernel/postrm.d/zz-update-grub: 223s Sourcing file `/etc/default/grub' 223s Sourcing file `/etc/default/grub.d/50-cloudimg-settings.cfg' 223s Generating grub configuration file ... 223s Found linux image: /boot/vmlinuz-6.14.0-10-generic 223s Found initrd image: /boot/initrd.img-6.14.0-10-generic 224s Warning: os-prober will not be executed to detect other bootable partitions. 224s Systems on them will not be added to the GRUB boot configuration. 224s Check GRUB_DISABLE_OS_PROBER documentation entry. 224s Adding boot menu entry for UEFI Firmware Settings ... 224s done 224s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 224s Processing triggers for libc-bin (2.41-1ubuntu1) ... 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 ... 81650 files and directories currently installed.) 224s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8) ... 225s Purging configuration files for libpython3.12-minimal:arm64 (3.12.9-1) ... 225s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8) ... 225s autopkgtest [17:37:35]: upgrading testbed (apt dist-upgrade and autopurge) 225s Reading package lists... 226s Building dependency tree... 226s Reading state information... 227s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 227s Starting 2 pkgProblemResolver with broken count: 0 227s Done 229s Entering ResolveByKeep 229s 230s Calculating upgrade... 230s The following packages will be upgraded: 230s libc-bin libc-dev-bin libc6 libc6-dev locales 230s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 230s Need to get 9530 kB of archives. 230s After this operation, 0 B of additional disk space will be used. 230s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6-dev arm64 2.41-1ubuntu2 [1750 kB] 232s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-dev-bin arm64 2.41-1ubuntu2 [24.0 kB] 232s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc6 arm64 2.41-1ubuntu2 [2910 kB] 235s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 libc-bin arm64 2.41-1ubuntu2 [600 kB] 236s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main arm64 locales all 2.41-1ubuntu2 [4246 kB] 241s Preconfiguring packages ... 241s Fetched 9530 kB in 10s (1001 kB/s) 241s (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 ... 81647 files and directories currently installed.) 241s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_arm64.deb ... 241s Unpacking libc6-dev:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 241s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_arm64.deb ... 241s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 241s Preparing to unpack .../libc6_2.41-1ubuntu2_arm64.deb ... 242s Unpacking libc6:arm64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 242s Setting up libc6:arm64 (2.41-1ubuntu2) ... 242s (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 ... 81647 files and directories currently installed.) 242s Preparing to unpack .../libc-bin_2.41-1ubuntu2_arm64.deb ... 242s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 242s Setting up libc-bin (2.41-1ubuntu2) ... 242s (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 ... 81647 files and directories currently installed.) 242s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 242s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 243s Setting up locales (2.41-1ubuntu2) ... 245s Generating locales (this might take a while)... 248s en_US.UTF-8... done 248s Generation complete. 248s Setting up libc-dev-bin (2.41-1ubuntu2) ... 248s Setting up libc6-dev:arm64 (2.41-1ubuntu2) ... 248s Processing triggers for man-db (2.13.0-1) ... 249s Processing triggers for systemd (257.3-1ubuntu3) ... 251s Reading package lists... 251s Building dependency tree... 251s Reading state information... 252s Starting pkgProblemResolver with broken count: 0 252s Starting 2 pkgProblemResolver with broken count: 0 252s Done 253s Solving dependencies... 253s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 254s autopkgtest [17:38:04]: rebooting testbed after setup commands that affected boot 277s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 284s autopkgtest [17:38:34]: testbed running kernel: Linux 6.14.0-10-generic #10-Ubuntu SMP PREEMPT_DYNAMIC Wed Mar 12 15:45:31 UTC 2025 287s autopkgtest [17:38:37]: @@@@@@@@@@@@@@@@@@@@ apt-source wyrd 289s Get:1 http://ftpmaster.internal/ubuntu plucky/universe wyrd 1.7.1-2 (dsc) [1956 B] 289s Get:2 http://ftpmaster.internal/ubuntu plucky/universe wyrd 1.7.1-2 (tar) [68.6 kB] 289s Get:3 http://ftpmaster.internal/ubuntu plucky/universe wyrd 1.7.1-2 (diff) [5984 B] 290s gpgv: Signature made Tue Aug 6 11:20:00 2024 UTC 290s gpgv: using RSA key 6DE24E97ECA886CC56E6250E21B8EEF1B1893081 290s gpgv: issuer "glondu@debian.org" 290s gpgv: Can't check signature: No public key 290s dpkg-source: warning: cannot verify inline signature for ./wyrd_1.7.1-2.dsc: no acceptable signature found 290s autopkgtest [17:38:40]: testing package wyrd version 1.7.1-2 290s autopkgtest [17:38:40]: build not needed 291s autopkgtest [17:38:41]: test command1: preparing testbed 291s Reading package lists... 292s Building dependency tree... 292s Reading state information... 292s Starting pkgProblemResolver with broken count: 0 292s Starting 2 pkgProblemResolver with broken count: 0 293s Done 294s The following NEW packages will be installed: 294s expect libtcl8.6 remind tcl-expect tcl8.6 wyrd 294s 0 upgraded, 6 newly installed, 0 to remove and 0 not upgraded. 294s Need to get 2432 kB of archives. 294s After this operation, 9192 kB of additional disk space will be used. 294s Get:1 http://ftpmaster.internal/ubuntu plucky/main arm64 libtcl8.6 arm64 8.6.16+dfsg-1 [987 kB] 295s Get:2 http://ftpmaster.internal/ubuntu plucky/main arm64 tcl8.6 arm64 8.6.16+dfsg-1 [14.8 kB] 295s Get:3 http://ftpmaster.internal/ubuntu plucky/universe arm64 tcl-expect arm64 5.45.4-4 [112 kB] 295s Get:4 http://ftpmaster.internal/ubuntu plucky/universe arm64 expect arm64 5.45.4-4 [137 kB] 295s Get:5 http://ftpmaster.internal/ubuntu plucky/universe arm64 remind arm64 05.03.02-1 [309 kB] 296s Get:6 http://ftpmaster.internal/ubuntu plucky/universe arm64 wyrd arm64 1.7.1-2 [872 kB] 297s Fetched 2432 kB in 3s (909 kB/s) 297s Selecting previously unselected package libtcl8.6:arm64. 297s (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 ... 81647 files and directories currently installed.) 297s Preparing to unpack .../0-libtcl8.6_8.6.16+dfsg-1_arm64.deb ... 297s Unpacking libtcl8.6:arm64 (8.6.16+dfsg-1) ... 298s Selecting previously unselected package tcl8.6. 298s Preparing to unpack .../1-tcl8.6_8.6.16+dfsg-1_arm64.deb ... 298s Unpacking tcl8.6 (8.6.16+dfsg-1) ... 298s Selecting previously unselected package tcl-expect:arm64. 298s Preparing to unpack .../2-tcl-expect_5.45.4-4_arm64.deb ... 298s Unpacking tcl-expect:arm64 (5.45.4-4) ... 298s Selecting previously unselected package expect. 298s Preparing to unpack .../3-expect_5.45.4-4_arm64.deb ... 298s Unpacking expect (5.45.4-4) ... 298s Selecting previously unselected package remind. 298s Preparing to unpack .../4-remind_05.03.02-1_arm64.deb ... 298s Unpacking remind (05.03.02-1) ... 298s Selecting previously unselected package wyrd. 298s Preparing to unpack .../5-wyrd_1.7.1-2_arm64.deb ... 298s Unpacking wyrd (1.7.1-2) ... 298s Setting up libtcl8.6:arm64 (8.6.16+dfsg-1) ... 298s Setting up remind (05.03.02-1) ... 298s Setting up tcl8.6 (8.6.16+dfsg-1) ... 298s Setting up wyrd (1.7.1-2) ... 298s Setting up tcl-expect:arm64 (5.45.4-4) ... 298s Setting up expect (5.45.4-4) ... 298s Processing triggers for man-db (2.13.0-1) ... 299s Processing triggers for libc-bin (2.41-1ubuntu2) ... 300s autopkgtest [17:38:50]: test command1: export HOME="$AUTOPKGTEST_TMP" && wyrd --add "drop off package at 3pm" && TERM=linux expect -c 'set stty_init "rows 60 columns 80"; spawn -nottycopy wyrd; expect_before timeout { exit 1 }; expect -re "15:00.*drop off package" { send Q; expect eof } eof; exit [lindex [wait] 3]' 300s autopkgtest [17:38:50]: test command1: [----------------------- 301s spawn -nottycopy wyrd 301s )0[?7h[?25l[?1c?:help t:new timed u:new untimed :edit :home z:zoom ... │15:00│ M│16:00│  March 2025 a│17:00 │ Su Mo Tu We Th Fr Sa r│18:00│1  │19:00│ 2 3 4 5 6 7 8 1│20:00│ 9 10 11 12 13 14 15 5│21:00│ 16 17 18 19 20 21 22  │22:00│ 23 24 25 26 27 28 29  │23:00 │ 30 31 M│00:00│ a│01:00├───────────────────────────────────────r│02:00│  │03:00│ 1│04:00│ 6│05:00│  │06:00│  │07:00│  │08:00│  │09:00│  │10:00│  │11:00│  │12:00│  │13:00│  │14:00│  │15:00 │ drop off package│  │16:00│  │17:00│  │18:00│  │19:00│  │20:00│  │21:00│  │22:00│  │23:00 │ M│00:00│ a│01:00│ r│02:00│  │03:00│ 1│04:00│ 7│05:00│  │06:00│  │07:00│  │08:00│  │09:00│  │10:00│  │11:00│  │12:00│  │13:00│  │14:00│  │15:00│  │16:00│  │17:00│  │18:00│ Saturday, March 15 at 5:00pm  (no reminder selected) Wyrd v1.7.1 Currently: Saturday, March 15 at 5:38pm[?25h[?0c autopkgtest [17:38:51]: test command1: -----------------------] 302s command1 PASS 302s autopkgtest [17:38:52]: test command1: - - - - - - - - - - results - - - - - - - - - - 302s autopkgtest [17:38:52]: @@@@@@@@@@@@@@@@@@@@ summary 302s command1 PASS 320s nova [W] Using flock in prodstack6-arm64 320s Creating nova instance adt-plucky-arm64-wyrd-20250315-173350-juju-7f2275-prod-proposed-migration-environment-2-7b88ef01-6669-49bb-9d78-e7316e297f89 from image adt/ubuntu-plucky-arm64-server-20250315.img (UUID bd6e766c-b51f-4b53-86d6-23aa4d18f524)... 320s nova [W] Timed out waiting for 4aee5f00-68d5-44eb-9c9a-23dc731b5f54 to get deleted.