0s autopkgtest [18:49:08]: starting date and time: 2024-12-17 18:49:08+0000 0s autopkgtest [18:49:08]: git checkout: c2a78735 Merge branch 'timeout-nova-boot' into 'ubuntu/production' 0s autopkgtest [18:49:08]: host juju-7f2275-prod-proposed-migration-environment-15; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.g29d1qoz/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:dpkg --apt-upgrade clamav --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=dpkg/1.22.6ubuntu6.2 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor builder-cpu2-ram4-disk20 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-15@bos03-15.secgroup --name adt-noble-amd64-clamav-20241217-184908-juju-7f2275-prod-proposed-migration-environment-15-3c2aba69-081b-47d2-82df-338af6c3e68a --image adt/ubuntu-noble-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-15 --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/ 53s autopkgtest [18:50:01]: testbed dpkg architecture: amd64 53s autopkgtest [18:50:01]: testbed apt version: 2.7.14build2 53s autopkgtest [18:50:01]: @@@@@@@@@@@@@@@@@@@@ test bed setup 53s autopkgtest [18:50:01]: testbed release detected to be: None 54s autopkgtest [18:50:02]: updating testbed package index (apt update) 54s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 55s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 55s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 55s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 55s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [75.0 kB] 55s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [75.5 kB] 55s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [4008 B] 55s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main i386 Packages [70.8 kB] 55s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 Packages [143 kB] 55s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 c-n-f Metadata [3768 B] 55s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 Packages [59.3 kB] 55s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/restricted i386 Packages [1176 B] 55s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/restricted amd64 c-n-f Metadata [360 B] 55s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/universe i386 Packages [369 kB] 55s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 Packages [496 kB] 55s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/universe amd64 c-n-f Metadata [10.7 kB] 55s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/multiverse amd64 c-n-f Metadata [344 B] 60s Fetched 1575 kB in 1s (1417 kB/s) 61s Reading package lists... 62s Reading package lists... 62s Building dependency tree... 62s Reading state information... 62s Calculating upgrade... 62s The following packages will be upgraded: 62s cloud-init fwupd libfwupd2 linux-firmware 63s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 63s Need to get 503 MB of archives. 63s After this operation, 984 kB of additional disk space will be used. 63s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 libfwupd2 amd64 1.9.27-0ubuntu1~24.04.1 [136 kB] 63s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 fwupd amd64 1.9.27-0ubuntu1~24.04.1 [4584 kB] 64s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 linux-firmware amd64 20240318.git3b128b60-0ubuntu2.6 [498 MB] 100s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 cloud-init all 24.4-0ubuntu1~24.04.2 [602 kB] 100s Preconfiguring packages ... 100s Fetched 503 MB in 38s (13.4 MB/s) 101s (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 ... 105899 files and directories currently installed.) 101s Preparing to unpack .../libfwupd2_1.9.27-0ubuntu1~24.04.1_amd64.deb ... 101s Unpacking libfwupd2:amd64 (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 101s Preparing to unpack .../fwupd_1.9.27-0ubuntu1~24.04.1_amd64.deb ... 101s Unpacking fwupd (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 101s Preparing to unpack .../linux-firmware_20240318.git3b128b60-0ubuntu2.6_amd64.deb ... 101s Unpacking linux-firmware (20240318.git3b128b60-0ubuntu2.6) over (20240318.git3b128b60-0ubuntu2.5) ... 104s Preparing to unpack .../cloud-init_24.4-0ubuntu1~24.04.2_all.deb ... 104s Unpacking cloud-init (24.4-0ubuntu1~24.04.2) over (24.3.1-0ubuntu0~24.04.2) ... 104s Setting up cloud-init (24.4-0ubuntu1~24.04.2) ... 106s Setting up linux-firmware (20240318.git3b128b60-0ubuntu2.6) ... 106s Setting up libfwupd2:amd64 (1.9.27-0ubuntu1~24.04.1) ... 106s Setting up fwupd (1.9.27-0ubuntu1~24.04.1) ... 107s fwupd-offline-update.service is a disabled or a static unit not running, not starting it. 107s fwupd-refresh.service is a disabled or a static unit not running, not starting it. 107s fwupd.service is a disabled or a static unit not running, not starting it. 107s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 107s Processing triggers for man-db (2.12.0-4build2) ... 108s Processing triggers for dbus (1.14.10-4ubuntu4.1) ... 108s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 108s Processing triggers for initramfs-tools (0.142ubuntu25.4) ... 108s update-initramfs: Generating /boot/initrd.img-6.8.0-51-generic 108s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 117s Reading package lists... 118s Building dependency tree... 118s Reading state information... 118s 0 upgraded, 0 newly installed, 0 to remove and 3 not upgraded. 118s autopkgtest [18:51:06]: upgrading testbed (apt dist-upgrade and autopurge) 118s Reading package lists... 119s Building dependency tree... 119s Reading state information... 119s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 119s Starting 2 pkgProblemResolver with broken count: 0 119s Done 120s Entering ResolveByKeep 120s 120s The following packages will be upgraded: 120s dpkg dpkg-dev libdpkg-perl 121s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 121s Need to get 2625 kB of archives. 121s After this operation, 0 B of additional disk space will be used. 121s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 dpkg amd64 1.22.6ubuntu6.2 [1281 kB] 121s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 dpkg-dev all 1.22.6ubuntu6.2 [1074 kB] 121s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main amd64 libdpkg-perl all 1.22.6ubuntu6.2 [269 kB] 122s Fetched 2625 kB in 1s (3490 kB/s) 122s (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 ... 106004 files and directories currently installed.) 122s Preparing to unpack .../dpkg_1.22.6ubuntu6.2_amd64.deb ... 122s Unpacking dpkg (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 122s Setting up dpkg (1.22.6ubuntu6.2) ... 122s (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 ... 106004 files and directories currently installed.) 122s Preparing to unpack .../dpkg-dev_1.22.6ubuntu6.2_all.deb ... 122s Unpacking dpkg-dev (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 123s Preparing to unpack .../libdpkg-perl_1.22.6ubuntu6.2_all.deb ... 123s Unpacking libdpkg-perl (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 123s Setting up libdpkg-perl (1.22.6ubuntu6.2) ... 123s Setting up dpkg-dev (1.22.6ubuntu6.2) ... 123s Processing triggers for man-db (2.12.0-4build2) ... 124s Reading package lists... 125s Building dependency tree... 125s Reading state information... 125s Starting pkgProblemResolver with broken count: 0 125s Starting 2 pkgProblemResolver with broken count: 0 125s Done 126s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 126s autopkgtest [18:51:14]: rebooting testbed after setup commands that affected boot 130s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 145s autopkgtest [18:51:33]: testbed running kernel: Linux 6.8.0-51-generic #52-Ubuntu SMP PREEMPT_DYNAMIC Thu Dec 5 13:09:44 UTC 2024 148s autopkgtest [18:51:36]: @@@@@@@@@@@@@@@@@@@@ apt-source clamav 158s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (dsc) [3174 B] 158s Get:2 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (tar) [32.3 MB] 158s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (diff) [228 kB] 158s gpgv: Signature made Mon Sep 9 11:23:03 2024 UTC 158s gpgv: using RSA key 50C4A0DDCF31E452CEB19B516569D855A744BE93 158s gpgv: Can't check signature: No public key 158s dpkg-source: warning: cannot verify inline signature for ./clamav_1.0.7+dfsg-0ubuntu0.24.04.1.dsc: no acceptable signature found 163s autopkgtest [18:51:51]: testing package clamav version 1.0.7+dfsg-0ubuntu0.24.04.1 164s autopkgtest [18:51:52]: build not needed 175s autopkgtest [18:52:03]: test clamd: preparing testbed 175s Reading package lists... 175s Building dependency tree... 175s Reading state information... 176s Starting pkgProblemResolver with broken count: 0 176s Starting 2 pkgProblemResolver with broken count: 0 176s Done 177s The following NEW packages will be installed: 177s clamav clamav-base clamav-daemon clamav-freshclam clamav-milter 177s libclamav11t64 libmilter1.0.1 libmspack0t64 177s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded. 177s Need to get 13.0 MB of archives. 177s After this operation, 57.2 MB of additional disk space will be used. 177s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main amd64 clamav-base all 1.0.7+dfsg-0ubuntu0.24.04.1 [93.4 kB] 177s Get:2 http://ftpmaster.internal/ubuntu noble/main amd64 libmspack0t64 amd64 0.11-1.1build1 [40.0 kB] 177s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main amd64 libclamav11t64 amd64 1.0.7+dfsg-0ubuntu0.24.04.1 [6713 kB] 178s Get:4 http://ftpmaster.internal/ubuntu noble-updates/main amd64 clamav-freshclam amd64 1.0.7+dfsg-0ubuntu0.24.04.1 [97.6 kB] 178s Get:5 http://ftpmaster.internal/ubuntu noble-updates/main amd64 clamav-daemon amd64 1.0.7+dfsg-0ubuntu0.24.04.1 [214 kB] 178s Get:6 http://ftpmaster.internal/ubuntu noble/universe amd64 libmilter1.0.1 amd64 8.18.1-2 [40.1 kB] 178s Get:7 http://ftpmaster.internal/ubuntu noble-updates/universe amd64 clamav-milter amd64 1.0.7+dfsg-0ubuntu0.24.04.1 [117 kB] 178s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main amd64 clamav amd64 1.0.7+dfsg-0ubuntu0.24.04.1 [5684 kB] 178s Preconfiguring packages ... 178s Fetched 13.0 MB in 1s (10.8 MB/s) 178s Selecting previously unselected package clamav-base. 179s (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 ... 106004 files and directories currently installed.) 179s Preparing to unpack .../0-clamav-base_1.0.7+dfsg-0ubuntu0.24.04.1_all.deb ... 179s Unpacking clamav-base (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Selecting previously unselected package libmspack0t64:amd64. 179s Preparing to unpack .../1-libmspack0t64_0.11-1.1build1_amd64.deb ... 179s Unpacking libmspack0t64:amd64 (0.11-1.1build1) ... 179s Selecting previously unselected package libclamav11t64:amd64. 179s Preparing to unpack .../2-libclamav11t64_1.0.7+dfsg-0ubuntu0.24.04.1_amd64.deb ... 179s Unpacking libclamav11t64:amd64 (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Selecting previously unselected package clamav-freshclam. 179s Preparing to unpack .../3-clamav-freshclam_1.0.7+dfsg-0ubuntu0.24.04.1_amd64.deb ... 179s Unpacking clamav-freshclam (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Selecting previously unselected package clamav-daemon. 179s Preparing to unpack .../4-clamav-daemon_1.0.7+dfsg-0ubuntu0.24.04.1_amd64.deb ... 179s Unpacking clamav-daemon (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Selecting previously unselected package libmilter1.0.1:amd64. 179s Preparing to unpack .../5-libmilter1.0.1_8.18.1-2_amd64.deb ... 179s Unpacking libmilter1.0.1:amd64 (8.18.1-2) ... 179s Selecting previously unselected package clamav-milter. 179s Preparing to unpack .../6-clamav-milter_1.0.7+dfsg-0ubuntu0.24.04.1_amd64.deb ... 179s Unpacking clamav-milter (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Selecting previously unselected package clamav. 179s Preparing to unpack .../7-clamav_1.0.7+dfsg-0ubuntu0.24.04.1_amd64.deb ... 179s Unpacking clamav (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Setting up libmspack0t64:amd64 (0.11-1.1build1) ... 179s Setting up libmilter1.0.1:amd64 (8.18.1-2) ... 179s Setting up libclamav11t64:amd64 (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Setting up clamav-base (1.0.7+dfsg-0ubuntu0.24.04.1) ... 179s Setting up clamav-freshclam (1.0.7+dfsg-0ubuntu0.24.04.1) ... 180s Setting up clamav-daemon (1.0.7+dfsg-0ubuntu0.24.04.1) ... 181s Created symlink /etc/systemd/system/multi-user.target.wants/clamav-daemon.service → /usr/lib/systemd/system/clamav-daemon.service. 181s Created symlink /etc/systemd/system/sockets.target.wants/clamav-daemon.socket → /usr/lib/systemd/system/clamav-daemon.socket. 182s Setting up clamav (1.0.7+dfsg-0ubuntu0.24.04.1) ... 182s Setting up clamav-milter (1.0.7+dfsg-0ubuntu0.24.04.1) ... 183s Processing triggers for man-db (2.12.0-4build2) ... 184s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 185s autopkgtest [18:52:13]: test clamd: [----------------------- 185s OK 186s autopkgtest [18:52:14]: test clamd: -----------------------] 186s clamd PASS 186s autopkgtest [18:52:14]: test clamd: - - - - - - - - - - results - - - - - - - - - - 187s autopkgtest [18:52:15]: test client: preparing testbed 187s Reading package lists... 187s Building dependency tree... 187s Reading state information... 188s Starting pkgProblemResolver with broken count: 0 188s Starting 2 pkgProblemResolver with broken count: 0 188s Done 188s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 190s autopkgtest [18:52:18]: test client: [----------------------- 190s autopkgtest [18:52:18]: test client: -----------------------] 191s autopkgtest [18:52:19]: test client: - - - - - - - - - - results - - - - - - - - - - 191s client PASS 191s autopkgtest [18:52:19]: test milter: preparing testbed 191s Reading package lists... 192s Building dependency tree... 192s Reading state information... 192s Starting pkgProblemResolver with broken count: 0 192s Starting 2 pkgProblemResolver with broken count: 0 192s Done 193s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 194s autopkgtest [18:52:22]: test milter: [----------------------- 194s OK 195s autopkgtest [18:52:23]: test milter: -----------------------] 195s autopkgtest [18:52:23]: test milter: - - - - - - - - - - results - - - - - - - - - - 195s milter PASS 196s autopkgtest [18:52:24]: @@@@@@@@@@@@@@@@@@@@ summary 196s clamd PASS 196s client PASS 196s milter PASS 212s nova [W] Skipping flock for amd64 212s Creating nova instance adt-noble-amd64-clamav-20241217-184908-juju-7f2275-prod-proposed-migration-environment-15-3c2aba69-081b-47d2-82df-338af6c3e68a from image adt/ubuntu-noble-amd64-server-20241217.img (UUID 72014d14-24a3-433f-a6e8-c0a0a479a03a)... 212s nova [W] Timed out waiting for a3b14598-625a-4652-9c45-26663dafdd0e to get deleted.