0s autopkgtest [01:21:48]: starting date and time: 2024-06-04 01:21:48+0000 0s autopkgtest [01:21:48]: git checkout: 930f72e5 setup-testbed: don't install 'Recommends' for 'linux-generic' 0s autopkgtest [01:21:48]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.jk_7iw6u/out --timeout-copy=6000 --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:systemd,src:collectd,src:dpdk --apt-upgrade bluez --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=systemd/256~rc3-5ubuntu1 collectd/5.12.0-18build1 dpdk/23.11.1-1' -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@bos03-arm64-37.secgroup --name adt-oracular-arm64-bluez-20240604-012148-juju-7f2275-prod-proposed-migration-environment-2-2301a0d7-6997-4780-a282-507f753f28c8 --image adt/ubuntu-oracular-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'"'"'' --mirror=http://ftpmaster.internal/ubuntu/ 55s autopkgtest [01:22:43]: testbed dpkg architecture: arm64 55s autopkgtest [01:22:43]: testbed apt version: 2.9.3 55s autopkgtest [01:22:43]: @@@@@@@@@@@@@@@@@@@@ test bed setup 56s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed InRelease [110 kB] 56s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/restricted Sources [4792 B] 56s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main Sources [42.5 kB] 56s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse Sources [1680 B] 56s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/universe Sources [425 kB] 56s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 Packages [82.6 kB] 56s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/restricted arm64 Packages [12.3 kB] 56s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/universe arm64 Packages [353 kB] 57s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/multiverse arm64 Packages [1392 B] 57s Fetched 1034 kB in 1s (1183 kB/s) 57s Reading package lists... 59s Reading package lists... 59s Building dependency tree... 59s Reading state information... 60s Calculating upgrade... 60s The following package was automatically installed and is no longer required: 60s systemd-dev 60s Use 'sudo apt autoremove' to remove it. 60s The following packages will be upgraded: 60s cryptsetup-bin libcryptsetup12 libevdev2 libnss-systemd libpam-systemd 60s libsystemd-shared libsystemd0 libudev1 systemd systemd-dev systemd-resolved 60s systemd-sysv systemd-timesyncd udev 60s 14 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 60s Need to get 9638 kB of archives. 60s After this operation, 2051 kB of additional disk space will be used. 60s Get:1 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 systemd-dev all 256~rc3-5ubuntu1 [110 kB] 61s Get:2 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 systemd-timesyncd arm64 256~rc3-5ubuntu1 [34.9 kB] 61s Get:3 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 systemd-resolved arm64 256~rc3-5ubuntu1 [308 kB] 61s Get:4 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libsystemd-shared arm64 256~rc3-5ubuntu1 [2128 kB] 61s Get:5 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libsystemd0 arm64 256~rc3-5ubuntu1 [437 kB] 61s Get:6 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 systemd-sysv arm64 256~rc3-5ubuntu1 [11.9 kB] 61s Get:7 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libnss-systemd arm64 256~rc3-5ubuntu1 [160 kB] 61s Get:8 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libpam-systemd arm64 256~rc3-5ubuntu1 [239 kB] 61s Get:9 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 systemd arm64 256~rc3-5ubuntu1 [3578 kB] 61s Get:10 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 udev arm64 256~rc3-5ubuntu1 [1936 kB] 61s Get:11 http://ftpmaster.internal/ubuntu oracular-proposed/main arm64 libudev1 arm64 256~rc3-5ubuntu1 [190 kB] 61s Get:12 http://ftpmaster.internal/ubuntu oracular/main arm64 libcryptsetup12 arm64 2:2.7.0-1ubuntu5 [261 kB] 61s Get:13 http://ftpmaster.internal/ubuntu oracular/main arm64 libevdev2 arm64 1.13.2+dfsg-1 [35.7 kB] 61s Get:14 http://ftpmaster.internal/ubuntu oracular/main arm64 cryptsetup-bin arm64 2:2.7.0-1ubuntu5 [210 kB] 62s Fetched 9638 kB in 1s (9360 kB/s) 62s (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 ... 78194 files and directories currently installed.) 62s Preparing to unpack .../systemd-dev_256~rc3-5ubuntu1_all.deb ... 62s Unpacking systemd-dev (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 62s Preparing to unpack .../systemd-timesyncd_256~rc3-5ubuntu1_arm64.deb ... 62s Unpacking systemd-timesyncd (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 62s Preparing to unpack .../systemd-resolved_256~rc3-5ubuntu1_arm64.deb ... 62s Unpacking systemd-resolved (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../libsystemd-shared_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking libsystemd-shared:arm64 (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../libsystemd0_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking libsystemd0:arm64 (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Setting up libsystemd0:arm64 (256~rc3-5ubuntu1) ... 63s (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 ... 78196 files and directories currently installed.) 63s Preparing to unpack .../0-systemd-sysv_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking systemd-sysv (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../1-libnss-systemd_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking libnss-systemd:arm64 (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../2-libpam-systemd_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking libpam-systemd:arm64 (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../3-systemd_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking systemd (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../4-udev_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking udev (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Preparing to unpack .../5-libudev1_256~rc3-5ubuntu1_arm64.deb ... 63s Unpacking libudev1:arm64 (256~rc3-5ubuntu1) over (255.4-1ubuntu8) ... 63s Setting up libudev1:arm64 (256~rc3-5ubuntu1) ... 64s (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 ... 78257 files and directories currently installed.) 64s Preparing to unpack .../libcryptsetup12_2%3a2.7.0-1ubuntu5_arm64.deb ... 64s Unpacking libcryptsetup12:arm64 (2:2.7.0-1ubuntu5) over (2:2.7.0-1ubuntu4) ... 64s Preparing to unpack .../libevdev2_1.13.2+dfsg-1_arm64.deb ... 64s Unpacking libevdev2:arm64 (1.13.2+dfsg-1) over (1.13.1+dfsg-1build1) ... 64s Preparing to unpack .../cryptsetup-bin_2%3a2.7.0-1ubuntu5_arm64.deb ... 64s Unpacking cryptsetup-bin (2:2.7.0-1ubuntu5) over (2:2.7.0-1ubuntu4) ... 64s Setting up systemd-dev (256~rc3-5ubuntu1) ... 64s Setting up libsystemd-shared:arm64 (256~rc3-5ubuntu1) ... 64s Setting up libcryptsetup12:arm64 (2:2.7.0-1ubuntu5) ... 64s Setting up libevdev2:arm64 (1.13.2+dfsg-1) ... 64s Setting up cryptsetup-bin (2:2.7.0-1ubuntu5) ... 64s Setting up systemd (256~rc3-5ubuntu1) ... 64s Installing new version of config file /etc/systemd/journald.conf ... 64s Installing new version of config file /etc/systemd/logind.conf ... 64s Installing new version of config file /etc/systemd/networkd.conf ... 64s Installing new version of config file /etc/systemd/sleep.conf ... 64s Installing new version of config file /etc/systemd/system.conf ... 64s /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. 64s Created symlink '/run/systemd/system/tmp.mount' → '/dev/null'. 64s /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. 65s Setting up systemd-timesyncd (256~rc3-5ubuntu1) ... 65s Setting up udev (256~rc3-5ubuntu1) ... 66s Setting up systemd-resolved (256~rc3-5ubuntu1) ... 66s Installing new version of config file /etc/systemd/resolved.conf ... 66s Setting up systemd-sysv (256~rc3-5ubuntu1) ... 66s Setting up libnss-systemd:arm64 (256~rc3-5ubuntu1) ... 66s Setting up libpam-systemd:arm64 (256~rc3-5ubuntu1) ... 67s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 67s Processing triggers for man-db (2.12.1-1) ... 68s Processing triggers for dbus (1.14.10-4ubuntu4) ... 68s Processing triggers for shared-mime-info (2.4-5) ... 68s Warning: program compiled against libxml 212 using older 209 68s Processing triggers for initramfs-tools (0.142ubuntu27) ... 68s update-initramfs: Generating /boot/initrd.img-6.8.0-31-generic 68s W: No lz4 in /usr/bin:/sbin:/bin, using gzip 85s System running in EFI mode, skipping. 85s Reading package lists... 85s Building dependency tree... 85s Reading state information... 86s The following packages will be REMOVED: 86s systemd-dev* 86s 0 upgraded, 0 newly installed, 1 to remove and 0 not upgraded. 86s After this operation, 758 kB disk space will be freed. 86s (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 ... 78257 files and directories currently installed.) 86s Removing systemd-dev (256~rc3-5ubuntu1) ... 87s Hit:1 http://ftpmaster.internal/ubuntu oracular InRelease 87s Hit:2 http://ftpmaster.internal/ubuntu oracular-updates InRelease 87s Hit:3 http://ftpmaster.internal/ubuntu oracular-security InRelease 87s Hit:4 http://ftpmaster.internal/ubuntu oracular-proposed InRelease 89s Reading package lists... 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 89s Calculating upgrade... 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 91s autopkgtest [01:23:19]: rebooting testbed after setup commands that affected boot 95s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 115s autopkgtest-virt-ssh: WARNING: ssh connection failed. Retrying in 3 seconds... 121s autopkgtest [01:23:49]: testbed running kernel: Linux 6.8.0-31-generic #31-Ubuntu SMP PREEMPT_DYNAMIC Sat Apr 20 02:32:42 UTC 2024 125s autopkgtest [01:23:53]: @@@@@@@@@@@@@@@@@@@@ apt-source bluez 132s Get:1 http://ftpmaster.internal/ubuntu oracular/main bluez 5.73-1ubuntu2 (dsc) [3210 B] 132s Get:2 http://ftpmaster.internal/ubuntu oracular/main bluez 5.73-1ubuntu2 (tar) [3578 kB] 132s Get:3 http://ftpmaster.internal/ubuntu oracular/main bluez 5.73-1ubuntu2 (asc) [801 B] 132s Get:4 http://ftpmaster.internal/ubuntu oracular/main bluez 5.73-1ubuntu2 (diff) [56.1 kB] 133s gpgv: Signature made Thu May 2 21:43:47 2024 UTC 133s gpgv: using RSA key 4D0BE12F0E4776D8AACE9696E66C775AEBFE6C7D 133s gpgv: Can't check signature: No public key 133s dpkg-source: warning: cannot verify inline signature for ./bluez_5.73-1ubuntu2.dsc: no acceptable signature found 133s autopkgtest [01:24:01]: testing package bluez version 5.73-1ubuntu2 134s autopkgtest [01:24:02]: build not needed 135s autopkgtest [01:24:03]: test bluez-response: preparing testbed 136s Reading package lists... 136s Building dependency tree... 136s Reading state information... 137s Starting pkgProblemResolver with broken count: 0 137s Starting 2 pkgProblemResolver with broken count: 0 137s Done 138s The following additional packages will be installed: 138s bluez bluez-test-scripts libasound2-data libasound2t64 138s Suggested packages: 138s pulseaudio-module-bluetooth alsa-utils libasound2-plugins 138s Recommended packages: 138s alsa-ucm-conf alsa-topology-conf 138s The following NEW packages will be installed: 138s autopkgtest-satdep bluez bluez-test-scripts libasound2-data libasound2t64 138s 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded. 138s Need to get 1812 kB/1813 kB of archives. 138s After this operation, 7183 kB of additional disk space will be used. 138s Get:1 /tmp/autopkgtest.kLtt7c/1-autopkgtest-satdep.deb autopkgtest-satdep arm64 0 [724 B] 138s Get:2 http://ftpmaster.internal/ubuntu oracular/main arm64 libasound2-data all 1.2.11-1build2 [21.0 kB] 138s Get:3 http://ftpmaster.internal/ubuntu oracular/main arm64 libasound2t64 arm64 1.2.11-1build2 [387 kB] 138s Get:4 http://ftpmaster.internal/ubuntu oracular/main arm64 bluez arm64 5.73-1ubuntu2 [1361 kB] 139s Get:5 http://ftpmaster.internal/ubuntu oracular/universe arm64 bluez-test-scripts all 5.73-1ubuntu2 [43.6 kB] 139s Fetched 1812 kB in 1s (2924 kB/s) 139s Selecting previously unselected package libasound2-data. 140s (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 ... 78210 files and directories currently installed.) 140s Preparing to unpack .../libasound2-data_1.2.11-1build2_all.deb ... 140s Unpacking libasound2-data (1.2.11-1build2) ... 140s Selecting previously unselected package libasound2t64:arm64. 140s Preparing to unpack .../libasound2t64_1.2.11-1build2_arm64.deb ... 140s Unpacking libasound2t64:arm64 (1.2.11-1build2) ... 140s Selecting previously unselected package bluez. 140s Preparing to unpack .../bluez_5.73-1ubuntu2_arm64.deb ... 140s Unpacking bluez (5.73-1ubuntu2) ... 140s Selecting previously unselected package bluez-test-scripts. 140s Preparing to unpack .../bluez-test-scripts_5.73-1ubuntu2_all.deb ... 140s Unpacking bluez-test-scripts (5.73-1ubuntu2) ... 140s Selecting previously unselected package autopkgtest-satdep. 140s Preparing to unpack .../1-autopkgtest-satdep.deb ... 140s Unpacking autopkgtest-satdep (0) ... 140s Setting up libasound2-data (1.2.11-1build2) ... 140s Setting up libasound2t64:arm64 (1.2.11-1build2) ... 140s Setting up bluez-test-scripts (5.73-1ubuntu2) ... 140s Setting up bluez (5.73-1ubuntu2) ... 141s Created symlink '/etc/systemd/system/dbus-org.bluez.service' → '/usr/lib/systemd/system/bluetooth.service'. 141s Created symlink '/etc/systemd/system/bluetooth.target.wants/bluetooth.service' → '/usr/lib/systemd/system/bluetooth.service'. 141s Setting up autopkgtest-satdep (0) ... 141s Processing triggers for man-db (2.12.1-1) ... 143s Processing triggers for dbus (1.14.10-4ubuntu4) ... 143s Processing triggers for libc-bin (2.39-0ubuntu8.1) ... 146s (Reading database ... 78452 files and directories currently installed.) 146s Removing autopkgtest-satdep (0) ... 147s autopkgtest [01:24:15]: test bluez-response: [----------------------- 147s /tmp/autopkgtest.kLtt7c/build.Rsw/src/debian/tests/bluez-response:17: SyntaxWarning: invalid escape sequence '\(' 147s p2 = subprocess.Popen(['grep', '\(^hci\|BD\ Address\)'], 148s testAdapter (__main__.TestBluezResponse.testAdapter) ... skipped 'No bluetooth devices available for testing' 148s testDevice (__main__.TestBluezResponse.testDevice) ... skipped 'No bluetooth devices available for testing' 148s 148s ---------------------------------------------------------------------- 148s Ran 2 tests in 1.267s 148s 148s OK (skipped=2) 148s autopkgtest [01:24:16]: test bluez-response: -----------------------] 149s bluez-response FAIL stderr: /tmp/autopkgtest.kLtt7c/build.Rsw/src/debian/tests/bluez-response:17: SyntaxWarning: invalid escape sequence '\(' 149s autopkgtest [01:24:17]: test bluez-response: - - - - - - - - - - results - - - - - - - - - - 149s autopkgtest [01:24:17]: test bluez-response: - - - - - - - - - - stderr - - - - - - - - - - 149s /tmp/autopkgtest.kLtt7c/build.Rsw/src/debian/tests/bluez-response:17: SyntaxWarning: invalid escape sequence '\(' 149s p2 = subprocess.Popen(['grep', '\(^hci\|BD\ Address\)'], 149s autopkgtest [01:24:17]: @@@@@@@@@@@@@@@@@@@@ summary 149s bluez-response FAIL stderr: /tmp/autopkgtest.kLtt7c/build.Rsw/src/debian/tests/bluez-response:17: SyntaxWarning: invalid escape sequence '\(' 161s Skipping flock in bos03-arm64 161s Creating nova instance adt-oracular-arm64-bluez-20240604-012148-juju-7f2275-prod-proposed-migration-environment-2-2301a0d7-6997-4780-a282-507f753f28c8 from image adt/ubuntu-oracular-arm64-server-20240603.img (UUID 7d7961a3-6831-426e-8d11-0c7edcc5e680)...