0s autopkgtest [17:53:55]: starting date and time: 2024-03-21 17:53:55+0000 0s autopkgtest [17:53:55]: git checkout: 4a1cd702 l/adt_testbed: don't blame the testbed for unsolvable build deps 0s autopkgtest [17:53:55]: host juju-7f2275-prod-proposed-migration-environment-3; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.gc2caxc8/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --setup-commands /home/ubuntu/autopkgtest/setup-commands/setup-testbed --apt-pocket=proposed=src:db5.3 --apt-upgrade c-icap --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=db5.3/5.3.28+dfsg2-6 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-3@bos02-arm64-13.secgroup --name adt-noble-arm64-c-icap-20240321-175355-juju-7f2275-prod-proposed-migration-environment-3 --image adt/ubuntu-noble-arm64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-3 --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,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 278s autopkgtest [17:58:33]: testbed dpkg architecture: arm64 279s autopkgtest [17:58:34]: testbed apt version: 2.7.12 279s autopkgtest [17:58:34]: @@@@@@@@@@@@@@@@@@@@ test bed setup 282s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [117 kB] 283s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [497 kB] 284s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [53.9 kB] 284s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [6540 B] 284s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [3765 kB] 284s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 Packages [677 kB] 285s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main arm64 c-n-f Metadata [3144 B] 285s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 Packages [33.7 kB] 285s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted arm64 c-n-f Metadata [116 B] 285s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 Packages [4184 kB] 285s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe arm64 c-n-f Metadata [8528 B] 285s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 Packages [67.4 kB] 285s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/multiverse arm64 c-n-f Metadata [116 B] 305s Fetched 9413 kB in 11s (871 kB/s) 307s Reading package lists... 321s Reading package lists... 323s Building dependency tree... 323s Reading state information... 326s Calculating upgrade... 328s The following packages will be upgraded: 328s debianutils linux-firmware 328s 2 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 328s Need to get 476 MB of archives. 328s After this operation, 5724 kB of additional disk space will be used. 328s Get:1 http://ftpmaster.internal/ubuntu noble/main arm64 debianutils arm64 5.17 [90.1 kB] 329s Get:2 http://ftpmaster.internal/ubuntu noble/main arm64 linux-firmware arm64 20240318.git3b128b60-0ubuntu1 [475 MB] 407s Fetched 476 MB in 1min 14s (6411 kB/s) 410s (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 ... 75850 files and directories currently installed.) 410s Preparing to unpack .../debianutils_5.17_arm64.deb ... 410s Unpacking debianutils (5.17) over (5.16) ... 411s Setting up debianutils (5.17) ... 412s (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 ... 75850 files and directories currently installed.) 412s Preparing to unpack .../linux-firmware_20240318.git3b128b60-0ubuntu1_arm64.deb ... 412s Unpacking linux-firmware (20240318.git3b128b60-0ubuntu1) over (20240202.git36777504-0ubuntu1) ... 461s Setting up linux-firmware (20240318.git3b128b60-0ubuntu1) ... 461s Processing triggers for man-db (2.12.0-3) ... 469s Processing triggers for initramfs-tools (0.142ubuntu20) ... 473s update-initramfs: Generating /boot/initrd.img-6.8.0-11-generic 476s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 661s System running in EFI mode, skipping. 663s Reading package lists... 665s Building dependency tree... 665s Reading state information... 669s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 672s sh: Attempting to set up Debian/Ubuntu apt sources automatically 673s sh: Distribution appears to be Ubuntu 681s Reading package lists... 682s Building dependency tree... 682s Reading state information... 687s eatmydata is already the newest version (131-1). 687s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 687s Reading package lists... 689s Building dependency tree... 689s Reading state information... 693s dbus is already the newest version (1.14.10-4ubuntu1). 693s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 693s Reading package lists... 694s Building dependency tree... 694s Reading state information... 698s rng-tools-debian is already the newest version (2.4). 698s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 698s Reading package lists... 699s Building dependency tree... 699s Reading state information... 703s The following packages will be REMOVED: 703s cloud-init* python3-configobj* python3-debconf* 706s 0 upgraded, 0 newly installed, 3 to remove and 0 not upgraded. 706s After this operation, 3252 kB disk space will be freed. 706s (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 ... 75912 files and directories currently installed.) 706s Removing cloud-init (24.1.1-0ubuntu1) ... 710s Removing python3-configobj (5.0.8-3) ... 711s Removing python3-debconf (1.5.86) ... 711s Processing triggers for man-db (2.12.0-3) ... 713s (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 ... 75523 files and directories currently installed.) 713s Purging configuration files for cloud-init (24.1.1-0ubuntu1) ... 719s dpkg: warning: while removing cloud-init, directory '/etc/cloud/cloud.cfg.d' not empty so not removed 719s Processing triggers for rsyslog (8.2312.0-3ubuntu3) ... 721s invoke-rc.d: policy-rc.d denied execution of try-restart. 721s Reading package lists... 721s Building dependency tree... 721s Reading state information... 725s linux-generic is already the newest version (6.8.0-11.11+1). 725s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 727s Hit:1 http://ftpmaster.internal/ubuntu noble InRelease 727s Hit:2 http://ftpmaster.internal/ubuntu noble-updates InRelease 727s Hit:3 http://ftpmaster.internal/ubuntu noble-security InRelease 748s Reading package lists... 749s Reading package lists... 750s Building dependency tree... 750s Reading state information... 753s Calculating upgrade... 756s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 756s Reading package lists... 757s Building dependency tree... 757s Reading state information... 761s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 761s autopkgtest [18:06:36]: rebooting testbed after setup commands that affected boot 944s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 979s autopkgtest [18:10:14]: testbed running kernel: Linux 6.8.0-11-generic #11-Ubuntu SMP PREEMPT_DYNAMIC Wed Feb 14 02:53:31 UTC 2024 987s autopkgtest [18:10:22]: @@@@@@@@@@@@@@@@@@@@ apt-source c-icap 999s Get:1 http://ftpmaster.internal/ubuntu noble/universe c-icap 1:0.5.10-6 (dsc) [2064 B] 999s Get:2 http://ftpmaster.internal/ubuntu noble/universe c-icap 1:0.5.10-6 (tar) [695 kB] 999s Get:3 http://ftpmaster.internal/ubuntu noble/universe c-icap 1:0.5.10-6 (diff) [18.4 kB] 1003s gpgv: Signature made Sat Aug 19 22:07:21 2023 UTC 1003s gpgv: using RSA key 7E7729476D87D6F11D91ACCBC293E7B461825ACE 1003s gpgv: Can't check signature: No public key 1003s dpkg-source: warning: cannot verify inline signature for ./c-icap_0.5.10-6.dsc: no acceptable signature found 1005s autopkgtest [18:10:40]: testing package c-icap version 1:0.5.10-6 1005s autopkgtest [18:10:40]: build not needed 1006s autopkgtest [18:10:41]: test basic: preparing testbed 1014s Reading package lists... 1015s Building dependency tree... 1015s Reading state information... 1016s Starting pkgProblemResolver with broken count: 0 1017s Starting 2 pkgProblemResolver with broken count: 0 1017s Done 1019s The following additional packages will be installed: 1019s c-icap libicapapi5 1019s Suggested packages: 1019s libc-icap-module squid 1019s The following NEW packages will be installed: 1019s autopkgtest-satdep c-icap libicapapi5 1019s 0 upgraded, 3 newly installed, 0 to remove and 0 not upgraded. 1019s Need to get 204 kB/205 kB of archives. 1019s After this operation, 1235 kB of additional disk space will be used. 1019s Get:1 /tmp/autopkgtest.C3ggbV/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [708 B] 1020s Get:2 http://ftpmaster.internal/ubuntu noble/universe arm64 libicapapi5 arm64 1:0.5.10-6 [97.8 kB] 1020s Get:3 http://ftpmaster.internal/ubuntu noble/universe arm64 c-icap arm64 1:0.5.10-6 [106 kB] 1023s Fetched 204 kB in 1s (282 kB/s) 1023s Selecting previously unselected package libicapapi5:arm64. 1024s (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 ... 75468 files and directories currently installed.) 1024s Preparing to unpack .../libicapapi5_1%3a0.5.10-6_arm64.deb ... 1024s Unpacking libicapapi5:arm64 (1:0.5.10-6) ... 1024s Selecting previously unselected package c-icap. 1024s Preparing to unpack .../c-icap_1%3a0.5.10-6_arm64.deb ... 1024s Unpacking c-icap (1:0.5.10-6) ... 1024s Selecting previously unselected package autopkgtest-satdep. 1025s Preparing to unpack .../1-autopkgtest-satdep.deb ... 1025s Unpacking autopkgtest-satdep (0) ... 1025s Setting up libicapapi5:arm64 (1:0.5.10-6) ... 1025s Setting up c-icap (1:0.5.10-6) ... 1032s Setting up autopkgtest-satdep (0) ... 1032s Processing triggers for man-db (2.12.0-3) ... 1034s Processing triggers for libc-bin (2.39-0ubuntu2) ... 1049s (Reading database ... 75503 files and directories currently installed.) 1049s Removing autopkgtest-satdep (0) ... 1052s autopkgtest [18:11:27]: test basic: [----------------------- 1052s Enabling c-icap 1052s Synchronizing state of c-icap.service with SysV service script with /usr/lib/systemd/systemd-sysv-install. 1052s Executing: /usr/lib/systemd/systemd-sysv-install enable c-icap 1059s Created symlink /etc/systemd/system/multi-user.target.wants/c-icap.service → /usr/lib/systemd/system/c-icap.service. 1062s Starting c-icap 1063s ● c-icap.service - ICAP server 1063s Loaded: loaded (/usr/lib/systemd/system/c-icap.service; enabled; preset: enabled) 1063s Active: active (running) since Thu 2024-03-21 18:11:38 UTC; 56ms ago 1063s Process: 1418 ExecStartPre=/bin/mkdir -p /run/c-icap (code=exited, status=0/SUCCESS) 1063s Process: 1420 ExecStartPre=/bin/chown c-icap:c-icap /run/c-icap (code=exited, status=0/SUCCESS) 1063s Process: 1422 ExecStart=/usr/bin/c-icap (code=exited, status=0/SUCCESS) 1063s Main PID: 1423 (c-icap) 1063s Tasks: 37 (limit: 1620) 1063s Memory: 3.0M (peak: 3.1M) 1063s CPU: 202ms 1063s CGroup: /system.slice/c-icap.service 1063s ├─1423 /usr/bin/c-icap 1063s ├─1424 /usr/bin/c-icap 1063s ├─1425 /usr/bin/c-icap 1063s └─1442 /usr/bin/c-icap 1063s 1063s Mar 21 18:11:38 autopkgtest systemd[1]: Starting c-icap.service - ICAP server... 1063s Mar 21 18:11:38 autopkgtest systemd[1]: Started c-icap.service - ICAP server. 1063s Testing c-icap 1064s Testing echo service (Echo demo service) 1065s autopkgtest [18:11:40]: test basic: -----------------------] 1066s autopkgtest [18:11:41]: test basic: - - - - - - - - - - results - - - - - - - - - - 1066s basic PASS 1067s autopkgtest [18:11:42]: @@@@@@@@@@@@@@@@@@@@ summary 1067s basic PASS 1088s Creating nova instance adt-noble-arm64-c-icap-20240321-175355-juju-7f2275-prod-proposed-migration-environment-3 from image adt/ubuntu-noble-arm64-server-20240320.img (UUID 6a08b5d2-0d74-409b-820d-5d035099b87d)...