0s autopkgtest [09:14:29]: starting date and time: 2024-07-31 09:14:29+0000 0s autopkgtest [09:14:29]: git checkout: fd3bed09 nova: allow more retries for quota issues 0s autopkgtest [09:14:29]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.6iv6tkfx/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 --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' -- lxd -r lxd-armhf-10.145.243.234 lxd-armhf-10.145.243.234:autopkgtest/ubuntu/noble/armhf 35s autopkgtest [09:15:04]: testbed dpkg architecture: armhf 37s autopkgtest [09:15:06]: testbed apt version: 2.7.14build2 37s autopkgtest [09:15:06]: @@@@@@@@@@@@@@@@@@@@ test bed setup 46s Get:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease [265 kB] 46s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/universe Sources [9488 B] 46s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/restricted Sources [10.2 kB] 46s Get:4 http://ftpmaster.internal/ubuntu noble-proposed/main Sources [36.9 kB] 46s Get:5 http://ftpmaster.internal/ubuntu noble-proposed/main armhf Packages [72.8 kB] 46s Get:6 http://ftpmaster.internal/ubuntu noble-proposed/main armhf c-n-f Metadata [2212 B] 46s Get:7 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf Packages [1176 B] 46s Get:8 http://ftpmaster.internal/ubuntu noble-proposed/restricted armhf c-n-f Metadata [116 B] 46s Get:9 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf Packages [49.0 kB] 46s Get:10 http://ftpmaster.internal/ubuntu noble-proposed/universe armhf c-n-f Metadata [2152 B] 46s Get:11 http://ftpmaster.internal/ubuntu noble-proposed/multiverse armhf c-n-f Metadata [116 B] 48s Fetched 449 kB in 1s (624 kB/s) 48s Reading package lists... 66s tee: /proc/self/fd/2: Permission denied 83s Hit:1 http://ftpmaster.internal/ubuntu noble-proposed InRelease 83s Hit:2 http://ftpmaster.internal/ubuntu noble InRelease 83s Hit:3 http://ftpmaster.internal/ubuntu noble-updates InRelease 83s Hit:4 http://ftpmaster.internal/ubuntu noble-security InRelease 84s Reading package lists... 84s Reading package lists... 84s Building dependency tree... 84s Reading state information... 85s Calculating upgrade... 85s The following packages will be upgraded: 85s dracut-install ubuntu-pro-client ubuntu-pro-client-l10n 85s 3 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 85s Need to get 286 kB of archives. 85s After this operation, 13.3 kB of additional disk space will be used. 85s Get:1 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-pro-client-l10n armhf 33.2~24.04 [19.3 kB] 86s Get:2 http://ftpmaster.internal/ubuntu noble-proposed/main armhf ubuntu-pro-client armhf 33.2~24.04 [233 kB] 86s Get:3 http://ftpmaster.internal/ubuntu noble-proposed/main armhf dracut-install armhf 060+5-1ubuntu3.2 [34.5 kB] 86s Fetched 286 kB in 0s (605 kB/s) 86s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 57906 files and directories currently installed.) 86s Preparing to unpack .../ubuntu-pro-client-l10n_33.2~24.04_armhf.deb ... 86s Unpacking ubuntu-pro-client-l10n (33.2~24.04) over (32.3.1~24.04) ... 86s Preparing to unpack .../ubuntu-pro-client_33.2~24.04_armhf.deb ... 86s Unpacking ubuntu-pro-client (33.2~24.04) over (32.3.1~24.04) ... 86s Preparing to unpack .../dracut-install_060+5-1ubuntu3.2_armhf.deb ... 86s Unpacking dracut-install (060+5-1ubuntu3.2) over (060+5-1ubuntu3.1) ... 86s Setting up dracut-install (060+5-1ubuntu3.2) ... 86s Setting up ubuntu-pro-client (33.2~24.04) ... 86s Installing new version of config file /etc/apparmor.d/ubuntu_pro_apt_news ... 87s apparmor_parser: Unable to replace "ubuntu_pro_apt_news". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 87s 87s apparmor_parser: Unable to replace "apt_methods". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 87s 87s apparmor_parser: Unable to replace "ubuntu_pro_esm_cache". apparmor_parser: Access denied. You need policy admin privileges to manage profiles. 87s 88s Setting up ubuntu-pro-client-l10n (33.2~24.04) ... 88s Processing triggers for man-db (2.12.0-4build2) ... 89s Reading package lists... 89s Building dependency tree... 89s Reading state information... 90s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 92s autopkgtest [09:16:01]: rebooting testbed after setup commands that affected boot 135s autopkgtest [09:16:44]: testbed running kernel: Linux 6.5.0-44-generic #44~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue Jun 18 16:55:18 UTC 2 164s autopkgtest [09:17:13]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 175s Get:1 http://ftpmaster.internal/ubuntu noble/main wsl-pro-service 0.1.4 (dsc) [1420 B] 175s Get:2 http://ftpmaster.internal/ubuntu noble/main wsl-pro-service 0.1.4 (tar) [1762 kB] 175s gpgv: Signature made Fri Apr 19 05:59:17 2024 UTC 175s gpgv: using DSA key DD00EF8F4D23C30D78EC990998B24A9CE4AC208E 175s gpgv: Can't check signature: No public key 175s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.4.dsc: no acceptable signature found 175s autopkgtest [09:17:24]: testing package wsl-pro-service version 0.1.4 177s autopkgtest [09:17:26]: build not needed 180s autopkgtest [09:17:29]: test command1: preparing testbed 191s Reading package lists... 191s Building dependency tree... 191s Reading state information... 191s Starting pkgProblemResolver with broken count: 0 192s Starting 2 pkgProblemResolver with broken count: 0 192s Done 192s The following additional packages will be installed: 192s autoconf automake autopoint autotools-dev build-essential cpp cpp-13 192s cpp-13-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper debugedit 192s dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-13 192s g++-13-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-13 192s gcc-13-arm-linux-gnueabihf gcc-13-base gcc-arm-linux-gnueabihf gettext 192s golang-1.22-go golang-1.22-src golang-go golang-src intltool-debian 192s libarchive-zip-perl libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 192s libcrypt-dev libdebhelper-perl libdw1t64 libfile-stripnondeterminism-perl 192s libgcc-13-dev libgomp1 libisl23 libmpc3 libstdc++-13-dev 192s libsub-override-perl libtool libubsan1 linux-libc-dev m4 po-debconf 192s rpcsvc-proto 192s Suggested packages: 192s autoconf-archive gnu-standards autoconf-doc cpp-doc gcc-13-locales 192s cpp-13-doc dh-make gcc-13-doc gcc-multilib manpages-dev flex bison gdb 192s gcc-doc gdb-arm-linux-gnueabihf gettext-doc libasprintf-dev libgettextpo-dev 192s bzr | brz git mercurial subversion glibc-doc libstdc++-13-doc libtool-doc 192s gfortran | fortran95-compiler gcj-jdk m4-doc libmail-box-perl 192s Recommended packages: 192s pkg-config manpages manpages-dev libc-devtools libarchive-cpio-perl 192s libltdl-dev libmail-sendmail-perl 192s The following NEW packages will be installed: 192s autoconf automake autopkgtest-satdep autopoint autotools-dev build-essential 192s cpp cpp-13 cpp-13-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper 192s debugedit dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ 192s g++-13 g++-13-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-13 192s gcc-13-arm-linux-gnueabihf gcc-13-base gcc-arm-linux-gnueabihf gettext 192s golang-1.22-go golang-1.22-src golang-go golang-src intltool-debian 192s libarchive-zip-perl libasan8 libatomic1 libc-dev-bin libc6-dev libcc1-0 192s libcrypt-dev libdebhelper-perl libdw1t64 libfile-stripnondeterminism-perl 192s libgcc-13-dev libgomp1 libisl23 libmpc3 libstdc++-13-dev 192s libsub-override-perl libtool libubsan1 linux-libc-dev m4 po-debconf 192s rpcsvc-proto 192s 0 upgraded, 54 newly installed, 0 to remove and 0 not upgraded. 192s Need to get 95.3 MB/95.3 MB of archives. 192s After this operation, 377 MB of additional disk space will be used. 192s Get:1 /tmp/autopkgtest.7C7ui6/1-autopkgtest-satdep.deb autopkgtest-satdep armhf 0 [764 B] 192s Get:2 http://ftpmaster.internal/ubuntu noble/main armhf m4 armhf 1.4.19-4build1 [235 kB] 193s Get:3 http://ftpmaster.internal/ubuntu noble/main armhf autoconf all 2.71-3 [339 kB] 193s Get:4 http://ftpmaster.internal/ubuntu noble/main armhf autotools-dev all 20220109.1 [44.9 kB] 193s Get:5 http://ftpmaster.internal/ubuntu noble/main armhf automake all 1:1.16.5-1.3ubuntu1 [558 kB] 193s Get:6 http://ftpmaster.internal/ubuntu noble/main armhf autopoint all 0.21-14ubuntu2 [422 kB] 193s Get:7 http://ftpmaster.internal/ubuntu noble-updates/main armhf libc-dev-bin armhf 2.39-0ubuntu8.2 [19.1 kB] 193s Get:8 http://ftpmaster.internal/ubuntu noble-updates/main armhf linux-libc-dev armhf 6.8.0-39.39 [1604 kB] 193s Get:9 http://ftpmaster.internal/ubuntu noble/main armhf libcrypt-dev armhf 1:4.4.36-4build1 [120 kB] 193s Get:10 http://ftpmaster.internal/ubuntu noble/main armhf rpcsvc-proto armhf 1.4.2-0ubuntu7 [62.2 kB] 193s Get:11 http://ftpmaster.internal/ubuntu noble-updates/main armhf libc6-dev armhf 2.39-0ubuntu8.2 [1351 kB] 193s Get:12 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13-base armhf 13.2.0-23ubuntu4 [48.9 kB] 193s Get:13 http://ftpmaster.internal/ubuntu noble/main armhf libisl23 armhf 0.26-3build1 [544 kB] 193s Get:14 http://ftpmaster.internal/ubuntu noble/main armhf libmpc3 armhf 1.3.1-1build1 [46.7 kB] 193s Get:15 http://ftpmaster.internal/ubuntu noble/main armhf cpp-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [8759 kB] 194s Get:16 http://ftpmaster.internal/ubuntu noble/main armhf cpp-13 armhf 13.2.0-23ubuntu4 [1034 B] 194s Get:17 http://ftpmaster.internal/ubuntu noble/main armhf cpp-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [5320 B] 194s Get:18 http://ftpmaster.internal/ubuntu noble/main armhf cpp armhf 4:13.2.0-7ubuntu1 [22.4 kB] 194s Get:19 http://ftpmaster.internal/ubuntu noble/main armhf libcc1-0 armhf 14-20240412-0ubuntu1 [39.0 kB] 194s Get:20 http://ftpmaster.internal/ubuntu noble/main armhf libgomp1 armhf 14-20240412-0ubuntu1 [125 kB] 194s Get:21 http://ftpmaster.internal/ubuntu noble/main armhf libatomic1 armhf 14-20240412-0ubuntu1 [7816 B] 194s Get:22 http://ftpmaster.internal/ubuntu noble/main armhf libasan8 armhf 14-20240412-0ubuntu1 [2942 kB] 194s Get:23 http://ftpmaster.internal/ubuntu noble/main armhf libubsan1 armhf 14-20240412-0ubuntu1 [1154 kB] 194s Get:24 http://ftpmaster.internal/ubuntu noble/main armhf libgcc-13-dev armhf 13.2.0-23ubuntu4 [899 kB] 194s Get:25 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [16.9 MB] 194s Get:26 http://ftpmaster.internal/ubuntu noble/main armhf gcc-13 armhf 13.2.0-23ubuntu4 [453 kB] 194s Get:27 http://ftpmaster.internal/ubuntu noble/main armhf gcc-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [1220 B] 194s Get:28 http://ftpmaster.internal/ubuntu noble/main armhf gcc armhf 4:13.2.0-7ubuntu1 [5022 B] 194s Get:29 http://ftpmaster.internal/ubuntu noble/main armhf libstdc++-13-dev armhf 13.2.0-23ubuntu4 [2456 kB] 194s Get:30 http://ftpmaster.internal/ubuntu noble/main armhf g++-13-arm-linux-gnueabihf armhf 13.2.0-23ubuntu4 [9941 kB] 195s Get:31 http://ftpmaster.internal/ubuntu noble/main armhf g++-13 armhf 13.2.0-23ubuntu4 [14.5 kB] 195s Get:32 http://ftpmaster.internal/ubuntu noble/main armhf g++-arm-linux-gnueabihf armhf 4:13.2.0-7ubuntu1 [966 B] 195s Get:33 http://ftpmaster.internal/ubuntu noble/main armhf g++ armhf 4:13.2.0-7ubuntu1 [1090 B] 195s Get:34 http://ftpmaster.internal/ubuntu noble/main armhf build-essential armhf 12.10ubuntu1 [4928 B] 195s Get:35 http://ftpmaster.internal/ubuntu noble/main armhf libdebhelper-perl all 13.14.1ubuntu5 [89.8 kB] 195s Get:36 http://ftpmaster.internal/ubuntu noble/main armhf libtool all 2.4.7-7build1 [166 kB] 195s Get:37 http://ftpmaster.internal/ubuntu noble/main armhf dh-autoreconf all 20 [16.1 kB] 195s Get:38 http://ftpmaster.internal/ubuntu noble/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 195s Get:39 http://ftpmaster.internal/ubuntu noble/main armhf libsub-override-perl all 0.10-1 [10.0 kB] 195s Get:40 http://ftpmaster.internal/ubuntu noble/main armhf libfile-stripnondeterminism-perl all 1.13.1-1 [18.1 kB] 195s Get:41 http://ftpmaster.internal/ubuntu noble/main armhf dh-strip-nondeterminism all 1.13.1-1 [5362 B] 195s Get:42 http://ftpmaster.internal/ubuntu noble/main armhf libdw1t64 armhf 0.190-1.1build4 [235 kB] 195s Get:43 http://ftpmaster.internal/ubuntu noble/main armhf debugedit armhf 1:5.0-5build2 [42.3 kB] 195s Get:44 http://ftpmaster.internal/ubuntu noble/main armhf dwz armhf 0.15-1build6 [116 kB] 195s Get:45 http://ftpmaster.internal/ubuntu noble/main armhf gettext armhf 0.21-14ubuntu2 [800 kB] 195s Get:46 http://ftpmaster.internal/ubuntu noble/main armhf intltool-debian all 0.35.0+20060710.6 [23.2 kB] 195s Get:47 http://ftpmaster.internal/ubuntu noble/main armhf po-debconf all 1.0.21+nmu1 [233 kB] 195s Get:48 http://ftpmaster.internal/ubuntu noble/main armhf debhelper all 13.14.1ubuntu5 [869 kB] 195s Get:49 http://ftpmaster.internal/ubuntu noble-updates/universe armhf dh-apport all 2.28.1-0ubuntu3 [17.2 kB] 195s Get:50 http://ftpmaster.internal/ubuntu noble-updates/main armhf golang-1.22-src all 1.22.2-2ubuntu0.1 [19.7 MB] 196s Get:51 http://ftpmaster.internal/ubuntu noble-updates/main armhf golang-1.22-go armhf 1.22.2-2ubuntu0.1 [23.7 MB] 196s Get:52 http://ftpmaster.internal/ubuntu noble/main armhf golang-src all 2:1.22~2build1 [5078 B] 196s Get:53 http://ftpmaster.internal/ubuntu noble/main armhf golang-go armhf 2:1.22~2build1 [43.9 kB] 196s Get:54 http://ftpmaster.internal/ubuntu noble/main armhf dh-golang all 1.62 [25.2 kB] 197s Fetched 95.3 MB in 4s (23.4 MB/s) 197s Selecting previously unselected package m4. 197s (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 ... 57907 files and directories currently installed.) 197s Preparing to unpack .../00-m4_1.4.19-4build1_armhf.deb ... 197s Unpacking m4 (1.4.19-4build1) ... 197s Selecting previously unselected package autoconf. 197s Preparing to unpack .../01-autoconf_2.71-3_all.deb ... 197s Unpacking autoconf (2.71-3) ... 197s Selecting previously unselected package autotools-dev. 197s Preparing to unpack .../02-autotools-dev_20220109.1_all.deb ... 197s Unpacking autotools-dev (20220109.1) ... 198s Selecting previously unselected package automake. 198s Preparing to unpack .../03-automake_1%3a1.16.5-1.3ubuntu1_all.deb ... 198s Unpacking automake (1:1.16.5-1.3ubuntu1) ... 198s Selecting previously unselected package autopoint. 198s Preparing to unpack .../04-autopoint_0.21-14ubuntu2_all.deb ... 198s Unpacking autopoint (0.21-14ubuntu2) ... 198s Selecting previously unselected package libc-dev-bin. 198s Preparing to unpack .../05-libc-dev-bin_2.39-0ubuntu8.2_armhf.deb ... 198s Unpacking libc-dev-bin (2.39-0ubuntu8.2) ... 198s Selecting previously unselected package linux-libc-dev:armhf. 198s Preparing to unpack .../06-linux-libc-dev_6.8.0-39.39_armhf.deb ... 198s Unpacking linux-libc-dev:armhf (6.8.0-39.39) ... 198s Selecting previously unselected package libcrypt-dev:armhf. 198s Preparing to unpack .../07-libcrypt-dev_1%3a4.4.36-4build1_armhf.deb ... 198s Unpacking libcrypt-dev:armhf (1:4.4.36-4build1) ... 198s Selecting previously unselected package rpcsvc-proto. 199s Preparing to unpack .../08-rpcsvc-proto_1.4.2-0ubuntu7_armhf.deb ... 199s Unpacking rpcsvc-proto (1.4.2-0ubuntu7) ... 199s Selecting previously unselected package libc6-dev:armhf. 199s Preparing to unpack .../09-libc6-dev_2.39-0ubuntu8.2_armhf.deb ... 199s Unpacking libc6-dev:armhf (2.39-0ubuntu8.2) ... 199s Selecting previously unselected package gcc-13-base:armhf. 199s Preparing to unpack .../10-gcc-13-base_13.2.0-23ubuntu4_armhf.deb ... 199s Unpacking gcc-13-base:armhf (13.2.0-23ubuntu4) ... 199s Selecting previously unselected package libisl23:armhf. 199s Preparing to unpack .../11-libisl23_0.26-3build1_armhf.deb ... 199s Unpacking libisl23:armhf (0.26-3build1) ... 199s Selecting previously unselected package libmpc3:armhf. 199s Preparing to unpack .../12-libmpc3_1.3.1-1build1_armhf.deb ... 199s Unpacking libmpc3:armhf (1.3.1-1build1) ... 199s Selecting previously unselected package cpp-13-arm-linux-gnueabihf. 199s Preparing to unpack .../13-cpp-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 199s Unpacking cpp-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 199s Selecting previously unselected package cpp-13. 200s Preparing to unpack .../14-cpp-13_13.2.0-23ubuntu4_armhf.deb ... 200s Unpacking cpp-13 (13.2.0-23ubuntu4) ... 200s Selecting previously unselected package cpp-arm-linux-gnueabihf. 200s Preparing to unpack .../15-cpp-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 200s Unpacking cpp-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 200s Selecting previously unselected package cpp. 200s Preparing to unpack .../16-cpp_4%3a13.2.0-7ubuntu1_armhf.deb ... 200s Unpacking cpp (4:13.2.0-7ubuntu1) ... 200s Selecting previously unselected package libcc1-0:armhf. 200s Preparing to unpack .../17-libcc1-0_14-20240412-0ubuntu1_armhf.deb ... 200s Unpacking libcc1-0:armhf (14-20240412-0ubuntu1) ... 200s Selecting previously unselected package libgomp1:armhf. 200s Preparing to unpack .../18-libgomp1_14-20240412-0ubuntu1_armhf.deb ... 200s Unpacking libgomp1:armhf (14-20240412-0ubuntu1) ... 200s Selecting previously unselected package libatomic1:armhf. 200s Preparing to unpack .../19-libatomic1_14-20240412-0ubuntu1_armhf.deb ... 200s Unpacking libatomic1:armhf (14-20240412-0ubuntu1) ... 200s Selecting previously unselected package libasan8:armhf. 200s Preparing to unpack .../20-libasan8_14-20240412-0ubuntu1_armhf.deb ... 200s Unpacking libasan8:armhf (14-20240412-0ubuntu1) ... 200s Selecting previously unselected package libubsan1:armhf. 200s Preparing to unpack .../21-libubsan1_14-20240412-0ubuntu1_armhf.deb ... 200s Unpacking libubsan1:armhf (14-20240412-0ubuntu1) ... 200s Selecting previously unselected package libgcc-13-dev:armhf. 200s Preparing to unpack .../22-libgcc-13-dev_13.2.0-23ubuntu4_armhf.deb ... 200s Unpacking libgcc-13-dev:armhf (13.2.0-23ubuntu4) ... 200s Selecting previously unselected package gcc-13-arm-linux-gnueabihf. 200s Preparing to unpack .../23-gcc-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 200s Unpacking gcc-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 201s Selecting previously unselected package gcc-13. 201s Preparing to unpack .../24-gcc-13_13.2.0-23ubuntu4_armhf.deb ... 201s Unpacking gcc-13 (13.2.0-23ubuntu4) ... 201s Selecting previously unselected package gcc-arm-linux-gnueabihf. 201s Preparing to unpack .../25-gcc-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 201s Unpacking gcc-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 201s Selecting previously unselected package gcc. 201s Preparing to unpack .../26-gcc_4%3a13.2.0-7ubuntu1_armhf.deb ... 201s Unpacking gcc (4:13.2.0-7ubuntu1) ... 201s Selecting previously unselected package libstdc++-13-dev:armhf. 201s Preparing to unpack .../27-libstdc++-13-dev_13.2.0-23ubuntu4_armhf.deb ... 201s Unpacking libstdc++-13-dev:armhf (13.2.0-23ubuntu4) ... 201s Selecting previously unselected package g++-13-arm-linux-gnueabihf. 201s Preparing to unpack .../28-g++-13-arm-linux-gnueabihf_13.2.0-23ubuntu4_armhf.deb ... 201s Unpacking g++-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 201s Selecting previously unselected package g++-13. 201s Preparing to unpack .../29-g++-13_13.2.0-23ubuntu4_armhf.deb ... 201s Unpacking g++-13 (13.2.0-23ubuntu4) ... 201s Selecting previously unselected package g++-arm-linux-gnueabihf. 201s Preparing to unpack .../30-g++-arm-linux-gnueabihf_4%3a13.2.0-7ubuntu1_armhf.deb ... 201s Unpacking g++-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 201s Selecting previously unselected package g++. 201s Preparing to unpack .../31-g++_4%3a13.2.0-7ubuntu1_armhf.deb ... 201s Unpacking g++ (4:13.2.0-7ubuntu1) ... 201s Selecting previously unselected package build-essential. 201s Preparing to unpack .../32-build-essential_12.10ubuntu1_armhf.deb ... 201s Unpacking build-essential (12.10ubuntu1) ... 201s Selecting previously unselected package libdebhelper-perl. 201s Preparing to unpack .../33-libdebhelper-perl_13.14.1ubuntu5_all.deb ... 201s Unpacking libdebhelper-perl (13.14.1ubuntu5) ... 201s Selecting previously unselected package libtool. 202s Preparing to unpack .../34-libtool_2.4.7-7build1_all.deb ... 202s Unpacking libtool (2.4.7-7build1) ... 202s Selecting previously unselected package dh-autoreconf. 202s Preparing to unpack .../35-dh-autoreconf_20_all.deb ... 202s Unpacking dh-autoreconf (20) ... 202s Selecting previously unselected package libarchive-zip-perl. 202s Preparing to unpack .../36-libarchive-zip-perl_1.68-1_all.deb ... 202s Unpacking libarchive-zip-perl (1.68-1) ... 202s Selecting previously unselected package libsub-override-perl. 202s Preparing to unpack .../37-libsub-override-perl_0.10-1_all.deb ... 202s Unpacking libsub-override-perl (0.10-1) ... 202s Selecting previously unselected package libfile-stripnondeterminism-perl. 202s Preparing to unpack .../38-libfile-stripnondeterminism-perl_1.13.1-1_all.deb ... 202s Unpacking libfile-stripnondeterminism-perl (1.13.1-1) ... 202s Selecting previously unselected package dh-strip-nondeterminism. 202s Preparing to unpack .../39-dh-strip-nondeterminism_1.13.1-1_all.deb ... 202s Unpacking dh-strip-nondeterminism (1.13.1-1) ... 202s Selecting previously unselected package libdw1t64:armhf. 202s Preparing to unpack .../40-libdw1t64_0.190-1.1build4_armhf.deb ... 202s Unpacking libdw1t64:armhf (0.190-1.1build4) ... 202s Selecting previously unselected package debugedit. 202s Preparing to unpack .../41-debugedit_1%3a5.0-5build2_armhf.deb ... 202s Unpacking debugedit (1:5.0-5build2) ... 202s Selecting previously unselected package dwz. 202s Preparing to unpack .../42-dwz_0.15-1build6_armhf.deb ... 202s Unpacking dwz (0.15-1build6) ... 202s Selecting previously unselected package gettext. 202s Preparing to unpack .../43-gettext_0.21-14ubuntu2_armhf.deb ... 202s Unpacking gettext (0.21-14ubuntu2) ... 202s Selecting previously unselected package intltool-debian. 202s Preparing to unpack .../44-intltool-debian_0.35.0+20060710.6_all.deb ... 202s Unpacking intltool-debian (0.35.0+20060710.6) ... 202s Selecting previously unselected package po-debconf. 202s Preparing to unpack .../45-po-debconf_1.0.21+nmu1_all.deb ... 202s Unpacking po-debconf (1.0.21+nmu1) ... 202s Selecting previously unselected package debhelper. 203s Preparing to unpack .../46-debhelper_13.14.1ubuntu5_all.deb ... 203s Unpacking debhelper (13.14.1ubuntu5) ... 203s Selecting previously unselected package dh-apport. 203s Preparing to unpack .../47-dh-apport_2.28.1-0ubuntu3_all.deb ... 203s Unpacking dh-apport (2.28.1-0ubuntu3) ... 203s Selecting previously unselected package golang-1.22-src. 203s Preparing to unpack .../48-golang-1.22-src_1.22.2-2ubuntu0.1_all.deb ... 203s Unpacking golang-1.22-src (1.22.2-2ubuntu0.1) ... 205s Selecting previously unselected package golang-1.22-go. 205s Preparing to unpack .../49-golang-1.22-go_1.22.2-2ubuntu0.1_armhf.deb ... 205s Unpacking golang-1.22-go (1.22.2-2ubuntu0.1) ... 205s Selecting previously unselected package golang-src. 205s Preparing to unpack .../50-golang-src_2%3a1.22~2build1_all.deb ... 205s Unpacking golang-src (2:1.22~2build1) ... 205s Selecting previously unselected package golang-go:armhf. 206s Preparing to unpack .../51-golang-go_2%3a1.22~2build1_armhf.deb ... 206s Unpacking golang-go:armhf (2:1.22~2build1) ... 206s Selecting previously unselected package dh-golang. 206s Preparing to unpack .../52-dh-golang_1.62_all.deb ... 206s Unpacking dh-golang (1.62) ... 206s Selecting previously unselected package autopkgtest-satdep. 206s Preparing to unpack .../53-1-autopkgtest-satdep.deb ... 206s Unpacking autopkgtest-satdep (0) ... 206s Setting up libarchive-zip-perl (1.68-1) ... 206s Setting up libdebhelper-perl (13.14.1ubuntu5) ... 206s Setting up linux-libc-dev:armhf (6.8.0-39.39) ... 206s Setting up m4 (1.4.19-4build1) ... 206s Setting up libgomp1:armhf (14-20240412-0ubuntu1) ... 206s Setting up dh-apport (2.28.1-0ubuntu3) ... 206s Setting up libdw1t64:armhf (0.190-1.1build4) ... 206s Setting up autotools-dev (20220109.1) ... 206s Setting up rpcsvc-proto (1.4.2-0ubuntu7) ... 206s Setting up gcc-13-base:armhf (13.2.0-23ubuntu4) ... 206s Setting up golang-1.22-src (1.22.2-2ubuntu0.1) ... 206s Setting up libmpc3:armhf (1.3.1-1build1) ... 206s Setting up libatomic1:armhf (14-20240412-0ubuntu1) ... 206s Setting up autopoint (0.21-14ubuntu2) ... 206s Setting up autoconf (2.71-3) ... 206s Setting up libubsan1:armhf (14-20240412-0ubuntu1) ... 206s Setting up dwz (0.15-1build6) ... 206s Setting up libcrypt-dev:armhf (1:4.4.36-4build1) ... 206s Setting up libasan8:armhf (14-20240412-0ubuntu1) ... 206s Setting up debugedit (1:5.0-5build2) ... 206s Setting up libsub-override-perl (0.10-1) ... 206s Setting up libisl23:armhf (0.26-3build1) ... 206s Setting up libc-dev-bin (2.39-0ubuntu8.2) ... 206s Setting up golang-src (2:1.22~2build1) ... 206s Setting up libcc1-0:armhf (14-20240412-0ubuntu1) ... 206s Setting up automake (1:1.16.5-1.3ubuntu1) ... 206s update-alternatives: using /usr/bin/automake-1.16 to provide /usr/bin/automake (automake) in auto mode 206s Setting up libfile-stripnondeterminism-perl (1.13.1-1) ... 206s Setting up gettext (0.21-14ubuntu2) ... 206s Setting up cpp-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 206s Setting up golang-1.22-go (1.22.2-2ubuntu0.1) ... 206s Setting up intltool-debian (0.35.0+20060710.6) ... 206s Setting up dh-strip-nondeterminism (1.13.1-1) ... 206s Setting up libgcc-13-dev:armhf (13.2.0-23ubuntu4) ... 206s Setting up libc6-dev:armhf (2.39-0ubuntu8.2) ... 206s Setting up cpp-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 206s Setting up libstdc++-13-dev:armhf (13.2.0-23ubuntu4) ... 206s Setting up cpp-13 (13.2.0-23ubuntu4) ... 206s Setting up golang-go:armhf (2:1.22~2build1) ... 206s Setting up po-debconf (1.0.21+nmu1) ... 206s Setting up gcc-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 206s Setting up gcc-13 (13.2.0-23ubuntu4) ... 206s Setting up cpp (4:13.2.0-7ubuntu1) ... 206s Setting up gcc-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 206s Setting up g++-13-arm-linux-gnueabihf (13.2.0-23ubuntu4) ... 206s Setting up g++-arm-linux-gnueabihf (4:13.2.0-7ubuntu1) ... 206s Setting up g++-13 (13.2.0-23ubuntu4) ... 206s Setting up libtool (2.4.7-7build1) ... 206s Setting up gcc (4:13.2.0-7ubuntu1) ... 206s Setting up dh-autoreconf (20) ... 206s Setting up g++ (4:13.2.0-7ubuntu1) ... 206s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 206s Setting up build-essential (12.10ubuntu1) ... 206s Setting up debhelper (13.14.1ubuntu5) ... 206s Setting up dh-golang (1.62) ... 206s Setting up autopkgtest-satdep (0) ... 206s Processing triggers for man-db (2.12.0-4build2) ... 207s Processing triggers for install-info (7.1-3build2) ... 207s Processing triggers for libc-bin (2.39-0ubuntu8.2) ... 219s (Reading database ... 76047 files and directories currently installed.) 219s Removing autopkgtest-satdep (0) ... 225s autopkgtest [09:18:14]: test command1: ./debian/tests/test 225s autopkgtest [09:18:14]: test command1: [----------------------- 246s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 246s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 246s === RUN TestRunSignal 246s === RUN TestRunSignal/Send_SIGINT_exits 246s INFO Starting WSL Pro Service version Dev 246s === RUN TestRunSignal/Send_SIGTERM_exits 246s INFO Starting WSL Pro Service version Dev 246s --- PASS: TestRunSignal (0.20s) 246s --- PASS: TestRunSignal/Send_SIGINT_exits (0.10s) 246s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.10s) 246s === RUN TestRun 246s === PAUSE TestRun 246s === CONT TestRun 246s === RUN TestRun/Run_and_return_usage_error 246s === PAUSE TestRun/Run_and_return_usage_error 246s === RUN TestRun/Run_and_usage_error_only_does_not_fail 246s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 246s === RUN TestRun/Run_and_exit_successfully 246s === PAUSE TestRun/Run_and_exit_successfully 246s === RUN TestRun/Run_and_return_error 246s === PAUSE TestRun/Run_and_return_error 246s === CONT TestRun/Run_and_exit_successfully 246s === CONT TestRun/Run_and_return_usage_error 246s === CONT TestRun/Run_and_usage_error_only_does_not_fail 246s === CONT TestRun/Run_and_return_error 246s INFO Starting WSL Pro Service version Dev 246s INFO Starting WSL Pro Service version Dev 246s INFO Starting WSL Pro Service version Dev 246s INFO Starting WSL Pro Service version Dev 246s ERROR context.Background Error requested 246s ERROR context.Background Error requested 246s --- PASS: TestRun (0.00s) 246s --- PASS: TestRun/Run_and_return_error (0.10s) 246s --- PASS: TestRun/Run_and_return_usage_error (0.10s) 246s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.10s) 246s --- PASS: TestRun/Run_and_exit_successfully (0.10s) 246s PASS 246s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 0.343s 246s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 290s === RUN TestHelp 290s --- PASS: TestHelp (0.00s) 290s === RUN TestCompletion 290s --- PASS: TestCompletion (0.00s) 290s === RUN TestVersion 290s --- PASS: TestVersion (0.00s) 290s === RUN TestNoUsageError 290s --- PASS: TestNoUsageError (0.10s) 290s === RUN TestUsageError 290s === PAUSE TestUsageError 290s === RUN TestCanQuitWhenExecute 290s === PAUSE TestCanQuitWhenExecute 290s === RUN TestCanQuitTwice 290s === PAUSE TestCanQuitTwice 290s === RUN TestAppCanQuitWithoutExecute 290s === PAUSE TestAppCanQuitWithoutExecute 290s === RUN TestAppRunFailsOnComponentsCreationAndQuit 290s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 290s === RUN TestAppGetRootCmd 290s === PAUSE TestAppGetRootCmd 290s === RUN TestWithProMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithProMock (0.00s) 290s === RUN TestWithWslPathMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithWslPathMock (0.00s) 290s === RUN TestWithWslInfoMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithWslInfoMock (0.00s) 290s === RUN TestWithCmdExeMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithCmdExeMock (0.00s) 290s === CONT TestUsageError 290s === CONT TestAppCanQuitWithoutExecute 290s service_test.go:140: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 290s --- SKIP: TestAppCanQuitWithoutExecute (0.00s) 290s === CONT TestAppGetRootCmd 290s === CONT TestCanQuitTwice 290s === CONT TestCanQuitWhenExecute 290s === CONT TestAppRunFailsOnComponentsCreationAndQuit 290s time="2024-07-31T09:18:35Z" level=debug msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/cmd/wsl-pro-service/service/service.go:66 New.func1() Debug mode is enabled" 290s time="2024-07-31T09:18:35Z" level=debug msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/internal/daemon/daemon.go:75 New() Building new daemon" 290s time="2024-07-31T09:18:35Z" level=info msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41405" 290s time="2024-07-31T09:18:35Z" level=debug msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/cmd/wsl-pro-service/service/service.go:66 New.func1() Debug mode is enabled" 290s time="2024-07-31T09:18:35Z" level=debug msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/internal/daemon/daemon.go:75 New() Building new daemon" 290s time="2024-07-31T09:18:36Z" level=info msg="/tmp/autopkgtest.7C7ui6/build.vY4/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40957" 290s --- PASS: TestUsageError (1.60s) 290s --- PASS: TestAppGetRootCmd (1.84s) 290s time="2024-07-31T09:18:59Z" 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:42451: connect: connection refused\"" 290s --- PASS: TestCanQuitWhenExecute (24.52s) 290s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (32.28s) 290s time="2024-07-31T09:19:18Z" level=warning msg="Daemon: disconnected from Windows host" 290s time="2024-07-31T09:19:18Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 290s time="2024-07-31T09:19:18Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 290s time="2024-07-31T09:19:18Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" 290s --- PASS: TestCanQuitTwice (43.58s) 290s PASS 290s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 43.816s 290s === RUN TestApplyProToken 290s === PAUSE TestApplyProToken 290s === RUN TestApplyLandscapeConfig 290s === PAUSE TestApplyLandscapeConfig 290s === RUN TestWithProMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithProMock (0.00s) 290s === RUN TestWithLandscapeConfigMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithLandscapeConfigMock (0.00s) 290s === RUN TestWithWslPathMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithWslPathMock (0.00s) 290s === RUN TestWithWslInfoMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithWslInfoMock (0.00s) 290s === RUN TestWithCmdExeMock 290s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 290s --- SKIP: TestWithCmdExeMock (0.00s) 290s === CONT TestApplyProToken 290s === RUN TestApplyProToken/Success_attaching 290s === PAUSE TestApplyProToken/Success_attaching 290s === RUN TestApplyProToken/Success_detaching 290s === PAUSE TestApplyProToken/Success_detaching 290s === RUN TestApplyProToken/Error_calling_pro_detach 290s === PAUSE TestApplyProToken/Error_calling_pro_detach 290s === RUN TestApplyProToken/Error_calling_pro_attach 290s === PAUSE TestApplyProToken/Error_calling_pro_attach 290s === CONT TestApplyProToken/Success_attaching 290s === CONT TestApplyProToken/Error_calling_pro_attach 290s === CONT TestApplyProToken/Error_calling_pro_detach 290s === CONT TestApplyLandscapeConfig 290s === CONT TestApplyProToken/Success_detaching 290s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 290s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 290s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 290s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 290s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 290s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 290s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 290s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 290s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 290s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 290s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 290s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyLandscapeConfig: received config: registering" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyProToken: Received empty token: detaching" 290s time="2024-07-31T09:18:35Z" level=info msg="ApplyLandscapeConfig: received config: registering" 290s --- PASS: TestApplyLandscapeConfig (0.00s) 290s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (8.36s) 290s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (8.57s) 290s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (8.85s) 290s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (10.92s) 290s --- PASS: TestApplyProToken (0.00s) 290s --- PASS: TestApplyProToken/Success_detaching (7.40s) 290s --- PASS: TestApplyProToken/Error_calling_pro_detach (8.13s) 290s --- PASS: TestApplyProToken/Error_calling_pro_attach (11.12s) 290s --- PASS: TestApplyProToken/Success_attaching (14.86s) 290s PASS 290s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 14.905s 384s === RUN TestNew 384s === PAUSE TestNew 384s === RUN TestServe 384s === PAUSE TestServe 384s === RUN TestServeAndQuit 384s === PAUSE TestServeAndQuit 384s === RUN TestReconnection 384s === PAUSE TestReconnection 384s === RUN TestWithProMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithProMock (0.00s) 384s === RUN TestWithWslPathMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslPathMock (0.00s) 384s === RUN TestWithWslInfoMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslInfoMock (0.00s) 384s === RUN TestWithCmdExeMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithCmdExeMock (0.00s) 384s === CONT TestNew 384s === RUN TestNew/Success 384s === PAUSE TestNew/Success 384s === RUN TestNew/Error_when_WslPath_returns_error 384s === PAUSE TestNew/Error_when_WslPath_returns_error 384s === CONT TestNew/Success 384s === CONT TestServeAndQuit 384s === RUN TestServeAndQuit/Success_with_graceful_quit 384s === PAUSE TestServeAndQuit/Success_with_graceful_quit 384s === RUN TestServeAndQuit/Success_with_forceful_quit 384s === PAUSE TestServeAndQuit/Success_with_forceful_quit 384s === RUN TestServeAndQuit/Success_with_double_quit 384s === PAUSE TestServeAndQuit/Success_with_double_quit 384s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 384s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 384s === CONT TestServeAndQuit/Success_with_graceful_quit 384s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 384s === CONT TestServe 384s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 384s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 384s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 384s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 384s === RUN TestServe/No_connection_because_the_port_file_has_port_0 384s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 384s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 384s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 384s === RUN TestServe/No_connection_because_there_is_no_server 384s === CONT TestServeAndQuit/Success_with_double_quit 384s === PAUSE TestServe/No_connection_because_there_is_no_server 384s === RUN TestServe/No_connection_because_there_are_no_certificates 384s === PAUSE TestServe/No_connection_because_there_are_no_certificates 384s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 384s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 384s === RUN TestServe/Success 384s === PAUSE TestServe/Success 384s === RUN TestServe/Success_with_systemd_notifier_returning_true 384s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 384s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 384s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 384s === RUN TestServe/No_connection_because_the_port_file_is_empty 384s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 384s === RUN TestServe/Error_because_the_context_is_pre-cancelled 384s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 384s === RUN TestServe/Error_because_the_notifier_returns_an_error 384s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 384s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 384s === CONT TestServeAndQuit/Success_with_forceful_quit 384s === CONT TestNew/Error_when_WslPath_returns_error 384s === CONT TestReconnection 384s === RUN TestReconnection/Success_connecting_after_failing_to_connect 384s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 384s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 384s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 384s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 384s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 384s === CONT TestServe/Success 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46801" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40307" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44465" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40329" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39047" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39261" 384s time="2024-07-31T09:18:35Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:50Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:18:50Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:18:50Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:18:50Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:18:50Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:18:50Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s === CONT TestServe/No_connection_because_the_port_file_is_empty 384s time="2024-07-31T09:18:50Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:18:50Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:18:50Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:18:50Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42063" 384s time="2024-07-31T09:18:50Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:51Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:18:51Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:18:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s === CONT TestServe/Error_because_the_notifier_returns_an_error 384s time="2024-07-31T09:18:52Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34339" 384s time="2024-07-31T09:18:52Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:54Z" level=info msg="Daemon: connecting to Windows Agent" 384s --- PASS: TestNew (0.00s) 384s --- PASS: TestNew/Success (16.59s) 384s --- PASS: TestNew/Error_when_WslPath_returns_error (18.85s) 384s === CONT TestServe/Error_because_the_context_is_pre-cancelled 384s time="2024-07-31T09:18:54Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38437" 384s time="2024-07-31T09:18:54Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:18:54Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:18:54Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:18:54Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40307" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:18:56Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39261" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40329" 384s time="2024-07-31T09:18:56Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:18:56Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:18:56Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:01Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:01Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:01Z" level=debug msg="All connections have now ended." 384s === CONT TestServe/No_connection_because_there_is_no_server 384s time="2024-07-31T09:19:02Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43801" 384s time="2024-07-31T09:19:02Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:03Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:03Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:03Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:03Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:04Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44465" 384s time="2024-07-31T09:19:04Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:04Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:04Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:04Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:04Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:04Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:04Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:04Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:04Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:04Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:04Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:04Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 384s time="2024-07-31T09:19:04Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37865" 384s time="2024-07-31T09:19:04Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:06Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:06Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:06Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:06Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:06Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:06Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:06Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:06Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:06Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:06Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:06Z" level=info msg="Stopping active requests." 384s time="2024-07-31T09:19:06Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:06Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:06Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:06Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:06Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:06Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s === CONT TestServe/No_connection_because_there_are_no_certificates 384s === CONT TestServe/No_connection_because_the_port_file_has_port_0 384s time="2024-07-31T09:19:06Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43469" 384s time="2024-07-31T09:19:07Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:07Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43289" 384s time="2024-07-31T09:19:07Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:08Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:08Z" 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" 384s time="2024-07-31T09:19:08Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:09Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 384s time="2024-07-31T09:19:09Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:09Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:09Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:09Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:09Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:09Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:10Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:10Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:10Z" level=debug msg="All connections have now ended." 384s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 384s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 384s === CONT TestServe/Success_with_systemd_notifier_returning_true 384s time="2024-07-31T09:19:10Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40261" 384s time="2024-07-31T09:19:10Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:10Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39189" 384s time="2024-07-31T09:19:10Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:10Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44767" 384s time="2024-07-31T09:19:10Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:13Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:13Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:13Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:13Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:13Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:13Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:13Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:13Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:13Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:13Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:13Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:14Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:14Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:14Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:14Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:14Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:14Z" level=debug msg="All connections have now ended." 384s --- PASS: TestServeAndQuit (0.00s) 384s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (15.32s) 384s --- PASS: TestServeAndQuit/Success_with_forceful_quit (31.16s) 384s --- PASS: TestServeAndQuit/Success_with_graceful_quit (31.38s) 384s --- PASS: TestServeAndQuit/Success_with_double_quit (40.20s) 384s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 384s time="2024-07-31T09:19:16Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35557" 384s time="2024-07-31T09:19:16Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:21Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:27Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:27Z" 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" 384s time="2024-07-31T09:19:27Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:28Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:28Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:28Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:28Z" 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" 384s time="2024-07-31T09:19:28Z" level=info msg="Reconnecting to Windows host in 2 seconds" 384s time="2024-07-31T09:19:28Z" level=debug msg="All connections have now ended." 384s === CONT TestReconnection/Success_connecting_after_failing_to_connect 384s time="2024-07-31T09:19:29Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:29Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:29Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:30Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43801" 384s time="2024-07-31T09:19:30Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:30Z" 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:43801: connect: connection refused\"" 384s time="2024-07-31T09:19:30Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:30Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:30Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:30Z" level=debug msg="All connections have now ended." 384s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 384s time="2024-07-31T09:19:30Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:31Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:31Z" 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" 384s time="2024-07-31T09:19:31Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:32Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:32Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:32Z" level=debug msg="All connections have now ended." 384s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 384s time="2024-07-31T09:19:32Z" level=debug msg="Building new daemon" 384s time="2024-07-31T09:19:34Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:19:34Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:34Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:35Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:35Z" 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_exist172950031/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist172950031/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 384s time="2024-07-31T09:19:35Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:36Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:36Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:36Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:39Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:39Z" 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" 384s time="2024-07-31T09:19:39Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:40Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43469" 384s time="2024-07-31T09:19:40Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates1061398633/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 384s time="2024-07-31T09:19:40Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:40Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:37865" 384s time="2024-07-31T09:19:40Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_file1090623538/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 384s time="2024-07-31T09:19:40Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:40Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:40Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:40Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:40Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:40Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:40Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:40Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:40Z" 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" 384s time="2024-07-31T09:19:40Z" level=info msg="Reconnecting to Windows host in 2 seconds" 384s time="2024-07-31T09:19:40Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:40Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:40Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:41Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44767" 384s time="2024-07-31T09:19:41Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:41Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:41Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:41Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:42Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:19:42Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:42Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:42Z" 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_connect2009192332/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect2009192332/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 384s time="2024-07-31T09:19:42Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:42Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:42Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33113" 384s time="2024-07-31T09:19:42Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35157" 384s time="2024-07-31T09:19:42Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:19:42Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:42Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:42Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44403" 384s time="2024-07-31T09:19:42Z" level=debug msg="Ready state sent to systemd" 384s time="2024-07-31T09:19:42Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:42Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:43Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:43Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:43Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:43Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:43Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:43Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:44Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35157" 384s time="2024-07-31T09:19:44Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:44Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:44Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:44Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:44Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44403" 384s time="2024-07-31T09:19:44Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:44Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:44Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:44Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:45Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33113" 384s time="2024-07-31T09:19:45Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:45Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:45Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:45Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:45Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:45Z" level=info msg="Waiting for active requests to close." 384s time="2024-07-31T09:19:45Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:45Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:45Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:45Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:45Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s --- PASS: TestServe (0.00s) 384s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (26.41s) 384s --- PASS: TestServe/Success (29.27s) 384s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (15.95s) 384s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (18.27s) 384s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (19.58s) 384s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (22.18s) 384s --- PASS: TestServe/No_connection_because_there_is_no_server (28.76s) 384s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (22.53s) 384s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (26.03s) 384s --- PASS: TestServe/No_connection_because_there_are_no_certificates (34.12s) 384s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (25.09s) 384s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (36.05s) 384s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (34.72s) 384s time="2024-07-31T09:19:45Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:45Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:45Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:45Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:45Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:19:45Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:45Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38821" 384s time="2024-07-31T09:19:46Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:46Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:46Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:46Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:46Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:46Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:46Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:46Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:46Z" level=info msg="Stopping active requests." 384s time="2024-07-31T09:19:46Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:46Z" level=info msg="Reconnecting to Windows host in 2 seconds" 384s time="2024-07-31T09:19:46Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:46Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:46Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:19:46Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:19:46Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:19:47Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38821" 384s time="2024-07-31T09:19:47Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:19:47Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:19:47Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:19:47Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:19:48Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:19:48Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:19:48Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:19:48Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:19:48Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:48Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:48Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:48Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:19:48Z" level=info msg="Stopping active requests." 384s time="2024-07-31T09:19:48Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:19:48Z" level=info msg="Reconnecting to Windows host in 2 seconds" 384s time="2024-07-31T09:19:48Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:19:48Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:19:48Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:20:50Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:20:50Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:20:50Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:20:50Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:20:50Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:20:50Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:20: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_previous_long-lived_connection_dropped909985195/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_previous_long-lived_connection_dropped909985195/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 384s time="2024-07-31T09:20:50Z" level=info msg="Reconnecting to Windows host in 1 seconds" 384s time="2024-07-31T09:20:50Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:20:50Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44347" 384s time="2024-07-31T09:20:51Z" level=info msg="Daemon: connecting to Windows Agent" 384s time="2024-07-31T09:20:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 384s time="2024-07-31T09:20:52Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44347" 384s time="2024-07-31T09:20:52Z" level=info msg="Daemon: completed connection to Windows Agent" 384s time="2024-07-31T09:20:52Z" level=debug msg="Updated systemd status to \"Connected\"" 384s time="2024-07-31T09:20:52Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 384s time="2024-07-31T09:20:52Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 384s time="2024-07-31T09:20:53Z" level=debug msg="Server: sent preface messages to all streams" 384s time="2024-07-31T09:20:53Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:20:53Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:20:53Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:20:53Z" level=info msg="Stopping daemon requested." 384s time="2024-07-31T09:20:53Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:20:53Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:20:53Z" level=info msg="Stopping active requests." 384s time="2024-07-31T09:20:53Z" level=warning msg="Daemon: disconnected from Windows host" 384s time="2024-07-31T09:20:53Z" level=info msg="Reconnecting to Windows host in 2 seconds" 384s time="2024-07-31T09:20:53Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 384s time="2024-07-31T09:20:53Z" level=debug msg="Updated systemd status to \"Stopped\"" 384s time="2024-07-31T09:20:53Z" level=debug msg="All connections have now ended." 384s time="2024-07-31T09:20:53Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s --- PASS: TestReconnection (0.00s) 384s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (17.43s) 384s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (16.08s) 384s --- PASS: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (82.91s) 384s PASS 384s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 138.150s 384s === RUN TestConnect 384s === PAUSE TestConnect 384s === RUN TestSendAndRecv 384s --- PASS: TestSendAndRecv (0.41s) 384s === RUN TestServe 384s === PAUSE TestServe 384s === RUN TestStop 384s === PAUSE TestStop 384s === RUN TestWithProMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithProMock (0.00s) 384s === RUN TestWithWslPathMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslPathMock (0.00s) 384s === RUN TestWithWslInfoMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslInfoMock (0.00s) 384s === RUN TestWithCmdExeMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithCmdExeMock (0.00s) 384s === CONT TestConnect 384s === RUN TestConnect/Success 384s === PAUSE TestConnect/Success 384s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 384s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 384s === CONT TestConnect/Success 384s === CONT TestStop 384s === CONT TestServe 384s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 384s time="2024-07-31T09:18:36Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36853" 384s time="2024-07-31T09:18:36Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39615" 384s time="2024-07-31T09:18:46Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:18:46Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:18:46Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s time="2024-07-31T09:18:48Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 384s time="2024-07-31T09:18:48Z" level=info msg="MockWindowsAgent: Connected ready" 384s time="2024-07-31T09:18:48Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 384s --- PASS: TestConnect (0.00s) 384s --- PASS: TestConnect/Success (0.31s) 384s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.11s) 384s time="2024-07-31T09:18:58Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:18:58Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:18:58Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s --- PASS: TestStop (22.91s) 384s time="2024-07-31T09:19:10Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:10Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 384s time="2024-07-31T09:19:10Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 384s --- PASS: TestServe (35.22s) 384s PASS 384s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 35.765s 384s === RUN TestInfo 384s === PAUSE TestInfo 384s === RUN TestWslDistroName 384s === PAUSE TestWslDistroName 384s === RUN TestUserProfileDir 384s === PAUSE TestUserProfileDir 384s === RUN TestProStatus 384s === PAUSE TestProStatus 384s === RUN TestProAttach 384s === PAUSE TestProAttach 384s === RUN TestProDetach 384s === PAUSE TestProDetach 384s === RUN TestLandscapeEnable 384s === PAUSE TestLandscapeEnable 384s === RUN TestWindowsHostAddress 384s === PAUSE TestWindowsHostAddress 384s === RUN TestLandscapeDisable 384s === PAUSE TestLandscapeDisable 384s === RUN TestRealBackend 384s === PAUSE TestRealBackend 384s === RUN TestWithProMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithProMock (0.00s) 384s === RUN TestWithLandscapeConfigMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithLandscapeConfigMock (0.00s) 384s === RUN TestWithWslPathMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslPathMock (0.00s) 384s === RUN TestWithWslInfoMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithWslInfoMock (0.00s) 384s === RUN TestWithCmdExeMock 384s mock_executables.go:629: Skipped because it is not a real test, but rather a mocked executable 384s --- SKIP: TestWithCmdExeMock (0.00s) 384s === CONT TestInfo 384s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 384s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 384s === RUN TestInfo/Success 384s === PAUSE TestInfo/Success 384s === RUN TestInfo/Error_when_WslDistroName_fails 384s === PAUSE TestInfo/Error_when_WslDistroName_fails 384s === RUN TestInfo/Error_when_pro_status_command_fails 384s === PAUSE TestInfo/Error_when_pro_status_command_fails 384s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 384s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 384s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 384s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 384s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 384s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 384s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 384s === CONT TestUserProfileDir 384s === CONT TestLandscapeEnable 384s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 384s === RUN TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 384s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 384s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 384s === PAUSE TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 384s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 384s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 384s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 384s === CONT TestRealBackend 384s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 384s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 384s === RUN TestUserProfileDir/Error_on_cmd.exe_error 384s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 384s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 384s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 384s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 384s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 384s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 384s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 384s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 384s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 384s === RUN TestUserProfileDir/Error_on_wslpath_error 384s === PAUSE TestUserProfileDir/Error_on_wslpath_error 384s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 384s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 384s === CONT TestLandscapeDisable 384s === RUN TestLandscapeDisable/Success 384s === PAUSE TestLandscapeDisable/Success 384s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 384s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 384s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 384s === CONT TestProDetach 384s === RUN TestProDetach/success_on_unattached_distro 384s === PAUSE TestProDetach/success_on_unattached_distro 384s === RUN TestProDetach/success_on_attached_distro 384s === PAUSE TestProDetach/success_on_attached_distro 384s === CONT TestProAttach 384s === CONT TestProStatus 384s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 384s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 384s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 384s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 384s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 384s === RUN TestProStatus/success_on_unattached_distro 384s === PAUSE TestProStatus/success_on_unattached_distro 384s === RUN TestLandscapeEnable/Success 384s === PAUSE TestLandscapeEnable/Success 384s === RUN TestLandscapeEnable/Success_overriding_computer_title 384s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 384s === PAUSE TestLandscapeEnable/Success_overriding_computer_title 384s === RUN TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 384s === PAUSE TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 384s === RUN TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 384s === PAUSE TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 384s === RUN TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 384s === RUN TestProAttach/success 384s === PAUSE TestProAttach/success 384s === RUN TestProAttach/error_on_'pro_attach'_error 384s === PAUSE TestProAttach/error_on_'pro_attach'_error 384s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 384s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 384s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 384s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 384s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 384s === CONT TestWslDistroName 384s === RUN TestWslDistroName/Success_using_wslpath 384s === PAUSE TestWslDistroName/Success_using_wslpath 384s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 384s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 384s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 384s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 384s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 384s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 384s === RUN TestProStatus/success_on_attached_distro 384s === PAUSE TestProStatus/success_on_attached_distro 384s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 384s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 384s === RUN TestProStatus/error_on_'pro_attach'_error 384s === PAUSE TestProStatus/error_on_'pro_attach'_error 384s === CONT TestInfo/Error_when_WslDistroName_fails 384s === CONT TestInfo/Error_when_pro_status_command_fails 384s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 384s === PAUSE TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 384s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 384s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 384s === CONT TestWindowsHostAddress 384s --- PASS: TestRealBackend (0.00s) 384s === CONT TestInfo/Success 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 384s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 384s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 384s === RUN TestWindowsHostAddress/Success_without_NAT 384s === PAUSE TestWindowsHostAddress/Success_without_NAT 384s === RUN TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 384s === PAUSE TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 384s === RUN TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 384s === PAUSE TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 384s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 384s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 384s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 384s === CONT TestLandscapeDisable/Success 384s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 384s system_test.go:205: Removing default proc/mounts 384s === CONT TestUserProfileDir/Error_on_wslpath_error 384s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 384s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 384s system_test.go:205: Removing default proc/mounts 384s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 384s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 384s === CONT TestUserProfileDir/Error_on_cmd.exe_error 384s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 384s --- PASS: TestInfo (0.00s) 384s --- PASS: TestInfo/Error_when_WslDistroName_fails (8.90s) 384s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (9.60s) 384s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (10.47s) 384s --- PASS: TestInfo/Error_when_pro_status_command_fails (10.79s) 384s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (11.68s) 384s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (11.73s) 384s --- PASS: TestInfo/Success (14.01s) 384s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 384s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 384s === CONT TestProAttach/success 384s === CONT TestProDetach/success_on_unattached_distro 384s === CONT TestWslDistroName/Success_using_wslpath 384s --- PASS: TestLandscapeDisable (0.00s) 384s --- PASS: TestLandscapeDisable/Success (5.89s) 384s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (5.85s) 384s === CONT TestProAttach/error_on_'pro_attach'_error 384s === CONT TestProStatus/success_on_unattached_distro 384s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 384s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 384s --- PASS: TestUserProfileDir (0.00s) 384s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.00s) 384s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.00s) 384s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (0.22s) 384s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (18.28s) 384s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (8.46s) 384s --- PASS: TestUserProfileDir/Error_on_wslpath_error (10.89s) 384s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (14.88s) 384s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (15.08s) 384s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (15.87s) 384s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (13.64s) 384s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 384s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 384s === CONT TestProDetach/success_on_attached_distro 384s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 384s --- PASS: TestProAttach (0.00s) 384s --- PASS: TestProAttach/success (10.92s) 384s --- PASS: TestProAttach/error_on_'pro_attach'_error (9.33s) 384s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 384s === CONT TestProStatus/error_on_'pro_attach'_error 384s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 384s === CONT TestProStatus/success_on_attached_distro 384s === CONT TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 384s time="2024-07-31T09:19:12Z" level=info msg="Landscape config contains key \"tags\". Its value will not be overridden." 384s === CONT TestLandscapeEnable/Success_overriding_computer_title 384s time="2024-07-31T09:19:13Z" level=info msg="Landscape config contains key \"computer_title\". Its value will be overridden." 384s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_written 384s --- PASS: TestProDetach (0.00s) 384s --- PASS: TestProDetach/success_on_unattached_distro (9.98s) 384s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (9.35s) 384s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (8.37s) 384s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (10.12s) 384s --- PASS: TestProDetach/success_on_attached_distro (8.57s) 384s === CONT TestLandscapeEnable/Error_when_the_file_cannot_be_parsed 384s === CONT TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 384s time="2024-07-31T09:19:13Z" level=info msg="Landscape config contains key \"tags\". Its value will not be overridden." 384s === CONT TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 384s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 384s === CONT TestLandscapeEnable/Success 384s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 384s --- PASS: TestWslDistroName (0.00s) 384s --- PASS: TestWslDistroName/Success_using_wslpath (8.68s) 384s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.39s) 384s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (9.12s) 384s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (10.41s) 384s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed 384s --- PASS: TestProStatus (0.00s) 384s --- PASS: TestProStatus/success_on_unattached_distro (8.27s) 384s --- PASS: TestProStatus/error_on_'pro_attach'_error (9.41s) 384s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (10.45s) 384s --- PASS: TestProStatus/success_on_attached_distro (11.66s) 384s === NAME TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 384s system_test.go:456: testdata/TestLandscapeEnable/golden/do_not_append_wsl_tag_when_config_tag_is_provided_but_empty 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 384s === NAME TestLandscapeEnable/Success 384s system_test.go:456: testdata/TestLandscapeEnable/golden/success 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist 384s === NAME TestLandscapeEnable/Success_overriding_computer_title 384s system_test.go:456: testdata/TestLandscapeEnable/golden/success_overriding_computer_title 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 384s === NAME TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided 384s system_test.go:456: testdata/TestLandscapeEnable/golden/do_not_append_wsl_tag_when_config_tag_is_provided 384s === CONT TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback 384s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 384s === CONT TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback 384s === CONT TestWindowsHostAddress/Success_without_NAT 384s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 384s === NAME TestLandscapeEnable/Success_overriding_the_SSL_certficate_path 384s system_test.go:456: testdata/TestLandscapeEnable/golden/success_overriding_the_ssl_certficate_path 384s --- PASS: TestLandscapeEnable (0.00s) 384s --- PASS: TestLandscapeEnable/Error_when_the_file_cannot_be_parsed (0.00s) 384s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_written (1.01s) 384s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (0.59s) 384s --- PASS: TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided_but_empty (12.62s) 384s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (10.43s) 384s --- PASS: TestLandscapeEnable/Success (9.66s) 384s --- PASS: TestLandscapeEnable/Success_overriding_computer_title (13.48s) 384s --- PASS: TestLandscapeEnable/Do_not_append_wsl_tag_when_config_tag_is_provided (13.28s) 384s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (9.61s) 384s --- PASS: TestLandscapeEnable/Success_overriding_the_SSL_certficate_path (26.39s) 384s --- PASS: TestWindowsHostAddress (0.01s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_is_ill-formed (10.11s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_has_an_ill-formed_IP (10.11s) 384s --- PASS: TestWindowsHostAddress/Success_with_NAT,_nameserver_is_loopback (10.32s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/etc/resolv.conf_does_not_exist (13.44s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (14.08s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (12.67s) 384s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (10.15s) 384s --- PASS: TestWindowsHostAddress/Success_with_NAT,_nameserver_is_not_loopback (8.15s) 384s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (5.38s) 384s --- PASS: TestWindowsHostAddress/Success_without_NAT (6.45s) 384s PASS 384s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 66.832s 385s autopkgtest [09:20:54]: test command1: -----------------------] 389s command1 PASS 389s autopkgtest [09:20:58]: test command1: - - - - - - - - - - results - - - - - - - - - - 393s autopkgtest [09:21:02]: @@@@@@@@@@@@@@@@@@@@ summary 393s command1 PASS