0s autopkgtest [22:34:33]: starting date and time: 2024-12-17 22:34:33+0000 0s autopkgtest [22:34:33]: git checkout: c2a78735 Merge branch 'timeout-nova-boot' into 'ubuntu/production' 0s autopkgtest [22:34:33]: host juju-7f2275-prod-proposed-migration-environment-20; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.hd42egr0/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 autopkgtest-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-20@bos03-ppc64el-20.secgroup --name adt-noble-ppc64el-clamav-20241217-223433-juju-7f2275-prod-proposed-migration-environment-20-f5c8bc99-f941-4f67-9576-d5f1be95f6b9 --image adt/ubuntu-noble-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-20 --net-id=net_prod-proposed-migration-ppc64el -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/ 77s autopkgtest [22:35:50]: testbed dpkg architecture: ppc64el 78s autopkgtest [22:35:51]: testbed apt version: 2.7.14build2 78s autopkgtest [22:35:51]: @@@@@@@@@@@@@@@@@@@@ test bed setup 78s autopkgtest [22:35:51]: testbed release detected to be: None 79s autopkgtest [22:35:52]: updating testbed package index (apt update) 79s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 79s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 80s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 80s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 80s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [75.5 kB] 80s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [4008 B] 80s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [76.5 kB] 80s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el Packages [109 kB] 80s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el c-n-f Metadata [3752 B] 80s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el Packages [1176 B] 80s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/restricted ppc64el c-n-f Metadata [116 B] 80s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el Packages [450 kB] 80s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/universe ppc64el c-n-f Metadata [9704 B] 80s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/multiverse ppc64el c-n-f Metadata [116 B] 84s Fetched 995 kB in 1s (1201 kB/s) 85s Reading package lists... 86s Reading package lists... 86s Building dependency tree... 86s Reading state information... 86s Calculating upgrade... 86s The following packages will be upgraded: 86s cloud-init fwupd libfwupd2 linux-firmware 87s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 87s Need to get 503 MB of archives. 87s After this operation, 1005 kB of additional disk space will be used. 87s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libfwupd2 ppc64el 1.9.27-0ubuntu1~24.04.1 [138 kB] 87s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el fwupd ppc64el 1.9.27-0ubuntu1~24.04.1 [4690 kB] 87s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el linux-firmware ppc64el 20240318.git3b128b60-0ubuntu2.6 [498 MB] 99s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el cloud-init all 24.4-0ubuntu1~24.04.2 [602 kB] 100s Preconfiguring packages ... 100s Fetched 503 MB in 13s (38.9 MB/s) 100s (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 ... 103294 files and directories currently installed.) 100s Preparing to unpack .../libfwupd2_1.9.27-0ubuntu1~24.04.1_ppc64el.deb ... 100s Unpacking libfwupd2:ppc64el (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 100s Preparing to unpack .../fwupd_1.9.27-0ubuntu1~24.04.1_ppc64el.deb ... 100s Unpacking fwupd (1.9.27-0ubuntu1~24.04.1) over (1.9.24-1~24.04.1) ... 100s Preparing to unpack .../linux-firmware_20240318.git3b128b60-0ubuntu2.6_ppc64el.deb ... 100s Unpacking linux-firmware (20240318.git3b128b60-0ubuntu2.6) over (20240318.git3b128b60-0ubuntu2.5) ... 103s 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) ... 105s Setting up linux-firmware (20240318.git3b128b60-0ubuntu2.6) ... 105s Setting up libfwupd2:ppc64el (1.9.27-0ubuntu1~24.04.1) ... 105s Setting up fwupd (1.9.27-0ubuntu1~24.04.1) ... 106s fwupd-offline-update.service is a disabled or a static unit not running, not starting it. 106s fwupd-refresh.service is a disabled or a static unit not running, not starting it. 106s fwupd.service is a disabled or a static unit not running, not starting it. 106s Processing triggers for rsyslog (8.2312.0-3ubuntu9) ... 106s Processing triggers for man-db (2.12.0-4build2) ... 107s Processing triggers for dbus (1.14.10-4ubuntu4.1) ... 107s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 107s Processing triggers for initramfs-tools (0.142ubuntu25.4) ... 107s update-initramfs: Generating /boot/initrd.img-6.8.0-51-generic 107s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s 0 upgraded, 0 newly installed, 0 to remove and 3 not upgraded. 115s autopkgtest [22:36:28]: upgrading testbed (apt dist-upgrade and autopurge) 115s Reading package lists... 115s Building dependency tree... 115s Reading state information... 115s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 115s Starting 2 pkgProblemResolver with broken count: 0 115s Done 116s Entering ResolveByKeep 116s 116s The following packages will be upgraded: 116s dpkg dpkg-dev libdpkg-perl 116s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 116s Need to get 2683 kB of archives. 116s After this operation, 0 B of additional disk space will be used. 116s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el dpkg ppc64el 1.22.6ubuntu6.2 [1340 kB] 117s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el dpkg-dev all 1.22.6ubuntu6.2 [1074 kB] 117s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main ppc64el libdpkg-perl all 1.22.6ubuntu6.2 [269 kB] 117s Fetched 2683 kB in 1s (3058 kB/s) 117s (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 ... 103399 files and directories currently installed.) 117s Preparing to unpack .../dpkg_1.22.6ubuntu6.2_ppc64el.deb ... 117s Unpacking dpkg (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 117s Setting up dpkg (1.22.6ubuntu6.2) ... 118s (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 ... 103399 files and directories currently installed.) 118s Preparing to unpack .../dpkg-dev_1.22.6ubuntu6.2_all.deb ... 118s Unpacking dpkg-dev (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 118s Preparing to unpack .../libdpkg-perl_1.22.6ubuntu6.2_all.deb ... 118s Unpacking libdpkg-perl (1.22.6ubuntu6.2) over (1.22.6ubuntu6.1) ... 118s Setting up libdpkg-perl (1.22.6ubuntu6.2) ... 118s Setting up dpkg-dev (1.22.6ubuntu6.2) ... 118s Processing triggers for man-db (2.12.0-4build2) ... 119s Reading package lists... 120s Building dependency tree... 120s Reading state information... 120s Starting pkgProblemResolver with broken count: 0 120s Starting 2 pkgProblemResolver with broken count: 0 120s Done 120s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 120s autopkgtest [22:36:33]: rebooting testbed after setup commands that affected boot 154s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 160s autopkgtest [22:37:13]: testbed running kernel: Linux 6.8.0-51-generic #52-Ubuntu SMP Thu Dec 5 14:46:44 UTC 2024 163s autopkgtest [22:37:16]: @@@@@@@@@@@@@@@@@@@@ apt-source clamav 170s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (dsc) [3174 B] 170s Get:2 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (tar) [32.3 MB] 170s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main clamav 1.0.7+dfsg-0ubuntu0.24.04.1 (diff) [228 kB] 170s gpgv: Signature made Mon Sep 9 11:23:03 2024 UTC 170s gpgv: using RSA key 50C4A0DDCF31E452CEB19B516569D855A744BE93 170s gpgv: Can't check signature: No public key 170s dpkg-source: warning: cannot verify inline signature for ./clamav_1.0.7+dfsg-0ubuntu0.24.04.1.dsc: no acceptable signature found 176s autopkgtest [22:37:29]: testing package clamav version 1.0.7+dfsg-0ubuntu0.24.04.1 177s autopkgtest [22:37:30]: build not needed 187s autopkgtest [22:37:40]: test clamd: preparing testbed 187s Reading package lists... 188s Building dependency tree... 188s Reading state information... 188s Starting pkgProblemResolver with broken count: 0 188s Starting 2 pkgProblemResolver with broken count: 0 188s Done 188s The following NEW packages will be installed: 188s clamav clamav-base clamav-daemon clamav-freshclam clamav-milter 188s libclamav11t64 libmilter1.0.1 libmspack0t64 188s 0 upgraded, 8 newly installed, 0 to remove and 0 not upgraded. 188s Need to get 6976 kB of archives. 188s After this operation, 34.1 MB of additional disk space will be used. 188s Get:1 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el clamav-base all 1.0.7+dfsg-0ubuntu0.24.04.1 [93.4 kB] 188s Get:2 http://ftpmaster.internal/ubuntu noble/main ppc64el libmspack0t64 ppc64el 0.11-1.1build1 [56.6 kB] 188s Get:3 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el libclamav11t64 ppc64el 1.0.7+dfsg-0ubuntu0.24.04.1 [3817 kB] 189s Get:4 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el clamav-freshclam ppc64el 1.0.7+dfsg-0ubuntu0.24.04.1 [101 kB] 189s Get:5 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el clamav-daemon ppc64el 1.0.7+dfsg-0ubuntu0.24.04.1 [235 kB] 189s Get:6 http://ftpmaster.internal/ubuntu noble/universe ppc64el libmilter1.0.1 ppc64el 8.18.1-2 [45.9 kB] 189s Get:7 http://ftpmaster.internal/ubuntu noble-updates/universe ppc64el clamav-milter ppc64el 1.0.7+dfsg-0ubuntu0.24.04.1 [121 kB] 189s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main ppc64el clamav ppc64el 1.0.7+dfsg-0ubuntu0.24.04.1 [2506 kB] 189s Preconfiguring packages ... 189s Fetched 6976 kB in 1s (7686 kB/s) 189s Selecting previously unselected package clamav-base. 190s (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 ... 103399 files and directories currently installed.) 190s Preparing to unpack .../0-clamav-base_1.0.7+dfsg-0ubuntu0.24.04.1_all.deb ... 190s Unpacking clamav-base (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Selecting previously unselected package libmspack0t64:ppc64el. 190s Preparing to unpack .../1-libmspack0t64_0.11-1.1build1_ppc64el.deb ... 190s Unpacking libmspack0t64:ppc64el (0.11-1.1build1) ... 190s Selecting previously unselected package libclamav11t64:ppc64el. 190s Preparing to unpack .../2-libclamav11t64_1.0.7+dfsg-0ubuntu0.24.04.1_ppc64el.deb ... 190s Unpacking libclamav11t64:ppc64el (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Selecting previously unselected package clamav-freshclam. 190s Preparing to unpack .../3-clamav-freshclam_1.0.7+dfsg-0ubuntu0.24.04.1_ppc64el.deb ... 190s Unpacking clamav-freshclam (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Selecting previously unselected package clamav-daemon. 190s Preparing to unpack .../4-clamav-daemon_1.0.7+dfsg-0ubuntu0.24.04.1_ppc64el.deb ... 190s Unpacking clamav-daemon (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Selecting previously unselected package libmilter1.0.1:ppc64el. 190s Preparing to unpack .../5-libmilter1.0.1_8.18.1-2_ppc64el.deb ... 190s Unpacking libmilter1.0.1:ppc64el (8.18.1-2) ... 190s Selecting previously unselected package clamav-milter. 190s Preparing to unpack .../6-clamav-milter_1.0.7+dfsg-0ubuntu0.24.04.1_ppc64el.deb ... 190s Unpacking clamav-milter (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Selecting previously unselected package clamav. 190s Preparing to unpack .../7-clamav_1.0.7+dfsg-0ubuntu0.24.04.1_ppc64el.deb ... 190s Unpacking clamav (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Setting up libmspack0t64:ppc64el (0.11-1.1build1) ... 190s Setting up libmilter1.0.1:ppc64el (8.18.1-2) ... 190s Setting up libclamav11t64:ppc64el (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Setting up clamav-base (1.0.7+dfsg-0ubuntu0.24.04.1) ... 190s Setting up clamav-freshclam (1.0.7+dfsg-0ubuntu0.24.04.1) ... 191s Setting up clamav-daemon (1.0.7+dfsg-0ubuntu0.24.04.1) ... 192s Created symlink /etc/systemd/system/multi-user.target.wants/clamav-daemon.service → /usr/lib/systemd/system/clamav-daemon.service. 192s Created symlink /etc/systemd/system/sockets.target.wants/clamav-daemon.socket → /usr/lib/systemd/system/clamav-daemon.socket. 192s Setting up clamav (1.0.7+dfsg-0ubuntu0.24.04.1) ... 192s Setting up clamav-milter (1.0.7+dfsg-0ubuntu0.24.04.1) ... 193s Processing triggers for man-db (2.12.0-4build2) ... 194s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 196s autopkgtest [22:37:49]: test clamd: [----------------------- 196s OK 196s autopkgtest [22:37:49]: test clamd: -----------------------] 197s clamd PASS 197s autopkgtest [22:37:50]: test clamd: - - - - - - - - - - results - - - - - - - - - - 197s autopkgtest [22:37:50]: test client: preparing testbed 197s Reading package lists... 198s Building dependency tree... 198s Reading state information... 198s Starting pkgProblemResolver with broken count: 0 198s Starting 2 pkgProblemResolver with broken count: 0 198s Done 198s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 199s autopkgtest [22:37:52]: test client: [----------------------- 200s autopkgtest [22:37:53]: test client: -----------------------] 200s client PASS 200s autopkgtest [22:37:53]: test client: - - - - - - - - - - results - - - - - - - - - - 200s autopkgtest [22:37:53]: test milter: preparing testbed 201s Reading package lists... 201s Building dependency tree... 201s Reading state information... 201s Starting pkgProblemResolver with broken count: 0 201s Starting 2 pkgProblemResolver with broken count: 0 201s Done 201s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 202s autopkgtest [22:37:55]: test milter: [----------------------- 202s OK 203s autopkgtest [22:37:56]: test milter: -----------------------] 203s autopkgtest [22:37:56]: test milter: - - - - - - - - - - results - - - - - - - - - - 203s milter PASS 204s autopkgtest [22:37:57]: @@@@@@@@@@@@@@@@@@@@ summary 204s clamd PASS 204s client PASS 204s milter PASS 208s nova [W] Using flock in prodstack6-ppc64el 208s Creating nova instance adt-noble-ppc64el-clamav-20241217-223433-juju-7f2275-prod-proposed-migration-environment-20-f5c8bc99-f941-4f67-9576-d5f1be95f6b9 from image adt/ubuntu-noble-ppc64el-server-20241217.img (UUID c05ba098-b366-4390-91d1-1c665f2b9c85)... 208s nova [W] Timed out waiting for 570cb345-2de9-449e-be87-fa6132d1121f to get deleted.