0s autopkgtest [21:30:09]: starting date and time: 2025-03-15 21:30:09+0000 0s autopkgtest [21:30:09]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [21:30:09]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.9z6xvv6s/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade procmail --timeout-short=1200 --timeout-copy=80000 --timeout-build=80000 --env=ADT_TEST_TRIGGERS=glibc/2.41-1ubuntu2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-riscv64-20.secgroup --name adt-plucky-riscv64-procmail-20250315-201530-juju-7f2275-prod-proposed-migration-environment-20-fc87765b-c07a-487f-9fd7-1953dc4975f6 --image adt/ubuntu-plucky-riscv64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-riscv64 -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/ 417s autopkgtest [21:37:06]: testbed dpkg architecture: riscv64 419s autopkgtest [21:37:08]: testbed apt version: 2.9.33 423s autopkgtest [21:37:12]: @@@@@@@@@@@@@@@@@@@@ test bed setup 425s autopkgtest [21:37:14]: testbed release detected to be: None 435s autopkgtest [21:37:24]: updating testbed package index (apt update) 439s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 439s Hit:2 http://ftpmaster.internal/ubuntu plucky InRelease 439s Hit:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease 439s Hit:4 http://ftpmaster.internal/ubuntu plucky-security InRelease 440s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [44.1 kB] 442s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [369 kB] 443s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [14.5 kB] 443s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 Packages [72.7 kB] 443s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 c-n-f Metadata [1792 B] 443s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted riscv64 c-n-f Metadata [120 B] 443s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe riscv64 Packages [319 kB] 444s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe riscv64 c-n-f Metadata [14.3 kB] 444s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse riscv64 Packages [3532 B] 444s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse riscv64 c-n-f Metadata [272 B] 460s Fetched 965 kB in 8s (120 kB/s) 491s Reading package lists... 502s Reading package lists... 505s Building dependency tree... 505s Reading state information... 511s Calculating upgrade... 514s Calculating upgrade... 516s The following packages will be upgraded: 516s pinentry-curses python3-jinja2 strace 517s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 517s Need to get 615 kB of archives. 517s After this operation, 27.6 kB of additional disk space will be used. 517s Get:1 http://ftpmaster.internal/ubuntu plucky/main riscv64 strace riscv64 6.13+ds-1ubuntu1 [460 kB] 518s Get:2 http://ftpmaster.internal/ubuntu plucky/main riscv64 pinentry-curses riscv64 1.3.1-2ubuntu3 [45.4 kB] 518s Get:3 http://ftpmaster.internal/ubuntu plucky/main riscv64 python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 528s Fetched 615 kB in 1s (425 kB/s) 532s (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 ... 114110 files and directories currently installed.) 532s Preparing to unpack .../strace_6.13+ds-1ubuntu1_riscv64.deb ... 532s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 534s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_riscv64.deb ... 534s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 535s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 539s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 540s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 540s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 548s Setting up strace (6.13+ds-1ubuntu1) ... 548s Processing triggers for man-db (2.13.0-1) ... 565s Reading package lists... 568s Building dependency tree... 568s Reading state information... 573s Solving dependencies... 575s The following packages will be REMOVED: 575s libnsl2* libpython3.12-minimal* libpython3.12-stdlib* libpython3.12t64* 575s linux-headers-6.11.0-8-generic* linux-image-6.11.0-8-generic* 575s linux-modules-6.11.0-8-generic* linux-riscv-headers-6.11.0-8* 575s linux-riscv-tools-6.11.0-8* linux-tools-6.11.0-8-generic* 584s 0 upgraded, 0 newly installed, 10 to remove and 5 not upgraded. 584s After this operation, 355 MB disk space will be freed. 586s (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 ... 114110 files and directories currently installed.) 587s Removing linux-tools-6.11.0-8-generic (6.11.0-8.8.1) ... 587s Removing linux-riscv-tools-6.11.0-8 (6.11.0-8.8.1) ... 587s Removing libpython3.12t64:riscv64 (3.12.9-1) ... 587s Removing libpython3.12-stdlib:riscv64 (3.12.9-1) ... 590s Removing libnsl2:riscv64 (1.3.0-3build3) ... 590s Removing libpython3.12-minimal:riscv64 (3.12.9-1) ... 593s Removing linux-headers-6.11.0-8-generic (6.11.0-8.8.1) ... 602s Removing linux-image-6.11.0-8-generic (6.11.0-8.8.1) ... 610s I: /boot/vmlinuz.old is now a symlink to vmlinuz-6.14.0-7-generic 610s I: /boot/initrd.img.old is now a symlink to initrd.img-6.14.0-7-generic 611s /etc/kernel/postrm.d/initramfs-tools: 611s update-initramfs: Deleting /boot/initrd.img-6.11.0-8-generic 612s /etc/kernel/postrm.d/zz-u-boot-menu: 612s P: Checking for EXTLINUX directory... found. 613s P: Writing config for vmlinuz-6.14.0-7-generic... 614s P: Updating /boot/extlinux/extlinux.conf... 618s /etc/kernel/postrm.d/zz-update-grub: 618s Sourcing file `/etc/default/grub' 618s Generating grub configuration file ... 628s Found linux image: /boot/vmlinuz-6.14.0-7-generic 629s Found initrd image: /boot/initrd.img-6.14.0-7-generic 640s Warning: os-prober will not be executed to detect other bootable partitions. 640s Systems on them will not be added to the GRUB boot configuration. 640s Check GRUB_DISABLE_OS_PROBER documentation entry. 640s Adding boot menu entry for UEFI Firmware Settings ... 641s done 642s Removing linux-modules-6.11.0-8-generic (6.11.0-8.8.1) ... 654s Removing linux-riscv-headers-6.11.0-8 (6.11.0-8.8.1) ... 686s Processing triggers for libc-bin (2.41-1ubuntu1) ... 690s (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 ... 75587 files and directories currently installed.) 690s Purging configuration files for linux-image-6.11.0-8-generic (6.11.0-8.8.1) ... 693s /etc/kernel/postrm.d/zz-u-boot-menu: 693s P: Checking for EXTLINUX directory... found. 695s P: Writing config for vmlinuz-6.14.0-7-generic... 698s Purging configuration files for libpython3.12-minimal:riscv64 (3.12.9-1) ... 699s Purging configuration files for linux-modules-6.11.0-8-generic (6.11.0-8.8.1) ... 714s autopkgtest [21:42:03]: upgrading testbed (apt dist-upgrade and autopurge) 717s Reading package lists... 721s Building dependency tree... 721s Reading state information... 729s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 730s Starting 2 pkgProblemResolver with broken count: 0 730s Done 737s Entering ResolveByKeep 741s 744s Calculating upgrade... 746s The following packages will be upgraded: 746s libc-bin libc-dev-bin libc6 libc6-dev locales 748s 5 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 748s Need to get 11.3 MB of archives. 748s After this operation, 2048 B of additional disk space will be used. 748s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 libc6-dev riscv64 2.41-1ubuntu2 [3560 kB] 749s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 libc-dev-bin riscv64 2.41-1ubuntu2 [24.0 kB] 749s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 libc6 riscv64 2.41-1ubuntu2 [2845 kB] 750s Get:4 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 libc-bin riscv64 2.41-1ubuntu2 [640 kB] 750s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/main riscv64 locales all 2.41-1ubuntu2 [4246 kB] 762s Preconfiguring packages ... 767s Fetched 11.3 MB in 5s (2239 kB/s) 769s (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 ... 75584 files and directories currently installed.) 769s Preparing to unpack .../libc6-dev_2.41-1ubuntu2_riscv64.deb ... 769s Unpacking libc6-dev:riscv64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 780s Preparing to unpack .../libc-dev-bin_2.41-1ubuntu2_riscv64.deb ... 780s Unpacking libc-dev-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 781s Preparing to unpack .../libc6_2.41-1ubuntu2_riscv64.deb ... 789s Unpacking libc6:riscv64 (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 795s Setting up libc6:riscv64 (2.41-1ubuntu2) ... 803s (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 ... 75584 files and directories currently installed.) 803s Preparing to unpack .../libc-bin_2.41-1ubuntu2_riscv64.deb ... 803s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 806s Setting up libc-bin (2.41-1ubuntu2) ... 809s (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 ... 75584 files and directories currently installed.) 809s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 809s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 819s Setting up locales (2.41-1ubuntu2) ... 885s Generating locales (this might take a while)... 918s en_US.UTF-8... done 918s Generation complete. 919s Setting up libc-dev-bin (2.41-1ubuntu2) ... 919s Setting up libc6-dev:riscv64 (2.41-1ubuntu2) ... 919s Processing triggers for man-db (2.13.0-1) ... 930s Processing triggers for systemd (257.3-1ubuntu3) ... 966s Reading package lists... 970s Building dependency tree... 970s Reading state information... 973s Starting pkgProblemResolver with broken count: 0 973s Starting 2 pkgProblemResolver with broken count: 0 973s Done 978s Solving dependencies... 980s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 984s autopkgtest [21:46:33]: rebooting testbed after setup commands that affected boot 997s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1000s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1033s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1066s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1099s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1132s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1165s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1198s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 1224s autopkgtest [21:50:33]: testbed running kernel: Linux 6.14.0-7-generic #7.1-Ubuntu SMP PREEMPT_DYNAMIC Sat Mar 1 14:36:03 UTC 2025 1246s autopkgtest [21:50:55]: @@@@@@@@@@@@@@@@@@@@ apt-source procmail 1268s Get:1 http://ftpmaster.internal/ubuntu plucky/main procmail 3.24-1ubuntu3 (dsc) [1843 B] 1268s Get:2 http://ftpmaster.internal/ubuntu plucky/main procmail 3.24-1ubuntu3 (tar) [300 kB] 1268s Get:3 http://ftpmaster.internal/ubuntu plucky/main procmail 3.24-1ubuntu3 (diff) [13.2 kB] 1273s gpgv: Signature made Tue Sep 3 19:25:49 2024 UTC 1273s gpgv: using RSA key A661100B3DAC1D4F2CAD8A54E603B2578FB8F0FB 1273s gpgv: Can't check signature: No public key 1273s dpkg-source: warning: cannot verify inline signature for ./procmail_3.24-1ubuntu3.dsc: no acceptable signature found 1277s autopkgtest [21:51:26]: testing package procmail version 3.24-1ubuntu3 1279s autopkgtest [21:51:28]: build not needed 1281s autopkgtest [21:51:30]: test basic: preparing testbed 1287s Reading package lists... 1291s Building dependency tree... 1291s Reading state information... 1294s Starting pkgProblemResolver with broken count: 0 1295s Starting 2 pkgProblemResolver with broken count: 0 1295s Done 1301s The following NEW packages will be installed: 1301s procmail 1301s 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. 1301s Need to get 149 kB of archives. 1301s After this operation, 303 kB of additional disk space will be used. 1301s Get:1 http://ftpmaster.internal/ubuntu plucky/main riscv64 procmail riscv64 3.24-1ubuntu3 [149 kB] 1310s Fetched 149 kB in 1s (183 kB/s) 1311s Selecting previously unselected package procmail. 1313s (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 ... 75584 files and directories currently installed.) 1313s Preparing to unpack .../procmail_3.24-1ubuntu3_riscv64.deb ... 1313s Unpacking procmail (3.24-1ubuntu3) ... 1314s Setting up procmail (3.24-1ubuntu3) ... 1314s Processing triggers for man-db (2.13.0-1) ... 1341s autopkgtest [21:52:30]: test basic: [----------------------- 1345s [0] 1346s [1] 1348s 0 1348s total 8 1348s -rw------- 1 root root 139 Mar 15 21:52 backup 1348s -rw------- 1 root root 139 Mar 15 21:52 inbox 1348s Subject: Test email 1348s Subject: Test email 1348s 1348s [2] 1351s total 16 1351s -rw------- 1 root root 139 Mar 15 21:52 backup 1351s -rw------- 1 root root 141 Mar 15 21:52 ham 1351s -rw------- 1 root root 139 Mar 15 21:52 inbox 1351s -rw------- 1 root root 155 Mar 15 21:52 spam 1351s Subject: Test email 1 1351s From xyz at test.org Tue Jan 08 01:02:03 2024 1351s From: xyz at test.org 1351s Date: Mon, 01 Jan 2024 01:02:03 -0700 1351s Subject: Test email 1 1351s 1351s Body text 1351s 1351s Subject: spam message 1351s 1351s [3] 1351s [3.1] 1352s 1352s LOGFILE=/tmp/procmail.log 1352s VERBOSE=on 1352s MAILDIR=/tmp/Mail-NRIy 1352s 1352s :0 1352s * Subject: .*email 1352s { 1352s NEW_SUBJECT=`formail -zx "Subject:" | expand | sed -e 's/email/message/'` 1352s 1352s :0 fwh 1352s | formail -I "Subject: $NEW_SUBJECT" 1352s } 1352s 1352s :0 1352s inbox 1352s 1352s [3.2] 1352s 0 1352s [3.3] 1352s total 16 1352s -rw------- 1 root root 139 Mar 15 21:52 backup 1352s -rw------- 1 root root 141 Mar 15 21:52 ham 1352s -rw------- 1 root root 280 Mar 15 21:52 inbox 1352s -rw------- 1 root root 155 Mar 15 21:52 spam 1352s From xyz at test.org Tue Jan 08 01:02:03 2024 1352s From: xyz at test.org 1352s Date: Mon, 01 Jan 2024 01:02:03 -0700 1352s 1352s Body text 1352s 1352s From xyz at test.org Tue Jan 08 01:02:03 2024 1352s From: xyz at test.org 1352s Date: Mon, 01 Jan 2024 01:02:03 -0700 1352s Subject: Test message 1352s 1352s Body text 1352s 1352s Subject: Test message 1352s 1354s autopkgtest [21:52:43]: test basic: -----------------------] 1358s basic PASS 1358s autopkgtest [21:52:47]: test basic: - - - - - - - - - - results - - - - - - - - - - 1361s autopkgtest [21:52:50]: @@@@@@@@@@@@@@@@@@@@ summary 1361s basic PASS 1380s nova [W] Using flock in prodstack6-riscv64 1380s Creating nova instance adt-plucky-riscv64-procmail-20250315-201530-juju-7f2275-prod-proposed-migration-environment-20-fc87765b-c07a-487f-9fd7-1953dc4975f6 from image adt/ubuntu-plucky-riscv64-server-20250315.img (UUID 306bcabb-e549-4f8c-9dd8-573d52716ea6)... 1380s nova [W] Timed out waiting for 63f1d46e-0938-4457-8ec7-4bdeeeeeb546 to get deleted.