0s autopkgtest [21:34:24]: starting date and time: 2024-08-22 21:34:24+0000 0s autopkgtest [21:34:24]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [21:34:24]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.8q74r5pe/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_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\n" >> /etc/environment' --apt-pocket=proposed=src:ubuntu-advantage-tools,src:python3-defaults --apt-upgrade wsl-pro-service --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 '--env=ADT_TEST_TRIGGERS=ubuntu-advantage-tools/33.2~24.04.1 python3-defaults/3.12.3-0ubuntu2' -- lxd -r lxd-armhf-10.145.243.27 lxd-armhf-10.145.243.27:autopkgtest/ubuntu/noble/armhf 59s autopkgtest [21:35:23]: testbed dpkg architecture: armhf 61s autopkgtest [21:35:25]: testbed apt version: 2.7.14build2 61s autopkgtest [21:35:25]: @@@@@@@@@@@@@@@@@@@@ test bed setup 71s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 73s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/multiverse Sources [2280 B] 73s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [16.0 kB] 73s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [170 kB] 73s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [31.0 kB] 73s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main armhf Packages [166 kB] 73s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main armhf c-n-f Metadata [4636 B] 73s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf Packages [1548 B] 73s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf c-n-f Metadata [116 B] 73s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf Packages [77.5 kB] 73s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf c-n-f Metadata [3828 B] 73s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/multiverse armhf c-n-f Metadata [116 B] 76s Fetched 738 kB in 3s (253 kB/s) 77s Reading package lists... 95s tee: /proc/self/fd/2: Permission denied 117s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 117s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 117s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 117s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 118s Reading package lists... 118s Reading package lists... 118s Building dependency tree... 118s Reading state information... 119s Calculating upgrade... 119s The following packages were automatically installed and are no longer required: 119s linux-headers-6.8.0-40 linux-headers-6.8.0-40-generic 119s Use 'apt autoremove' to remove them. 120s The following NEW packages will be installed: 120s linux-headers-6.8.0-41 linux-headers-6.8.0-41-generic 120s The following packages have been kept back: 120s python3-apt 120s The following packages will be upgraded: 120s bzip2 curl dbus dbus-bin dbus-daemon dbus-session-bus-common 120s dbus-system-bus-common dbus-user-session dpkg dpkg-dev e2fsprogs 120s e2fsprogs-l10n libbz2-1.0 libc-bin libc6 libcom-err2 libcurl3t64-gnutls 120s libcurl4t64 libdbus-1-3 libdpkg-perl libext2fs2t64 libgnutls30t64 120s libhogweed6t64 libicu74 liblz4-1 liblzma5 libnetplan1 libnettle8t64 120s libnss-systemd libp11-kit0 libpam-systemd libpython3-stdlib libsasl2-2 120s libsasl2-modules libsasl2-modules-db libseccomp2 libss2 libssl3t64 120s libsystemd-shared libsystemd0 libudev1 libzstd1 linux-headers-generic 120s locales logsave netplan-generator netplan.io openssh-client openssh-server 120s openssh-sftp-server openssl python-apt-common python3 python3-minimal 120s python3-netplan systemd systemd-dev systemd-resolved systemd-sysv 120s systemd-timesyncd ubuntu-minimal ubuntu-pro-client ubuntu-pro-client-l10n 120s ubuntu-standard udev xz-utils zlib1g zstd 120s 68 upgraded, 2 newly installed, 0 to remove and 1 not upgraded. 120s Need to get 54.6 MB of archives. 120s After this operation, 91.0 MB of additional disk space will be used. 120s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dpkg armhf 1.22.6ubuntu6.1 [1229 kB] 120s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libc6 armhf 2.39-0ubuntu8.3 [2828 kB] 120s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libc-bin armhf 2.39-0ubuntu8.3 [570 kB] 121s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main armhf e2fsprogs-l10n all 1.47.0-2.4~exp1ubuntu4.1 [6004 B] 121s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main armhf logsave armhf 1.47.0-2.4~exp1ubuntu4.1 [22.1 kB] 121s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libext2fs2t64 armhf 1.47.0-2.4~exp1ubuntu4.1 [202 kB] 121s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main armhf e2fsprogs armhf 1.47.0-2.4~exp1ubuntu4.1 [571 kB] 121s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/main armhf python3-minimal armhf 3.12.3-0ubuntu2 [27.4 kB] 121s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/main armhf python3 armhf 3.12.3-0ubuntu2 [23.0 kB] 121s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libpython3-stdlib armhf 3.12.3-0ubuntu2 [10.0 kB] 121s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libnss-systemd armhf 255.4-1ubuntu8.4 [148 kB] 121s Get:12 http://ftpmaster.internal/ubuntu noble-proposed/main armhf systemd-dev all 255.4-1ubuntu8.4 [104 kB] 121s Get:13 http://ftpmaster.internal/ubuntu noble-proposed/main armhf systemd-timesyncd armhf 255.4-1ubuntu8.4 [36.0 kB] 121s Get:14 http://ftpmaster.internal/ubuntu noble-proposed/main armhf systemd-resolved armhf 255.4-1ubuntu8.4 [289 kB] 121s Get:15 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libsystemd-shared armhf 255.4-1ubuntu8.4 [2010 kB] 121s Get:16 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libsystemd0 armhf 255.4-1ubuntu8.4 [411 kB] 121s Get:17 http://ftpmaster.internal/ubuntu noble-proposed/main armhf systemd-sysv armhf 255.4-1ubuntu8.4 [11.9 kB] 121s Get:18 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libpam-systemd armhf 255.4-1ubuntu8.4 [216 kB] 121s Get:19 http://ftpmaster.internal/ubuntu noble-proposed/main armhf systemd armhf 255.4-1ubuntu8.4 [3503 kB] 121s Get:20 http://ftpmaster.internal/ubuntu noble-proposed/main armhf udev armhf 255.4-1ubuntu8.4 [1852 kB] 121s Get:21 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libudev1 armhf 255.4-1ubuntu8.4 [167 kB] 121s Get:22 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libssl3t64 armhf 3.0.13-0ubuntu3.3 [1561 kB] 121s Get:23 http://ftpmaster.internal/ubuntu noble-proposed/main armhf liblz4-1 armhf 1.9.4-1build1.1 [58.1 kB] 121s Get:24 http://ftpmaster.internal/ubuntu noble-proposed/main armhf liblzma5 armhf 5.6.1+really5.4.5-1build0.1 [112 kB] 121s Get:25 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libseccomp2 armhf 2.5.5-1ubuntu3.1 [49.6 kB] 121s Get:26 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libzstd1 armhf 1.5.5+dfsg2-2build1.1 [265 kB] 121s Get:27 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus-system-bus-common all 1.14.10-4ubuntu4.1 [81.6 kB] 121s Get:28 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus-session-bus-common all 1.14.10-4ubuntu4.1 [80.5 kB] 121s Get:29 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus-user-session armhf 1.14.10-4ubuntu4.1 [9970 B] 121s Get:30 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus-daemon armhf 1.14.10-4ubuntu4.1 [109 kB] 121s Get:31 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus-bin armhf 1.14.10-4ubuntu4.1 [37.1 kB] 121s Get:32 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dbus armhf 1.14.10-4ubuntu4.1 [28.1 kB] 121s Get:33 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libdbus-1-3 armhf 1.14.10-4ubuntu4.1 [190 kB] 121s Get:34 http://ftpmaster.internal/ubuntu noble-proposed/main armhf zlib1g armhf 1:1.3.dfsg-3.1ubuntu2.1 [49.3 kB] 121s Get:35 http://ftpmaster.internal/ubuntu noble-proposed/main armhf openssh-sftp-server armhf 1:9.6p1-3ubuntu13.5 [35.5 kB] 121s Get:36 http://ftpmaster.internal/ubuntu noble-proposed/main armhf openssh-server armhf 1:9.6p1-3ubuntu13.5 [504 kB] 121s Get:37 http://ftpmaster.internal/ubuntu noble-proposed/main armhf openssh-client armhf 1:9.6p1-3ubuntu13.5 [887 kB] 121s Get:38 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libcom-err2 armhf 1.47.0-2.4~exp1ubuntu4.1 [22.1 kB] 121s Get:39 http://ftpmaster.internal/ubuntu noble-proposed/main armhf bzip2 armhf 1.0.8-5.1build0.1 [33.6 kB] 121s Get:40 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libbz2-1.0 armhf 1.0.8-5.1build0.1 [31.2 kB] 121s Get:41 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libnettle8t64 armhf 3.9.1-2.2build1.1 [187 kB] 121s Get:42 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libhogweed6t64 armhf 3.9.1-2.2build1.1 [187 kB] 121s Get:43 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libp11-kit0 armhf 0.25.3-4ubuntu2.1 [258 kB] 121s Get:44 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libgnutls30t64 armhf 3.8.3-1.1ubuntu3.2 [947 kB] 121s Get:45 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libss2 armhf 1.47.0-2.4~exp1ubuntu4.1 [14.7 kB] 121s Get:46 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libicu74 armhf 74.2-1ubuntu3.1 [10.5 MB] 121s Get:47 http://ftpmaster.internal/ubuntu noble-proposed/main armhf python3-netplan armhf 1.0.1-1ubuntu2~24.04.1 [22.6 kB] 121s Get:48 http://ftpmaster.internal/ubuntu noble-proposed/main armhf netplan-generator armhf 1.0.1-1ubuntu2~24.04.1 [59.0 kB] 121s Get:49 http://ftpmaster.internal/ubuntu noble-proposed/main armhf netplan.io armhf 1.0.1-1ubuntu2~24.04.1 [65.0 kB] 121s Get:50 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libnetplan1 armhf 1.0.1-1ubuntu2~24.04.1 [118 kB] 121s Get:51 http://ftpmaster.internal/ubuntu noble-proposed/main armhf locales all 2.39-0ubuntu8.3 [4231 kB] 122s Get:52 http://ftpmaster.internal/ubuntu noble-proposed/main armhf openssl armhf 3.0.13-0ubuntu3.3 [975 kB] 122s Get:53 http://ftpmaster.internal/ubuntu noble-proposed/main armhf python-apt-common all 2.7.7ubuntu2 [20.0 kB] 122s Get:54 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-pro-client-l10n armhf 33.2~24.04.1 [19.3 kB] 122s Get:55 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-pro-client armhf 33.2~24.04.1 [233 kB] 122s Get:56 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-minimal armhf 1.539.1 [11.0 kB] 122s Get:57 http://ftpmaster.internal/ubuntu noble-proposed/main armhf xz-utils armhf 5.6.1+really5.4.5-1build0.1 [267 kB] 122s Get:58 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-standard armhf 1.539.1 [11.0 kB] 122s Get:59 http://ftpmaster.internal/ubuntu noble-proposed/main armhf curl armhf 8.5.0-2ubuntu10.3 [219 kB] 122s Get:60 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libcurl4t64 armhf 8.5.0-2ubuntu10.3 [297 kB] 122s Get:61 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dpkg-dev all 1.22.6ubuntu6.1 [1074 kB] 122s Get:62 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libdpkg-perl all 1.22.6ubuntu6.1 [269 kB] 122s Get:63 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libcurl3t64-gnutls armhf 8.5.0-2ubuntu10.3 [290 kB] 122s Get:64 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libsasl2-modules-db armhf 2.1.28+dfsg1-5ubuntu3.1 [19.3 kB] 122s Get:65 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libsasl2-2 armhf 2.1.28+dfsg1-5ubuntu3.1 [49.7 kB] 122s Get:66 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libsasl2-modules armhf 2.1.28+dfsg1-5ubuntu3.1 [61.5 kB] 122s Get:67 http://ftpmaster.internal/ubuntu noble-updates/main armhf linux-headers-6.8.0-41 all 6.8.0-41.41 [13.7 MB] 122s Get:68 http://ftpmaster.internal/ubuntu noble-updates/main armhf linux-headers-6.8.0-41-generic armhf 6.8.0-41.41 [1363 kB] 122s Get:69 http://ftpmaster.internal/ubuntu noble-updates/main armhf linux-headers-generic armhf 6.8.0-41.41 [10.2 kB] 122s Get:70 http://ftpmaster.internal/ubuntu noble-proposed/main armhf zstd armhf 1.5.5+dfsg2-2build1.1 [683 kB] 123s Preconfiguring packages ... 123s Fetched 54.6 MB in 3s (21.2 MB/s) 123s (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 ... 57904 files and directories currently installed.) 123s Preparing to unpack .../dpkg_1.22.6ubuntu6.1_armhf.deb ... 123s Unpacking dpkg (1.22.6ubuntu6.1) over (1.22.6ubuntu6) ... 124s Setting up dpkg (1.22.6ubuntu6.1) ... 125s (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 ... 57904 files and directories currently installed.) 125s Preparing to unpack .../libc6_2.39-0ubuntu8.3_armhf.deb ... 125s Unpacking libc6:armhf (2.39-0ubuntu8.3) over (2.39-0ubuntu8.2) ... 126s Setting up libc6:armhf (2.39-0ubuntu8.3) ... 127s (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 ... 57905 files and directories currently installed.) 127s Preparing to unpack .../libc-bin_2.39-0ubuntu8.3_armhf.deb ... 127s Unpacking libc-bin (2.39-0ubuntu8.3) over (2.39-0ubuntu8.2) ... 127s Setting up libc-bin (2.39-0ubuntu8.3) ... 128s (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 ... 57906 files and directories currently installed.) 128s Preparing to unpack .../e2fsprogs-l10n_1.47.0-2.4~exp1ubuntu4.1_all.deb ... 128s Unpacking e2fsprogs-l10n (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 129s Preparing to unpack .../logsave_1.47.0-2.4~exp1ubuntu4.1_armhf.deb ... 129s Unpacking logsave (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 129s Preparing to unpack .../libext2fs2t64_1.47.0-2.4~exp1ubuntu4.1_armhf.deb ... 129s Leaving 'diversion of /lib/arm-linux-gnueabihf/libe2p.so.2 to /lib/arm-linux-gnueabihf/libe2p.so.2.usr-is-merged by libext2fs2t64' 129s Leaving 'diversion of /lib/arm-linux-gnueabihf/libe2p.so.2.3 to /lib/arm-linux-gnueabihf/libe2p.so.2.3.usr-is-merged by libext2fs2t64' 129s Leaving 'diversion of /lib/arm-linux-gnueabihf/libext2fs.so.2 to /lib/arm-linux-gnueabihf/libext2fs.so.2.usr-is-merged by libext2fs2t64' 129s Leaving 'diversion of /lib/arm-linux-gnueabihf/libext2fs.so.2.4 to /lib/arm-linux-gnueabihf/libext2fs.so.2.4.usr-is-merged by libext2fs2t64' 129s Unpacking libext2fs2t64:armhf (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 129s Setting up libext2fs2t64:armhf (1.47.0-2.4~exp1ubuntu4.1) ... 129s (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 ... 57906 files and directories currently installed.) 129s Preparing to unpack .../e2fsprogs_1.47.0-2.4~exp1ubuntu4.1_armhf.deb ... 129s Unpacking e2fsprogs (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 129s Preparing to unpack .../python3-minimal_3.12.3-0ubuntu2_armhf.deb ... 129s Unpacking python3-minimal (3.12.3-0ubuntu2) over (3.12.3-0ubuntu1) ... 129s Setting up python3-minimal (3.12.3-0ubuntu2) ... 131s (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 ... 57906 files and directories currently installed.) 131s Preparing to unpack .../0-python3_3.12.3-0ubuntu2_armhf.deb ... 131s Unpacking python3 (3.12.3-0ubuntu2) over (3.12.3-0ubuntu1) ... 131s Preparing to unpack .../1-libpython3-stdlib_3.12.3-0ubuntu2_armhf.deb ... 131s Unpacking libpython3-stdlib:armhf (3.12.3-0ubuntu2) over (3.12.3-0ubuntu1) ... 131s Preparing to unpack .../2-libnss-systemd_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking libnss-systemd:armhf (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../3-systemd-dev_255.4-1ubuntu8.4_all.deb ... 131s Unpacking systemd-dev (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../4-systemd-timesyncd_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking systemd-timesyncd (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../5-systemd-resolved_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking systemd-resolved (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../6-libsystemd-shared_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking libsystemd-shared:armhf (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../7-libsystemd0_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking libsystemd0:armhf (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Setting up libsystemd0:armhf (255.4-1ubuntu8.4) ... 131s (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 ... 57906 files and directories currently installed.) 131s Preparing to unpack .../systemd-sysv_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking systemd-sysv (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../libpam-systemd_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking libpam-systemd:armhf (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 131s Preparing to unpack .../systemd_255.4-1ubuntu8.4_armhf.deb ... 131s Unpacking systemd (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 132s Preparing to unpack .../udev_255.4-1ubuntu8.4_armhf.deb ... 132s Unpacking udev (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 132s Preparing to unpack .../libudev1_255.4-1ubuntu8.4_armhf.deb ... 132s Unpacking libudev1:armhf (255.4-1ubuntu8.4) over (255.4-1ubuntu8.2) ... 132s Setting up libudev1:armhf (255.4-1ubuntu8.4) ... 132s (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 ... 57906 files and directories currently installed.) 132s Preparing to unpack .../libssl3t64_3.0.13-0ubuntu3.3_armhf.deb ... 132s Unpacking libssl3t64:armhf (3.0.13-0ubuntu3.3) over (3.0.13-0ubuntu3.2) ... 132s Setting up libssl3t64:armhf (3.0.13-0ubuntu3.3) ... 133s (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 ... 57906 files and directories currently installed.) 133s Preparing to unpack .../liblz4-1_1.9.4-1build1.1_armhf.deb ... 133s Unpacking liblz4-1:armhf (1.9.4-1build1.1) over (1.9.4-1build1) ... 133s Setting up liblz4-1:armhf (1.9.4-1build1.1) ... 133s (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 ... 57906 files and directories currently installed.) 133s Preparing to unpack .../liblzma5_5.6.1+really5.4.5-1build0.1_armhf.deb ... 133s Unpacking liblzma5:armhf (5.6.1+really5.4.5-1build0.1) over (5.6.1+really5.4.5-1) ... 133s Setting up liblzma5:armhf (5.6.1+really5.4.5-1build0.1) ... 133s (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 ... 57906 files and directories currently installed.) 133s Preparing to unpack .../libseccomp2_2.5.5-1ubuntu3.1_armhf.deb ... 133s Unpacking libseccomp2:armhf (2.5.5-1ubuntu3.1) over (2.5.5-1ubuntu3) ... 133s Setting up libseccomp2:armhf (2.5.5-1ubuntu3.1) ... 133s (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 ... 57906 files and directories currently installed.) 133s Preparing to unpack .../libzstd1_1.5.5+dfsg2-2build1.1_armhf.deb ... 133s Unpacking libzstd1:armhf (1.5.5+dfsg2-2build1.1) over (1.5.5+dfsg2-2build1) ... 133s Setting up libzstd1:armhf (1.5.5+dfsg2-2build1.1) ... 133s (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 ... 57906 files and directories currently installed.) 133s Preparing to unpack .../0-dbus-system-bus-common_1.14.10-4ubuntu4.1_all.deb ... 133s Unpacking dbus-system-bus-common (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 133s Preparing to unpack .../1-dbus-session-bus-common_1.14.10-4ubuntu4.1_all.deb ... 133s Unpacking dbus-session-bus-common (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 133s Preparing to unpack .../2-dbus-user-session_1.14.10-4ubuntu4.1_armhf.deb ... 133s Unpacking dbus-user-session (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 133s Preparing to unpack .../3-dbus-daemon_1.14.10-4ubuntu4.1_armhf.deb ... 133s Unpacking dbus-daemon (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 133s Preparing to unpack .../4-dbus-bin_1.14.10-4ubuntu4.1_armhf.deb ... 133s Unpacking dbus-bin (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 134s Preparing to unpack .../5-dbus_1.14.10-4ubuntu4.1_armhf.deb ... 134s Unpacking dbus (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 134s Preparing to unpack .../6-libdbus-1-3_1.14.10-4ubuntu4.1_armhf.deb ... 134s Unpacking libdbus-1-3:armhf (1.14.10-4ubuntu4.1) over (1.14.10-4ubuntu4) ... 134s Preparing to unpack .../7-zlib1g_1%3a1.3.dfsg-3.1ubuntu2.1_armhf.deb ... 134s Unpacking zlib1g:armhf (1:1.3.dfsg-3.1ubuntu2.1) over (1:1.3.dfsg-3.1ubuntu2) ... 134s Setting up zlib1g:armhf (1:1.3.dfsg-3.1ubuntu2.1) ... 134s (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 ... 57906 files and directories currently installed.) 134s Preparing to unpack .../0-openssh-sftp-server_1%3a9.6p1-3ubuntu13.5_armhf.deb ... 134s Unpacking openssh-sftp-server (1:9.6p1-3ubuntu13.5) over (1:9.6p1-3ubuntu13.4) ... 134s Preparing to unpack .../1-openssh-server_1%3a9.6p1-3ubuntu13.5_armhf.deb ... 136s Unpacking openssh-server (1:9.6p1-3ubuntu13.5) over (1:9.6p1-3ubuntu13.4) ... 136s Preparing to unpack .../2-openssh-client_1%3a9.6p1-3ubuntu13.5_armhf.deb ... 136s Unpacking openssh-client (1:9.6p1-3ubuntu13.5) over (1:9.6p1-3ubuntu13.4) ... 136s Preparing to unpack .../3-libcom-err2_1.47.0-2.4~exp1ubuntu4.1_armhf.deb ... 136s Unpacking libcom-err2:armhf (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 136s Preparing to unpack .../4-bzip2_1.0.8-5.1build0.1_armhf.deb ... 136s Unpacking bzip2 (1.0.8-5.1build0.1) over (1.0.8-5.1) ... 136s Preparing to unpack .../5-libbz2-1.0_1.0.8-5.1build0.1_armhf.deb ... 136s Unpacking libbz2-1.0:armhf (1.0.8-5.1build0.1) over (1.0.8-5.1) ... 136s Setting up libbz2-1.0:armhf (1.0.8-5.1build0.1) ... 136s (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 ... 57906 files and directories currently installed.) 136s Preparing to unpack .../libnettle8t64_3.9.1-2.2build1.1_armhf.deb ... 136s Unpacking libnettle8t64:armhf (3.9.1-2.2build1.1) over (3.9.1-2.2build1) ... 136s Setting up libnettle8t64:armhf (3.9.1-2.2build1.1) ... 136s (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 ... 57906 files and directories currently installed.) 136s Preparing to unpack .../libhogweed6t64_3.9.1-2.2build1.1_armhf.deb ... 136s Unpacking libhogweed6t64:armhf (3.9.1-2.2build1.1) over (3.9.1-2.2build1) ... 136s Setting up libhogweed6t64:armhf (3.9.1-2.2build1.1) ... 136s (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 ... 57906 files and directories currently installed.) 136s Preparing to unpack .../libp11-kit0_0.25.3-4ubuntu2.1_armhf.deb ... 136s Unpacking libp11-kit0:armhf (0.25.3-4ubuntu2.1) over (0.25.3-4ubuntu2) ... 136s Setting up libp11-kit0:armhf (0.25.3-4ubuntu2.1) ... 136s (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 ... 57906 files and directories currently installed.) 136s Preparing to unpack .../libgnutls30t64_3.8.3-1.1ubuntu3.2_armhf.deb ... 136s Unpacking libgnutls30t64:armhf (3.8.3-1.1ubuntu3.2) over (3.8.3-1.1ubuntu3.1) ... 136s Setting up libgnutls30t64:armhf (3.8.3-1.1ubuntu3.2) ... 136s (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 ... 57906 files and directories currently installed.) 136s Preparing to unpack .../00-libss2_1.47.0-2.4~exp1ubuntu4.1_armhf.deb ... 136s Unpacking libss2:armhf (1.47.0-2.4~exp1ubuntu4.1) over (1.47.0-2.4~exp1ubuntu4) ... 136s Preparing to unpack .../01-libicu74_74.2-1ubuntu3.1_armhf.deb ... 136s Unpacking libicu74:armhf (74.2-1ubuntu3.1) over (74.2-1ubuntu3) ... 137s Preparing to unpack .../02-python3-netplan_1.0.1-1ubuntu2~24.04.1_armhf.deb ... 137s Unpacking python3-netplan (1.0.1-1ubuntu2~24.04.1) over (1.0-2ubuntu1.2) ... 137s Preparing to unpack .../03-netplan-generator_1.0.1-1ubuntu2~24.04.1_armhf.deb ... 137s Adding 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 137s Unpacking netplan-generator (1.0.1-1ubuntu2~24.04.1) over (1.0-2ubuntu1.2) ... 137s Preparing to unpack .../04-netplan.io_1.0.1-1ubuntu2~24.04.1_armhf.deb ... 137s Unpacking netplan.io (1.0.1-1ubuntu2~24.04.1) over (1.0-2ubuntu1.2) ... 137s Preparing to unpack .../05-libnetplan1_1.0.1-1ubuntu2~24.04.1_armhf.deb ... 137s Unpacking libnetplan1:armhf (1.0.1-1ubuntu2~24.04.1) over (1.0-2ubuntu1.2) ... 137s Preparing to unpack .../06-locales_2.39-0ubuntu8.3_all.deb ... 137s Unpacking locales (2.39-0ubuntu8.3) over (2.39-0ubuntu8.2) ... 137s Preparing to unpack .../07-openssl_3.0.13-0ubuntu3.3_armhf.deb ... 137s Unpacking openssl (3.0.13-0ubuntu3.3) over (3.0.13-0ubuntu3.2) ... 137s Preparing to unpack .../08-python-apt-common_2.7.7ubuntu2_all.deb ... 137s Unpacking python-apt-common (2.7.7ubuntu2) over (2.7.7ubuntu1) ... 138s Preparing to unpack .../09-ubuntu-pro-client-l10n_33.2~24.04.1_armhf.deb ... 138s Unpacking ubuntu-pro-client-l10n (33.2~24.04.1) over (32.3.1~24.04) ... 138s Preparing to unpack .../10-ubuntu-pro-client_33.2~24.04.1_armhf.deb ... 138s Unpacking ubuntu-pro-client (33.2~24.04.1) over (32.3.1~24.04) ... 138s Preparing to unpack .../11-ubuntu-minimal_1.539.1_armhf.deb ... 138s Unpacking ubuntu-minimal (1.539.1) over (1.539) ... 138s Preparing to unpack .../12-xz-utils_5.6.1+really5.4.5-1build0.1_armhf.deb ... 138s Unpacking xz-utils (5.6.1+really5.4.5-1build0.1) over (5.6.1+really5.4.5-1) ... 138s Preparing to unpack .../13-ubuntu-standard_1.539.1_armhf.deb ... 138s Unpacking ubuntu-standard (1.539.1) over (1.539) ... 138s Preparing to unpack .../14-curl_8.5.0-2ubuntu10.3_armhf.deb ... 138s Unpacking curl (8.5.0-2ubuntu10.3) over (8.5.0-2ubuntu10.2) ... 138s Preparing to unpack .../15-libcurl4t64_8.5.0-2ubuntu10.3_armhf.deb ... 138s Unpacking libcurl4t64:armhf (8.5.0-2ubuntu10.3) over (8.5.0-2ubuntu10.2) ... 138s Preparing to unpack .../16-dpkg-dev_1.22.6ubuntu6.1_all.deb ... 138s Unpacking dpkg-dev (1.22.6ubuntu6.1) over (1.22.6ubuntu6) ... 139s Preparing to unpack .../17-libdpkg-perl_1.22.6ubuntu6.1_all.deb ... 139s Unpacking libdpkg-perl (1.22.6ubuntu6.1) over (1.22.6ubuntu6) ... 139s Preparing to unpack .../18-libcurl3t64-gnutls_8.5.0-2ubuntu10.3_armhf.deb ... 139s Unpacking libcurl3t64-gnutls:armhf (8.5.0-2ubuntu10.3) over (8.5.0-2ubuntu10.2) ... 139s Preparing to unpack .../19-libsasl2-modules-db_2.1.28+dfsg1-5ubuntu3.1_armhf.deb ... 139s Unpacking libsasl2-modules-db:armhf (2.1.28+dfsg1-5ubuntu3.1) over (2.1.28+dfsg1-5ubuntu3) ... 139s Preparing to unpack .../20-libsasl2-2_2.1.28+dfsg1-5ubuntu3.1_armhf.deb ... 139s Unpacking libsasl2-2:armhf (2.1.28+dfsg1-5ubuntu3.1) over (2.1.28+dfsg1-5ubuntu3) ... 139s Preparing to unpack .../21-libsasl2-modules_2.1.28+dfsg1-5ubuntu3.1_armhf.deb ... 139s Unpacking libsasl2-modules:armhf (2.1.28+dfsg1-5ubuntu3.1) over (2.1.28+dfsg1-5ubuntu3) ... 139s Selecting previously unselected package linux-headers-6.8.0-41. 139s Preparing to unpack .../22-linux-headers-6.8.0-41_6.8.0-41.41_all.deb ... 139s Unpacking linux-headers-6.8.0-41 (6.8.0-41.41) ... 141s Selecting previously unselected package linux-headers-6.8.0-41-generic. 142s Preparing to unpack .../23-linux-headers-6.8.0-41-generic_6.8.0-41.41_armhf.deb ... 142s Unpacking linux-headers-6.8.0-41-generic (6.8.0-41.41) ... 143s Preparing to unpack .../24-linux-headers-generic_6.8.0-41.41_armhf.deb ... 143s Unpacking linux-headers-generic (6.8.0-41.41) over (6.8.0-40.40) ... 143s Preparing to unpack .../25-zstd_1.5.5+dfsg2-2build1.1_armhf.deb ... 143s Unpacking zstd (1.5.5+dfsg2-2build1.1) over (1.5.5+dfsg2-2build1) ... 143s Setting up libcurl4t64:armhf (8.5.0-2ubuntu10.3) ... 143s Setting up openssh-client (1:9.6p1-3ubuntu13.5) ... 143s Setting up libsasl2-modules:armhf (2.1.28+dfsg1-5ubuntu3.1) ... 143s Setting up libcurl3t64-gnutls:armhf (8.5.0-2ubuntu10.3) ... 143s Setting up systemd-dev (255.4-1ubuntu8.4) ... 143s Setting up libcom-err2:armhf (1.47.0-2.4~exp1ubuntu4.1) ... 143s Setting up libnetplan1:armhf (1.0.1-1ubuntu2~24.04.1) ... 143s Setting up bzip2 (1.0.8-5.1build0.1) ... 143s Setting up locales (2.39-0ubuntu8.3) ... 144s Generating locales (this might take a while)... 147s en_US.UTF-8... done 147s Generation complete. 147s Setting up libsasl2-modules-db:armhf (2.1.28+dfsg1-5ubuntu3.1) ... 147s Setting up libdbus-1-3:armhf (1.14.10-4ubuntu4.1) ... 147s Setting up xz-utils (5.6.1+really5.4.5-1build0.1) ... 147s Setting up libsystemd-shared:armhf (255.4-1ubuntu8.4) ... 147s Setting up libss2:armhf (1.47.0-2.4~exp1ubuntu4.1) ... 147s Setting up libdpkg-perl (1.22.6ubuntu6.1) ... 147s Setting up logsave (1.47.0-2.4~exp1ubuntu4.1) ... 147s Setting up libsasl2-2:armhf (2.1.28+dfsg1-5ubuntu3.1) ... 147s Setting up libicu74:armhf (74.2-1ubuntu3.1) ... 147s Setting up python-apt-common (2.7.7ubuntu2) ... 147s Setting up dbus-session-bus-common (1.14.10-4ubuntu4.1) ... 147s Setting up curl (8.5.0-2ubuntu10.3) ... 147s Setting up dbus-system-bus-common (1.14.10-4ubuntu4.1) ... 147s Setting up openssl (3.0.13-0ubuntu3.3) ... 147s Setting up linux-headers-6.8.0-41 (6.8.0-41.41) ... 147s Setting up zstd (1.5.5+dfsg2-2build1.1) ... 147s Setting up dbus-bin (1.14.10-4ubuntu4.1) ... 147s Setting up libpython3-stdlib:armhf (3.12.3-0ubuntu2) ... 147s Setting up openssh-sftp-server (1:9.6p1-3ubuntu13.5) ... 147s Setting up linux-headers-6.8.0-41-generic (6.8.0-41.41) ... 147s Setting up openssh-server (1:9.6p1-3ubuntu13.5) ... 151s Setting up e2fsprogs (1.47.0-2.4~exp1ubuntu4.1) ... 151s update-initramfs: deferring update (trigger activated) 152s e2scrub_all.service is a disabled or a static unit not running, not starting it. 152s Setting up python3 (3.12.3-0ubuntu2) ... 153s Setting up systemd (255.4-1ubuntu8.4) ... 156s Setting up linux-headers-generic (6.8.0-41.41) ... 156s Setting up dbus-daemon (1.14.10-4ubuntu4.1) ... 156s Setting up dpkg-dev (1.22.6ubuntu6.1) ... 156s Setting up dbus (1.14.10-4ubuntu4.1) ... 156s A reboot is required to replace the running dbus-daemon. 156s Please reboot the system when convenient. 158s Setting up systemd-timesyncd (255.4-1ubuntu8.4) ... 159s Setting up udev (255.4-1ubuntu8.4) ... 162s Setting up python3-netplan (1.0.1-1ubuntu2~24.04.1) ... 162s Setting up netplan-generator (1.0.1-1ubuntu2~24.04.1) ... 162s Removing 'diversion of /lib/systemd/system-generators/netplan to /lib/systemd/system-generators/netplan.usr-is-merged by netplan-generator' 162s Setting up ubuntu-pro-client (33.2~24.04.1) ... 162s Installing new version of config file /etc/apparmor.d/ubuntu_pro_apt_news ... 162s apparmor_parser: Unable to replace "ubuntu_pro_apt_news". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 162s 163s apparmor_parser: Unable to replace "apt_methods". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 163s 163s apparmor_parser: Unable to replace "ubuntu_pro_esm_cache". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 163s 166s Setting up systemd-resolved (255.4-1ubuntu8.4) ... 168s Setting up ubuntu-pro-client-l10n (33.2~24.04.1) ... 168s Setting up systemd-sysv (255.4-1ubuntu8.4) ... 168s Setting up e2fsprogs-l10n (1.47.0-2.4~exp1ubuntu4.1) ... 168s Setting up libnss-systemd:armhf (255.4-1ubuntu8.4) ... 168s Setting up netplan.io (1.0.1-1ubuntu2~24.04.1) ... 168s Setting up libpam-systemd:armhf (255.4-1ubuntu8.4) ... 168s Setting up ubuntu-minimal (1.539.1) ... 168s Setting up ubuntu-standard (1.539.1) ... 168s Setting up dbus-user-session (1.14.10-4ubuntu4.1) ... 168s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 168s Processing triggers for ufw (0.36.2-6) ... 169s Processing triggers for man-db (2.12.0-4build2) ... 170s Processing triggers for initramfs-tools (0.142ubuntu25.1) ... 171s Reading package lists... 171s Building dependency tree... 171s Reading state information... 172s The following packages will be REMOVED: 172s linux-headers-6.8.0-40* linux-headers-6.8.0-40-generic* 172s 0 upgraded, 0 newly installed, 2 to remove and 1 not upgraded. 172s After this operation, 91.9 MB disk space will be freed. 173s (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 ... 89059 files and directories currently installed.) 173s Removing linux-headers-6.8.0-40-generic (6.8.0-40.40) ... 173s Removing linux-headers-6.8.0-40 (6.8.0-40.40) ... 177s autopkgtest [21:37:21]: rebooting testbed after setup commands that affected boot 228s autopkgtest [21:38:12]: testbed running kernel: Linux 6.5.0-45-generic #45~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Mon Jul 15 20:13:54 UTC 2 256s autopkgtest [21:38:40]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 267s Get:1 http://ftpmaster.internal/ubuntu noble/main wsl-pro-service 0.1.4 (dsc) [1420 B] 267s Get:2 http://ftpmaster.internal/ubuntu noble/main wsl-pro-service 0.1.4 (tar) [1762 kB] 268s gpgv: Signature made Fri Apr 19 05:59:17 2024 UTC 268s gpgv: using DSA key DD00EF8F4D23C30D78EC990998B24A9CE4AC208E 268s gpgv: Can't check signature: No public key 268s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.4.dsc: no acceptable signature found 268s autopkgtest [21:38:52]: testing package wsl-pro-service version 0.1.4 270s autopkgtest [21:38:54]: build not needed 273s autopkgtest [21:38:57]: test command1: preparing testbed 283s Reading package lists... 283s Building dependency tree... 283s Reading state information... 284s Starting pkgProblemResolver with broken count: 0 284s Starting 2 pkgProblemResolver with broken count: 0 284s Done 284s The following additional packages will be installed: 284s autoconf automake autopoint autotools-dev build-essential cpp cpp-13 284s cpp-13-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper debugedit 284s dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13 284s g++-13-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-13 284s gcc-13-arm-linux-gnueabihf gcc-13-base gcc-arm-linux-gnueabihf gettext 284s golang-1.22-go golang-1.22-src golang-go golang-src intltool-debian 284s libarchive-zip-perl libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 284s libcrypt-dev libdebhelper-perl libdw1t64 libfile-stripnondeterminism-perl 284s libgcc-13-dev libgomp1 libisl23 libmpc3 libstdc++-13-dev 284s libsub-override-perl libtool libubsan1 linux-libc-dev m4 po-debconf 284s rpcsvc-proto 285s Suggested packages: 285s autoconf-archive gnu-standards autoconf-doc cpp-doc gcc-13-locales 285s cpp-13-doc dh-make gcc-13-doc gcc-multilib manpages-dev flex bison gdb 285s gcc-doc gdb-arm-linux-gnueabihf gettext-doc libasprintf-dev libgettextpo-dev 285s bzr | brz git mercurial subversion glibc-doc libstdc++-13-doc libtool-doc 285s gfortran | fortran95-compiler gcj-jdk m4-doc libmail-box-perl 285s Recommended packages: 285s pkg-config manpages manpages-dev libc-devtools libarchive-cpio-perl 285s libltdl-dev libmail-sendmail-perl 285s The following NEW packages will be installed: 285s autoconf automake autopkgtest-satdep autopoint autotools-dev build-essential 285s cpp cpp-13 cpp-13-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper 285s debugedit dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ 285s g++-13 g++-13-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-13 285s gcc-13-arm-linux-gnueabihf gcc-13-base gcc-arm-linux-gnueabihf gettext 285s golang-1.22-go golang-1.22-src golang-go golang-src intltool-debian 285s libarchive-zip-perl libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 285s libcrypt-dev libdebhelper-perl libdw1t64 libfile-stripnondeterminism-perl 285s libgcc-13-dev libgomp1 libisl23 libmpc3 libstdc++-13-dev 285s libsub-override-perl libtool libubsan1 linux-libc-dev m4 po-debconf 285s rpcsvc-proto 285s 0 upgraded, 54 newly installed, 0 to remove and 1 not upgraded. 285s Need to get 95.5 MB/95.5 MB of archives. 285s After this operation, 378 MB of additional disk space will be used. 285s Get:1 /tmp/autopkgtest.OmchTW/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [764 B] 285s Get:2 http://ftpmaster.internal/ubuntu noble/main armhf m4 armhf 1.4.19-4build1 [235 kB] 285s Get:3 http://ftpmaster.internal/ubuntu noble/main armhf autoconf all 2.71-3 [339 kB] 285s Get:4 http://ftpmaster.internal/ubuntu noble/main armhf autotools-dev all 20220109.1 [44.9 kB] 285s Get:5 http://ftpmaster.internal/ubuntu noble/main armhf automake all 1:1.16.5-1.3ubuntu1 [558 kB] 285s Get:6 http://ftpmaster.internal/ubuntu noble/main armhf autopoint all 0.21-14ubuntu2 [422 kB] 285s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libc-dev-bin armhf 2.39-0ubuntu8.3 [59.2 kB] 285s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main armhf linux-libc-dev armhf 6.8.0-41.41 [1630 kB] 285s Get:9 http://ftpmaster.internal/ubuntu noble/main armhf libcrypt-dev armhf 1:4.4.36-4build1 [120 kB] 285s Get:10 http://ftpmaster.internal/ubuntu noble/main armhf rpcsvc-proto armhf 1.4.2-0ubuntu7 [62.2 kB] 285s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/main armhf libc6-dev armhf 2.39-0ubuntu8.3 [1392 kB] 285s Get:12 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13-base armhf 13.2.0-23ubuntu4 [48.9 kB] 285s Get:13 http://ftpmaster.internal/ubuntu noble/main armhf libisl23 armhf 0.26-3build1 [544 kB] 286s Get:14 http://ftpmaster.internal/ubuntu noble/main armhf libmpc3 armhf 1.3.1-1build1 [46.7 kB] 286s Get:15 http://ftpmaster.internal/ubuntu noble/main armhf cpp-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [8759 kB] 286s Get:16 http://ftpmaster.internal/ubuntu noble/main armhf cpp-13 armhf 13.2.0-23ubuntu4 [1034 B] 286s Get:17 http://ftpmaster.internal/ubuntu noble/main armhf cpp-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [5320 B] 286s Get:18 http://ftpmaster.internal/ubuntu noble/main armhf cpp armhf 4:13.2.0-7ubuntu1 [22.4 kB] 286s Get:19 http://ftpmaster.internal/ubuntu noble/main armhf libcc1-0 armhf 14-20240412-0ubuntu1 [39.0 kB] 286s Get:20 http://ftpmaster.internal/ubuntu noble/main armhf libgomp1 armhf 14-20240412-0ubuntu1 [125 kB] 286s Get:21 http://ftpmaster.internal/ubuntu noble/main armhf libatomic1 armhf 14-20240412-0ubuntu1 [7816 B] 286s Get:22 http://ftpmaster.internal/ubuntu noble/main armhf libasan8 armhf 14-20240412-0ubuntu1 [2942 kB] 286s Get:23 http://ftpmaster.internal/ubuntu noble/main armhf libubsan1 armhf 14-20240412-0ubuntu1 [1154 kB] 286s Get:24 http://ftpmaster.internal/ubuntu noble/main armhf libgcc-13-dev armhf 13.2.0-23ubuntu4 [899 kB] 286s Get:25 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [16.9 MB] 286s Get:26 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13 armhf 13.2.0-23ubuntu4 [453 kB] 286s Get:27 http://ftpmaster.internal/ubuntu noble/main armhf gcc-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [1220 B] 286s Get:28 http://ftpmaster.internal/ubuntu noble/main armhf gcc armhf 4:13.2.0-7ubuntu1 [5022 B] 286s Get:29 http://ftpmaster.internal/ubuntu noble/main armhf libstdc++-13-dev armhf 13.2.0-23ubuntu4 [2456 kB] 286s Get:30 http://ftpmaster.internal/ubuntu noble/main armhf g++-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [9941 kB] 287s Get:31 http://ftpmaster.internal/ubuntu noble/main armhf g++-13 armhf 13.2.0-23ubuntu4 [14.5 kB] 287s Get:32 http://ftpmaster.internal/ubuntu noble/main armhf g++-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [966 B] 287s Get:33 http://ftpmaster.internal/ubuntu noble/main armhf g++ armhf 4:13.2.0-7ubuntu1 [1090 B] 287s Get:34 http://ftpmaster.internal/ubuntu noble/main armhf build-essential armhf 12.10ubuntu1 [4928 B] 287s Get:35 http://ftpmaster.internal/ubuntu noble/main armhf libdebhelper-perl all 13.14.1ubuntu5 [89.8 kB] 287s Get:36 http://ftpmaster.internal/ubuntu noble/main armhf libtool all 2.4.7-7build1 [166 kB] 287s Get:37 http://ftpmaster.internal/ubuntu noble/main armhf dh-autoreconf all 20 [16.1 kB] 287s Get:38 http://ftpmaster.internal/ubuntu noble/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 287s Get:39 http://ftpmaster.internal/ubuntu noble/main armhf libsub-override-perl all 0.10-1 [10.0 kB] 287s Get:40 http://ftpmaster.internal/ubuntu noble/main armhf libfile-stripnondeterminism-perl all 1.13.1-1 [18.1 kB] 287s Get:41 http://ftpmaster.internal/ubuntu noble/main armhf dh-strip-nondeterminism all 1.13.1-1 [5362 B] 287s Get:42 http://ftpmaster.internal/ubuntu noble/main armhf libdw1t64 armhf 0.190-1.1build4 [235 kB] 287s Get:43 http://ftpmaster.internal/ubuntu noble/main armhf debugedit armhf 1:5.0-5build2 [42.3 kB] 287s Get:44 http://ftpmaster.internal/ubuntu noble/main armhf dwz armhf 0.15-1build6 [116 kB] 287s Get:45 http://ftpmaster.internal/ubuntu noble/main armhf gettext armhf 0.21-14ubuntu2 [800 kB] 287s Get:46 http://ftpmaster.internal/ubuntu noble/main armhf intltool-debian all 0.35.0+20060710.6 [23.2 kB] 287s Get:47 http://ftpmaster.internal/ubuntu noble/main armhf po-debconf all 1.0.21+nmu1 [233 kB] 287s Get:48 http://ftpmaster.internal/ubuntu noble/main armhf debhelper all 13.14.1ubuntu5 [869 kB] 287s Get:49 http://ftpmaster.internal/ubuntu noble-updates/universe armhf dh-apport all 2.28.1-0ubuntu3.1 [17.6 kB] 287s Get:50 http://ftpmaster.internal/ubuntu noble-proposed/main armhf golang-1.22-src all 1.22.2-2ubuntu0.2 [19.7 MB] 287s Get:51 http://ftpmaster.internal/ubuntu noble-proposed/main armhf golang-1.22-go armhf 1.22.2-2ubuntu0.2 [23.7 MB] 288s Get:52 http://ftpmaster.internal/ubuntu noble/main armhf golang-src all 2:1.22~2build1 [5078 B] 288s Get:53 http://ftpmaster.internal/ubuntu noble/main armhf golang-go armhf 2:1.22~2build1 [43.9 kB] 288s Get:54 http://ftpmaster.internal/ubuntu noble/main armhf dh-golang all 1.62 [25.2 kB] 288s Fetched 95.5 MB in 3s (28.4 MB/s) 289s Selecting previously unselected package m4. 289s (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 ... 57908 files and directories currently installed.) 289s Preparing to unpack .../00-m4_1.4.19-4build1_armhf.deb ... 289s Unpacking m4 (1.4.19-4build1) ... 289s Selecting previously unselected package autoconf. 289s Preparing to unpack .../01-autoconf_2.71-3_all.deb ... 289s Unpacking autoconf (2.71-3) ... 289s Selecting previously unselected package autotools-dev. 289s Preparing to unpack .../02-autotools-dev_20220109.1_all.deb ... 289s Unpacking autotools-dev (20220109.1) ... 289s Selecting previously unselected package automake. 289s Preparing to unpack .../03-automake_1%3a1.16.5-1.3ubuntu1_all.deb ... 289s Unpacking automake (1:1.16.5-1.3ubuntu1) ... 289s Selecting previously unselected package autopoint. 289s Preparing to unpack .../04-autopoint_0.21-14ubuntu2_all.deb ... 289s Unpacking autopoint (0.21-14ubuntu2) ... 289s Selecting previously unselected package libc-dev-bin. 289s Preparing to unpack .../05-libc-dev-bin_2.39-0ubuntu8.3_armhf.deb ... 289s Unpacking libc-dev-bin (2.39-0ubuntu8.3) ... 289s Selecting previously unselected package linux-libc-dev:armhf. 289s Preparing to unpack .../06-linux-libc-dev_6.8.0-41.41_armhf.deb ... 289s Unpacking linux-libc-dev:armhf (6.8.0-41.41) ... 289s Selecting previously unselected package libcrypt-dev:armhf. 289s Preparing to unpack .../07-libcrypt-dev_1%3a4.4.36-4build1_armhf.deb ... 289s Unpacking libcrypt-dev:armhf (1:4.4.36-4build1) ... 289s Selecting previously unselected package rpcsvc-proto. 289s Preparing to unpack .../08-rpcsvc-proto_1.4.2-0ubuntu7_armhf.deb ... 289s Unpacking rpcsvc-proto (1.4.2-0ubuntu7) ... 289s Selecting previously unselected package libc6-dev:armhf. 289s Preparing to unpack .../09-libc6-dev_2.39-0ubuntu8.3_armhf.deb ... 289s Unpacking libc6-dev:armhf (2.39-0ubuntu8.3) ... 290s Selecting previously unselected package gcc-13-base:armhf. 290s Preparing to unpack .../10-gcc-13-base_13.2.0-23ubuntu4_armhf.deb ... 290s Unpacking gcc-13-base:armhf (13.2.0-23ubuntu4) ... 290s Selecting previously unselected package libisl23:armhf. 290s Preparing to unpack .../11-libisl23_0.26-3build1_armhf.deb ... 290s Unpacking libisl23:armhf (0.26-3build1) ... 290s Selecting previously unselected package libmpc3:armhf. 290s Preparing to unpack .../12-libmpc3_1.3.1-1build1_armhf.deb ... 290s Unpacking libmpc3:armhf (1.3.1-1build1) ... 290s Selecting previously unselected package cpp-13-arm-linux-gnueabihf. 290s Preparing to unpack .../13-cpp-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 290s Unpacking cpp-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 290s Selecting previously unselected package cpp-13. 290s Preparing to unpack .../14-cpp-13_13.2.0-23ubuntu4_armhf.deb ... 290s Unpacking cpp-13 (13.2.0-23ubuntu4) ... 290s Selecting previously unselected package cpp-arm-linux-gnueabihf. 290s Preparing to unpack .../15-cpp-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 290s Unpacking cpp-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 290s Selecting previously unselected package cpp. 290s Preparing to unpack .../16-cpp_4%3a13.2.0-7ubuntu1_armhf.deb ... 290s Unpacking cpp (4:13.2.0-7ubuntu1) ... 290s Selecting previously unselected package libcc1-0:armhf. 291s Preparing to unpack .../17-libcc1-0_14-20240412-0ubuntu1_armhf.deb ... 291s Unpacking libcc1-0:armhf (14-20240412-0ubuntu1) ... 291s Selecting previously unselected package libgomp1:armhf. 291s Preparing to unpack .../18-libgomp1_14-20240412-0ubuntu1_armhf.deb ... 291s Unpacking libgomp1:armhf (14-20240412-0ubuntu1) ... 291s Selecting previously unselected package libatomic1:armhf. 291s Preparing to unpack .../19-libatomic1_14-20240412-0ubuntu1_armhf.deb ... 291s Unpacking libatomic1:armhf (14-20240412-0ubuntu1) ... 291s Selecting previously unselected package libasan8:armhf. 291s Preparing to unpack .../20-libasan8_14-20240412-0ubuntu1_armhf.deb ... 291s Unpacking libasan8:armhf (14-20240412-0ubuntu1) ... 291s Selecting previously unselected package libubsan1:armhf. 291s Preparing to unpack .../21-libubsan1_14-20240412-0ubuntu1_armhf.deb ... 291s Unpacking libubsan1:armhf (14-20240412-0ubuntu1) ... 291s Selecting previously unselected package libgcc-13-dev:armhf. 291s Preparing to unpack .../22-libgcc-13-dev_13.2.0-23ubuntu4_armhf.deb ... 291s Unpacking libgcc-13-dev:armhf (13.2.0-23ubuntu4) ... 291s Selecting previously unselected package gcc-13-arm-linux-gnueabihf. 291s Preparing to unpack .../23-gcc-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 291s Unpacking gcc-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 292s Selecting previously unselected package gcc-13. 292s Preparing to unpack .../24-gcc-13_13.2.0-23ubuntu4_armhf.deb ... 292s Unpacking gcc-13 (13.2.0-23ubuntu4) ... 292s Selecting previously unselected package gcc-arm-linux-gnueabihf. 292s Preparing to unpack .../25-gcc-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 292s Unpacking gcc-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 292s Selecting previously unselected package gcc. 292s Preparing to unpack .../26-gcc_4%3a13.2.0-7ubuntu1_armhf.deb ... 292s Unpacking gcc (4:13.2.0-7ubuntu1) ... 292s Selecting previously unselected package libstdc++-13-dev:armhf. 293s Preparing to unpack .../27-libstdc++-13-dev_13.2.0-23ubuntu4_armhf.deb ... 293s Unpacking libstdc++-13-dev:armhf (13.2.0-23ubuntu4) ... 293s Selecting previously unselected package g++-13-arm-linux-gnueabihf. 293s Preparing to unpack .../28-g++-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 293s Unpacking g++-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 293s Selecting previously unselected package g++-13. 293s Preparing to unpack .../29-g++-13_13.2.0-23ubuntu4_armhf.deb ... 293s Unpacking g++-13 (13.2.0-23ubuntu4) ... 293s Selecting previously unselected package g++-arm-linux-gnueabihf. 293s Preparing to unpack .../30-g++-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 293s Unpacking g++-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 293s Selecting previously unselected package g++. 293s Preparing to unpack .../31-g++_4%3a13.2.0-7ubuntu1_armhf.deb ... 293s Unpacking g++ (4:13.2.0-7ubuntu1) ... 293s Selecting previously unselected package build-essential. 293s Preparing to unpack .../32-build-essential_12.10ubuntu1_armhf.deb ... 293s Unpacking build-essential (12.10ubuntu1) ... 293s Selecting previously unselected package libdebhelper-perl. 293s Preparing to unpack .../33-libdebhelper-perl_13.14.1ubuntu5_all.deb ... 293s Unpacking libdebhelper-perl (13.14.1ubuntu5) ... 293s Selecting previously unselected package libtool. 293s Preparing to unpack .../34-libtool_2.4.7-7build1_all.deb ... 293s Unpacking libtool (2.4.7-7build1) ... 293s Selecting previously unselected package dh-autoreconf. 293s Preparing to unpack .../35-dh-autoreconf_20_all.deb ... 293s Unpacking dh-autoreconf (20) ... 294s Selecting previously unselected package libarchive-zip-perl. 294s Preparing to unpack .../36-libarchive-zip-perl_1.68-1_all.deb ... 294s Unpacking libarchive-zip-perl (1.68-1) ... 294s Selecting previously unselected package libsub-override-perl. 294s Preparing to unpack .../37-libsub-override-perl_0.10-1_all.deb ... 294s Unpacking libsub-override-perl (0.10-1) ... 294s Selecting previously unselected package libfile-stripnondeterminism-perl. 294s Preparing to unpack .../38-libfile-stripnondeterminism-perl_1.13.1-1_all.deb ... 294s Unpacking libfile-stripnondeterminism-perl (1.13.1-1) ... 294s Selecting previously unselected package dh-strip-nondeterminism. 294s Preparing to unpack .../39-dh-strip-nondeterminism_1.13.1-1_all.deb ... 294s Unpacking dh-strip-nondeterminism (1.13.1-1) ... 294s Selecting previously unselected package libdw1t64:armhf. 294s Preparing to unpack .../40-libdw1t64_0.190-1.1build4_armhf.deb ... 294s Unpacking libdw1t64:armhf (0.190-1.1build4) ... 294s Selecting previously unselected package debugedit. 294s Preparing to unpack .../41-debugedit_1%3a5.0-5build2_armhf.deb ... 294s Unpacking debugedit (1:5.0-5build2) ... 294s Selecting previously unselected package dwz. 294s Preparing to unpack .../42-dwz_0.15-1build6_armhf.deb ... 294s Unpacking dwz (0.15-1build6) ... 294s Selecting previously unselected package gettext. 294s Preparing to unpack .../43-gettext_0.21-14ubuntu2_armhf.deb ... 294s Unpacking gettext (0.21-14ubuntu2) ... 294s Selecting previously unselected package intltool-debian. 294s Preparing to unpack .../44-intltool-debian_0.35.0+20060710.6_all.deb ... 294s Unpacking intltool-debian (0.35.0+20060710.6) ... 294s Selecting previously unselected package po-debconf. 294s Preparing to unpack .../45-po-debconf_1.0.21+nmu1_all.deb ... 294s Unpacking po-debconf (1.0.21+nmu1) ... 294s Selecting previously unselected package debhelper. 294s Preparing to unpack .../46-debhelper_13.14.1ubuntu5_all.deb ... 294s Unpacking debhelper (13.14.1ubuntu5) ... 294s Selecting previously unselected package dh-apport. 294s Preparing to unpack .../47-dh-apport_2.28.1-0ubuntu3.1_all.deb ... 294s Unpacking dh-apport (2.28.1-0ubuntu3.1) ... 294s Selecting previously unselected package golang-1.22-src. 294s Preparing to unpack .../48-golang-1.22-src_1.22.2-2ubuntu0.2_all.deb ... 294s Unpacking golang-1.22-src (1.22.2-2ubuntu0.2) ... 296s Selecting previously unselected package golang-1.22-go. 296s Preparing to unpack .../49-golang-1.22-go_1.22.2-2ubuntu0.2_armhf.deb ... 296s Unpacking golang-1.22-go (1.22.2-2ubuntu0.2) ... 297s Selecting previously unselected package golang-src. 297s Preparing to unpack .../50-golang-src_2%3a1.22~2build1_all.deb ... 297s Unpacking golang-src (2:1.22~2build1) ... 297s Selecting previously unselected package golang-go:armhf. 297s Preparing to unpack .../51-golang-go_2%3a1.22~2build1_armhf.deb ... 297s Unpacking golang-go:armhf (2:1.22~2build1) ... 297s Selecting previously unselected package dh-golang. 297s Preparing to unpack .../52-dh-golang_1.62_all.deb ... 297s Unpacking dh-golang (1.62) ... 297s Selecting previously unselected package autopkgtest-satdep. 297s Preparing to unpack .../53-1-autopkgtest-satdep.deb ... 297s Unpacking autopkgtest-satdep (0) ... 297s Setting up libarchive-zip-perl (1.68-1) ... 297s Setting up libdebhelper-perl (13.14.1ubuntu5) ... 297s Setting up linux-libc-dev:armhf (6.8.0-41.41) ... 297s Setting up m4 (1.4.19-4build1) ... 297s Setting up libgomp1:armhf (14-20240412-0ubuntu1) ... 297s Setting up dh-apport (2.28.1-0ubuntu3.1) ... 297s Setting up libdw1t64:armhf (0.190-1.1build4) ... 297s Setting up autotools-dev (20220109.1) ... 297s Setting up rpcsvc-proto (1.4.2-0ubuntu7) ... 297s Setting up gcc-13-base:armhf (13.2.0-23ubuntu4) ... 297s Setting up golang-1.22-src (1.22.2-2ubuntu0.2) ... 297s Setting up libmpc3:armhf (1.3.1-1build1) ... 297s Setting up libatomic1:armhf (14-20240412-0ubuntu1) ... 297s Setting up autopoint (0.21-14ubuntu2) ... 297s Setting up autoconf (2.71-3) ... 297s Setting up libubsan1:armhf (14-20240412-0ubuntu1) ... 297s Setting up dwz (0.15-1build6) ... 297s Setting up libcrypt-dev:armhf (1:4.4.36-4build1) ... 297s Setting up libasan8:armhf (14-20240412-0ubuntu1) ... 297s Setting up debugedit (1:5.0-5build2) ... 297s Setting up libsub-override-perl (0.10-1) ... 297s Setting up libisl23:armhf (0.26-3build1) ... 297s Setting up libc-dev-bin (2.39-0ubuntu8.3) ... 297s Setting up golang-src (2:1.22~2build1) ... 297s Setting up libcc1-0:armhf (14-20240412-0ubuntu1) ... 297s Setting up automake (1:1.16.5-1.3ubuntu1) ... 297s update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode 297s Setting up libfile-stripnondeterminism-perl (1.13.1-1) ... 297s Setting up gettext (0.21-14ubuntu2) ... 297s Setting up cpp-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 297s Setting up golang-1.22-go (1.22.2-2ubuntu0.2) ... 297s Setting up intltool-debian (0.35.0+20060710.6) ... 297s Setting up dh-strip-nondeterminism (1.13.1-1) ... 297s Setting up libgcc-13-dev:armhf (13.2.0-23ubuntu4) ... 297s Setting up libc6-dev:armhf (2.39-0ubuntu8.3) ... 297s Setting up cpp-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 297s Setting up libstdc++-13-dev:armhf (13.2.0-23ubuntu4) ... 297s Setting up cpp-13 (13.2.0-23ubuntu4) ... 297s Setting up golang-go:armhf (2:1.22~2build1) ... 297s Setting up po-debconf (1.0.21+nmu1) ... 297s Setting up gcc-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 297s Setting up gcc-13 (13.2.0-23ubuntu4) ... 297s Setting up cpp (4:13.2.0-7ubuntu1) ... 297s Setting up gcc-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 297s Setting up g++-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 297s Setting up g++-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 297s Setting up g++-13 (13.2.0-23ubuntu4) ... 297s Setting up libtool (2.4.7-7build1) ... 297s Setting up gcc (4:13.2.0-7ubuntu1) ... 297s Setting up dh-autoreconf (20) ... 297s Setting up g++ (4:13.2.0-7ubuntu1) ... 297s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 297s Setting up build-essential (12.10ubuntu1) ... 297s Setting up debhelper (13.14.1ubuntu5) ... 297s Setting up dh-golang (1.62) ... 297s Setting up autopkgtest-satdep (0) ... 297s Processing triggers for man-db (2.12.0-4build2) ... 299s Processing triggers for install-info (7.1-3build2) ... 299s Processing triggers for libc-bin (2.39-0ubuntu8.3) ... 309s (Reading database ... 76050 files and directories currently installed.) 309s Removing autopkgtest-satdep (0) ... 315s autopkgtest [21:39:39]: test command1: ./debian/tests/test 315s autopkgtest [21:39:39]: test command1: [----------------------- 385s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 385s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 386s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 388s === RUN TestRunSignal 388s === RUN TestRunSignal/Send_SIGINT_exits 388s INFO Starting WSL Pro Service version Dev 388s === RUN TestRunSignal/Send_SIGTERM_exits 388s INFO Starting WSL Pro Service version Dev 388s --- PASS: TestRunSignal (0.38s) 388s --- PASS: TestRunSignal/Send_SIGINT_exits (0.20s) 388s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.17s) 388s === RUN TestRun 388s === PAUSE TestRun 388s === CONT TestRun 388s === RUN TestRun/Run_and_exit_successfully 388s === PAUSE TestRun/Run_and_exit_successfully 388s === RUN TestRun/Run_and_return_error 388s === PAUSE TestRun/Run_and_return_error 388s === RUN TestRun/Run_and_return_usage_error 388s === PAUSE TestRun/Run_and_return_usage_error 388s === RUN TestRun/Run_and_usage_error_only_does_not_fail 388s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 388s === CONT TestRun/Run_and_exit_successfully 388s INFO Starting WSL Pro Service version Dev 388s === CONT TestRun/Run_and_usage_error_only_does_not_fail 388s INFO Starting WSL Pro Service version Dev 388s === CONT TestRun/Run_and_return_usage_error 388s INFO Starting WSL Pro Service version Dev 388s === CONT TestRun/Run_and_return_error 388s INFO Starting WSL Pro Service version Dev 388s ERROR context.Background Error requested 388s ERROR context.Background Error requested 388s --- PASS: TestRun (0.00s) 388s --- PASS: TestRun/Run_and_return_error (0.14s) 388s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.14s) 388s --- PASS: TestRun/Run_and_return_usage_error (0.14s) 388s --- PASS: TestRun/Run_and_exit_successfully (0.14s) 388s PASS 388s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 3.378s 437s === RUN TestHelp 437s --- PASS: TestHelp (0.35s) 437s === RUN TestCompletion 437s --- PASS: TestCompletion (0.09s) 437s === RUN TestVersion 437s --- PASS: TestVersion (0.00s) 437s === RUN TestNoUsageError 437s --- PASS: TestNoUsageError (0.00s) 437s === RUN TestUsageError 437s === PAUSE TestUsageError 437s === RUN TestCanQuitWhenExecute 437s === PAUSE TestCanQuitWhenExecute 437s === RUN TestCanQuitTwice 437s === PAUSE TestCanQuitTwice 437s === RUN TestAppCanQuitWithoutExecute 437s === PAUSE TestAppCanQuitWithoutExecute 437s === RUN TestAppRunFailsOnComponentsCreationAndQuit 437s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 437s === RUN TestAppGetRootCmd 437s === PAUSE TestAppGetRootCmd 437s === RUN TestWithProMock 437s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 437s --- SKIP: TestWithProMock (0.00s) 437s === RUN TestWithWslPathMock 437s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 437s --- SKIP: TestWithWslPathMock (0.00s) 437s === RUN TestWithWslInfoMock 437s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 437s --- SKIP: TestWithWslInfoMock (0.00s) 437s === RUN TestWithCmdExeMock 437s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 437s --- SKIP: TestWithCmdExeMock (0.00s) 437s === CONT TestUsageError 437s --- PASS: TestUsageError (0.00s) 437s === CONT TestAppGetRootCmd 437s --- PASS: TestAppGetRootCmd (0.00s) 437s === CONT TestAppRunFailsOnComponentsCreationAndQuit 437s === CONT TestCanQuitTwice 437s === CONT TestCanQuitWhenExecute 437s === CONT TestAppCanQuitWithoutExecute 437s service_test.go:140: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 437s --- SKIP: TestAppCanQuitWithoutExecute (0.00s) 437s time="2024-08-22T21:40:53Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/cmd/wsl-pro-service/service/service.go:66 New.func1() Debug mode is enabled" 437s time="2024-08-22T21:40:53Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:75 New() Building new daemon" 437s time="2024-08-22T21:40:53Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36457" 437s time="2024-08-22T21:40:53Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/cmd/wsl-pro-service/service/service.go:66 New.func1() Debug mode is enabled" 437s time="2024-08-22T21:40:53Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:75 New() Building new daemon" 437s time="2024-08-22T21:41:23Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:153 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 437s time="2024-08-22T21:41:24Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:153 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 437s time="2024-08-22T21:41:24Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 437s time="2024-08-22T21:41:24Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 437s time="2024-08-22T21:41:26Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:153 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 437s time="2024-08-22T21:41:27Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 437s time="2024-08-22T21:41:27Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 437s time="2024-08-22T21:41:30Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 437s time="2024-08-22T21:41:30Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 437s time="2024-08-22T21:41:30Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 437s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (37.49s) 437s time="2024-08-22T21:41:33Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:288 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:35665" 437s time="2024-08-22T21:41:33Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:173 (*Daemon).Serve.func1() Daemon: completed connection to Windows Agent" 437s time="2024-08-22T21:41:33Z" level=warning msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:184 (*Daemon).Serve.func1() Daemon: disconnected from Windows host: could not start serving: could not connect: could not connect to GRPC service: rpc error: code = Unavailable desc = connection error: desc = \"transport: Error while dialing: dial tcp 127.0.0.1:35665: connect: connection refused\"" 437s time="2024-08-22T21:41:33Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:209 (*Daemon).Serve() Reconnecting to Windows host in 1 seconds" 437s time="2024-08-22T21:41:33Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 437s time="2024-08-22T21:41:33Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 437s time="2024-08-22T21:41:33Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 437s time="2024-08-22T21:41:33Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 437s --- PASS: TestCanQuitWhenExecute (41.30s) 437s time="2024-08-22T21:41:34Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:288 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:44167" 437s time="2024-08-22T21:41:34Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:173 (*Daemon).Serve.func1() Daemon: completed connection to Windows Agent" 437s time="2024-08-22T21:41:34Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/streams/server.go:196 (*handlingLoop[...]).run() Started serving agentapi.ProAttachCmd requests" 437s time="2024-08-22T21:41:34Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/streams/server.go:196 (*handlingLoop[...]).run() Started serving agentapi.LandscapeConfigCmd requests" 437s time="2024-08-22T21:41:41Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/streams/server.go:141 (*Server).Serve() Server: sent preface messages to all streams" 437s time="2024-08-22T21:41:41Z" level=warning msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:186 (*Daemon).Serve.func1() Daemon: disconnected from Windows host" 437s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:209 (*Daemon).Serve() Reconnecting to Windows host in 1 seconds" 437s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/testutils/mock_agent.go:326 (*mockWSLInstanceService).LandscapeConfigCommands() MockWindowsAgent: LandscapeConfigCommands ready" 437s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/testutils/mock_agent.go:275 (*mockWSLInstanceService).Connected() MockWindowsAgent: Connected ready" 437s time="2024-08-22T21:41:41Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.OmchTW/build.rxO/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 437s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/testutils/mock_agent.go:300 (*mockWSLInstanceService).ProAttachmentCommands() MockWindowsAgent: ProAttachmentCommands ready" 438s time="2024-08-22T21:41:41Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.OmchTW/build.rxO/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 438s time="2024-08-22T21:41:41Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 438s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 438s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 438s time="2024-08-22T21:41:41Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 438s time="2024-08-22T21:41:41Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.OmchTW/build.rxO/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 438s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:220 (*Daemon).Quit() Stopping daemon requested." 438s time="2024-08-22T21:41:41Z" level=info msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:226 (*Daemon).Quit() Waiting for active requests to close." 438s time="2024-08-22T21:41:41Z" level=debug msg="/tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon.go:234 (*Daemon).Quit() All connections have now ended." 438s --- PASS: TestCanQuitTwice (48.75s) 438s PASS 438s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 52.378s 438s === RUN TestApplyProToken 438s === PAUSE TestApplyProToken 438s === RUN TestApplyLandscapeConfig 438s === PAUSE TestApplyLandscapeConfig 438s === RUN TestWithProMock 438s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 438s --- SKIP: TestWithProMock (0.00s) 438s === RUN TestWithLandscapeConfigMock 438s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 438s --- SKIP: TestWithLandscapeConfigMock (0.00s) 438s === RUN TestWithWslPathMock 438s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 438s --- SKIP: TestWithWslPathMock (0.00s) 438s === RUN TestWithWslInfoMock 438s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 438s --- SKIP: TestWithWslInfoMock (0.00s) 438s === RUN TestWithCmdExeMock 438s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 438s --- SKIP: TestWithCmdExeMock (0.00s) 438s === CONT TestApplyProToken 438s === RUN TestApplyProToken/Success_attaching 438s === PAUSE TestApplyProToken/Success_attaching 438s === RUN TestApplyProToken/Success_detaching 438s === PAUSE TestApplyProToken/Success_detaching 438s === RUN TestApplyProToken/Error_calling_pro_detach 438s === PAUSE TestApplyProToken/Error_calling_pro_detach 438s === CONT TestApplyLandscapeConfig 438s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 438s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 438s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 438s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 438s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 438s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 438s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 438s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 438s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 438s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 438s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 438s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 438s === RUN TestApplyProToken/Error_calling_pro_attach 438s === PAUSE TestApplyProToken/Error_calling_pro_attach 438s === CONT TestApplyProToken/Success_attaching 438s === CONT TestApplyProToken/Error_calling_pro_attach 438s === CONT TestApplyProToken/Success_detaching 438s === CONT TestApplyProToken/Error_calling_pro_detach 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyLandscapeConfig: received config: registering" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyProToken: Received empty token: detaching" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 438s time="2024-08-22T21:40:51Z" level=info msg="ApplyLandscapeConfig: received config: registering" 438s --- PASS: TestApplyLandscapeConfig (0.00s) 438s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (19.19s) 438s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (20.64s) 438s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (21.54s) 438s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (22.39s) 438s --- PASS: TestApplyProToken (0.04s) 438s --- PASS: TestApplyProToken/Error_calling_pro_detach (21.69s) 438s --- PASS: TestApplyProToken/Success_detaching (24.80s) 438s --- PASS: TestApplyProToken/Success_attaching (26.40s) 438s --- PASS: TestApplyProToken/Error_calling_pro_attach (26.86s) 438s PASS 438s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 29.200s 541s === RUN TestNew 541s === PAUSE TestNew 541s === RUN TestServe 541s === PAUSE TestServe 541s === RUN TestServeAndQuit 541s === PAUSE TestServeAndQuit 541s === RUN TestReconnection 541s === PAUSE TestReconnection 541s === RUN TestWithProMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithProMock (0.00s) 541s === RUN TestWithWslPathMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslPathMock (0.00s) 541s === RUN TestWithWslInfoMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslInfoMock (0.00s) 541s === RUN TestWithCmdExeMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithCmdExeMock (0.00s) 541s === CONT TestNew 541s === RUN TestNew/Success 541s === PAUSE TestNew/Success 541s === RUN TestNew/Error_when_WslPath_returns_error 541s === PAUSE TestNew/Error_when_WslPath_returns_error 541s === CONT TestNew/Success 541s === CONT TestServeAndQuit 541s === RUN TestServeAndQuit/Success_with_graceful_quit 541s === PAUSE TestServeAndQuit/Success_with_graceful_quit 541s === RUN TestServeAndQuit/Success_with_forceful_quit 541s === PAUSE TestServeAndQuit/Success_with_forceful_quit 541s === RUN TestServeAndQuit/Success_with_double_quit 541s === PAUSE TestServeAndQuit/Success_with_double_quit 541s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 541s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 541s === CONT TestServeAndQuit/Success_with_graceful_quit 541s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 541s === CONT TestServeAndQuit/Success_with_double_quit 541s === CONT TestServe 541s === RUN TestServe/Success_with_systemd_notifier_returning_true 541s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 541s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 541s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 541s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 541s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 541s === RUN TestServe/No_connection_because_there_is_no_server 541s === PAUSE TestServe/No_connection_because_there_is_no_server 541s === RUN TestServe/Error_because_the_context_is_pre-cancelled 541s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 541s === RUN TestServe/Success 541s === PAUSE TestServe/Success 541s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 541s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 541s === RUN TestServe/No_connection_because_the_port_file_is_empty 541s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 541s === RUN TestServe/No_connection_because_the_port_file_has_port_0 541s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 541s === RUN TestServe/No_connection_because_there_are_no_certificates 541s === PAUSE TestServe/No_connection_because_there_are_no_certificates 541s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 541s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 541s === RUN TestServe/Error_because_the_notifier_returns_an_error 541s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 541s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 541s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 541s === CONT TestServe/Success_with_systemd_notifier_returning_true 541s === CONT TestServeAndQuit/Success_with_forceful_quit 541s === CONT TestServe/No_connection_because_the_port_file_is_empty 541s === CONT TestNew/Error_when_WslPath_returns_error 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43907" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33989" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35583" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37731" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45147" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34045" 541s time="2024-08-22T21:40:53Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:18Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:18Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:18Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:18Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:18Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:18Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:20Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:20Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"\": could not split address: missing port in address" 541s time="2024-08-22T21:41:20Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:21Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:21Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:21Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:21Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:21Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 541s time="2024-08-22T21:41:21Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35593" 541s time="2024-08-22T21:41:21Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:21Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:21Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"\": could not split address: missing port in address" 541s time="2024-08-22T21:41:21Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 541s time="2024-08-22T21:41:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39587" 541s time="2024-08-22T21:41:22Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:22Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:22Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:22Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:22Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43907" 541s time="2024-08-22T21:41:22Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:22Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:22Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:22Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s === CONT TestServe/Error_because_the_notifier_returns_an_error 541s time="2024-08-22T21:41:23Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34591" 541s time="2024-08-22T21:41:23Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:23Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:23Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:23Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:24Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33989" 541s time="2024-08-22T21:41:24Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:24Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:24Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:24Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s === CONT TestServe/No_connection_because_there_are_no_certificates 541s --- PASS: TestNew (0.00s) 541s --- PASS: TestNew/Success (29.26s) 541s --- PASS: TestNew/Error_when_WslPath_returns_error (31.90s) 541s time="2024-08-22T21:41:25Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43847" 541s time="2024-08-22T21:41:25Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:25Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:25Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:25Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:28Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:28Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:28Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:28Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:28Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:28Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:28Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:28Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:28Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:28Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:28Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:28Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:28Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:28Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:28Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:28Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:28Z" level=debug msg="All connections have now ended." 541s === CONT TestServe/No_connection_because_the_port_file_has_port_0 541s time="2024-08-22T21:41:28Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34581" 541s time="2024-08-22T21:41:28Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:30Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:30Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:30Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:30Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:30Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:34045" 541s time="2024-08-22T21:41:30Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:30Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:30Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:30Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:30Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:30Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:30Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:30Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:30Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:30Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:30Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:30Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:30Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:30Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s === CONT TestServe/Error_because_the_context_is_pre-cancelled 541s time="2024-08-22T21:41:30Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34885" 541s time="2024-08-22T21:41:30Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:31Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45147" 541s time="2024-08-22T21:41:31Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:31Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:31Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:31Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:33Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:35Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:36Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 541s time="2024-08-22T21:41:36Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:36Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:36Z" level=debug msg="All connections have now ended." 541s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 541s time="2024-08-22T21:41:36Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40643" 541s time="2024-08-22T21:41:37Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:37Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:37Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:37Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:37Z" level=info msg="Stopping active requests." 541s time="2024-08-22T21:41:37Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:37Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:37Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:37Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:37Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:37Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:37Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:37Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s === CONT TestServe/Success 541s --- PASS: TestServeAndQuit (0.00s) 541s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (28.57s) 541s --- PASS: TestServeAndQuit/Success_with_double_quit (35.76s) 541s --- PASS: TestServeAndQuit/Success_with_graceful_quit (37.84s) 541s --- PASS: TestServeAndQuit/Success_with_forceful_quit (44.62s) 541s time="2024-08-22T21:41:37Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38227" 541s time="2024-08-22T21:41:37Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:38Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:38Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:38Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:38Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:38Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:38Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:38Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:38Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:38Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:38Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 541s time="2024-08-22T21:41:39Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:32935" 541s time="2024-08-22T21:41:39Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:39Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35593" 541s time="2024-08-22T21:41:39Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_file4223262802/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 541s time="2024-08-22T21:41:39Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:39Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:39Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:39Z" level=debug msg="All connections have now ended." 541s === CONT TestServe/No_connection_because_there_is_no_server 541s time="2024-08-22T21:41:39Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33077" 541s time="2024-08-22T21:41:39Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:41Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:41Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"127.0.0.1:0\": port cannot be zero" 541s time="2024-08-22T21:41:41Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:41Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:41Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:41Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:41Z" level=debug msg="All connections have now ended." 541s === CONT TestReconnection 541s === RUN TestReconnection/Success_connecting_after_failing_to_connect 541s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 541s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 541s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 541s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 541s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 541s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 541s time="2024-08-22T21:41:41Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:32955" 541s time="2024-08-22T21:41:41Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:42Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:42Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"127.0.0.1:0\": port cannot be zero" 541s time="2024-08-22T21:41:42Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s time="2024-08-22T21:41:42Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:42Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:42Z" level=debug msg="All connections have now ended." 541s === CONT TestReconnection/Success_connecting_after_failing_to_connect 541s time="2024-08-22T21:41:42Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:43Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:43Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:43Z" level=debug msg="All connections have now ended." 541s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 541s time="2024-08-22T21:41:43Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:46Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:46Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not read agent port file \"/tmp/TestServeNo_connection_because_the_port_file_does_not_exist3892375809/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist3892375809/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 541s time="2024-08-22T21:41:46Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:47Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43847" 541s time="2024-08-22T21:41:47Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates3236631291/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 541s time="2024-08-22T21:41:47Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:47Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:47Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:47Z" level=debug msg="All connections have now ended." 541s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 541s time="2024-08-22T21:41:47Z" level=debug msg="Building new daemon" 541s time="2024-08-22T21:41:47Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:47Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not read agent port file \"/tmp/TestServeNo_connection_because_the_port_file_does_not_exist3892375809/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist3892375809/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 541s time="2024-08-22T21:41:47Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s time="2024-08-22T21:41:47Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:48Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:48Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:48Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:49Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:49Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"127.0.0.1:-5\": port cannot be negative" 541s time="2024-08-22T21:41:49Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:49Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:50Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:50Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"127.0.0.1:portyMcPortface\": could not parse port as an integer: strconv.Atoi: parsing \"portyMcPortface\": invalid syntax" 541s time="2024-08-22T21:41:50Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:50Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38227" 541s time="2024-08-22T21:41:50Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:50Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:50Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:50Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:50Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:50Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:50Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not read agent port file \"/tmp/TestReconnectionSuccess_connecting_after_failing_to_connect3587078097/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect3587078097/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 541s time="2024-08-22T21:41:50Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:50Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:50Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46405" 541s time="2024-08-22T21:41:50Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:50Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:50Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:51Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46731" 541s time="2024-08-22T21:41:51Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:51Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:51Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:51Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"127.0.0.1:portyMcPortface\": could not parse port as an integer: strconv.Atoi: parsing \"portyMcPortface\": invalid syntax" 541s time="2024-08-22T21:41:51Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s time="2024-08-22T21:41:51Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33077" 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:51Z" level=warning msg="Daemon: disconnected from Windows host: could not start serving: could not connect: could not connect to GRPC service: rpc error: code = Unavailable desc = connection error: desc = \"transport: Error while dialing: dial tcp 127.0.0.1:33077: connect: connection refused\"" 541s time="2024-08-22T21:41:51Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:51Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38685" 541s time="2024-08-22T21:41:51Z" level=debug msg="Ready state sent to systemd" 541s time="2024-08-22T21:41:51Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:51Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:51Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:51Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:51Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:51Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:51Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:51Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:52Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:46731" 541s time="2024-08-22T21:41:52Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:52Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:52Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:52Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:53Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:53Z" level=info msg="Waiting for active requests to close." 541s time="2024-08-22T21:41:53Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:53Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:53Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:53Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:53Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:53Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s --- PASS: TestServe (0.00s) 541s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (29.95s) 541s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (13.86s) 541s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (46.01s) 541s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (18.47s) 541s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (10.75s) 541s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (20.44s) 541s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (14.70s) 541s --- PASS: TestServe/No_connection_because_there_are_no_certificates (22.32s) 541s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (11.71s) 541s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (11.84s) 541s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (9.91s) 541s --- PASS: TestServe/No_connection_because_there_is_no_server (11.91s) 541s --- PASS: TestServe/Success (15.42s) 541s time="2024-08-22T21:41:53Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:46405" 541s time="2024-08-22T21:41:53Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:53Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:53Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:53Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:53Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38685" 541s time="2024-08-22T21:41:53Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:53Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:53Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:53Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:54Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:54Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:54Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:54Z" level=info msg="Stopping active requests." 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:54Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s time="2024-08-22T21:41:54Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:54Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:54Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:41:54Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:54Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:41:54Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:54Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46883" 541s time="2024-08-22T21:41:55Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:41:55Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:41:57Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:46883" 541s time="2024-08-22T21:41:57Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:41:57Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:41:57Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s time="2024-08-22T21:41:57Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:41:59Z" level=debug msg="Server: sent preface messages to all streams" 541s time="2024-08-22T21:41:59Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:59Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:59Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:59Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:59Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:41:59Z" level=info msg="Stopping active requests." 541s time="2024-08-22T21:41:59Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:59Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:41:59Z" level=info msg="Reconnecting to Windows host in 2 seconds" 541s time="2024-08-22T21:41:59Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:41:59Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:59Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:41:59Z" level=debug msg="All connections have now ended." 541s time="2024-08-22T21:42:59Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:42:59Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:42:59Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:42:59Z" level=warning msg="Daemon: disconnected from Windows host" 541s time="2024-08-22T21:42:59Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:42:59Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:42:59Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not read agent port file \"/tmp/TestReconnectionSuccess_connecting_after_previous_long-lived_connection_dropped1570173590/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_previous_long-lived_connection_dropped1570173590/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 541s time="2024-08-22T21:42:59Z" level=info msg="Reconnecting to Windows host in 1 seconds" 541s time="2024-08-22T21:42:59Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 541s time="2024-08-22T21:43:00Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35345" 541s time="2024-08-22T21:43:00Z" level=info msg="Daemon: connecting to Windows Agent" 541s time="2024-08-22T21:43:00Z" level=debug msg="Updated systemd status to \"Connecting\"" 541s time="2024-08-22T21:43:18Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35345" 541s time="2024-08-22T21:43:18Z" level=info msg="Daemon: completed connection to Windows Agent" 541s time="2024-08-22T21:43:18Z" level=debug msg="Updated systemd status to \"Connected\"" 541s time="2024-08-22T21:43:18Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 541s time="2024-08-22T21:43:18Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 541s === NAME TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 541s daemon_test.go:392: 541s Error Trace: /tmp/autopkgtest.OmchTW/build.rxO/src/internal/daemon/daemon_test.go:392 541s Error: Condition never satisfied 541s Test: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 541s Messages: Daemon never connected to agent's service 541s time="2024-08-22T21:43:20Z" level=info msg="Stopping daemon requested." 541s time="2024-08-22T21:43:20Z" level=info msg="Stopping active requests." 541s time="2024-08-22T21:43:20Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:43:20Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:43:20Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:43:25Z" level=debug msg="Updated systemd status to \"Stopped\"" 541s time="2024-08-22T21:43:25Z" level=debug msg="All connections have now ended." 541s --- FAIL: TestReconnection (0.00s) 541s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (11.99s) 541s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (12.18s) 541s --- FAIL: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (101.86s) 541s FAIL 541s FAIL github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 156.067s 541s === RUN TestConnect 541s === PAUSE TestConnect 541s === RUN TestSendAndRecv 541s --- PASS: TestSendAndRecv (1.09s) 541s === RUN TestServe 541s === PAUSE TestServe 541s === RUN TestStop 541s === PAUSE TestStop 541s === RUN TestWithProMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithProMock (0.00s) 541s === RUN TestWithWslPathMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslPathMock (0.00s) 541s === RUN TestWithWslInfoMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslInfoMock (0.00s) 541s === RUN TestWithCmdExeMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithCmdExeMock (0.00s) 541s === CONT TestConnect 541s === RUN TestConnect/Success 541s === PAUSE TestConnect/Success 541s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 541s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 541s === CONT TestConnect/Success 541s === CONT TestStop 541s === CONT TestServe 541s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39031" 541s time="2024-08-22T21:40:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46533" 541s time="2024-08-22T21:41:10Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:10Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:10Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s time="2024-08-22T21:41:11Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 541s time="2024-08-22T21:41:11Z" level=info msg="MockWindowsAgent: Connected ready" 541s time="2024-08-22T21:41:11Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 541s --- PASS: TestConnect (0.00s) 541s --- PASS: TestConnect/Success (0.40s) 541s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.00s) 541s time="2024-08-22T21:41:21Z" level=warning msg="Streamserver: could not gather info after command completion: could not obtain pro status: pro status: /usr/bin/bash: error: context canceled.\n Stdout: \n Stderr: " 541s time="2024-08-22T21:41:21Z" level=warning msg="Streamserver: could not stream back info after command completion" 541s time="2024-08-22T21:41:21Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:21Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:21Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s --- PASS: TestStop (28.13s) 541s time="2024-08-22T21:41:32Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:32Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 541s time="2024-08-22T21:41:32Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 541s --- PASS: TestServe (39.16s) 541s PASS 541s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 42.871s 541s === RUN TestInfo 541s === PAUSE TestInfo 541s === RUN TestWslDistroName 541s === PAUSE TestWslDistroName 541s === RUN TestUserProfileDir 541s === PAUSE TestUserProfileDir 541s === RUN TestProStatus 541s === PAUSE TestProStatus 541s === RUN TestProAttach 541s === PAUSE TestProAttach 541s === RUN TestProDetach 541s === PAUSE TestProDetach 541s === RUN TestLandscapeEnable 541s === PAUSE TestLandscapeEnable 541s === RUN TestWindowsHostAddress 541s === PAUSE TestWindowsHostAddress 541s === RUN TestLandscapeDisable 541s === PAUSE TestLandscapeDisable 541s === RUN TestRealBackend 541s === PAUSE TestRealBackend 541s === RUN TestWithProMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithProMock (0.02s) 541s === RUN TestWithLandscapeConfigMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithLandscapeConfigMock (0.00s) 541s === RUN TestWithWslPathMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslPathMock (0.00s) 541s === RUN TestWithWslInfoMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithWslInfoMock (0.00s) 541s === RUN TestWithCmdExeMock 541s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 541s --- SKIP: TestWithCmdExeMock (0.00s) 541s === CONT TestInfo 541s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 541s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 541s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 541s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 541s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 541s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 541s === RUN TestInfo/Success 541s === PAUSE TestInfo/Success 541s === RUN TestInfo/Error_when_WslDistroName_fails 541s === PAUSE TestInfo/Error_when_WslDistroName_fails 541s === RUN TestInfo/Error_when_pro_status_command_fails 541s === PAUSE TestInfo/Error_when_pro_status_command_fails 541s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 541s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 541s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 541s === CONT TestUserProfileDir 541s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 541s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 541s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 541s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 541s === RUN TestUserProfileDir/Error_on_cmd.exe_error 541s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 541s === RUN TestUserProfileDir/Error_on_wslpath_error 541s === PAUSE TestUserProfileDir/Error_on_wslpath_error 541s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 541s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 541s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 541s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 541s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 541s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 541s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 541s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 541s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 541s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 541s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 541s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 541s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 541s === CONT TestInfo/Error_when_WslDistroName_fails 541s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 541s === CONT TestInfo/Error_when_pro_status_command_fails 541s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 541s === CONT TestLandscapeEnable 541s === RUN TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 541s === PAUSE TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 541s === RUN TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 541s === PAUSE TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 541s === RUN TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 541s === PAUSE TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 541s === RUN TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 541s === PAUSE TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 541s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 541s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 541s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 541s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 541s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 541s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 541s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 541s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 541s === RUN TestLandscapeEnable/Success 541s === PAUSE TestLandscapeEnable/Success 541s === RUN TestLandscapeEnable/Success_overriding_computer_title 541s === PAUSE TestLandscapeEnable/Success_overriding_computer_title 541s === CONT TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 541s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 541s === NAME TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 541s system_test.go:205: Removing default proc/mounts 541s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 541s system_test.go:205: Removing default proc/mounts 541s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 541s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 541s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 541s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 541s === CONT TestUserProfileDir/Error_on_wslpath_error 541s === CONT TestUserProfileDir/Error_on_cmd.exe_error 541s === NAME TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 541s system_test.go:456: testdata/TestLandscapeEnable/golden/success_overriding_the_ssl_certficate_path 541s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 541s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 541s === CONT TestRealBackend 541s --- PASS: TestRealBackend (0.00s) 541s === CONT TestLandscapeDisable 541s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 541s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 541s === RUN TestLandscapeDisable/Success 541s === PAUSE TestLandscapeDisable/Success 541s === CONT TestWindowsHostAddress 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 541s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 541s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 541s === RUN TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 541s === PAUSE TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 541s === RUN TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 541s === PAUSE TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 541s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 541s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 541s === RUN TestWindowsHostAddress/Success_without_NAT 541s === PAUSE TestWindowsHostAddress/Success_without_NAT 541s === CONT TestLandscapeEnable/Success_overriding_computer_title 541s time="2024-08-22T21:41:21Z" level=info msg="Landscape config contains key \"computer_title\". Its value will be overridden." 541s === CONT TestLandscapeEnable/Success 541s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 541s === CONT TestWslDistroName 541s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 541s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 541s === RUN TestWslDistroName/Success_using_wslpath 541s === PAUSE TestWslDistroName/Success_using_wslpath 541s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 541s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 541s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 541s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 541s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 541s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 541s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 541s === NAME TestLandscapeEnable/Success_overriding_computer_title 541s system_test.go:456: testdata/TestLandscapeEnable/golden/success_overriding_computer_title 541s === CONT TestInfo/Success 541s === NAME TestLandscapeEnable/Success 541s system_test.go:456: testdata/TestLandscapeEnable/golden/success 541s === CONT TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 541s time="2024-08-22T21:41:28Z" level=info msg="Landscape config contains key \"tags\". Its value will not be overridden." 541s === CONT TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 541s === CONT TestProAttach 541s === RUN TestProAttach/success 541s === PAUSE TestProAttach/success 541s === RUN TestProAttach/error_on_'pro_attach'_error 541s === PAUSE TestProAttach/error_on_'pro_attach'_error 541s === CONT TestProDetach 541s === RUN TestProDetach/success_on_unattached_distro 541s === PAUSE TestProDetach/success_on_unattached_distro 541s === RUN TestProDetach/success_on_attached_distro 541s === PAUSE TestProDetach/success_on_attached_distro 541s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 541s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 541s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 541s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 541s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 541s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 541s === CONT TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 541s time="2024-08-22T21:41:28Z" level=info msg="Landscape config contains key \"tags\". Its value will not be overridden." 541s === CONT TestProStatus 541s === RUN TestProStatus/success_on_unattached_distro 541s === PAUSE TestProStatus/success_on_unattached_distro 541s === RUN TestProStatus/success_on_attached_distro 541s === PAUSE TestProStatus/success_on_attached_distro 541s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 541s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 541s === RUN TestProStatus/error_on_'pro_attach'_error 541s === PAUSE TestProStatus/error_on_'pro_attach'_error 541s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 541s === CONT TestLandscapeDisable/Success 541s === CONT TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 541s === NAME TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 541s system_test.go:456: testdata/TestLandscapeEnable/golden/do_not_append_wsl_tag_when_config_tag_is_provided 541s === CONT TestWindowsHostAddress/Success_without_NAT 541s --- PASS: TestUserProfileDir (0.02s) 541s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (1.91s) 541s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.29s) 541s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.00s) 541s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (22.09s) 541s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (25.54s) 541s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (9.44s) 541s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (14.13s) 541s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (15.96s) 541s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (17.60s) 541s --- PASS: TestUserProfileDir/Error_on_wslpath_error (19.86s) 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 541s === NAME TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 541s system_test.go:456: testdata/TestLandscapeEnable/golden/do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 541s --- PASS: TestLandscapeEnable (0.00s) 541s --- PASS: TestLandscapeEnable/Success_overriding_the_SSL_certficate_path (23.49s) 541s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (0.00s) 541s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_written (0.05s) 541s --- PASS: TestLandscapeEnable/Success_overriding_computer_title (6.54s) 541s --- PASS: TestLandscapeEnable/Success (5.87s) 541s --- PASS: TestLandscapeEnable/Error_when_the_file_cannot_be_parsed (0.00s) 541s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (6.30s) 541s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (5.77s) 541s --- PASS: TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided (5.00s) 541s --- PASS: TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty (5.22s) 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 541s === CONT TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 541s --- PASS: TestInfo (0.00s) 541s --- PASS: TestInfo/Error_when_WslDistroName_fails (14.34s) 541s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (14.91s) 541s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (15.06s) 541s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (15.18s) 541s --- PASS: TestInfo/Error_when_pro_status_command_fails (16.47s) 541s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (6.78s) 541s --- PASS: TestInfo/Success (6.90s) 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 541s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 541s --- PASS: TestLandscapeDisable (0.00s) 541s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (6.40s) 541s --- PASS: TestLandscapeDisable/Success (6.76s) 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 541s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 541s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 541s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 541s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 541s === CONT TestWslDistroName/Success_using_wslpath 541s === CONT TestProAttach/success 541s === CONT TestProAttach/error_on_'pro_attach'_error 541s === CONT TestProDetach/success_on_unattached_distro 541s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 541s --- PASS: TestWindowsHostAddress (0.00s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist (3.86s) 541s --- PASS: TestWindowsHostAddress/Success_without_NAT (5.50s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (5.55s) 541s --- PASS: TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback (6.88s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (5.38s) 541s --- PASS: TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback (5.90s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (6.24s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP (4.70s) 541s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed (4.12s) 541s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (6.94s) 541s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 541s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 541s === CONT TestProDetach/success_on_attached_distro 541s === CONT TestProStatus/success_on_unattached_distro 541s --- PASS: TestWslDistroName (0.00s) 541s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.00s) 541s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (5.23s) 541s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (5.05s) 541s --- PASS: TestWslDistroName/Success_using_wslpath (6.89s) 541s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 541s === CONT TestProStatus/error_on_'pro_attach'_error 541s --- PASS: TestProAttach (0.00s) 541s --- PASS: TestProAttach/success (6.11s) 541s --- PASS: TestProAttach/error_on_'pro_attach'_error (5.27s) 541s === CONT TestProStatus/success_on_attached_distro 541s --- PASS: TestProDetach (0.00s) 541s --- PASS: TestProDetach/success_on_unattached_distro (4.97s) 541s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (5.11s) 541s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (5.13s) 541s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (5.15s) 541s --- PASS: TestProDetach/success_on_attached_distro (5.11s) 541s --- PASS: TestProStatus (0.00s) 541s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (3.30s) 541s --- PASS: TestProStatus/success_on_attached_distro (2.96s) 541s --- PASS: TestProStatus/success_on_unattached_distro (3.94s) 541s --- PASS: TestProStatus/error_on_'pro_attach'_error (3.82s) 541s PASS 541s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 60.113s 541s FAIL 545s autopkgtest [21:43:29]: test command1: -----------------------] 553s autopkgtest [21:43:37]: test command1: - - - - - - - - - - results - - - - - - - - - - 553s command1 FAIL non-zero exit status 1 558s autopkgtest [21:43:42]: @@@@@@@@@@@@@@@@@@@@ summary 558s command1 FAIL non-zero exit status 1