0s autopkgtest [11:33:32]: starting date and time: 2026-02-05 11:33:32+0000 0s autopkgtest [11:33:32]: git checkout: 508d4a25 a-v-ssh wait_for_ssh: demote "ssh connection failed" to a debug message 0s autopkgtest [11:33:32]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.k_u_ssy6/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,localhost,localdomain,internal,login.ubuntu.com,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,radosgw.ps5.canonical.com\n" >> /etc/environment' --apt-pocket=proposed=src:glibc --apt-upgrade wsl-pro-service --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.42-2ubuntu5 -- lxd -r lxd-armhf-10.145.243.232 lxd-armhf-10.145.243.232:autopkgtest/ubuntu/resolute/armhf 26s autopkgtest [11:33:58]: testbed dpkg architecture: armhf 28s autopkgtest [11:34:00]: testbed apt version: 3.1.14 32s autopkgtest [11:34:04]: @@@@@@@@@@@@@@@@@@@@ test bed setup 34s autopkgtest [11:34:06]: testbed release detected to be: None 42s autopkgtest [11:34:14]: updating testbed package index (apt update) 45s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 45s Get:2 http://ftpmaster.internal/ubuntu resolute InRelease [124 kB] 45s Get:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease [124 kB] 45s Get:4 http://ftpmaster.internal/ubuntu resolute-security InRelease [124 kB] 46s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [35.4 kB] 46s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5260 B] 46s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [227 kB] 46s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1696 kB] 46s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf Packages [253 kB] 46s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe armhf Packages [1396 kB] 47s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse armhf Packages [9664 B] 47s Get:12 http://ftpmaster.internal/ubuntu resolute/main Sources [1402 kB] 47s Get:13 http://ftpmaster.internal/ubuntu resolute/universe Sources [21.3 MB] 51s Get:14 http://ftpmaster.internal/ubuntu resolute/main armhf Packages [1374 kB] 51s Get:15 http://ftpmaster.internal/ubuntu resolute/universe armhf Packages [14.9 MB] 55s Fetched 43.1 MB in 10s (4319 kB/s) 56s Reading package lists... 63s autopkgtest [11:34:35]: upgrading testbed (apt dist-upgrade and autopurge) 65s Reading package lists... 65s Building dependency tree... 65s Reading state information... 65s Calculating upgrade... 66s The following packages will be upgraded: 66s libc-bin libc-gconv-modules-extra libc6 locales 66s 4 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 66s Need to get 7850 kB of archives. 66s After this operation, 0 B of additional disk space will be used. 66s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libc-gconv-modules-extra armhf 2.42-2ubuntu5 [1417 kB] 67s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libc6 armhf 2.42-2ubuntu5 [1632 kB] 67s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libc-bin armhf 2.42-2ubuntu5 [545 kB] 67s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf locales all 2.42-2ubuntu5 [4255 kB] 67s Preconfiguring packages ... 67s Fetched 7850 kB in 1s (9198 kB/s) 68s (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 ... 68395 files and directories currently installed.) 68s Preparing to unpack .../libc-gconv-modules-extra_2.42-2ubuntu5_armhf.deb ... 68s Unpacking libc-gconv-modules-extra:armhf (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 68s Setting up libc-gconv-modules-extra:armhf (2.42-2ubuntu5) ... 68s (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 ... 68395 files and directories currently installed.) 68s Preparing to unpack .../libc6_2.42-2ubuntu5_armhf.deb ... 68s readlink: /usr/lib/libeatmydata: No such file or directory 68s Unpacking libc6:armhf (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 68s Setting up libc6:armhf (2.42-2ubuntu5) ... 68s (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 ... 68395 files and directories currently installed.) 68s Preparing to unpack .../libc-bin_2.42-2ubuntu5_armhf.deb ... 68s Unpacking libc-bin (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 68s Setting up libc-bin (2.42-2ubuntu5) ... 69s (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 ... 68395 files and directories currently installed.) 69s Preparing to unpack .../locales_2.42-2ubuntu5_all.deb ... 69s Unpacking locales (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 69s Setting up locales (2.42-2ubuntu5) ... 70s Generating locales (this might take a while)... 73s en_US.UTF-8... done 73s Generation complete. 73s Processing triggers for systemd (259-1ubuntu3) ... 73s Processing triggers for man-db (2.13.1-1) ... 76s Reading package lists... 77s Building dependency tree... 77s Reading state information... 77s Solving dependencies... 77s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 79s autopkgtest [11:34:51]: rebooting testbed after setup commands that affected boot 124s autopkgtest [11:35:36]: testbed running kernel: Linux 6.8.0-87-generic #88~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Tue Oct 14 14:00:09 UTC 2 152s autopkgtest [11:36:04]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 163s Get:1 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (dsc) [2064 B] 163s Get:2 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (tar) [1790 kB] 164s gpgv: Signature made Tue Jun 10 19:06:57 2025 UTC 164s gpgv: using RSA key 92FE4F8B40CADC4ECCD60C1F5961FDBE9C619809 164s gpgv: Can't check signature: No public key 164s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.18.dsc: no acceptable signature found 164s autopkgtest [11:36:16]: testing package wsl-pro-service version 0.1.18 166s autopkgtest [11:36:18]: build not needed 169s autopkgtest [11:36:21]: test command1: preparing testbed 171s Reading package lists... 172s Building dependency tree... 172s Reading state information... 172s Solving dependencies... 172s The following NEW packages will be installed: 172s autoconf automake autopoint autotools-dev build-essential cpp cpp-15 172s cpp-15-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper debugedit 172s dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-15 172s g++-15-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-15 172s gcc-15-arm-linux-gnueabihf gcc-arm-linux-gnueabihf gettext golang-1.25-go 172s golang-1.25-src golang-go golang-src intltool-debian libarchive-zip-perl 172s libasan8 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev libdebhelper-perl 172s libdw1t64 libfile-stripnondeterminism-perl libgcc-15-dev libgomp1 libisl23 172s libmpc3 libstdc++-15-dev libtool libubsan1 linux-libc-dev m4 po-debconf 172s rpcsvc-proto 173s 0 upgraded, 50 newly installed, 0 to remove and 0 not upgraded. 173s Need to get 97.6 MB of archives. 173s After this operation, 375 MB of additional disk space will be used. 173s Get:1 http://ftpmaster.internal/ubuntu resolute/main armhf m4 armhf 1.4.20-2 [212 kB] 173s Get:2 http://ftpmaster.internal/ubuntu resolute/main armhf autoconf all 2.72-3.1ubuntu1 [384 kB] 173s Get:3 http://ftpmaster.internal/ubuntu resolute/main armhf autotools-dev all 20240727.1 [43.4 kB] 173s Get:4 http://ftpmaster.internal/ubuntu resolute/main armhf automake all 1:1.18.1-3build1 [582 kB] 173s Get:5 http://ftpmaster.internal/ubuntu resolute/main armhf autopoint all 0.23.2-1 [620 kB] 173s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libc-dev-bin armhf 2.42-2ubuntu5 [21.8 kB] 173s Get:7 http://ftpmaster.internal/ubuntu resolute/main armhf linux-libc-dev armhf 6.18.0-9.9 [1819 kB] 173s Get:8 http://ftpmaster.internal/ubuntu resolute/main armhf libcrypt-dev armhf 1:4.5.1-1 [128 kB] 173s Get:9 http://ftpmaster.internal/ubuntu resolute/main armhf rpcsvc-proto armhf 1.4.3-1build1 [62.6 kB] 173s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main armhf libc6-dev armhf 2.42-2ubuntu5 [1416 kB] 173s Get:11 http://ftpmaster.internal/ubuntu resolute/main armhf libisl23 armhf 0.27-1build1 [553 kB] 173s Get:12 http://ftpmaster.internal/ubuntu resolute/main armhf libmpc3 armhf 1.3.1-2 [47.0 kB] 173s Get:13 http://ftpmaster.internal/ubuntu resolute/main armhf cpp-15-arm-linux-gnueabihf armhf 15.2.0-12ubuntu1 [10.1 MB] 174s Get:14 http://ftpmaster.internal/ubuntu resolute/main armhf cpp-15 armhf 15.2.0-12ubuntu1 [1032 B] 174s Get:15 http://ftpmaster.internal/ubuntu resolute/main armhf cpp-arm-linux-gnueabihf armhf 4:15.2.0-4ubuntu1 [5756 B] 174s Get:16 http://ftpmaster.internal/ubuntu resolute/main armhf cpp armhf 4:15.2.0-4ubuntu1 [22.4 kB] 174s Get:17 http://ftpmaster.internal/ubuntu resolute/main armhf libcc1-0 armhf 15.2.0-12ubuntu1 [43.5 kB] 174s Get:18 http://ftpmaster.internal/ubuntu resolute/main armhf libgomp1 armhf 15.2.0-12ubuntu1 [129 kB] 174s Get:19 http://ftpmaster.internal/ubuntu resolute/main armhf libasan8 armhf 15.2.0-12ubuntu1 [2949 kB] 174s Get:20 http://ftpmaster.internal/ubuntu resolute/main armhf libubsan1 armhf 15.2.0-12ubuntu1 [1187 kB] 174s Get:21 http://ftpmaster.internal/ubuntu resolute/main armhf libgcc-15-dev armhf 15.2.0-12ubuntu1 [898 kB] 174s Get:22 http://ftpmaster.internal/ubuntu resolute/main armhf gcc-15-arm-linux-gnueabihf armhf 15.2.0-12ubuntu1 [19.5 MB] 175s Get:23 http://ftpmaster.internal/ubuntu resolute/main armhf gcc-15 armhf 15.2.0-12ubuntu1 [499 kB] 175s Get:24 http://ftpmaster.internal/ubuntu resolute/main armhf gcc-arm-linux-gnueabihf armhf 4:15.2.0-4ubuntu1 [1220 B] 175s Get:25 http://ftpmaster.internal/ubuntu resolute/main armhf gcc armhf 4:15.2.0-4ubuntu1 [5022 B] 175s Get:26 http://ftpmaster.internal/ubuntu resolute/main armhf libstdc++-15-dev armhf 15.2.0-12ubuntu1 [2638 kB] 175s Get:27 http://ftpmaster.internal/ubuntu resolute/main armhf g++-15-arm-linux-gnueabihf armhf 15.2.0-12ubuntu1 [11.4 MB] 175s Get:28 http://ftpmaster.internal/ubuntu resolute/main armhf g++-15 armhf 15.2.0-12ubuntu1 [25.3 kB] 175s Get:29 http://ftpmaster.internal/ubuntu resolute/main armhf g++-arm-linux-gnueabihf armhf 4:15.2.0-4ubuntu1 [968 B] 175s Get:30 http://ftpmaster.internal/ubuntu resolute/main armhf g++ armhf 4:15.2.0-4ubuntu1 [1086 B] 175s Get:31 http://ftpmaster.internal/ubuntu resolute/main armhf build-essential armhf 12.12ubuntu2 [5256 B] 175s Get:32 http://ftpmaster.internal/ubuntu resolute/main armhf libdebhelper-perl all 13.28ubuntu1 [97.4 kB] 175s Get:33 http://ftpmaster.internal/ubuntu resolute/main armhf libtool all 2.5.4-9 [169 kB] 175s Get:34 http://ftpmaster.internal/ubuntu resolute/main armhf dh-autoreconf all 21 [12.5 kB] 175s Get:35 http://ftpmaster.internal/ubuntu resolute/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 175s Get:36 http://ftpmaster.internal/ubuntu resolute/main armhf libfile-stripnondeterminism-perl all 1.15.0-1build1 [20.6 kB] 175s Get:37 http://ftpmaster.internal/ubuntu resolute/main armhf dh-strip-nondeterminism all 1.15.0-1build1 [5110 B] 175s Get:38 http://ftpmaster.internal/ubuntu resolute/main armhf libdw1t64 armhf 0.194-1 [254 kB] 175s Get:39 http://ftpmaster.internal/ubuntu resolute/main armhf debugedit armhf 1:5.2-3build1 [49.0 kB] 175s Get:40 http://ftpmaster.internal/ubuntu resolute/main armhf dwz armhf 0.16-2 [114 kB] 175s Get:41 http://ftpmaster.internal/ubuntu resolute/main armhf gettext armhf 0.23.2-1 [1059 kB] 175s Get:42 http://ftpmaster.internal/ubuntu resolute/main armhf intltool-debian all 0.35.0+20060710.6build1 [24.1 kB] 175s Get:43 http://ftpmaster.internal/ubuntu resolute/main armhf po-debconf all 1.0.22 [215 kB] 175s Get:44 http://ftpmaster.internal/ubuntu resolute/main armhf debhelper all 13.28ubuntu1 [916 kB] 175s Get:45 http://ftpmaster.internal/ubuntu resolute/universe armhf dh-apport all 2.33.1-0ubuntu3 [20.2 kB] 175s Get:46 http://ftpmaster.internal/ubuntu resolute/main armhf golang-1.25-src all 1.25.0-0ubuntu1 [23.0 MB] 176s Get:47 http://ftpmaster.internal/ubuntu resolute/main armhf golang-1.25-go armhf 1.25.0-0ubuntu1 [16.3 MB] 177s Get:48 http://ftpmaster.internal/ubuntu resolute/main armhf golang-src all 2:1.25~1 [5206 B] 177s Get:49 http://ftpmaster.internal/ubuntu resolute/main armhf golang-go armhf 2:1.25~1 [44.1 kB] 177s Get:50 http://ftpmaster.internal/ubuntu resolute/main armhf dh-golang all 1.63build1 [25.0 kB] 177s Fetched 97.6 MB in 4s (22.4 MB/s) 177s Selecting previously unselected package m4. 178s (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 ... 68395 files and directories currently installed.) 178s Preparing to unpack .../00-m4_1.4.20-2_armhf.deb ... 178s Unpacking m4 (1.4.20-2) ... 178s Selecting previously unselected package autoconf. 178s Preparing to unpack .../01-autoconf_2.72-3.1ubuntu1_all.deb ... 178s Unpacking autoconf (2.72-3.1ubuntu1) ... 178s Selecting previously unselected package autotools-dev. 178s Preparing to unpack .../02-autotools-dev_20240727.1_all.deb ... 178s Unpacking autotools-dev (20240727.1) ... 178s Selecting previously unselected package automake. 178s Preparing to unpack .../03-automake_1%3a1.18.1-3build1_all.deb ... 178s Unpacking automake (1:1.18.1-3build1) ... 178s Selecting previously unselected package autopoint. 178s Preparing to unpack .../04-autopoint_0.23.2-1_all.deb ... 178s Unpacking autopoint (0.23.2-1) ... 178s Selecting previously unselected package libc-dev-bin. 178s Preparing to unpack .../05-libc-dev-bin_2.42-2ubuntu5_armhf.deb ... 178s Unpacking libc-dev-bin (2.42-2ubuntu5) ... 178s Selecting previously unselected package linux-libc-dev:armhf. 178s Preparing to unpack .../06-linux-libc-dev_6.18.0-9.9_armhf.deb ... 178s Unpacking linux-libc-dev:armhf (6.18.0-9.9) ... 178s Selecting previously unselected package libcrypt-dev:armhf. 178s Preparing to unpack .../07-libcrypt-dev_1%3a4.5.1-1_armhf.deb ... 178s Unpacking libcrypt-dev:armhf (1:4.5.1-1) ... 178s Selecting previously unselected package rpcsvc-proto. 178s Preparing to unpack .../08-rpcsvc-proto_1.4.3-1build1_armhf.deb ... 178s Unpacking rpcsvc-proto (1.4.3-1build1) ... 178s Selecting previously unselected package libc6-dev:armhf. 178s Preparing to unpack .../09-libc6-dev_2.42-2ubuntu5_armhf.deb ... 178s Unpacking libc6-dev:armhf (2.42-2ubuntu5) ... 178s Selecting previously unselected package libisl23:armhf. 178s Preparing to unpack .../10-libisl23_0.27-1build1_armhf.deb ... 178s Unpacking libisl23:armhf (0.27-1build1) ... 178s Selecting previously unselected package libmpc3:armhf. 178s Preparing to unpack .../11-libmpc3_1.3.1-2_armhf.deb ... 178s Unpacking libmpc3:armhf (1.3.1-2) ... 178s Selecting previously unselected package cpp-15-arm-linux-gnueabihf. 178s Preparing to unpack .../12-cpp-15-arm-linux-gnueabihf_15.2.0-12ubuntu1_armhf.deb ... 178s Unpacking cpp-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package cpp-15. 179s Preparing to unpack .../13-cpp-15_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking cpp-15 (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package cpp-arm-linux-gnueabihf. 179s Preparing to unpack .../14-cpp-arm-linux-gnueabihf_4%3a15.2.0-4ubuntu1_armhf.deb ... 179s Unpacking cpp-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 179s Selecting previously unselected package cpp. 179s Preparing to unpack .../15-cpp_4%3a15.2.0-4ubuntu1_armhf.deb ... 179s Unpacking cpp (4:15.2.0-4ubuntu1) ... 179s Selecting previously unselected package libcc1-0:armhf. 179s Preparing to unpack .../16-libcc1-0_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking libcc1-0:armhf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package libgomp1:armhf. 179s Preparing to unpack .../17-libgomp1_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking libgomp1:armhf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package libasan8:armhf. 179s Preparing to unpack .../18-libasan8_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking libasan8:armhf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package libubsan1:armhf. 179s Preparing to unpack .../19-libubsan1_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking libubsan1:armhf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package libgcc-15-dev:armhf. 179s Preparing to unpack .../20-libgcc-15-dev_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking libgcc-15-dev:armhf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package gcc-15-arm-linux-gnueabihf. 179s Preparing to unpack .../21-gcc-15-arm-linux-gnueabihf_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking gcc-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package gcc-15. 179s Preparing to unpack .../22-gcc-15_15.2.0-12ubuntu1_armhf.deb ... 179s Unpacking gcc-15 (15.2.0-12ubuntu1) ... 179s Selecting previously unselected package gcc-arm-linux-gnueabihf. 179s Preparing to unpack .../23-gcc-arm-linux-gnueabihf_4%3a15.2.0-4ubuntu1_armhf.deb ... 179s Unpacking gcc-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 179s Selecting previously unselected package gcc. 180s Preparing to unpack .../24-gcc_4%3a15.2.0-4ubuntu1_armhf.deb ... 180s Unpacking gcc (4:15.2.0-4ubuntu1) ... 180s Selecting previously unselected package libstdc++-15-dev:armhf. 180s Preparing to unpack .../25-libstdc++-15-dev_15.2.0-12ubuntu1_armhf.deb ... 180s Unpacking libstdc++-15-dev:armhf (15.2.0-12ubuntu1) ... 180s Selecting previously unselected package g++-15-arm-linux-gnueabihf. 180s Preparing to unpack .../26-g++-15-arm-linux-gnueabihf_15.2.0-12ubuntu1_armhf.deb ... 180s Unpacking g++-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 180s Selecting previously unselected package g++-15. 180s Preparing to unpack .../27-g++-15_15.2.0-12ubuntu1_armhf.deb ... 180s Unpacking g++-15 (15.2.0-12ubuntu1) ... 180s Selecting previously unselected package g++-arm-linux-gnueabihf. 180s Preparing to unpack .../28-g++-arm-linux-gnueabihf_4%3a15.2.0-4ubuntu1_armhf.deb ... 180s Unpacking g++-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 180s Selecting previously unselected package g++. 180s Preparing to unpack .../29-g++_4%3a15.2.0-4ubuntu1_armhf.deb ... 180s Unpacking g++ (4:15.2.0-4ubuntu1) ... 180s Selecting previously unselected package build-essential. 180s Preparing to unpack .../30-build-essential_12.12ubuntu2_armhf.deb ... 180s Unpacking build-essential (12.12ubuntu2) ... 180s Selecting previously unselected package libdebhelper-perl. 180s Preparing to unpack .../31-libdebhelper-perl_13.28ubuntu1_all.deb ... 180s Unpacking libdebhelper-perl (13.28ubuntu1) ... 180s Selecting previously unselected package libtool. 180s Preparing to unpack .../32-libtool_2.5.4-9_all.deb ... 180s Unpacking libtool (2.5.4-9) ... 180s Selecting previously unselected package dh-autoreconf. 180s Preparing to unpack .../33-dh-autoreconf_21_all.deb ... 180s Unpacking dh-autoreconf (21) ... 180s Selecting previously unselected package libarchive-zip-perl. 180s Preparing to unpack .../34-libarchive-zip-perl_1.68-1_all.deb ... 180s Unpacking libarchive-zip-perl (1.68-1) ... 180s Selecting previously unselected package libfile-stripnondeterminism-perl. 180s Preparing to unpack .../35-libfile-stripnondeterminism-perl_1.15.0-1build1_all.deb ... 180s Unpacking libfile-stripnondeterminism-perl (1.15.0-1build1) ... 180s Selecting previously unselected package dh-strip-nondeterminism. 180s Preparing to unpack .../36-dh-strip-nondeterminism_1.15.0-1build1_all.deb ... 180s Unpacking dh-strip-nondeterminism (1.15.0-1build1) ... 180s Selecting previously unselected package libdw1t64:armhf. 181s Preparing to unpack .../37-libdw1t64_0.194-1_armhf.deb ... 181s Unpacking libdw1t64:armhf (0.194-1) ... 181s Selecting previously unselected package debugedit. 181s Preparing to unpack .../38-debugedit_1%3a5.2-3build1_armhf.deb ... 181s Unpacking debugedit (1:5.2-3build1) ... 181s Selecting previously unselected package dwz. 181s Preparing to unpack .../39-dwz_0.16-2_armhf.deb ... 181s Unpacking dwz (0.16-2) ... 181s Selecting previously unselected package gettext. 181s Preparing to unpack .../40-gettext_0.23.2-1_armhf.deb ... 181s Unpacking gettext (0.23.2-1) ... 181s Selecting previously unselected package intltool-debian. 181s Preparing to unpack .../41-intltool-debian_0.35.0+20060710.6build1_all.deb ... 181s Unpacking intltool-debian (0.35.0+20060710.6build1) ... 181s Selecting previously unselected package po-debconf. 181s Preparing to unpack .../42-po-debconf_1.0.22_all.deb ... 181s Unpacking po-debconf (1.0.22) ... 181s Selecting previously unselected package debhelper. 181s Preparing to unpack .../43-debhelper_13.28ubuntu1_all.deb ... 181s Unpacking debhelper (13.28ubuntu1) ... 181s Selecting previously unselected package dh-apport. 181s Preparing to unpack .../44-dh-apport_2.33.1-0ubuntu3_all.deb ... 181s Unpacking dh-apport (2.33.1-0ubuntu3) ... 181s Selecting previously unselected package golang-1.25-src. 181s Preparing to unpack .../45-golang-1.25-src_1.25.0-0ubuntu1_all.deb ... 181s Unpacking golang-1.25-src (1.25.0-0ubuntu1) ... 183s Selecting previously unselected package golang-1.25-go. 184s Preparing to unpack .../46-golang-1.25-go_1.25.0-0ubuntu1_armhf.deb ... 184s Unpacking golang-1.25-go (1.25.0-0ubuntu1) ... 184s Selecting previously unselected package golang-src. 184s Preparing to unpack .../47-golang-src_2%3a1.25~1_all.deb ... 184s Unpacking golang-src (2:1.25~1) ... 184s Selecting previously unselected package golang-go:armhf. 184s Preparing to unpack .../48-golang-go_2%3a1.25~1_armhf.deb ... 184s Unpacking golang-go:armhf (2:1.25~1) ... 184s Selecting previously unselected package dh-golang. 184s Preparing to unpack .../49-dh-golang_1.63build1_all.deb ... 184s Unpacking dh-golang (1.63build1) ... 184s Setting up libarchive-zip-perl (1.68-1) ... 184s Setting up libdebhelper-perl (13.28ubuntu1) ... 184s Setting up linux-libc-dev:armhf (6.18.0-9.9) ... 184s Setting up m4 (1.4.20-2) ... 184s Setting up libgomp1:armhf (15.2.0-12ubuntu1) ... 184s Setting up dh-apport (2.33.1-0ubuntu3) ... 184s Setting up libdw1t64:armhf (0.194-1) ... 184s Setting up autotools-dev (20240727.1) ... 184s Setting up rpcsvc-proto (1.4.3-1build1) ... 184s Setting up libmpc3:armhf (1.3.1-2) ... 184s Setting up autopoint (0.23.2-1) ... 184s Setting up autoconf (2.72-3.1ubuntu1) ... 184s Setting up libubsan1:armhf (15.2.0-12ubuntu1) ... 184s Setting up dwz (0.16-2) ... 184s Setting up golang-1.25-src (1.25.0-0ubuntu1) ... 184s Setting up libcrypt-dev:armhf (1:4.5.1-1) ... 184s Setting up libasan8:armhf (15.2.0-12ubuntu1) ... 184s Setting up debugedit (1:5.2-3build1) ... 184s Setting up libisl23:armhf (0.27-1build1) ... 184s Setting up libc-dev-bin (2.42-2ubuntu5) ... 184s Setting up golang-src (2:1.25~1) ... 184s Setting up cpp-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 184s Setting up libcc1-0:armhf (15.2.0-12ubuntu1) ... 184s Setting up cpp-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 184s Setting up automake (1:1.18.1-3build1) ... 184s update-alternatives: using /usr/bin/automake-1.18 to provide /usr/bin/automake (automake) in auto mode 184s Setting up libfile-stripnondeterminism-perl (1.15.0-1build1) ... 184s Setting up golang-1.25-go (1.25.0-0ubuntu1) ... 184s Setting up gettext (0.23.2-1) ... 184s Setting up libgcc-15-dev:armhf (15.2.0-12ubuntu1) ... 184s Setting up gcc-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 184s Setting up golang-go:armhf (2:1.25~1) ... 184s Setting up intltool-debian (0.35.0+20060710.6build1) ... 184s Setting up dh-strip-nondeterminism (1.15.0-1build1) ... 184s Setting up cpp-15 (15.2.0-12ubuntu1) ... 184s Setting up cpp (4:15.2.0-4ubuntu1) ... 184s Setting up libc6-dev:armhf (2.42-2ubuntu5) ... 184s Setting up gcc-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 184s Setting up po-debconf (1.0.22) ... 184s Setting up gcc-15 (15.2.0-12ubuntu1) ... 184s Setting up libstdc++-15-dev:armhf (15.2.0-12ubuntu1) ... 184s Setting up libtool (2.5.4-9) ... 184s Setting up g++-15-arm-linux-gnueabihf (15.2.0-12ubuntu1) ... 184s Setting up gcc (4:15.2.0-4ubuntu1) ... 184s Setting up dh-autoreconf (21) ... 184s Setting up g++-15 (15.2.0-12ubuntu1) ... 184s Setting up g++-arm-linux-gnueabihf (4:15.2.0-4ubuntu1) ... 184s Setting up debhelper (13.28ubuntu1) ... 184s Setting up g++ (4:15.2.0-4ubuntu1) ... 184s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 184s Setting up build-essential (12.12ubuntu2) ... 184s Setting up dh-golang (1.63build1) ... 184s Processing triggers for man-db (2.13.1-1) ... 185s Processing triggers for install-info (7.2-5) ... 186s Processing triggers for libc-bin (2.42-2ubuntu5) ... 194s autopkgtest [11:36:44]: test command1: ./debian/tests/test 194s autopkgtest [11:36:44]: test command1: [----------------------- 221s === RUN TestRunSignal 221s === RUN TestRunSignal/Send_SIGTERM_exits 221s INFO Starting WSL Pro Service version Dev 221s === RUN TestRunSignal/Send_SIGINT_exits 221s INFO Starting WSL Pro Service version Dev 221s --- PASS: TestRunSignal (0.20s) 221s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.10s) 221s --- PASS: TestRunSignal/Send_SIGINT_exits (0.10s) 221s === RUN TestRun 221s === PAUSE TestRun 221s === CONT TestRun 221s === RUN TestRun/Run_and_usage_error_only_does_not_fail 221s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 221s === RUN TestRun/Run_and_exit_successfully 221s === PAUSE TestRun/Run_and_exit_successfully 221s === RUN TestRun/Run_and_return_error 221s === PAUSE TestRun/Run_and_return_error 221s === RUN TestRun/Run_and_return_usage_error 221s === PAUSE TestRun/Run_and_return_usage_error 221s === CONT TestRun/Run_and_usage_error_only_does_not_fail 221s === CONT TestRun/Run_and_return_error 221s === CONT TestRun/Run_and_exit_successfully 221s === CONT TestRun/Run_and_return_usage_error 221s INFO Starting WSL Pro Service version Dev 221s INFO Starting WSL Pro Service version Dev 221s INFO Starting WSL Pro Service version Dev 221s INFO Starting WSL Pro Service version Dev 221s ERROR context.Background Error requested 221s ERROR context.Background Error requested 221s --- PASS: TestRun (0.00s) 221s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.10s) 221s --- PASS: TestRun/Run_and_exit_successfully (0.10s) 221s --- PASS: TestRun/Run_and_return_usage_error (0.10s) 221s --- PASS: TestRun/Run_and_return_error (0.10s) 221s PASS 221s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 0.328s 269s === RUN TestHelp 269s --- PASS: TestHelp (0.86s) 269s === RUN TestCompletion 269s --- PASS: TestCompletion (0.36s) 269s === RUN TestVersion 269s --- PASS: TestVersion (0.79s) 269s === RUN TestConfigBadArg 269s --- PASS: TestConfigBadArg (1.17s) 269s === RUN TestConfigArg 269s --- PASS: TestConfigArg (1.19s) 269s === RUN TestConfigAutoDetect 269s time="2026-02-05T11:37:17Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 269s --- PASS: TestConfigAutoDetect (0.44s) 269s === RUN TestNoUsageError 269s time="2026-02-05T11:37:18Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 269s --- PASS: TestNoUsageError (1.57s) 269s === RUN TestUsageError 269s === PAUSE TestUsageError 269s === RUN TestCanQuitWhenExecute 269s === PAUSE TestCanQuitWhenExecute 269s === RUN TestCanQuitTwice 269s === PAUSE TestCanQuitTwice 269s === RUN TestAppCanQuitWithoutExecute 269s === PAUSE TestAppCanQuitWithoutExecute 269s === RUN TestAppRunFailsOnComponentsCreationAndQuit 269s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 269s === RUN TestAppGetRootCmd 269s === PAUSE TestAppGetRootCmd 269s === RUN TestWithProMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithProMock (0.00s) 269s === RUN TestWithWslPathMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithWslPathMock (0.00s) 269s === RUN TestWithWslInfoMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithWslInfoMock (0.00s) 269s === RUN TestWithCmdExeMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithCmdExeMock (0.00s) 269s === CONT TestUsageError 269s === CONT TestAppCanQuitWithoutExecute 269s service_test.go:190: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 269s --- SKIP: TestAppCanQuitWithoutExecute (0.00s) 269s === CONT TestAppGetRootCmd 269s === CONT TestCanQuitTwice 269s === CONT TestAppRunFailsOnComponentsCreationAndQuit 269s === CONT TestCanQuitWhenExecute 269s --- PASS: TestUsageError (0.26s) 269s time="2026-02-05T11:37:20Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43959" 269s time="2026-02-05T11:37:20Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build43060488/b385/wsl-pro-service.yaml" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:74 New() Building new daemon" 269s time="2026-02-05T11:37:20Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40587" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:74 New() Building new daemon" 269s time="2026-02-05T11:37:20Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35623" 269s time="2026-02-05T11:37:20Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build43060488/b385/wsl-pro-service.yaml" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 269s time="2026-02-05T11:37:20Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:74 New() Building new daemon" 269s --- PASS: TestAppGetRootCmd (0.67s) 269s time="2026-02-05T11:37:40Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 269s time="2026-02-05T11:37:40Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 269s time="2026-02-05T11:37:40Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 7065" 269s time="2026-02-05T11:37:41Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 269s time="2026-02-05T11:37:41Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 269s time="2026-02-05T11:37:41Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 7065" 269s time="2026-02-05T11:37:42Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:37:42Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:37:43Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 269s time="2026-02-05T11:37:43Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 269s time="2026-02-05T11:37:43Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 7065" 269s time="2026-02-05T11:37:43Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:37:43Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:37:49Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:37:49Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:37:49Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (29.90s) 269s time="2026-02-05T11:37:51Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:43959" 269s time="2026-02-05T11:37:51Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 269s time="2026-02-05T11:37:51Z" level=warning msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:194 (*Daemon).serveOnce() 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:43959: connect: connection refused\"" 269s time="2026-02-05T11:37:51Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 269s time="2026-02-05T11:37:51Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s time="2026-02-05T11:37:51Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:37:51Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:37:51Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s --- PASS: TestCanQuitWhenExecute (32.23s) 269s time="2026-02-05T11:37:53Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:35623" 269s time="2026-02-05T11:37:53Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 269s time="2026-02-05T11:37:53Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.ProAttachCmd requests" 269s time="2026-02-05T11:37:53Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.LandscapeConfigCmd requests" 269s time="2026-02-05T11:38:00Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/streams/server.go:146 (*Server).Serve() Server: sent preface messages to all streams" 269s time="2026-02-05T11:38:00Z" level=warning msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:196 (*Daemon).serveOnce() Daemon: disconnected from Windows host" 269s time="2026-02-05T11:38:00Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 269s time="2026-02-05T11:38:00Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s time="2026-02-05T11:38:00Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:38:00Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:38:00Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s time="2026-02-05T11:38:00Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.PDoZ90/build.aZ5/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 269s time="2026-02-05T11:38:00Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.PDoZ90/build.aZ5/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 269s time="2026-02-05T11:38:00Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.PDoZ90/build.aZ5/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 269s time="2026-02-05T11:38:00Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 269s time="2026-02-05T11:38:00Z" level=info msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 269s time="2026-02-05T11:38:00Z" level=debug msg="/tmp/autopkgtest.PDoZ90/build.aZ5/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 269s --- PASS: TestCanQuitTwice (41.34s) 269s PASS 269s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 47.803s 269s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 269s === RUN TestApplyProToken 269s === PAUSE TestApplyProToken 269s === RUN TestApplyLandscapeConfig 269s === PAUSE TestApplyLandscapeConfig 269s === RUN TestWithProMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithProMock (0.00s) 269s === RUN TestWithLandscapeConfigMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithLandscapeConfigMock (0.00s) 269s === RUN TestWithWslPathMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithWslPathMock (0.00s) 269s === RUN TestWithWslInfoMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithWslInfoMock (0.00s) 269s === RUN TestWithCmdExeMock 269s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 269s --- SKIP: TestWithCmdExeMock (0.00s) 269s === CONT TestApplyProToken 269s === RUN TestApplyProToken/Success_attaching 269s === PAUSE TestApplyProToken/Success_attaching 269s === RUN TestApplyProToken/Success_detaching 269s === PAUSE TestApplyProToken/Success_detaching 269s === RUN TestApplyProToken/Error_calling_pro_detach 269s === PAUSE TestApplyProToken/Error_calling_pro_detach 269s === RUN TestApplyProToken/Error_calling_pro_attach 269s === PAUSE TestApplyProToken/Error_calling_pro_attach 269s === CONT TestApplyProToken/Success_attaching 269s === CONT TestApplyProToken/Error_calling_pro_attach 269s === CONT TestApplyLandscapeConfig 269s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 269s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 269s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 269s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 269s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 269s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 269s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 269s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 269s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 269s === CONT TestApplyProToken/Error_calling_pro_detach 269s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 269s === CONT TestApplyProToken/Success_detaching 269s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 269s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyLandscapeConfig: received config: registering" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyLandscapeConfig: received config: registering" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 269s time="2026-02-05T11:37:13Z" level=info msg="ApplyProToken: Received empty token: detaching" 269s --- PASS: TestApplyLandscapeConfig (0.00s) 269s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (10.77s) 269s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (10.92s) 269s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (11.09s) 269s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (12.26s) 269s --- PASS: TestApplyProToken (0.00s) 269s --- PASS: TestApplyProToken/Error_calling_pro_detach (11.49s) 269s --- PASS: TestApplyProToken/Success_detaching (11.89s) 269s --- PASS: TestApplyProToken/Error_calling_pro_attach (19.33s) 269s --- PASS: TestApplyProToken/Success_attaching (19.45s) 269s PASS 269s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 19.512s 269s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 366s === RUN TestNew 366s === PAUSE TestNew 366s === RUN TestServe 366s === PAUSE TestServe 366s === RUN TestServeAndQuit 366s === PAUSE TestServeAndQuit 366s === RUN TestRetryLogic 366s === PAUSE TestRetryLogic 366s === RUN TestReconnection 366s === PAUSE TestReconnection 366s === RUN TestWithProMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithProMock (0.00s) 366s === RUN TestWithWslPathMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslPathMock (0.00s) 366s === RUN TestWithWslInfoMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslInfoMock (0.00s) 366s === RUN TestWithCmdExeMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithCmdExeMock (0.00s) 366s === CONT TestNew 366s === RUN TestNew/Error_when_WslPath_returns_error 366s === PAUSE TestNew/Error_when_WslPath_returns_error 366s === RUN TestNew/Success 366s === PAUSE TestNew/Success 366s === CONT TestNew/Error_when_WslPath_returns_error 366s === CONT TestServeAndQuit 366s === RUN TestServeAndQuit/Success_with_double_quit 366s === PAUSE TestServeAndQuit/Success_with_double_quit 366s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 366s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 366s === RUN TestServeAndQuit/Success_with_graceful_quit 366s === PAUSE TestServeAndQuit/Success_with_graceful_quit 366s === RUN TestServeAndQuit/Success_with_forceful_quit 366s === PAUSE TestServeAndQuit/Success_with_forceful_quit 366s === CONT TestServeAndQuit/Success_with_double_quit 366s === CONT TestServe 366s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 366s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 366s === RUN TestServe/Error_because_the_notifier_returns_an_error 366s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 366s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 366s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 366s === RUN TestServe/Success 366s === PAUSE TestServe/Success 366s === RUN TestServe/Success_with_a_broken_Landscape_config 366s === PAUSE TestServe/Success_with_a_broken_Landscape_config 366s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 366s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 366s === RUN TestServe/No_connection_because_there_is_no_server 366s === PAUSE TestServe/No_connection_because_there_is_no_server 366s === RUN TestServe/No_connection_because_there_are_no_certificates 366s === PAUSE TestServe/No_connection_because_there_are_no_certificates 366s === RUN TestServe/Error_because_the_context_is_pre-cancelled 366s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 366s === RUN TestServe/Success_with_systemd_notifier_returning_true 366s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 366s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 366s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 366s === RUN TestServe/No_connection_because_the_port_file_is_empty 366s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 366s === RUN TestServe/No_connection_because_the_port_file_has_port_0 366s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 366s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 366s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 366s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 366s === CONT TestServeAndQuit/Success_with_forceful_quit 366s === CONT TestNew/Success 366s === CONT TestServeAndQuit/Success_with_graceful_quit 366s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 366s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40479" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45977" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43413" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43103" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35097" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45667" 366s time="2026-02-05T11:37:13Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:33Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:37:33Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:33Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:33Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:33Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:37:34Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:37:34Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:34Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:34Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:34Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s === CONT TestServe/No_connection_because_there_are_no_certificates 366s time="2026-02-05T11:37:34Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35359" 366s --- PASS: TestNew (0.00s) 366s --- PASS: TestNew/Success (21.57s) 366s --- PASS: TestNew/Error_when_WslPath_returns_error (21.75s) 366s === CONT TestServe/No_connection_because_the_port_file_has_port_0 366s time="2026-02-05T11:37:35Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:35Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34065" 366s time="2026-02-05T11:37:35Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:35Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:35Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:35Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:35Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:35Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:35Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:37:35Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:35Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:35Z" 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" 366s time="2026-02-05T11:37:35Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s === CONT TestServe/No_connection_because_the_port_file_is_empty 366s time="2026-02-05T11:37:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34343" 366s time="2026-02-05T11:37:35Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:35Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:37:35Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:35Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:35Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:37:36Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:36Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:36Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 366s time="2026-02-05T11:37:36Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33307" 366s time="2026-02-05T11:37:36Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:41Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35097" 366s time="2026-02-05T11:37:42Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:37:42Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:37:42Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:37:42Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:37:42Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40479" 366s time="2026-02-05T11:37:42Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:37:42Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:37:42Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:37:42Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:37:43Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45977" 366s time="2026-02-05T11:37:43Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_2293973009/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 366s time="2026-02-05T11:37:43Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:44Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:44Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:44Z" level=debug msg="All connections have now ended." 366s === CONT TestReconnection 366s === RUN TestReconnection/Success_connecting_after_failing_to_connect 366s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 366s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 366s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 366s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 366s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 366s === CONT TestRetryLogic 366s === RUN TestRetryLogic/With_the_context_cancelled_while_waiting 366s === PAUSE TestRetryLogic/With_the_context_cancelled_while_waiting 366s === RUN TestRetryLogic/When_max_attempts_are_exhausted 366s === PAUSE TestRetryLogic/When_max_attempts_are_exhausted 366s === RUN TestRetryLogic/Error_only_when_action_errors 366s === PAUSE TestRetryLogic/Error_only_when_action_errors 366s === RUN TestRetryLogic/Without_retries 366s === PAUSE TestRetryLogic/Without_retries 366s === RUN TestRetryLogic/With_the_context_pre-cancelled 366s === PAUSE TestRetryLogic/With_the_context_pre-cancelled 366s === CONT TestServe/Error_because_the_context_is_pre-cancelled 366s time="2026-02-05T11:37:44Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38583" 366s time="2026-02-05T11:37:44Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:44Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43413" 366s time="2026-02-05T11:37:44Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:37:44Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:37:44Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:37:44Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:37:50Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:37:50Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:37:50Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:37:50Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:37:51Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:51Z" level=info msg="Stopping active requests." 366s time="2026-02-05T11:37:51Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:37:51Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:51Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:37:51Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:37:51Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s === CONT TestServe/Success_with_a_broken_Landscape_config 366s time="2026-02-05T11:37:51Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45163" 366s time="2026-02-05T11:37:51Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:51Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:37:51Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:37:51Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:37:51Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:37:51Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:51Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:51Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:37:51Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:51Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:51Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:37:51Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:37:51Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:37:51Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:51Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:51Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/No_connection_because_there_is_no_server 366s time="2026-02-05T11:37:52Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:37:52Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:37:52Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:37:52Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:37:52Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43063" 366s time="2026-02-05T11:37:52Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:52Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:52Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:52Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:52Z" 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" 366s time="2026-02-05T11:37:52Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:52Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:52Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:52Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:37:52Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:52Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:37:52Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:37:52Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:37:52Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:52Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:52Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:52Z" level=debug msg="Checking cloud-init status" 366s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 366s --- PASS: TestServeAndQuit (0.00s) 366s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (22.23s) 366s --- PASS: TestServeAndQuit/Success_with_forceful_quit (37.91s) 366s --- PASS: TestServeAndQuit/Success_with_double_quit (38.91s) 366s --- PASS: TestServeAndQuit/Success_with_graceful_quit (39.56s) 366s time="2026-02-05T11:37:52Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:52Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:52Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41865" 366s time="2026-02-05T11:37:52Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:53Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:53Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:53Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:53Z" 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" 366s time="2026-02-05T11:37:53Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:53Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:53Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:53Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 366s time="2026-02-05T11:37:53Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44443" 366s time="2026-02-05T11:37:53Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:54Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:54Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:54Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/Success 366s time="2026-02-05T11:37:54Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34031" 366s time="2026-02-05T11:37:54Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:54Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:37:54Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:37:54Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:37:54Z" 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_exist2265089720/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist2265089720/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 366s time="2026-02-05T11:37:54Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:55Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:55Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:55Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/Error_because_the_notifier_returns_an_error 366s time="2026-02-05T11:37:56Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41517" 366s time="2026-02-05T11:37:56Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:59Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:59Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:59Z" level=debug msg="All connections have now ended." 366s === CONT TestServe/Success_with_systemd_notifier_returning_true 366s time="2026-02-05T11:37:59Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35359" 366s time="2026-02-05T11:37:59Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates2264347063/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 366s time="2026-02-05T11:37:59Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:37:59Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34439" 366s time="2026-02-05T11:37:59Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:37:59Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:37:59Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:37:59Z" level=debug msg="All connections have now ended." 366s === CONT TestReconnection/Success_connecting_after_failing_to_connect 366s time="2026-02-05T11:38:00Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:38:04Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:04Z" level=warning msg="Could not ensure valid Landscape configuration: could not ensure valid Landscape configuration: read /tmp/TestServeSuccess_with_a_broken_Landscape_config3753703831/001/etc/landscape/client.conf: is a directory" 366s time="2026-02-05T11:38:04Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:04Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:04Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:04Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:05Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:06Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:06Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:06Z" 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" 366s time="2026-02-05T11:38:06Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:06Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:06Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:06Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:06Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:06Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:06Z" level=debug msg="All connections have now ended." 366s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 366s time="2026-02-05T11:38:07Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:38:07Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:07Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:07Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:08Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 366s time="2026-02-05T11:38:08Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:08Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:08Z" level=debug msg="All connections have now ended." 366s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 366s time="2026-02-05T11:38:09Z" level=debug msg="Building new daemon" 366s time="2026-02-05T11:38:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43063" 366s time="2026-02-05T11:38:11Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:11Z" 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:43063: connect: connection refused\"" 366s time="2026-02-05T11:38:11Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45163" 366s time="2026-02-05T11:38:11Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:11Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:11Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:11Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:11Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:11Z" level=debug msg="All connections have now ended." 366s === CONT TestRetryLogic/With_the_context_cancelled_while_waiting 366s === CONT TestRetryLogic/Error_only_when_action_errors 366s === CONT TestRetryLogic/When_max_attempts_are_exhausted 366s === CONT TestRetryLogic/With_the_context_pre-cancelled 366s === CONT TestRetryLogic/Without_retries 366s time="2026-02-05T11:38:12Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:38:12Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:12Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:12Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:12Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:12Z" 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_connect1218987003/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect1218987003/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 366s time="2026-02-05T11:38:12Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:12Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:38:13Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:13Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:13Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:38:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35117" 366s --- PASS: TestRetryLogic (0.00s) 366s --- PASS: TestRetryLogic/Error_only_when_action_errors (0.00s) 366s --- PASS: TestRetryLogic/With_the_context_cancelled_while_waiting (0.04s) 366s --- PASS: TestRetryLogic/When_max_attempts_are_exhausted (0.43s) 366s --- PASS: TestRetryLogic/With_the_context_pre-cancelled (0.00s) 366s --- PASS: TestRetryLogic/Without_retries (0.71s) 366s time="2026-02-05T11:38:13Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:34031" 366s time="2026-02-05T11:38:13Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:13Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:13Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:13Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:13Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:14Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:38:14Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:14Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:14Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:14Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:17Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:17Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:17Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:17Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:18Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35117" 366s time="2026-02-05T11:38:18Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:18Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:38:18Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:18Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:19Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:19Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:19Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:19Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:19Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33563" 366s time="2026-02-05T11:38:19Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:38:19Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:19Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:19Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:19Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:19Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:19Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:19Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:38:19Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:19Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:38:19Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:19Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:19Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:19Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:34439" 366s time="2026-02-05T11:38:19Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:19Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:38:19Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:19Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:20Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39235" 366s time="2026-02-05T11:38:20Z" level=debug msg="Ready state sent to systemd" 366s time="2026-02-05T11:38:20Z" level=debug msg="Checking cloud-init status" 366s time="2026-02-05T11:38:20Z" level=debug msg="No Landscape configuration detected: nothing to do" 366s time="2026-02-05T11:38:20Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:20Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:20Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:20Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:20Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:38:20Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:20Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:38:20Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:20Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:20Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:23Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:23Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:23Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:23Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:23Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:23Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:23Z" level=info msg="Stopping active requests." 366s time="2026-02-05T11:38:23Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:23Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:23Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:38:23Z" level=info msg="Reconnecting to Windows host in 2 seconds" 366s time="2026-02-05T11:38:23Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:38:23Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:38:23Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:38:23Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33563" 366s time="2026-02-05T11:38:23Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:23Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:38:23Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:23Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:24Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:24Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:24Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:24Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:24Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39235" 366s time="2026-02-05T11:38:24Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:24Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:38:24Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:24Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:25Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:25Z" level=info msg="Waiting for active requests to close." 366s time="2026-02-05T11:38:25Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:38:25Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:25Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:38:25Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:38:25Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:38:25Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:25Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:25Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s --- PASS: TestServe (0.00s) 366s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (23.32s) 366s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (30.98s) 366s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (18.75s) 366s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (18.88s) 366s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (19.36s) 366s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (15.45s) 366s --- PASS: TestServe/No_connection_because_there_are_no_certificates (25.23s) 366s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (14.32s) 366s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (13.24s) 366s --- PASS: TestServe/No_connection_because_there_is_no_server (19.97s) 366s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (19.40s) 366s --- PASS: TestServe/Success_with_a_broken_Landscape_config (28.26s) 366s --- PASS: TestServe/Success (26.02s) 366s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (26.10s) 366s time="2026-02-05T11:38:27Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:27Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:27Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:27Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:28Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:28Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:28Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:28Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:28Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 366s time="2026-02-05T11:38:28Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:38:28Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:38:28Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:28Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:28Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:28Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40045" 366s time="2026-02-05T11:38:29Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:38:29Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:38:30Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40045" 366s time="2026-02-05T11:38:30Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:38:30Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:38:30Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:38:30Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:38:32Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:38:32Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:38:32Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:38:32Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:38:32Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:32Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:38:32Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:32Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:38:32Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 366s time="2026-02-05T11:38:32Z" level=info msg="Reconnecting to Windows host in 2 seconds" 366s time="2026-02-05T11:38:32Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:38:32Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:38:32Z" level=info msg="Stopping active requests." 366s time="2026-02-05T11:38:32Z" level=debug msg="All connections have now ended." 366s time="2026-02-05T11:39:33Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 366s time="2026-02-05T11:39:33Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:39:33Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:39:33Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:33Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:33Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:33Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43735" 366s time="2026-02-05T11:39:34Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33563" 366s time="2026-02-05T11:39:34Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:39:34Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:39:34Z" 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:33563: connect: connection refused\"" 366s time="2026-02-05T11:39:34Z" level=info msg="Reconnecting to Windows host in 1 seconds" 366s time="2026-02-05T11:39:34Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:39:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 7067" 366s time="2026-02-05T11:39:35Z" level=debug msg="Updated systemd status to \"Connecting\"" 366s time="2026-02-05T11:39:36Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43735" 366s time="2026-02-05T11:39:36Z" level=info msg="Daemon: completed connection to Windows Agent" 366s time="2026-02-05T11:39:36Z" level=debug msg="Updated systemd status to \"Connected\"" 366s time="2026-02-05T11:39:36Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 366s time="2026-02-05T11:39:36Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 366s time="2026-02-05T11:39:37Z" level=debug msg="Server: sent preface messages to all streams" 366s time="2026-02-05T11:39:37Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:39:37Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:39:37Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:39:38Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:38Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:38Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:39:38Z" level=info msg="Stopping daemon requested." 366s time="2026-02-05T11:39:38Z" level=info msg="Stopping active requests." 366s time="2026-02-05T11:39:38Z" level=warning msg="Daemon: disconnected from Windows host" 366s time="2026-02-05T11:39:38Z" level=info msg="Reconnecting to Windows host in 2 seconds" 366s time="2026-02-05T11:39:38Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 366s time="2026-02-05T11:39:38Z" level=debug msg="Updated systemd status to \"Stopped\"" 366s time="2026-02-05T11:39:38Z" level=debug msg="All connections have now ended." 366s --- PASS: TestReconnection (0.00s) 366s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (23.61s) 366s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (23.04s) 366s --- PASS: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (91.13s) 366s PASS 366s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 145.075s 366s === RUN TestConnect 366s === PAUSE TestConnect 366s === RUN TestSendAndRecv 366s --- PASS: TestSendAndRecv (0.41s) 366s === RUN TestServe 366s === PAUSE TestServe 366s === RUN TestStop 366s === PAUSE TestStop 366s === RUN TestWithProMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithProMock (0.00s) 366s === RUN TestWithWslPathMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslPathMock (0.00s) 366s === RUN TestWithWslInfoMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslInfoMock (0.00s) 366s === RUN TestWithCmdExeMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithCmdExeMock (0.00s) 366s === CONT TestConnect 366s === RUN TestConnect/Success 366s === CONT TestStop 366s === PAUSE TestConnect/Success 366s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 366s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 366s === CONT TestConnect/Success 366s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 366s === CONT TestServe 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33443" 366s time="2026-02-05T11:37:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33093" 366s time="2026-02-05T11:37:27Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:37:27Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:37:27Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s time="2026-02-05T11:37:28Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 366s time="2026-02-05T11:37:28Z" level=info msg="MockWindowsAgent: Connected ready" 366s time="2026-02-05T11:37:28Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 366s --- PASS: TestConnect (0.00s) 366s --- PASS: TestConnect/Success (0.32s) 366s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.01s) 366s time="2026-02-05T11:37:38Z" level=warning msg="Streamserver: could not gather info after command completion: could not obtain pro status: pro status: /usr/bin/bash: error: context canceled.\n Stdout: \n Stderr: " 366s time="2026-02-05T11:37:38Z" level=warning msg="Streamserver: could not stream back info after command completion: EOF" 366s time="2026-02-05T11:37:38Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:38Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:38Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s --- PASS: TestStop (25.35s) 366s time="2026-02-05T11:37:53Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:53Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 366s time="2026-02-05T11:37:53Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 366s --- PASS: TestServe (40.63s) 366s PASS 366s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 41.109s 366s === RUN TestNew 366s === PAUSE TestNew 366s === RUN TestInfo 366s === PAUSE TestInfo 366s === RUN TestWslDistroName 366s === PAUSE TestWslDistroName 366s === RUN TestUserProfileDir 366s === PAUSE TestUserProfileDir 366s === RUN TestProStatus 366s === PAUSE TestProStatus 366s === RUN TestProAttach 366s === PAUSE TestProAttach 366s === RUN TestProDetach 366s === PAUSE TestProDetach 366s === RUN TestLandscapeEnable 366s === PAUSE TestLandscapeEnable 366s === RUN TestWindowsHostAddress 366s === PAUSE TestWindowsHostAddress 366s === RUN TestLandscapeDisable 366s === PAUSE TestLandscapeDisable 366s === RUN TestEnsureValidLandscapeConfig 366s === PAUSE TestEnsureValidLandscapeConfig 366s === RUN TestRealBackend 366s === PAUSE TestRealBackend 366s === RUN TestWithProMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithProMock (0.00s) 366s === RUN TestWithLandscapeConfigMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithLandscapeConfigMock (0.00s) 366s === RUN TestWithWslPathMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslPathMock (0.00s) 366s === RUN TestWithWslInfoMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithWslInfoMock (0.00s) 366s === RUN TestWithCmdExeMock 366s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 366s --- SKIP: TestWithCmdExeMock (0.00s) 366s === CONT TestNew 366s === RUN TestNew/Return_a_new_system 366s === PAUSE TestNew/Return_a_new_system 366s === RUN TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 366s === PAUSE TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 366s === CONT TestNew/Return_a_new_system 366s === CONT TestProAttach 366s === RUN TestProAttach/success 366s === PAUSE TestProAttach/success 366s === RUN TestProAttach/error_on_'pro_attach'_error 366s === PAUSE TestProAttach/error_on_'pro_attach'_error 366s === CONT TestProAttach/success 366s === CONT TestWslDistroName 366s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 366s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 366s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 366s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 366s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 366s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 366s === RUN TestWslDistroName/Success_using_wslpath 366s === PAUSE TestWslDistroName/Success_using_wslpath 366s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 366s === CONT TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 366s === CONT TestEnsureValidLandscapeConfig 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 366s === CONT TestProStatus 366s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 366s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 366s === RUN TestProStatus/error_on_'pro_attach'_error 366s === PAUSE TestProStatus/error_on_'pro_attach'_error 366s === RUN TestProStatus/success_on_unattached_distro 366s === PAUSE TestProStatus/success_on_unattached_distro 366s === RUN TestProStatus/success_on_attached_distro 366s === PAUSE TestProStatus/success_on_attached_distro 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 366s === RUN TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 366s === PAUSE TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 366s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === RUN TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 366s === PAUSE TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 366s === RUN TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 366s === PAUSE TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 366s === RUN TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 366s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 366s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 366s === RUN TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 366s === PAUSE TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 366s === RUN TestEnsureValidLandscapeConfig/Regular_with_additional_keys 366s === PAUSE TestEnsureValidLandscapeConfig/Regular_with_additional_keys 366s === RUN TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 366s === PAUSE TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 366s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 366s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 366s === RUN TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 366s === PAUSE TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 366s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 366s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 366s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 366s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 366s === CONT TestWindowsHostAddress 366s === RUN TestWindowsHostAddress/Without_NAT 366s === PAUSE TestWindowsHostAddress/Without_NAT 366s === RUN TestWindowsHostAddress/With_NAT 366s === PAUSE TestWindowsHostAddress/With_NAT 366s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 366s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 366s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 366s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 366s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 366s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 366s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 366s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 366s === CONT TestLandscapeDisable 366s === RUN TestLandscapeDisable/Success 366s === PAUSE TestLandscapeDisable/Success 366s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 366s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 366s === CONT TestLandscapeEnable 366s === RUN TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 366s === PAUSE TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 366s === RUN TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 366s === PAUSE TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 366s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 366s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 366s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 366s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 366s === RUN TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 366s === PAUSE TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 366s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 366s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 366s === RUN TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 366s === PAUSE TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 366s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path 366s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path 366s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === RUN TestLandscapeEnable/Do_not_modify_other_sections_and_keys 366s === PAUSE TestLandscapeEnable/Do_not_modify_other_sections_and_keys 366s === RUN TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 366s === PAUSE TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 366s === RUN TestLandscapeEnable/Rerun_landscape_even_without_modifications 366s === PAUSE TestLandscapeEnable/Rerun_landscape_even_without_modifications 366s === RUN TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 366s === PAUSE TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 366s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 366s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 366s === RUN TestLandscapeEnable/Refresh_computer_title_if_changed 366s === PAUSE TestLandscapeEnable/Refresh_computer_title_if_changed 366s === RUN TestLandscapeEnable/Regular_with_additional_keys 366s === PAUSE TestLandscapeEnable/Regular_with_additional_keys 366s === CONT TestProDetach 366s === RUN TestProDetach/success_on_unattached_distro 366s === PAUSE TestProDetach/success_on_unattached_distro 366s === RUN TestProDetach/success_on_attached_distro 366s === PAUSE TestProDetach/success_on_attached_distro 366s === CONT TestRealBackend 366s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 366s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 366s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 366s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 366s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 366s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 366s === CONT TestProAttach/error_on_'pro_attach'_error 366s === CONT TestWslDistroName/Success_using_wslpath 366s === CONT TestUserProfileDir 366s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 366s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 366s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 366s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 366s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 366s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 366s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 366s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 366s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 366s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 366s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 366s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 366s === RUN TestUserProfileDir/Error_on_wslpath_error 366s === PAUSE TestUserProfileDir/Error_on_wslpath_error 366s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 366s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 366s === RUN TestUserProfileDir/Error_on_cmd.exe_error 366s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 366s === RUN TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 366s === PAUSE TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 366s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 366s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 366s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 366s --- PASS: TestRealBackend (0.02s) 366s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 366s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 366s --- PASS: TestNew (0.00s) 366s --- PASS: TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) (1.14s) 366s --- PASS: TestNew/Return_a_new_system (1.42s) 366s === CONT TestWindowsHostAddress/Without_NAT 366s === CONT TestProStatus/success_on_attached_distro 366s === CONT TestProStatus/success_on_unattached_distro 366s === CONT TestProStatus/error_on_'pro_attach'_error 366s --- PASS: TestWslDistroName (0.00s) 366s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.95s) 366s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (11.93s) 366s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (12.29s) 366s --- PASS: TestWslDistroName/Success_using_wslpath (12.71s) 366s === CONT TestLandscapeDisable/Success 366s === CONT TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 366s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 366s === CONT TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 366s --- PASS: TestProAttach (0.00s) 366s --- PASS: TestProAttach/success (13.43s) 366s --- PASS: TestProAttach/error_on_'pro_attach'_error (14.03s) 366s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 366s === CONT TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 366s === CONT TestEnsureValidLandscapeConfig/Regular_with_additional_keys 366s === CONT TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_transform_windows_ssl_certificate_empty_path 366s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 366s --- PASS: TestProStatus (0.00s) 366s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (12.05s) 366s --- PASS: TestProStatus/success_on_attached_distro (11.57s) 366s --- PASS: TestProStatus/success_on_unattached_distro (8.48s) 366s --- PASS: TestProStatus/error_on_'pro_attach'_error (9.42s) 366s === CONT TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 366s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_without_modifications 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 366s === CONT TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 366s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_due_whitespace_changes 366s === CONT TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 366s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === NAME TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/refresh_computer_title_if_changed 366s === CONT TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 366s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 366s === CONT TestProDetach/success_on_unattached_distro 366s === NAME TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/appends_any_required_fields_-_no_ssl 366s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 366s === NAME TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_modify_other_sections_and_keys 366s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 366s === NAME TestEnsureValidLandscapeConfig/Regular_with_additional_keys 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/regular_with_additional_keys 366s === NAME TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/reformat_landscape_config_to_proper_ini 366s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 366s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path 366s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 366s === CONT TestWindowsHostAddress/With_NAT 366s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 366s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 366s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path_with_forward_slash 366s --- PASS: TestEnsureValidLandscapeConfig (0.00s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section (1.48s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name (8.12s) 366s --- PASS: TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path (0.25s) 366s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications (9.02s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist (9.54s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed (0.31s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read (0.27s) 366s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes (8.67s) 366s --- PASS: TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created (0.43s) 366s --- PASS: TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed (9.17s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path (11.72s) 366s --- PASS: TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl (10.52s) 366s --- PASS: TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys (15.64s) 366s --- PASS: TestEnsureValidLandscapeConfig/Regular_with_additional_keys (18.11s) 366s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path (17.97s) 366s --- PASS: TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini (16.81s) 366s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails (16.43s) 366s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash (17.85s) 366s === CONT TestLandscapeEnable/Regular_with_additional_keys 366s === CONT TestLandscapeEnable/Refresh_computer_title_if_changed 366s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 366s === CONT TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 366s === CONT TestLandscapeEnable/Rerun_landscape_even_without_modifications 366s === CONT TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 366s === CONT TestLandscapeEnable/Do_not_modify_other_sections_and_keys 366s --- PASS: TestLandscapeDisable (0.00s) 366s --- PASS: TestLandscapeDisable/Success (8.58s) 366s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (7.38s) 366s --- PASS: TestWindowsHostAddress (0.00s) 366s --- PASS: TestWindowsHostAddress/Without_NAT (11.51s) 366s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (7.87s) 366s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (6.64s) 366s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (6.46s) 366s --- PASS: TestWindowsHostAddress/With_NAT (6.61s) 366s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (8.02s) 366s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 366s === NAME TestLandscapeEnable/Refresh_computer_title_if_changed 366s system_test.go:526: testdata/TestLandscapeEnable/golden/refresh_computer_title_if_changed 366s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path 366s === CONT TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 366s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 366s === NAME TestLandscapeEnable/Regular_with_additional_keys 366s system_test.go:526: testdata/TestLandscapeEnable/golden/regular_with_additional_keys 366s === CONT TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 366s === NAME TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 366s system_test.go:526: testdata/TestLandscapeEnable/golden/appends_any_required_fields_-_no_ssl 366s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 366s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 366s === NAME TestLandscapeEnable/Rerun_landscape_even_without_modifications 366s system_test.go:526: testdata/TestLandscapeEnable/golden/rerun_landscape_even_without_modifications 366s === CONT TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 366s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 366s === NAME TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 366s system_test.go:526: testdata/TestLandscapeEnable/golden/reformat_landscape_config_to_proper_ini 366s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 366s === NAME TestLandscapeEnable/Do_not_modify_other_sections_and_keys 366s system_test.go:526: testdata/TestLandscapeEnable/golden/do_not_modify_other_sections_and_keys 366s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 366s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 366s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path 366s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path 366s === CONT TestProDetach/success_on_attached_distro 366s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 366s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path_with_forward_slash 366s === CONT TestInfo 366s === RUN TestInfo/Success 366s === PAUSE TestInfo/Success 366s === RUN TestInfo/Error_when_WslDistroName_fails 366s === PAUSE TestInfo/Error_when_WslDistroName_fails 366s === RUN TestInfo/Error_when_pro_status_command_fails 366s === PAUSE TestInfo/Error_when_pro_status_command_fails 366s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 366s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 366s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 366s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 366s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 366s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 366s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 366s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 366s === CONT TestUserProfileDir/Error_on_wslpath_error 366s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 366s === CONT TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 366s === CONT TestUserProfileDir/Error_on_cmd.exe_error 366s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 366s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 366s --- PASS: TestProDetach (0.00s) 366s --- PASS: TestProDetach/success_on_unattached_distro (8.67s) 366s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (4.86s) 366s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (4.63s) 366s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (4.09s) 366s --- PASS: TestProDetach/success_on_attached_distro (4.35s) 366s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 366s system_test.go:245: Removing default proc/mounts 366s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 366s system_test.go:245: Removing default proc/mounts 366s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 366s --- PASS: TestLandscapeEnable (0.00s) 366s --- PASS: TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed (0.18s) 366s --- PASS: TestLandscapeEnable/Refresh_computer_title_if_changed (6.79s) 366s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (6.67s) 366s --- PASS: TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created (6.96s) 366s --- PASS: TestLandscapeEnable/Regular_with_additional_keys (12.56s) 366s --- PASS: TestLandscapeEnable/Appends_any_required_fields_-_no_ssl (7.19s) 366s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (7.17s) 366s --- PASS: TestLandscapeEnable/Rerun_landscape_even_without_modifications (11.83s) 366s --- PASS: TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section (0.04s) 366s --- PASS: TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini (12.47s) 366s --- PASS: TestLandscapeEnable/Do_not_modify_other_sections_and_keys (12.30s) 366s --- PASS: TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name (7.15s) 366s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path (12.51s) 366s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash (13.53s) 366s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed (5.22s) 366s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (10.02s) 366s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 366s === CONT TestInfo/Success 366s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 366s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 366s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 366s === CONT TestInfo/Error_when_pro_status_command_fails 366s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 366s === CONT TestInfo/Error_when_WslDistroName_fails 366s --- PASS: TestUserProfileDir (0.00s) 366s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.03s) 366s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (0.01s) 366s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.00s) 366s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (9.32s) 366s --- PASS: TestUserProfileDir/Error_when_UserProfile_env_var_is_empty (3.95s) 366s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (4.74s) 366s --- PASS: TestUserProfileDir/Error_on_wslpath_error (7.95s) 366s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (8.82s) 366s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (7.88s) 366s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (7.58s) 366s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (6.90s) 366s --- PASS: TestInfo (0.00s) 366s --- PASS: TestInfo/Success (3.34s) 366s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (4.38s) 366s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (4.14s) 366s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (3.87s) 366s --- PASS: TestInfo/Error_when_pro_status_command_fails (2.84s) 366s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (2.46s) 366s --- PASS: TestInfo/Error_when_WslDistroName_fails (1.97s) 366s PASS 366s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 73.914s 366s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 366s autopkgtest [11:39:38]: test command1: -----------------------] 370s autopkgtest [11:39:42]: test command1: - - - - - - - - - - results - - - - - - - - - - 370s command1 PASS 374s autopkgtest [11:39:46]: @@@@@@@@@@@@@@@@@@@@ summary 374s command1 PASS