0s autopkgtest [18:22:39]: starting date and time: 2025-03-15 18:22:39+0000 0s autopkgtest [18:22:39]: git checkout: 325255d2 Merge branch 'pin-any-arch' into 'ubuntu/production' 0s autopkgtest [18:22:39]: host juju-7f2275-prod-proposed-migration-environment-9; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.3lw8wud0/out --timeout-copy=6000 --setup-commands 'ln -s /dev/null /etc/systemd/system/bluetooth.service; printf "http_proxy=http://squid.internal:3128\nhttps_proxy=http://squid.internal:3128\nno_proxy=127.0.0.1,127.0.1.1,login.ubuntu.com,localhost,localdomain,novalocal,internal,archive.ubuntu.com,ports.ubuntu.com,security.ubuntu.com,ddebs.ubuntu.com,changelogs.ubuntu.com,keyserver.ubuntu.com,launchpadlibrarian.net,launchpadcontent.net,launchpad.net,10.24.0.0/24,keystone.ps5.canonical.com,objectstorage.prodstack5.canonical.com,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.41-1ubuntu2 -- lxd -r lxd-armhf-10.145.243.9 lxd-armhf-10.145.243.9:autopkgtest/ubuntu/plucky/armhf 21s autopkgtest [18:23:00]: testbed dpkg architecture: armhf 23s autopkgtest [18:23:02]: testbed apt version: 2.9.33 27s autopkgtest [18:23:06]: @@@@@@@@@@@@@@@@@@@@ test bed setup 29s autopkgtest [18:23:08]: testbed release detected to be: None 37s autopkgtest [18:23:16]: updating testbed package index (apt update) 39s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed InRelease [126 kB] 39s Get:2 http://ftpmaster.internal/ubuntu plucky InRelease [257 kB] 40s Get:3 http://ftpmaster.internal/ubuntu plucky-updates InRelease [126 kB] 40s Get:4 http://ftpmaster.internal/ubuntu plucky-security InRelease [126 kB] 40s Get:5 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse Sources [15.8 kB] 40s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main Sources [99.7 kB] 40s Get:7 http://ftpmaster.internal/ubuntu plucky-proposed/universe Sources [379 kB] 40s Get:8 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf Packages [114 kB] 40s Get:9 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf c-n-f Metadata [1832 B] 40s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/restricted armhf c-n-f Metadata [116 B] 40s Get:11 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf Packages [312 kB] 40s Get:12 http://ftpmaster.internal/ubuntu plucky-proposed/universe armhf c-n-f Metadata [11.1 kB] 40s Get:13 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf Packages [3472 B] 40s Get:14 http://ftpmaster.internal/ubuntu plucky-proposed/multiverse armhf c-n-f Metadata [240 B] 40s Get:15 http://ftpmaster.internal/ubuntu plucky/multiverse Sources [299 kB] 40s Get:16 http://ftpmaster.internal/ubuntu plucky/main Sources [1394 kB] 40s Get:17 http://ftpmaster.internal/ubuntu plucky/universe Sources [21.0 MB] 42s Get:18 http://ftpmaster.internal/ubuntu plucky/main armhf Packages [1378 kB] 42s Get:19 http://ftpmaster.internal/ubuntu plucky/main armhf c-n-f Metadata [29.4 kB] 42s Get:20 http://ftpmaster.internal/ubuntu plucky/restricted armhf c-n-f Metadata [108 B] 42s Get:21 http://ftpmaster.internal/ubuntu plucky/universe armhf Packages [15.1 MB] 42s Get:22 http://ftpmaster.internal/ubuntu plucky/multiverse armhf Packages [172 kB] 46s Fetched 41.0 MB in 6s (6433 kB/s) 47s Reading package lists... 53s autopkgtest [18:23:32]: upgrading testbed (apt dist-upgrade and autopurge) 55s Reading package lists... 55s Building dependency tree... 55s Reading state information... 56s Calculating upgrade...Starting pkgProblemResolver with broken count: 0 56s Starting 2 pkgProblemResolver with broken count: 0 56s Done 56s Entering ResolveByKeep 57s 57s Calculating upgrade... 57s The following packages will be upgraded: 57s libc-bin libc6 locales pinentry-curses python3-jinja2 sos strace 58s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 58s Need to get 8683 kB of archives. 58s After this operation, 23.6 kB of additional disk space will be used. 58s Get:1 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc6 armhf 2.41-1ubuntu2 [2932 kB] 58s Get:2 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc-bin armhf 2.41-1ubuntu2 [545 kB] 58s Get:3 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf locales all 2.41-1ubuntu2 [4246 kB] 58s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf strace armhf 6.13+ds-1ubuntu1 [445 kB] 58s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf pinentry-curses armhf 1.3.1-2ubuntu3 [40.6 kB] 58s Get:6 http://ftpmaster.internal/ubuntu plucky/main armhf python3-jinja2 all 3.1.5-2ubuntu1 [109 kB] 58s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf sos all 4.9.0-5 [365 kB] 61s Preconfiguring packages ... 61s Fetched 8683 kB in 1s (8361 kB/s) 61s (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 ... 64655 files and directories currently installed.) 61s Preparing to unpack .../libc6_2.41-1ubuntu2_armhf.deb ... 61s Unpacking libc6:armhf (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 61s Setting up libc6:armhf (2.41-1ubuntu2) ... 61s (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 ... 64655 files and directories currently installed.) 61s Preparing to unpack .../libc-bin_2.41-1ubuntu2_armhf.deb ... 61s Unpacking libc-bin (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 61s Setting up libc-bin (2.41-1ubuntu2) ... 61s (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 ... 64655 files and directories currently installed.) 61s Preparing to unpack .../locales_2.41-1ubuntu2_all.deb ... 61s Unpacking locales (2.41-1ubuntu2) over (2.41-1ubuntu1) ... 61s Preparing to unpack .../strace_6.13+ds-1ubuntu1_armhf.deb ... 61s Unpacking strace (6.13+ds-1ubuntu1) over (6.11-0ubuntu1) ... 61s Preparing to unpack .../pinentry-curses_1.3.1-2ubuntu3_armhf.deb ... 61s Unpacking pinentry-curses (1.3.1-2ubuntu3) over (1.3.1-2ubuntu2) ... 61s Preparing to unpack .../python3-jinja2_3.1.5-2ubuntu1_all.deb ... 61s Unpacking python3-jinja2 (3.1.5-2ubuntu1) over (3.1.5-2) ... 61s Preparing to unpack .../archives/sos_4.9.0-5_all.deb ... 61s Unpacking sos (4.9.0-5) over (4.9.0-4) ... 61s Setting up sos (4.9.0-5) ... 62s Setting up pinentry-curses (1.3.1-2ubuntu3) ... 62s Setting up locales (2.41-1ubuntu2) ... 62s Generating locales (this might take a while)... 64s en_US.UTF-8... done 64s Generation complete. 64s Setting up python3-jinja2 (3.1.5-2ubuntu1) ... 64s Setting up strace (6.13+ds-1ubuntu1) ... 64s Processing triggers for man-db (2.13.0-1) ... 65s Processing triggers for systemd (257.3-1ubuntu3) ... 68s Reading package lists... 68s Building dependency tree... 68s Reading state information... 68s Starting pkgProblemResolver with broken count: 0 69s Starting 2 pkgProblemResolver with broken count: 0 69s Done 69s Solving dependencies... 69s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 72s autopkgtest [18:23:51]: rebooting testbed after setup commands that affected boot 117s autopkgtest [18:24:36]: testbed running kernel: Linux 6.8.0-52-generic #53~22.04.1-Ubuntu SMP PREEMPT_DYNAMIC Wed Jan 15 18:10:51 UTC 2 152s autopkgtest [18:25:11]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 163s Get:1 http://ftpmaster.internal/ubuntu plucky/main wsl-pro-service 0.1.5 (dsc) [1422 B] 163s Get:2 http://ftpmaster.internal/ubuntu plucky/main wsl-pro-service 0.1.5 (tar) [1790 kB] 163s gpgv: Signature made Tue Sep 10 12:05:15 2024 UTC 163s gpgv: using DSA key DD00EF8F4D23C30D78EC990998B24A9CE4AC208E 163s gpgv: Can't check signature: No public key 163s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.5.dsc: no acceptable signature found 163s autopkgtest [18:25:22]: testing package wsl-pro-service version 0.1.5 166s autopkgtest [18:25:25]: build not needed 172s autopkgtest [18:25:31]: test command1: preparing testbed 175s Reading package lists... 175s Building dependency tree... 175s Reading state information... 175s Starting pkgProblemResolver with broken count: 0 175s Starting 2 pkgProblemResolver with broken count: 0 175s Done 176s The following NEW packages will be installed: 176s autoconf automake autopoint autotools-dev build-essential cpp cpp-14 176s cpp-14-arm-linux-gnueabihf cpp-arm-linux-gnueabihf debhelper debugedit 176s dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-14 176s g++-14-arm-linux-gnueabihf g++-arm-linux-gnueabihf gcc gcc-14 176s gcc-14-arm-linux-gnueabihf gcc-arm-linux-gnueabihf gettext golang-1.24-go 176s golang-1.24-src golang-go golang-src intltool-debian libarchive-zip-perl 176s libasan8 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev libdebhelper-perl 176s libdw1t64 libfile-stripnondeterminism-perl libgcc-14-dev libgomp1 libisl23 176s libmpc3 libstdc++-14-dev libtool libubsan1 linux-libc-dev m4 po-debconf 176s rpcsvc-proto 176s 0 upgraded, 50 newly installed, 0 to remove and 0 not upgraded. 176s Need to get 104 MB of archives. 176s After this operation, 415 MB of additional disk space will be used. 176s Get:1 http://ftpmaster.internal/ubuntu plucky/main armhf m4 armhf 1.4.19-7 [238 kB] 177s Get:2 http://ftpmaster.internal/ubuntu plucky/main armhf autoconf all 2.72-3ubuntu1 [383 kB] 177s Get:3 http://ftpmaster.internal/ubuntu plucky/main armhf autotools-dev all 20220109.1 [44.9 kB] 177s Get:4 http://ftpmaster.internal/ubuntu plucky/main armhf automake all 1:1.17-3ubuntu1 [572 kB] 177s Get:5 http://ftpmaster.internal/ubuntu plucky/main armhf autopoint all 0.23.1-1 [619 kB] 177s Get:6 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc-dev-bin armhf 2.41-1ubuntu2 [23.0 kB] 177s Get:7 http://ftpmaster.internal/ubuntu plucky/main armhf linux-libc-dev armhf 6.14.0-10.10 [1683 kB] 177s Get:8 http://ftpmaster.internal/ubuntu plucky/main armhf libcrypt-dev armhf 1:4.4.38-1 [120 kB] 177s Get:9 http://ftpmaster.internal/ubuntu plucky/main armhf rpcsvc-proto armhf 1.4.2-0ubuntu7 [62.2 kB] 177s Get:10 http://ftpmaster.internal/ubuntu plucky-proposed/main armhf libc6-dev armhf 2.41-1ubuntu2 [1396 kB] 177s Get:11 http://ftpmaster.internal/ubuntu plucky/main armhf libisl23 armhf 0.27-1 [546 kB] 177s Get:12 http://ftpmaster.internal/ubuntu plucky/main armhf libmpc3 armhf 1.3.1-1build2 [47.1 kB] 177s Get:13 http://ftpmaster.internal/ubuntu plucky/main armhf cpp-14-arm-linux-gnueabihf armhf 14.2.0-17ubuntu3 [9220 kB] 177s Get:14 http://ftpmaster.internal/ubuntu plucky/main armhf cpp-14 armhf 14.2.0-17ubuntu3 [1030 B] 177s Get:15 http://ftpmaster.internal/ubuntu plucky/main armhf cpp-arm-linux-gnueabihf armhf 4:14.2.0-1ubuntu1 [5578 B] 177s Get:16 http://ftpmaster.internal/ubuntu plucky/main armhf cpp armhf 4:14.2.0-1ubuntu1 [22.4 kB] 177s Get:17 http://ftpmaster.internal/ubuntu plucky/main armhf libcc1-0 armhf 15-20250222-0ubuntu1 [38.9 kB] 177s Get:18 http://ftpmaster.internal/ubuntu plucky/main armhf libgomp1 armhf 15-20250222-0ubuntu1 [128 kB] 177s Get:19 http://ftpmaster.internal/ubuntu plucky/main armhf libasan8 armhf 15-20250222-0ubuntu1 [2955 kB] 178s Get:20 http://ftpmaster.internal/ubuntu plucky/main armhf libubsan1 armhf 15-20250222-0ubuntu1 [1191 kB] 178s Get:21 http://ftpmaster.internal/ubuntu plucky/main armhf libgcc-14-dev armhf 14.2.0-17ubuntu3 [897 kB] 178s Get:22 http://ftpmaster.internal/ubuntu plucky/main armhf gcc-14-arm-linux-gnueabihf armhf 14.2.0-17ubuntu3 [18.0 MB] 179s Get:23 http://ftpmaster.internal/ubuntu plucky/main armhf gcc-14 armhf 14.2.0-17ubuntu3 [506 kB] 179s Get:24 http://ftpmaster.internal/ubuntu plucky/main armhf gcc-arm-linux-gnueabihf armhf 4:14.2.0-1ubuntu1 [1218 B] 179s Get:25 http://ftpmaster.internal/ubuntu plucky/main armhf gcc armhf 4:14.2.0-1ubuntu1 [5004 B] 179s Get:26 http://ftpmaster.internal/ubuntu plucky/main armhf libstdc++-14-dev armhf 14.2.0-17ubuntu3 [2573 kB] 179s Get:27 http://ftpmaster.internal/ubuntu plucky/main armhf g++-14-arm-linux-gnueabihf armhf 14.2.0-17ubuntu3 [10.5 MB] 179s Get:28 http://ftpmaster.internal/ubuntu plucky/main armhf g++-14 armhf 14.2.0-17ubuntu3 [21.8 kB] 179s Get:29 http://ftpmaster.internal/ubuntu plucky/main armhf g++-arm-linux-gnueabihf armhf 4:14.2.0-1ubuntu1 [966 B] 179s Get:30 http://ftpmaster.internal/ubuntu plucky/main armhf g++ armhf 4:14.2.0-1ubuntu1 [1084 B] 179s Get:31 http://ftpmaster.internal/ubuntu plucky/main armhf build-essential armhf 12.10ubuntu1 [4928 B] 179s Get:32 http://ftpmaster.internal/ubuntu plucky/main armhf libdebhelper-perl all 13.24.1ubuntu2 [95.4 kB] 179s Get:33 http://ftpmaster.internal/ubuntu plucky/main armhf libtool all 2.5.4-4 [168 kB] 179s Get:34 http://ftpmaster.internal/ubuntu plucky/main armhf dh-autoreconf all 20 [16.1 kB] 179s Get:35 http://ftpmaster.internal/ubuntu plucky/main armhf libarchive-zip-perl all 1.68-1 [90.2 kB] 179s Get:36 http://ftpmaster.internal/ubuntu plucky/main armhf libfile-stripnondeterminism-perl all 1.14.1-2 [20.3 kB] 180s Get:37 http://ftpmaster.internal/ubuntu plucky/main armhf dh-strip-nondeterminism all 1.14.1-2 [5064 B] 180s Get:38 http://ftpmaster.internal/ubuntu plucky/main armhf libdw1t64 armhf 0.192-4 [243 kB] 180s Get:39 http://ftpmaster.internal/ubuntu plucky/main armhf debugedit armhf 1:5.1-2 [46.7 kB] 180s Get:40 http://ftpmaster.internal/ubuntu plucky/main armhf dwz armhf 0.15-1build6 [116 kB] 180s Get:41 http://ftpmaster.internal/ubuntu plucky/main armhf gettext armhf 0.23.1-1 [1053 kB] 180s Get:42 http://ftpmaster.internal/ubuntu plucky/main armhf intltool-debian all 0.35.0+20060710.6 [23.2 kB] 180s Get:43 http://ftpmaster.internal/ubuntu plucky/main armhf po-debconf all 1.0.21+nmu1 [233 kB] 180s Get:44 http://ftpmaster.internal/ubuntu plucky/main armhf debhelper all 13.24.1ubuntu2 [895 kB] 180s Get:45 http://ftpmaster.internal/ubuntu plucky/universe armhf dh-apport all 2.32.0-0ubuntu2 [19.3 kB] 180s Get:46 http://ftpmaster.internal/ubuntu plucky/main armhf golang-1.24-src all 1.24.1-1 [22.0 MB] 181s Get:47 http://ftpmaster.internal/ubuntu plucky/main armhf golang-1.24-go armhf 1.24.1-1 [26.9 MB] 183s Get:48 http://ftpmaster.internal/ubuntu plucky/main armhf golang-src all 2:1.24~2 [5136 B] 183s Get:49 http://ftpmaster.internal/ubuntu plucky/main armhf golang-go armhf 2:1.24~2 [44.0 kB] 183s Get:50 http://ftpmaster.internal/ubuntu plucky/main armhf dh-golang all 1.63 [24.9 kB] 183s Fetched 104 MB in 7s (15.7 MB/s) 183s Selecting previously unselected package m4. 183s (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 ... 64655 files and directories currently installed.) 183s Preparing to unpack .../00-m4_1.4.19-7_armhf.deb ... 183s Unpacking m4 (1.4.19-7) ... 183s Selecting previously unselected package autoconf. 183s Preparing to unpack .../01-autoconf_2.72-3ubuntu1_all.deb ... 183s Unpacking autoconf (2.72-3ubuntu1) ... 183s Selecting previously unselected package autotools-dev. 183s Preparing to unpack .../02-autotools-dev_20220109.1_all.deb ... 183s Unpacking autotools-dev (20220109.1) ... 183s Selecting previously unselected package automake. 183s Preparing to unpack .../03-automake_1%3a1.17-3ubuntu1_all.deb ... 183s Unpacking automake (1:1.17-3ubuntu1) ... 183s Selecting previously unselected package autopoint. 183s Preparing to unpack .../04-autopoint_0.23.1-1_all.deb ... 183s Unpacking autopoint (0.23.1-1) ... 183s Selecting previously unselected package libc-dev-bin. 183s Preparing to unpack .../05-libc-dev-bin_2.41-1ubuntu2_armhf.deb ... 183s Unpacking libc-dev-bin (2.41-1ubuntu2) ... 183s Selecting previously unselected package linux-libc-dev:armhf. 183s Preparing to unpack .../06-linux-libc-dev_6.14.0-10.10_armhf.deb ... 183s Unpacking linux-libc-dev:armhf (6.14.0-10.10) ... 184s Selecting previously unselected package libcrypt-dev:armhf. 184s Preparing to unpack .../07-libcrypt-dev_1%3a4.4.38-1_armhf.deb ... 184s Unpacking libcrypt-dev:armhf (1:4.4.38-1) ... 184s Selecting previously unselected package rpcsvc-proto. 184s Preparing to unpack .../08-rpcsvc-proto_1.4.2-0ubuntu7_armhf.deb ... 184s Unpacking rpcsvc-proto (1.4.2-0ubuntu7) ... 184s Selecting previously unselected package libc6-dev:armhf. 184s Preparing to unpack .../09-libc6-dev_2.41-1ubuntu2_armhf.deb ... 184s Unpacking libc6-dev:armhf (2.41-1ubuntu2) ... 184s Selecting previously unselected package libisl23:armhf. 184s Preparing to unpack .../10-libisl23_0.27-1_armhf.deb ... 184s Unpacking libisl23:armhf (0.27-1) ... 184s Selecting previously unselected package libmpc3:armhf. 184s Preparing to unpack .../11-libmpc3_1.3.1-1build2_armhf.deb ... 184s Unpacking libmpc3:armhf (1.3.1-1build2) ... 184s Selecting previously unselected package cpp-14-arm-linux-gnueabihf. 184s Preparing to unpack .../12-cpp-14-arm-linux-gnueabihf_14.2.0-17ubuntu3_armhf.deb ... 184s Unpacking cpp-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 184s Selecting previously unselected package cpp-14. 184s Preparing to unpack .../13-cpp-14_14.2.0-17ubuntu3_armhf.deb ... 184s Unpacking cpp-14 (14.2.0-17ubuntu3) ... 184s Selecting previously unselected package cpp-arm-linux-gnueabihf. 184s Preparing to unpack .../14-cpp-arm-linux-gnueabihf_4%3a14.2.0-1ubuntu1_armhf.deb ... 184s Unpacking cpp-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 184s Selecting previously unselected package cpp. 184s Preparing to unpack .../15-cpp_4%3a14.2.0-1ubuntu1_armhf.deb ... 184s Unpacking cpp (4:14.2.0-1ubuntu1) ... 184s Selecting previously unselected package libcc1-0:armhf. 184s Preparing to unpack .../16-libcc1-0_15-20250222-0ubuntu1_armhf.deb ... 184s Unpacking libcc1-0:armhf (15-20250222-0ubuntu1) ... 184s Selecting previously unselected package libgomp1:armhf. 184s Preparing to unpack .../17-libgomp1_15-20250222-0ubuntu1_armhf.deb ... 184s Unpacking libgomp1:armhf (15-20250222-0ubuntu1) ... 184s Selecting previously unselected package libasan8:armhf. 184s Preparing to unpack .../18-libasan8_15-20250222-0ubuntu1_armhf.deb ... 184s Unpacking libasan8:armhf (15-20250222-0ubuntu1) ... 184s Selecting previously unselected package libubsan1:armhf. 184s Preparing to unpack .../19-libubsan1_15-20250222-0ubuntu1_armhf.deb ... 184s Unpacking libubsan1:armhf (15-20250222-0ubuntu1) ... 184s Selecting previously unselected package libgcc-14-dev:armhf. 184s Preparing to unpack .../20-libgcc-14-dev_14.2.0-17ubuntu3_armhf.deb ... 184s Unpacking libgcc-14-dev:armhf (14.2.0-17ubuntu3) ... 184s Selecting previously unselected package gcc-14-arm-linux-gnueabihf. 184s Preparing to unpack .../21-gcc-14-arm-linux-gnueabihf_14.2.0-17ubuntu3_armhf.deb ... 184s Unpacking gcc-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 185s Selecting previously unselected package gcc-14. 185s Preparing to unpack .../22-gcc-14_14.2.0-17ubuntu3_armhf.deb ... 185s Unpacking gcc-14 (14.2.0-17ubuntu3) ... 185s Selecting previously unselected package gcc-arm-linux-gnueabihf. 185s Preparing to unpack .../23-gcc-arm-linux-gnueabihf_4%3a14.2.0-1ubuntu1_armhf.deb ... 185s Unpacking gcc-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 185s Selecting previously unselected package gcc. 185s Preparing to unpack .../24-gcc_4%3a14.2.0-1ubuntu1_armhf.deb ... 185s Unpacking gcc (4:14.2.0-1ubuntu1) ... 185s Selecting previously unselected package libstdc++-14-dev:armhf. 185s Preparing to unpack .../25-libstdc++-14-dev_14.2.0-17ubuntu3_armhf.deb ... 185s Unpacking libstdc++-14-dev:armhf (14.2.0-17ubuntu3) ... 185s Selecting previously unselected package g++-14-arm-linux-gnueabihf. 185s Preparing to unpack .../26-g++-14-arm-linux-gnueabihf_14.2.0-17ubuntu3_armhf.deb ... 185s Unpacking g++-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 185s Selecting previously unselected package g++-14. 185s Preparing to unpack .../27-g++-14_14.2.0-17ubuntu3_armhf.deb ... 185s Unpacking g++-14 (14.2.0-17ubuntu3) ... 185s Selecting previously unselected package g++-arm-linux-gnueabihf. 185s Preparing to unpack .../28-g++-arm-linux-gnueabihf_4%3a14.2.0-1ubuntu1_armhf.deb ... 185s Unpacking g++-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 185s Selecting previously unselected package g++. 185s Preparing to unpack .../29-g++_4%3a14.2.0-1ubuntu1_armhf.deb ... 185s Unpacking g++ (4:14.2.0-1ubuntu1) ... 186s Selecting previously unselected package build-essential. 186s Preparing to unpack .../30-build-essential_12.10ubuntu1_armhf.deb ... 186s Unpacking build-essential (12.10ubuntu1) ... 186s Selecting previously unselected package libdebhelper-perl. 186s Preparing to unpack .../31-libdebhelper-perl_13.24.1ubuntu2_all.deb ... 186s Unpacking libdebhelper-perl (13.24.1ubuntu2) ... 186s Selecting previously unselected package libtool. 186s Preparing to unpack .../32-libtool_2.5.4-4_all.deb ... 186s Unpacking libtool (2.5.4-4) ... 186s Selecting previously unselected package dh-autoreconf. 186s Preparing to unpack .../33-dh-autoreconf_20_all.deb ... 186s Unpacking dh-autoreconf (20) ... 186s Selecting previously unselected package libarchive-zip-perl. 186s Preparing to unpack .../34-libarchive-zip-perl_1.68-1_all.deb ... 186s Unpacking libarchive-zip-perl (1.68-1) ... 186s Selecting previously unselected package libfile-stripnondeterminism-perl. 186s Preparing to unpack .../35-libfile-stripnondeterminism-perl_1.14.1-2_all.deb ... 186s Unpacking libfile-stripnondeterminism-perl (1.14.1-2) ... 186s Selecting previously unselected package dh-strip-nondeterminism. 186s Preparing to unpack .../36-dh-strip-nondeterminism_1.14.1-2_all.deb ... 186s Unpacking dh-strip-nondeterminism (1.14.1-2) ... 186s Selecting previously unselected package libdw1t64:armhf. 186s Preparing to unpack .../37-libdw1t64_0.192-4_armhf.deb ... 186s Unpacking libdw1t64:armhf (0.192-4) ... 186s Selecting previously unselected package debugedit. 186s Preparing to unpack .../38-debugedit_1%3a5.1-2_armhf.deb ... 186s Unpacking debugedit (1:5.1-2) ... 186s Selecting previously unselected package dwz. 186s Preparing to unpack .../39-dwz_0.15-1build6_armhf.deb ... 186s Unpacking dwz (0.15-1build6) ... 186s Selecting previously unselected package gettext. 186s Preparing to unpack .../40-gettext_0.23.1-1_armhf.deb ... 186s Unpacking gettext (0.23.1-1) ... 186s Selecting previously unselected package intltool-debian. 186s Preparing to unpack .../41-intltool-debian_0.35.0+20060710.6_all.deb ... 186s Unpacking intltool-debian (0.35.0+20060710.6) ... 186s Selecting previously unselected package po-debconf. 186s Preparing to unpack .../42-po-debconf_1.0.21+nmu1_all.deb ... 186s Unpacking po-debconf (1.0.21+nmu1) ... 186s Selecting previously unselected package debhelper. 186s Preparing to unpack .../43-debhelper_13.24.1ubuntu2_all.deb ... 186s Unpacking debhelper (13.24.1ubuntu2) ... 186s Selecting previously unselected package dh-apport. 186s Preparing to unpack .../44-dh-apport_2.32.0-0ubuntu2_all.deb ... 186s Unpacking dh-apport (2.32.0-0ubuntu2) ... 186s Selecting previously unselected package golang-1.24-src. 186s Preparing to unpack .../45-golang-1.24-src_1.24.1-1_all.deb ... 186s Unpacking golang-1.24-src (1.24.1-1) ... 189s Selecting previously unselected package golang-1.24-go. 189s Preparing to unpack .../46-golang-1.24-go_1.24.1-1_armhf.deb ... 189s Unpacking golang-1.24-go (1.24.1-1) ... 189s Selecting previously unselected package golang-src. 189s Preparing to unpack .../47-golang-src_2%3a1.24~2_all.deb ... 189s Unpacking golang-src (2:1.24~2) ... 189s Selecting previously unselected package golang-go:armhf. 189s Preparing to unpack .../48-golang-go_2%3a1.24~2_armhf.deb ... 189s Unpacking golang-go:armhf (2:1.24~2) ... 189s Selecting previously unselected package dh-golang. 189s Preparing to unpack .../49-dh-golang_1.63_all.deb ... 189s Unpacking dh-golang (1.63) ... 189s Setting up golang-1.24-src (1.24.1-1) ... 189s Setting up libarchive-zip-perl (1.68-1) ... 189s Setting up libdebhelper-perl (13.24.1ubuntu2) ... 189s Setting up linux-libc-dev:armhf (6.14.0-10.10) ... 189s Setting up m4 (1.4.19-7) ... 189s Setting up libgomp1:armhf (15-20250222-0ubuntu1) ... 189s Setting up dh-apport (2.32.0-0ubuntu2) ... 189s Setting up libdw1t64:armhf (0.192-4) ... 189s Setting up autotools-dev (20220109.1) ... 189s Setting up rpcsvc-proto (1.4.2-0ubuntu7) ... 189s Setting up libmpc3:armhf (1.3.1-1build2) ... 189s Setting up autopoint (0.23.1-1) ... 189s Setting up golang-1.24-go (1.24.1-1) ... 189s Setting up autoconf (2.72-3ubuntu1) ... 189s Setting up libubsan1:armhf (15-20250222-0ubuntu1) ... 189s Setting up dwz (0.15-1build6) ... 189s Setting up libcrypt-dev:armhf (1:4.4.38-1) ... 189s Setting up libasan8:armhf (15-20250222-0ubuntu1) ... 190s Setting up debugedit (1:5.1-2) ... 190s Setting up libgcc-14-dev:armhf (14.2.0-17ubuntu3) ... 190s Setting up libisl23:armhf (0.27-1) ... 190s Setting up libc-dev-bin (2.41-1ubuntu2) ... 190s Setting up golang-src (2:1.24~2) ... 190s Setting up libcc1-0:armhf (15-20250222-0ubuntu1) ... 190s Setting up cpp-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 190s Setting up automake (1:1.17-3ubuntu1) ... 190s update-alternatives: using /usr/bin/automake-1.17 to provide /usr/bin/automake (automake) in auto mode 190s Setting up libfile-stripnondeterminism-perl (1.14.1-2) ... 190s Setting up gettext (0.23.1-1) ... 190s Setting up golang-go:armhf (2:1.24~2) ... 190s Setting up gcc-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 190s Setting up intltool-debian (0.35.0+20060710.6) ... 190s Setting up cpp-14 (14.2.0-17ubuntu3) ... 190s Setting up dh-strip-nondeterminism (1.14.1-2) ... 190s Setting up libc6-dev:armhf (2.41-1ubuntu2) ... 190s Setting up libstdc++-14-dev:armhf (14.2.0-17ubuntu3) ... 190s Setting up cpp-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 190s Setting up gcc-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 190s Setting up g++-14-arm-linux-gnueabihf (14.2.0-17ubuntu3) ... 190s Setting up po-debconf (1.0.21+nmu1) ... 190s Setting up gcc-14 (14.2.0-17ubuntu3) ... 190s Setting up cpp (4:14.2.0-1ubuntu1) ... 190s Setting up g++-14 (14.2.0-17ubuntu3) ... 190s Setting up g++-arm-linux-gnueabihf (4:14.2.0-1ubuntu1) ... 190s Setting up libtool (2.5.4-4) ... 190s Setting up gcc (4:14.2.0-1ubuntu1) ... 190s Setting up dh-autoreconf (20) ... 190s Setting up g++ (4:14.2.0-1ubuntu1) ... 190s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 190s Setting up build-essential (12.10ubuntu1) ... 190s Setting up debhelper (13.24.1ubuntu2) ... 190s Setting up dh-golang (1.63) ... 190s Processing triggers for man-db (2.13.0-1) ... 191s Processing triggers for install-info (7.1.1-1) ... 191s Processing triggers for libc-bin (2.41-1ubuntu2) ... 197s autopkgtest [18:25:56]: test command1: ./debian/tests/test 197s autopkgtest [18:25:56]: test command1: [----------------------- 223s === RUN TestRunSignal 223s === RUN TestRunSignal/Send_SIGINT_exits 223s INFO Starting WSL Pro Service version Dev 223s === RUN TestRunSignal/Send_SIGTERM_exits 223s INFO Starting WSL Pro Service version Dev 223s --- PASS: TestRunSignal (0.21s) 223s --- PASS: TestRunSignal/Send_SIGINT_exits (0.10s) 223s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.10s) 223s === RUN TestRun 223s === PAUSE TestRun 223s === CONT TestRun 223s === RUN TestRun/Run_and_exit_successfully 223s === PAUSE TestRun/Run_and_exit_successfully 223s === RUN TestRun/Run_and_return_error 223s === PAUSE TestRun/Run_and_return_error 223s === RUN TestRun/Run_and_return_usage_error 223s === PAUSE TestRun/Run_and_return_usage_error 223s === RUN TestRun/Run_and_usage_error_only_does_not_fail 223s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 223s === CONT TestRun/Run_and_exit_successfully 223s === CONT TestRun/Run_and_return_usage_error 223s === CONT TestRun/Run_and_usage_error_only_does_not_fail 223s INFO Starting WSL Pro Service version Dev 223s INFO Starting WSL Pro Service version Dev 223s INFO Starting WSL Pro Service version Dev 223s === CONT TestRun/Run_and_return_error 223s INFO Starting WSL Pro Service version Dev 223s ERROR context.Background Error requested 223s ERROR context.Background Error requested 223s --- PASS: TestRun (0.00s) 223s --- PASS: TestRun/Run_and_exit_successfully (0.10s) 223s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.10s) 223s --- PASS: TestRun/Run_and_return_usage_error (0.10s) 223s --- PASS: TestRun/Run_and_return_error (0.10s) 223s PASS 223s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 0.352s 260s === RUN TestHelp 260s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 260s --- PASS: TestHelp (1.11s) 260s === RUN TestCompletion 260s time="2025-03-15T18:26:23Z" level=debug msg="No Landscape configuration detected: nothing to do" 260s --- PASS: TestCompletion (0.37s) 260s === RUN TestVersion 260s --- PASS: TestVersion (1.36s) 260s === RUN TestConfigBadArg 260s --- PASS: TestConfigBadArg (1.33s) 260s === RUN TestConfigArg 260s --- PASS: TestConfigArg (0.39s) 260s === RUN TestConfigAutoDetect 260s time="2025-03-15T18:26:26Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 260s --- PASS: TestConfigAutoDetect (0.84s) 260s === RUN TestNoUsageError 260s time="2025-03-15T18:26:27Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:27Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 260s --- PASS: TestNoUsageError (0.56s) 260s === RUN TestUsageError 260s === PAUSE TestUsageError 260s === RUN TestCanQuitWhenExecute 260s === PAUSE TestCanQuitWhenExecute 260s === RUN TestCanQuitTwice 260s === PAUSE TestCanQuitTwice 260s === RUN TestAppCanQuitWithoutExecute 260s === PAUSE TestAppCanQuitWithoutExecute 260s === RUN TestAppRunFailsOnComponentsCreationAndQuit 260s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 260s === RUN TestAppGetRootCmd 260s === PAUSE TestAppGetRootCmd 260s === RUN TestWithProMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithProMock (0.00s) 260s === RUN TestWithWslPathMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithWslPathMock (0.00s) 260s === RUN TestWithWslInfoMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithWslInfoMock (0.00s) 260s === RUN TestWithCmdExeMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithCmdExeMock (0.00s) 260s === CONT TestUsageError 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s === CONT TestAppGetRootCmd 260s === CONT TestAppRunFailsOnComponentsCreationAndQuit 260s === CONT TestAppCanQuitWithoutExecute 260s === CONT TestCanQuitTwice 260s === CONT TestCanQuitWhenExecute 260s === NAME TestAppCanQuitWithoutExecute 260s service_test.go:190: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 260s --- SKIP: TestAppCanQuitWithoutExecute (0.01s) 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s --- PASS: TestAppGetRootCmd (0.08s) 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37889" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:74 New() Building new daemon" 260s --- PASS: TestUsageError (0.20s) 260s time="2025-03-15T18:26:28Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44939" 260s time="2025-03-15T18:26:28Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build1832364060/b377/wsl-pro-service.yaml" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:74 New() Building new daemon" 260s time="2025-03-15T18:26:28Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44467" 260s time="2025-03-15T18:26:28Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build1832364060/b377/wsl-pro-service.yaml" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/system/landscape.go:43 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 260s time="2025-03-15T18:26:28Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:74 New() Building new daemon" 260s time="2025-03-15T18:26:45Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:152 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:152 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:46Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:152 (*Daemon).Serve.func1() Daemon: connecting to Windows Agent" 260s time="2025-03-15T18:26:53Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:290 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:44939" 260s time="2025-03-15T18:26:53Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:172 (*Daemon).Serve.func1() Daemon: completed connection to Windows Agent" 260s time="2025-03-15T18:26:53Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.ProAttachCmd requests" 260s time="2025-03-15T18:26:53Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.LandscapeConfigCmd requests" 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:290 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:44467" 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:172 (*Daemon).Serve.func1() Daemon: completed connection to Windows Agent" 260s time="2025-03-15T18:26:54Z" level=warning msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:183 (*Daemon).Serve.func1() Daemon: disconnected from Windows host: could not start serving: could not connect: could not connect to GRPC service: rpc error: code = Unavailable desc = connection error: desc = \"transport: Error while dialing: dial tcp 127.0.0.1:44467: connect: connection refused\"" 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:208 (*Daemon).Serve() Reconnecting to Windows host in 1 seconds" 260s time="2025-03-15T18:26:54Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:54Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s --- PASS: TestCanQuitWhenExecute (26.03s) 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:54Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:54Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (26.32s) 260s time="2025-03-15T18:26:59Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/streams/server.go:146 (*Server).Serve() Server: sent preface messages to all streams" 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:326 (*mockWSLInstanceService).LandscapeConfigCommands() MockWindowsAgent: LandscapeConfigCommands ready" 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:275 (*mockWSLInstanceService).Connected() MockWindowsAgent: Connected ready" 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/testutils/mock_agent.go:300 (*mockWSLInstanceService).ProAttachmentCommands() MockWindowsAgent: ProAttachmentCommands ready" 260s time="2025-03-15T18:26:59Z" level=warning msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:185 (*Daemon).Serve.func1() Daemon: disconnected from Windows host" 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:208 (*Daemon).Serve() Reconnecting to Windows host in 1 seconds" 260s time="2025-03-15T18:26:59Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:59Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s time="2025-03-15T18:26:59Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.LgoN7t/build.On7/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 260s time="2025-03-15T18:26:59Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.LgoN7t/build.On7/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 260s time="2025-03-15T18:26:59Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.LgoN7t/build.On7/src/vendor/github.com/ubuntu/decorate/decorate.go:27" 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:219 (*Daemon).Quit() Stopping daemon requested." 260s time="2025-03-15T18:26:59Z" level=info msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:225 (*Daemon).Quit() Waiting for active requests to close." 260s time="2025-03-15T18:26:59Z" level=debug msg="/tmp/autopkgtest.LgoN7t/build.On7/src/internal/daemon/daemon.go:233 (*Daemon).Quit() All connections have now ended." 260s --- PASS: TestCanQuitTwice (30.96s) 260s PASS 260s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 37.008s 260s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 260s === RUN TestApplyProToken 260s === PAUSE TestApplyProToken 260s === RUN TestApplyLandscapeConfig 260s === PAUSE TestApplyLandscapeConfig 260s === RUN TestWithProMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithProMock (0.00s) 260s === RUN TestWithLandscapeConfigMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithLandscapeConfigMock (0.00s) 260s === RUN TestWithWslPathMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithWslPathMock (0.00s) 260s === RUN TestWithWslInfoMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithWslInfoMock (0.00s) 260s === RUN TestWithCmdExeMock 260s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 260s --- SKIP: TestWithCmdExeMock (0.00s) 260s === CONT TestApplyProToken 260s === RUN TestApplyProToken/Success_attaching 260s === PAUSE TestApplyProToken/Success_attaching 260s === RUN TestApplyProToken/Success_detaching 260s === PAUSE TestApplyProToken/Success_detaching 260s === RUN TestApplyProToken/Error_calling_pro_detach 260s === PAUSE TestApplyProToken/Error_calling_pro_detach 260s === RUN TestApplyProToken/Error_calling_pro_attach 260s === PAUSE TestApplyProToken/Error_calling_pro_attach 260s === CONT TestApplyProToken/Success_attaching 260s === CONT TestApplyLandscapeConfig 260s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 260s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 260s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 260s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 260s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 260s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 260s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 260s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 260s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 260s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 260s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 260s === CONT TestApplyProToken/Error_calling_pro_detach 260s === CONT TestApplyProToken/Error_calling_pro_attach 260s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 260s === CONT TestApplyProToken/Success_detaching 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyProToken: Received empty token: detaching" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyLandscapeConfig: received config: registering" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyLandscapeConfig: received config: registering" 260s time="2025-03-15T18:26:22Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 260s --- PASS: TestApplyLandscapeConfig (0.00s) 260s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (9.33s) 260s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (9.40s) 260s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (9.51s) 260s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (10.21s) 260s --- PASS: TestApplyProToken (0.00s) 260s --- PASS: TestApplyProToken/Success_detaching (9.15s) 260s --- PASS: TestApplyProToken/Error_calling_pro_detach (9.24s) 260s --- PASS: TestApplyProToken/Success_attaching (16.14s) 260s --- PASS: TestApplyProToken/Error_calling_pro_attach (16.78s) 260s PASS 260s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 16.841s 260s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 324s === RUN TestNew 324s === PAUSE TestNew 324s === RUN TestServe 324s === PAUSE TestServe 324s === RUN TestServeAndQuit 324s === PAUSE TestServeAndQuit 324s === RUN TestReconnection 324s === PAUSE TestReconnection 324s === RUN TestWithProMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithProMock (0.00s) 324s === RUN TestWithWslPathMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslPathMock (0.00s) 324s === RUN TestWithWslInfoMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslInfoMock (0.00s) 324s === RUN TestWithCmdExeMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithCmdExeMock (0.00s) 324s === CONT TestNew 324s === RUN TestNew/Success 324s === PAUSE TestNew/Success 324s === RUN TestNew/Error_when_WslPath_returns_error 324s === PAUSE TestNew/Error_when_WslPath_returns_error 324s === CONT TestNew/Success 324s === CONT TestServeAndQuit 324s === RUN TestServeAndQuit/Success_with_graceful_quit 324s === PAUSE TestServeAndQuit/Success_with_graceful_quit 324s === RUN TestServeAndQuit/Success_with_forceful_quit 324s === PAUSE TestServeAndQuit/Success_with_forceful_quit 324s === CONT TestReconnection 324s === CONT TestServe 324s === CONT TestNew/Error_when_WslPath_returns_error 324s === RUN TestServeAndQuit/Success_with_double_quit 324s === PAUSE TestServeAndQuit/Success_with_double_quit 324s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 324s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 324s === CONT TestServeAndQuit/Success_with_graceful_quit 324s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 324s === CONT TestServeAndQuit/Success_with_double_quit 324s === CONT TestServeAndQuit/Success_with_forceful_quit 324s === RUN TestReconnection/Success_connecting_after_failing_to_connect 324s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s === RUN TestServe/No_connection_because_the_port_file_is_empty 324s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 324s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 324s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 324s === RUN TestServe/No_connection_because_the_port_file_has_port_0 324s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 324s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 324s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 324s === RUN TestServe/No_connection_because_there_is_no_server 324s === PAUSE TestServe/No_connection_because_there_is_no_server 324s === RUN TestServe/Error_because_the_context_is_pre-cancelled 324s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 324s === RUN TestServe/Error_because_the_notifier_returns_an_error 324s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 324s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 324s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 324s === RUN TestServe/Success 324s === PAUSE TestServe/Success 324s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 324s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 324s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 324s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 324s === CONT TestReconnection/Success_connecting_after_failing_to_connect 324s === RUN TestServe/Success_with_systemd_notifier_returning_true 324s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 324s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 324s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 324s === RUN TestServe/No_connection_because_there_are_no_certificates 324s === PAUSE TestServe/No_connection_because_there_are_no_certificates 324s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 324s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 324s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33391" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41879" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34611" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42637" 324s time="2025-03-15T18:26:22Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:40Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:26:40Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:40Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:26:40Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44129" 324s time="2025-03-15T18:26:40Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:26:40Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:40Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s === CONT TestServe/No_connection_because_the_port_file_is_empty 324s time="2025-03-15T18:26:40Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:40Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46143" 324s time="2025-03-15T18:26:40Z" level=debug msg="Building new daemon" 324s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 324s --- PASS: TestNew (0.00s) 324s --- PASS: TestNew/Error_when_WslPath_returns_error (17.85s) 324s --- PASS: TestNew/Success (18.46s) 324s time="2025-03-15T18:26:40Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:40Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34387" 324s time="2025-03-15T18:26:40Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:41Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:26:41Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:41Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:26:41Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:26:41Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:41Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:26:41Z" 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_connect3196728334/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect3196728334/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 324s time="2025-03-15T18:26:41Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:26:41Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:26:41Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:26:41Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:41Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:26:41Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41817" 324s time="2025-03-15T18:26:42Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:42Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:42Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:42Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:42Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 324s time="2025-03-15T18:26:42Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:42Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:26:42Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:42Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:32797" 324s time="2025-03-15T18:26:42Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:46Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44129" 324s time="2025-03-15T18:26:46Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:26:46Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:26:46Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:26:46Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:26:47Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:42637" 324s time="2025-03-15T18:26:47Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:26:47Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:26:47Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:26:47Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:26:48Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:41879" 324s time="2025-03-15T18:26:48Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:26:48Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:26:48Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:34611" 324s time="2025-03-15T18:26:48Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:26:48Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:26:48Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:26:48Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:26:48Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:26:48Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:26:50Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:41817" 324s time="2025-03-15T18:26:50Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:26:50Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:26:50Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:26:50Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:26:54Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:54Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:26:54Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:54Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:54Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:54Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:54Z" 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" 324s time="2025-03-15T18:26:54Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:26:55Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:55Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:55Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:26:55Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:55Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:55Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_there_are_no_certificates 324s time="2025-03-15T18:26:55Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:55Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39831" 324s time="2025-03-15T18:26:55Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping active requests." 324s time="2025-03-15T18:26:55Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:26:55Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:55Z" 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" 324s time="2025-03-15T18:26:55Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:55Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:55Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 324s time="2025-03-15T18:26:55Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s === CONT TestServe/Success_with_systemd_notifier_returning_true 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33875" 324s time="2025-03-15T18:26:55Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:55Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:55Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:55Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:55Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:26:55Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:26:55Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:55Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34033" 324s time="2025-03-15T18:26:55Z" level=debug msg="Building new daemon" 324s --- PASS: TestServeAndQuit (0.00s) 324s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (20.11s) 324s --- PASS: TestServeAndQuit/Success_with_double_quit (32.88s) 324s --- PASS: TestServeAndQuit/Success_with_forceful_quit (33.26s) 324s --- PASS: TestServeAndQuit/Success_with_graceful_quit (33.71s) 324s === CONT TestServe/Success 324s time="2025-03-15T18:26:56Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:56Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36261" 324s time="2025-03-15T18:26:56Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:57Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:26:57Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:57Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:57Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:57Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:57Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:57Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:57Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 324s time="2025-03-15T18:26:57Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:26:57Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:26:57Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:57Z" level=info msg="Stopping active requests." 324s time="2025-03-15T18:26:57Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:26:57Z" level=debug msg="All connections have now ended." 324s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 324s time="2025-03-15T18:26:57Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:26:57Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:26:57Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:26:59Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:26:59Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:26:59Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_there_is_no_server 324s time="2025-03-15T18:26:59Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:00Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43395" 324s time="2025-03-15T18:27:00Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:03Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:32797" 324s time="2025-03-15T18:27:03Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_file838744958/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 324s time="2025-03-15T18:27:03Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:03Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:03Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:03Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/Error_because_the_notifier_returns_an_error 324s time="2025-03-15T18:27:04Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:04Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36475" 324s time="2025-03-15T18:27:04Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:05Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:06Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:06Z" 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_exist2649238683/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist2649238683/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 324s time="2025-03-15T18:27:06Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:06Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:27:06Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:06Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:27:06Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:07Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:07Z" 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_exist2649238683/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist2649238683/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 324s time="2025-03-15T18:27:07Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:27:07Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:07Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:07Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/Error_because_the_context_is_pre-cancelled 324s time="2025-03-15T18:27:07Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:07Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41993" 324s time="2025-03-15T18:27:07Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:07Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42061" 324s time="2025-03-15T18:27:07Z" level=debug msg="Ready state sent to systemd" 324s time="2025-03-15T18:27:07Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:07Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:27:10Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39831" 324s time="2025-03-15T18:27:11Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates3311070753/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 324s time="2025-03-15T18:27:11Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:34033" 324s time="2025-03-15T18:27:11Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:27:11Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:27:11Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:27:11Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:27:11Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:11Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:11Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_the_port_file_has_port_0 324s time="2025-03-15T18:27:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:36261" 324s time="2025-03-15T18:27:11Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:27:11Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:27:11Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:27:11Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:11Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42025" 324s time="2025-03-15T18:27:11Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:12Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:42061" 324s time="2025-03-15T18:27:12Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:27:12Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:27:12Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:27:12Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:27:15Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43395" 324s time="2025-03-15T18:27:15Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:27:15Z" 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:43395: connect: connection refused\"" 324s time="2025-03-15T18:27:15Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:15Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:15Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:15Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 324s time="2025-03-15T18:27:15Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:15Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34841" 324s time="2025-03-15T18:27:15Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:15Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 324s time="2025-03-15T18:27:15Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:15Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:15Z" level=debug msg="All connections have now ended." 324s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 324s time="2025-03-15T18:27:15Z" level=debug msg="No Landscape configuration detected: nothing to do" 324s time="2025-03-15T18:27:15Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37079" 324s time="2025-03-15T18:27:15Z" level=debug msg="Building new daemon" 324s time="2025-03-15T18:27:16Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:27:16Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:27:16Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:27:17Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:17Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:17Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:17Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:27:17Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:27:17Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:27:17Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 324s time="2025-03-15T18:27:18Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:18Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44717" 324s time="2025-03-15T18:27:18Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:18Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:18Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:27:18Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:18Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:27:18Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:27:18Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:18Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:18Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:27:18Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:18Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:18Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:19Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:19Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:27:21Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:21Z" 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" 324s time="2025-03-15T18:27:21Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:22Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:22Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:22Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:22Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44717" 324s time="2025-03-15T18:27:22Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:27:22Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:27:22Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:27:22Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:27:23Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:23Z" 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" 324s time="2025-03-15T18:27:23Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:24Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:24Z" 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" 324s time="2025-03-15T18:27:24Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:24Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:24Z" 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" 324s time="2025-03-15T18:27:24Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:27:24Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:24Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:24Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:25Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:25Z" level=info msg="Waiting for active requests to close." 324s time="2025-03-15T18:27:25Z" level=debug msg="All connections have now ended." 324s --- PASS: TestServe (0.01s) 324s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (15.29s) 324s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (19.00s) 324s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (21.59s) 324s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (11.92s) 324s --- PASS: TestServe/No_connection_because_there_are_no_certificates (16.56s) 324s --- PASS: TestServe/No_connection_because_there_is_no_server (15.31s) 324s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (11.67s) 324s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (10.50s) 324s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (22.69s) 324s --- PASS: TestServe/Success (22.79s) 324s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (10.36s) 324s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (9.13s) 324s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (9.34s) 324s time="2025-03-15T18:27:25Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:27:25Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:27:25Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:27:25Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:27:25Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:25Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:27:25Z" level=info msg="Stopping active requests." 324s time="2025-03-15T18:27:25Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:25Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:25Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:27:25Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:27:25Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:27:25Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:27:25Z" level=debug msg="All connections have now ended." 324s time="2025-03-15T18:27:59Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:59Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:59Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:27:59Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 324s time="2025-03-15T18:27:59Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:27:59Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:27:59Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not read agent port file \"/tmp/TestReconnectionSuccess_connecting_after_previous_long-lived_connection_dropped1268722771/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_previous_long-lived_connection_dropped1268722771/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 324s time="2025-03-15T18:27:59Z" level=info msg="Reconnecting to Windows host in 1 seconds" 324s time="2025-03-15T18:27:59Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:27:59Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39895" 324s time="2025-03-15T18:28:00Z" level=info msg="Daemon: connecting to Windows Agent" 324s time="2025-03-15T18:28:00Z" level=debug msg="Updated systemd status to \"Connecting\"" 324s time="2025-03-15T18:28:01Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39895" 324s time="2025-03-15T18:28:01Z" level=info msg="Daemon: completed connection to Windows Agent" 324s time="2025-03-15T18:28:01Z" level=debug msg="Updated systemd status to \"Connected\"" 324s time="2025-03-15T18:28:01Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 324s time="2025-03-15T18:28:01Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 324s time="2025-03-15T18:28:02Z" level=debug msg="Server: sent preface messages to all streams" 324s time="2025-03-15T18:28:02Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:28:02Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:28:02Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:28:03Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:28:03Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:28:03Z" level=info msg="Stopping daemon requested." 324s time="2025-03-15T18:28:03Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:28:03Z" level=info msg="Stopping active requests." 324s time="2025-03-15T18:28:03Z" level=warning msg="Daemon: disconnected from Windows host" 324s time="2025-03-15T18:28:03Z" level=info msg="Reconnecting to Windows host in 2 seconds" 324s time="2025-03-15T18:28:03Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 324s time="2025-03-15T18:28:03Z" level=debug msg="Updated systemd status to \"Stopped\"" 324s time="2025-03-15T18:28:03Z" level=debug msg="All connections have now ended." 324s --- PASS: TestReconnection (0.01s) 324s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (35.44s) 324s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (27.88s) 324s --- PASS: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (100.82s) 324s PASS 324s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 100.891s 324s === RUN TestConnect 324s === PAUSE TestConnect 324s === RUN TestSendAndRecv 324s --- PASS: TestSendAndRecv (0.42s) 324s === RUN TestServe 324s === PAUSE TestServe 324s === RUN TestStop 324s === PAUSE TestStop 324s === RUN TestWithProMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithProMock (0.00s) 324s === RUN TestWithWslPathMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslPathMock (0.00s) 324s === RUN TestWithWslInfoMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslInfoMock (0.00s) 324s === RUN TestWithCmdExeMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithCmdExeMock (0.00s) 324s === CONT TestConnect 324s === RUN TestConnect/Success 324s === PAUSE TestConnect/Success 324s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 324s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 324s === CONT TestConnect/Success 324s === CONT TestStop 324s === CONT TestServe 324s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 324s time="2025-03-15T18:26:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37379" 324s time="2025-03-15T18:26:23Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40097" 324s time="2025-03-15T18:26:32Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:32Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:32Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s time="2025-03-15T18:26:34Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 324s time="2025-03-15T18:26:34Z" level=info msg="MockWindowsAgent: Connected ready" 324s time="2025-03-15T18:26:34Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 324s --- PASS: TestConnect (0.00s) 324s --- PASS: TestConnect/Success (0.33s) 324s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.00s) 324s time="2025-03-15T18:26:42Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:42Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:42Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s --- PASS: TestStop (20.38s) 324s time="2025-03-15T18:26:58Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:58Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 324s time="2025-03-15T18:26:58Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 324s --- PASS: TestServe (35.71s) 324s PASS 324s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 36.197s 324s === RUN TestNew 324s === PAUSE TestNew 324s === RUN TestInfo 324s === PAUSE TestInfo 324s === RUN TestWslDistroName 324s === PAUSE TestWslDistroName 324s === RUN TestUserProfileDir 324s === PAUSE TestUserProfileDir 324s === RUN TestProStatus 324s === PAUSE TestProStatus 324s === RUN TestProAttach 324s === PAUSE TestProAttach 324s === RUN TestProDetach 324s === PAUSE TestProDetach 324s === RUN TestLandscapeEnable 324s === PAUSE TestLandscapeEnable 324s === RUN TestWindowsHostAddress 324s === PAUSE TestWindowsHostAddress 324s === RUN TestLandscapeDisable 324s === PAUSE TestLandscapeDisable 324s === RUN TestEnsureValidLandscapeConfig 324s === PAUSE TestEnsureValidLandscapeConfig 324s === RUN TestRealBackend 324s === PAUSE TestRealBackend 324s === RUN TestWithProMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithProMock (0.00s) 324s === RUN TestWithLandscapeConfigMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithLandscapeConfigMock (0.00s) 324s === RUN TestWithWslPathMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslPathMock (0.00s) 324s === RUN TestWithWslInfoMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithWslInfoMock (0.00s) 324s === RUN TestWithCmdExeMock 324s mock_executables.go:645: Skipped because it is not a real test, but rather a mocked executable 324s --- SKIP: TestWithCmdExeMock (0.00s) 324s === CONT TestNew 324s === RUN TestNew/Return_a_new_system 324s === PAUSE TestNew/Return_a_new_system 324s === RUN TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 324s === PAUSE TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 324s === CONT TestNew/Return_a_new_system 324s === CONT TestProDetach 324s === RUN TestProDetach/success_on_unattached_distro 324s === PAUSE TestProDetach/success_on_unattached_distro 324s === RUN TestProDetach/success_on_attached_distro 324s === PAUSE TestProDetach/success_on_attached_distro 324s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 324s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 324s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 324s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 324s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 324s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 324s === CONT TestProDetach/success_on_unattached_distro 324s === CONT TestLandscapeDisable 324s === RUN TestLandscapeDisable/Success 324s === PAUSE TestLandscapeDisable/Success 324s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 324s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 324s === CONT TestLandscapeDisable/Success 324s === CONT TestUserProfileDir 324s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 324s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 324s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 324s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 324s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 324s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 324s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 324s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 324s === RUN TestUserProfileDir/Error_on_wslpath_error 324s === PAUSE TestUserProfileDir/Error_on_wslpath_error 324s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 324s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 324s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 324s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 324s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 324s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 324s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 324s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 324s === RUN TestUserProfileDir/Error_on_cmd.exe_error 324s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 324s === RUN TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 324s === PAUSE TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 324s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 324s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 324s === CONT TestInfo 324s === RUN TestInfo/Success 324s === PAUSE TestInfo/Success 324s === RUN TestInfo/Error_when_WslDistroName_fails 324s === PAUSE TestInfo/Error_when_WslDistroName_fails 324s === RUN TestInfo/Error_when_pro_status_command_fails 324s === PAUSE TestInfo/Error_when_pro_status_command_fails 324s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 324s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 324s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 324s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 324s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 324s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 324s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 324s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 324s === CONT TestInfo/Success 324s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 324s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 324s === CONT TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 324s time="2025-03-15T18:26:26Z" level=warning msg="Could not ensure valid Landscape configuration: could not ensure valid Landscape configuration: could not register distro to Landscape: could not parse config: key-value delimiter not found: {\n" 324s === CONT TestProDetach/success_on_attached_distro 324s --- PASS: TestNew (0.00s) 324s --- PASS: TestNew/Return_a_new_system (1.64s) 324s --- PASS: TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) (0.37s) 324s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 324s === CONT TestWslDistroName 324s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 324s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 324s === RUN TestWslDistroName/Success_using_wslpath 324s === PAUSE TestWslDistroName/Success_using_wslpath 324s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 324s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 324s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 324s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 324s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 324s === CONT TestInfo/Error_when_WslDistroName_fails 324s === CONT TestEnsureValidLandscapeConfig 324s === CONT TestRealBackend 324s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 324s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 324s === RUN TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 324s === PAUSE TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 324s === RUN TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 324s === PAUSE TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 324s === RUN TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 324s === PAUSE TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 324s === RUN TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 324s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 324s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 324s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 324s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 324s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 324s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 324s === RUN TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 324s === PAUSE TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 324s === RUN TestEnsureValidLandscapeConfig/Regular_with_additional_keys 324s === PAUSE TestEnsureValidLandscapeConfig/Regular_with_additional_keys 324s === RUN TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 324s === PAUSE TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 324s === RUN TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 324s === PAUSE TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 324s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 324s --- PASS: TestRealBackend (0.11s) 324s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 324s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 324s === CONT TestInfo/Error_when_pro_status_command_fails 324s === CONT TestWindowsHostAddress 324s === RUN TestWindowsHostAddress/Without_NAT 324s === PAUSE TestWindowsHostAddress/Without_NAT 324s === RUN TestWindowsHostAddress/With_NAT 324s === PAUSE TestWindowsHostAddress/With_NAT 324s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 324s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 324s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 324s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 324s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 324s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 324s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 324s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 324s === CONT TestLandscapeEnable 324s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 324s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 324s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path 324s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path 324s === RUN TestLandscapeEnable/Refresh_computer_title_if_changed 324s === PAUSE TestLandscapeEnable/Refresh_computer_title_if_changed 324s === RUN TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 324s === PAUSE TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 324s === RUN TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 324s === PAUSE TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 324s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 324s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 324s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 324s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 324s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 324s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 324s === RUN TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 324s === PAUSE TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 324s === RUN TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 324s === PAUSE TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 324s === RUN TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 324s === PAUSE TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 324s === RUN TestLandscapeEnable/Do_not_modify_other_sections_and_keys 324s === PAUSE TestLandscapeEnable/Do_not_modify_other_sections_and_keys 324s === RUN TestLandscapeEnable/Rerun_landscape_even_without_modifications 324s === PAUSE TestLandscapeEnable/Rerun_landscape_even_without_modifications 324s === RUN TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 324s === PAUSE TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 324s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 324s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 324s === RUN TestLandscapeEnable/Regular_with_additional_keys 324s === PAUSE TestLandscapeEnable/Regular_with_additional_keys 324s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 324s system_test.go:245: Removing default proc/mounts 324s === CONT TestProAttach 324s === RUN TestProAttach/success 324s === PAUSE TestProAttach/success 324s === RUN TestProAttach/error_on_'pro_attach'_error 324s === PAUSE TestProAttach/error_on_'pro_attach'_error 324s === CONT TestUserProfileDir/Error_on_cmd.exe_error 324s --- PASS: TestProDetach (0.00s) 324s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (9.05s) 324s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (9.48s) 324s --- PASS: TestProDetach/success_on_unattached_distro (10.06s) 324s --- PASS: TestProDetach/success_on_attached_distro (8.55s) 324s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (8.30s) 324s === CONT TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 324s --- PASS: TestLandscapeDisable (0.00s) 324s --- PASS: TestLandscapeDisable/Success (11.88s) 324s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (7.63s) 324s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 324s === CONT TestProStatus 324s === RUN TestProStatus/success_on_unattached_distro 324s === PAUSE TestProStatus/success_on_unattached_distro 324s === RUN TestProStatus/success_on_attached_distro 324s === PAUSE TestProStatus/success_on_attached_distro 324s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 324s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 324s === RUN TestProStatus/error_on_'pro_attach'_error 324s === PAUSE TestProStatus/error_on_'pro_attach'_error 324s === CONT TestUserProfileDir/Error_on_wslpath_error 324s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 324s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 324s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 324s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 324s system_test.go:245: Removing default proc/mounts 324s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 324s --- PASS: TestInfo (0.00s) 324s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (10.56s) 324s --- PASS: TestInfo/Success (11.39s) 324s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (8.34s) 324s --- PASS: TestInfo/Error_when_WslDistroName_fails (8.47s) 324s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (7.78s) 324s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (8.77s) 324s --- PASS: TestInfo/Error_when_pro_status_command_fails (8.44s) 324s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 324s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 324s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 324s === CONT TestWslDistroName/Success_using_wslpath 324s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 324s === CONT TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 324s === CONT TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 324s --- PASS: TestWslDistroName (0.00s) 324s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.14s) 324s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (7.76s) 324s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (6.46s) 324s --- PASS: TestWslDistroName/Success_using_wslpath (6.06s) 324s === CONT TestEnsureValidLandscapeConfig/Regular_with_additional_keys 324s === CONT TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 324s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 324s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 324s --- PASS: TestUserProfileDir (0.00s) 324s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (0.14s) 324s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.00s) 324s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (19.04s) 324s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.06s) 324s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (6.38s) 324s --- PASS: TestUserProfileDir/Error_when_UserProfile_env_var_is_empty (7.37s) 324s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (13.41s) 324s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (13.58s) 324s --- PASS: TestUserProfileDir/Error_on_wslpath_error (14.70s) 324s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (14.30s) 324s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (14.33s) 324s === NAME TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/appends_any_required_fields_-_no_ssl 324s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_without_modifications 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 324s === NAME TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/reformat_landscape_config_to_proper_ini 324s === CONT TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 324s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 324s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 324s === CONT TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 324s === CONT TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 324s === NAME TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/do_not_modify_other_sections_and_keys 324s === CONT TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/do_not_transform_windows_ssl_certificate_empty_path 324s === CONT TestWindowsHostAddress/Without_NAT 324s === NAME TestEnsureValidLandscapeConfig/Regular_with_additional_keys 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/regular_with_additional_keys 324s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 324s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 324s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path_with_forward_slash 324s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 324s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 324s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 324s === CONT TestWindowsHostAddress/With_NAT 324s === NAME TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 324s system_test.go:767: testdata/TestEnsureValidLandscapeConfig/golden/refresh_computer_title_if_changed 324s === CONT TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 324s --- PASS: TestEnsureValidLandscapeConfig (0.00s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read (0.19s) 324s --- PASS: TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl (5.61s) 324s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications (5.09s) 324s --- PASS: TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini (9.84s) 324s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path (12.45s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section (0.08s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed (0.02s) 324s --- PASS: TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created (0.23s) 324s --- PASS: TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys (11.27s) 324s --- PASS: TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path (0.12s) 324s --- PASS: TestEnsureValidLandscapeConfig/Regular_with_additional_keys (11.17s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist (5.30s) 324s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash (10.39s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name (6.03s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path (5.23s) 324s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails (12.56s) 324s --- PASS: TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed (5.28s) 324s === CONT TestLandscapeEnable/Regular_with_additional_keys 324s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 324s === CONT TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 324s === CONT TestLandscapeEnable/Rerun_landscape_even_without_modifications 324s === CONT TestLandscapeEnable/Do_not_modify_other_sections_and_keys 324s === CONT TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 324s === CONT TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 324s --- PASS: TestWindowsHostAddress (0.00s) 324s --- PASS: TestWindowsHostAddress/Without_NAT (5.17s) 324s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (5.00s) 324s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (5.60s) 324s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (5.33s) 324s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (4.83s) 324s --- PASS: TestWindowsHostAddress/With_NAT (5.69s) 324s === CONT TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 324s === NAME TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 324s system_test.go:526: testdata/TestLandscapeEnable/golden/appends_any_required_fields_-_no_ssl 324s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 324s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 324s === NAME TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 324s system_test.go:526: testdata/TestLandscapeEnable/golden/reformat_landscape_config_to_proper_ini 324s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 324s === CONT TestLandscapeEnable/Refresh_computer_title_if_changed 324s === NAME TestLandscapeEnable/Regular_with_additional_keys 324s system_test.go:526: testdata/TestLandscapeEnable/golden/regular_with_additional_keys 324s === CONT TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 324s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path 324s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 324s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path_with_forward_slash 324s === CONT TestProAttach/success 324s === NAME TestLandscapeEnable/Rerun_landscape_even_without_modifications 324s system_test.go:526: testdata/TestLandscapeEnable/golden/rerun_landscape_even_without_modifications 324s === CONT TestProAttach/error_on_'pro_attach'_error 324s === CONT TestProStatus/success_on_unattached_distro 324s === NAME TestLandscapeEnable/Do_not_modify_other_sections_and_keys 324s system_test.go:526: testdata/TestLandscapeEnable/golden/do_not_modify_other_sections_and_keys 324s === CONT TestProStatus/error_on_'pro_attach'_error 324s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 324s === NAME TestLandscapeEnable/Refresh_computer_title_if_changed 324s system_test.go:526: testdata/TestLandscapeEnable/golden/refresh_computer_title_if_changed 324s === CONT TestProStatus/success_on_attached_distro 324s --- PASS: TestProAttach (0.00s) 324s --- PASS: TestProAttach/success (3.31s) 324s --- PASS: TestProAttach/error_on_'pro_attach'_error (3.41s) 324s --- PASS: TestProStatus (0.00s) 324s --- PASS: TestProStatus/success_on_unattached_distro (3.48s) 324s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (2.73s) 324s --- PASS: TestProStatus/error_on_'pro_attach'_error (3.04s) 324s --- PASS: TestProStatus/success_on_attached_distro (1.80s) 324s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path 324s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path 324s --- PASS: TestLandscapeEnable (0.00s) 324s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed (5.84s) 324s --- PASS: TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section (0.08s) 324s --- PASS: TestLandscapeEnable/Appends_any_required_fields_-_no_ssl (4.57s) 324s --- PASS: TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name (4.24s) 324s --- PASS: TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini (9.09s) 324s --- PASS: TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created (4.50s) 324s --- PASS: TestLandscapeEnable/Regular_with_additional_keys (8.65s) 324s --- PASS: TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed (0.02s) 324s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash (8.25s) 324s --- PASS: TestLandscapeEnable/Rerun_landscape_even_without_modifications (7.30s) 324s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (3.75s) 324s --- PASS: TestLandscapeEnable/Do_not_modify_other_sections_and_keys (7.85s) 324s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (3.55s) 324s --- PASS: TestLandscapeEnable/Refresh_computer_title_if_changed (3.81s) 324s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (5.84s) 324s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path (5.01s) 324s PASS 324s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 61.478s 324s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 324s autopkgtest [18:28:03]: test command1: -----------------------] 328s autopkgtest [18:28:07]: test command1: - - - - - - - - - - results - - - - - - - - - - 328s command1 PASS 332s autopkgtest [18:28:11]: @@@@@@@@@@@@@@@@@@@@ summary 332s command1 PASS