0s autopkgtest [11:47:24]: starting date and time: 2026-02-05 11:47:24+0000 0s autopkgtest [11:47:24]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [11:47:24]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work.lyvuc014/out --timeout-copy=6000 --needs-internet=try --setup-commands /home/ubuntu/autopkgtest-cloud/worker-config-production/setup-canonical.sh --apt-pocket=proposed=src:glibc --apt-upgrade wsl-pro-service --timeout-short=300 --timeout-copy=20000 --timeout-build=20000 --env=ADT_TEST_TRIGGERS=glibc/2.42-2ubuntu5 -- ssh -s /home/ubuntu/autopkgtest/ssh-setup/nova -- --flavor autopkgtest-cpu2-ram4-disk20-ppc64el --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-ppc64el-8.secgroup --name adt-resolute-ppc64el-wsl-pro-service-20260205-114724-juju-7f2275-prod-proposed-migration-environment-2-92018589-f3a7-46ac-95fd-76ae4afbac9d --image adt/ubuntu-resolute-ppc64el-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-ppc64el -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 5s Creating nova instance adt-resolute-ppc64el-wsl-pro-service-20260205-114724-juju-7f2275-prod-proposed-migration-environment-2-92018589-f3a7-46ac-95fd-76ae4afbac9d from image adt/ubuntu-resolute-ppc64el-server-20260205.img (UUID f866c950-0b62-4023-bac6-0f13279e15ed)... 59s autopkgtest [11:48:23]: testbed dpkg architecture: ppc64el 59s autopkgtest [11:48:23]: testbed apt version: 3.1.14 60s autopkgtest [11:48:24]: @@@@@@@@@@@@@@@@@@@@ test bed setup 60s autopkgtest [11:48:24]: testbed release detected to be: None 61s autopkgtest [11:48:25]: updating testbed package index (apt update) 61s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 61s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 61s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 61s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 61s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [227 kB] 62s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [5260 B] 62s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [35.4 kB] 62s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1696 kB] 62s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el Packages [261 kB] 62s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/universe ppc64el Packages [1492 kB] 62s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse ppc64el Packages [21.9 kB] 62s Fetched 3863 kB in 1s (3073 kB/s) 63s Reading package lists... 64s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 64s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 64s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 64s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 65s Reading package lists... 65s Reading package lists... 65s Building dependency tree... 65s Reading state information... 65s Calculating upgrade... 65s The following packages will be upgraded: 65s libc-bin libc-gconv-modules-extra libc6 locales pollinate 65s python3-referencing sed 65s 7 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 65s Need to get 8612 kB of archives. 65s After this operation, 0 B of additional disk space will be used. 65s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el sed ppc64el 4.9-2build3 [211 kB] 65s Get:2 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libc-gconv-modules-extra ppc64el 2.42-2ubuntu5 [1448 kB] 66s Get:3 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libc6 ppc64el 2.42-2ubuntu5 [1913 kB] 66s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libc-bin ppc64el 2.42-2ubuntu5 [748 kB] 66s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el locales all 2.42-2ubuntu5 [4255 kB] 66s Get:6 http://ftpmaster.internal/ubuntu resolute/main ppc64el pollinate all 4.33-4ubuntu5 [14.0 kB] 66s Get:7 http://ftpmaster.internal/ubuntu resolute/main ppc64el python3-referencing all 0.36.2-1ubuntu2 [22.2 kB] 66s dpkg-preconfigure: unable to re-open stdin: No such file or directory 66s Fetched 8612 kB in 1s (13.5 MB/s) 67s (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 ... 82008 files and directories currently installed.) 67s Preparing to unpack .../sed_4.9-2build3_ppc64el.deb ... 67s Unpacking sed (4.9-2build3) over (4.9-2build2) ... 67s Setting up sed (4.9-2build3) ... 67s (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 ... 82008 files and directories currently installed.) 67s Preparing to unpack .../libc-gconv-modules-extra_2.42-2ubuntu5_ppc64el.deb ... 67s Unpacking libc-gconv-modules-extra:ppc64el (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 67s Setting up libc-gconv-modules-extra:ppc64el (2.42-2ubuntu5) ... 67s (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 ... 82008 files and directories currently installed.) 67s Preparing to unpack .../libc6_2.42-2ubuntu5_ppc64el.deb ... 67s Unpacking libc6:ppc64el (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 67s Setting up libc6:ppc64el (2.42-2ubuntu5) ... 68s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 82008 files and directories currently installed.) 68s Preparing to unpack .../libc-bin_2.42-2ubuntu5_ppc64el.deb ... 68s Unpacking libc-bin (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 69s Setting up libc-bin (2.42-2ubuntu5) ... 69s (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 82008 files and directories currently installed.) 69s Preparing to unpack .../locales_2.42-2ubuntu5_all.deb ... 69s Unpacking locales (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 69s Preparing to unpack .../pollinate_4.33-4ubuntu5_all.deb ... 69s Unpacking pollinate (4.33-4ubuntu5) over (4.33-4ubuntu4) ... 69s Preparing to unpack .../python3-referencing_0.36.2-1ubuntu2_all.deb ... 69s Unpacking python3-referencing (0.36.2-1ubuntu2) over (0.36.2-1ubuntu1) ... 69s Setting up locales (2.42-2ubuntu5) ... 70s Generating locales (this might take a while)... 71s en_US.UTF-8... done 71s Generation complete. 71s Setting up pollinate (4.33-4ubuntu5) ... 82s Setting up python3-referencing (0.36.2-1ubuntu2) ... 82s Processing triggers for man-db (2.13.1-1) ... 84s Processing triggers for install-info (7.2-5) ... 84s Processing triggers for systemd (259-1ubuntu3) ... 85s autopkgtest [11:48:49]: upgrading testbed (apt dist-upgrade and autopurge) 85s Reading package lists... 85s Building dependency tree... 85s Reading state information... 85s Calculating upgrade... 85s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 86s Reading package lists... 86s Building dependency tree... 86s Reading state information... 86s Solving dependencies... 86s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 86s autopkgtest [11:48:50]: rebooting testbed after setup commands that affected boot 125s autopkgtest [11:49:29]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:45:54 UTC 2026 128s autopkgtest [11:49:32]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 132s Get:1 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (dsc) [2064 B] 132s Get:2 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (tar) [1790 kB] 132s gpgv: Signature made Tue Jun 10 19:06:57 2025 UTC 132s gpgv: using RSA key 92FE4F8B40CADC4ECCD60C1F5961FDBE9C619809 132s gpgv: Can't check signature: No public key 132s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.18.dsc: no acceptable signature found 132s autopkgtest [11:49:36]: testing package wsl-pro-service version 0.1.18 132s autopkgtest [11:49:36]: build not needed 134s autopkgtest [11:49:38]: test command1: preparing testbed 134s Reading package lists... 135s Building dependency tree... 135s Reading state information... 135s Solving dependencies... 135s The following NEW packages will be installed: 135s autoconf automake autopoint autotools-dev build-essential cpp cpp-15 135s cpp-15-powerpc64le-linux-gnu cpp-powerpc64le-linux-gnu debhelper debugedit 135s dh-apport dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-15 135s g++-15-powerpc64le-linux-gnu g++-powerpc64le-linux-gnu gcc gcc-15 135s gcc-15-powerpc64le-linux-gnu gcc-powerpc64le-linux-gnu gettext 135s golang-1.25-go golang-1.25-src golang-go golang-src intltool-debian 135s libarchive-zip-perl libasan8 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev 135s libdebhelper-perl libfile-stripnondeterminism-perl libgcc-15-dev libgomp1 135s libisl23 libitm1 liblsan0 libmpc3 libquadmath0 libstdc++-15-dev libtool 135s libtsan2 libubsan1 linux-libc-dev m4 po-debconf rpcsvc-proto 135s 0 upgraded, 53 newly installed, 0 to remove and 0 not upgraded. 135s Need to get 110 MB of archives. 135s After this operation, 466 MB of additional disk space will be used. 135s Get:1 http://ftpmaster.internal/ubuntu resolute/main ppc64el m4 ppc64el 1.4.20-2 [236 kB] 135s Get:2 http://ftpmaster.internal/ubuntu resolute/main ppc64el autoconf all 2.72-3.1ubuntu1 [384 kB] 135s Get:3 http://ftpmaster.internal/ubuntu resolute/main ppc64el autotools-dev all 20240727.1 [43.4 kB] 135s Get:4 http://ftpmaster.internal/ubuntu resolute/main ppc64el automake all 1:1.18.1-3build1 [582 kB] 135s Get:5 http://ftpmaster.internal/ubuntu resolute/main ppc64el autopoint all 0.23.2-1 [620 kB] 136s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libc-dev-bin ppc64el 2.42-2ubuntu5 [23.9 kB] 136s Get:7 http://ftpmaster.internal/ubuntu resolute/main ppc64el linux-libc-dev ppc64el 6.18.0-9.9 [1847 kB] 136s Get:8 http://ftpmaster.internal/ubuntu resolute/main ppc64el libcrypt-dev ppc64el 1:4.5.1-1 [162 kB] 136s Get:9 http://ftpmaster.internal/ubuntu resolute/main ppc64el rpcsvc-proto ppc64el 1.4.3-1build1 [84.2 kB] 136s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main ppc64el libc6-dev ppc64el 2.42-2ubuntu5 [2079 kB] 137s Get:11 http://ftpmaster.internal/ubuntu resolute/main ppc64el libisl23 ppc64el 0.27-1build1 [893 kB] 137s Get:12 http://ftpmaster.internal/ubuntu resolute/main ppc64el libmpc3 ppc64el 1.3.1-2 [62.5 kB] 137s Get:13 http://ftpmaster.internal/ubuntu resolute/main ppc64el cpp-15-powerpc64le-linux-gnu ppc64el 15.2.0-12ubuntu1 [11.4 MB] 142s Get:14 http://ftpmaster.internal/ubuntu resolute/main ppc64el cpp-15 ppc64el 15.2.0-12ubuntu1 [1038 B] 142s Get:15 http://ftpmaster.internal/ubuntu resolute/main ppc64el cpp-powerpc64le-linux-gnu ppc64el 4:15.2.0-4ubuntu1 [5746 B] 142s Get:16 http://ftpmaster.internal/ubuntu resolute/main ppc64el cpp ppc64el 4:15.2.0-4ubuntu1 [22.4 kB] 142s Get:17 http://ftpmaster.internal/ubuntu resolute/main ppc64el libcc1-0 ppc64el 15.2.0-12ubuntu1 [49.0 kB] 142s Get:18 http://ftpmaster.internal/ubuntu resolute/main ppc64el libgomp1 ppc64el 15.2.0-12ubuntu1 [169 kB] 142s Get:19 http://ftpmaster.internal/ubuntu resolute/main ppc64el libitm1 ppc64el 15.2.0-12ubuntu1 [32.2 kB] 142s Get:20 http://ftpmaster.internal/ubuntu resolute/main ppc64el libasan8 ppc64el 15.2.0-12ubuntu1 [3006 kB] 144s Get:21 http://ftpmaster.internal/ubuntu resolute/main ppc64el liblsan0 ppc64el 15.2.0-12ubuntu1 [1374 kB] 145s Get:22 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtsan2 ppc64el 15.2.0-12ubuntu1 [2729 kB] 146s Get:23 http://ftpmaster.internal/ubuntu resolute/main ppc64el libubsan1 ppc64el 15.2.0-12ubuntu1 [1231 kB] 147s Get:24 http://ftpmaster.internal/ubuntu resolute/main ppc64el libquadmath0 ppc64el 15.2.0-12ubuntu1 [160 kB] 147s Get:25 http://ftpmaster.internal/ubuntu resolute/main ppc64el libgcc-15-dev ppc64el 15.2.0-12ubuntu1 [1670 kB] 148s Get:26 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc-15-powerpc64le-linux-gnu ppc64el 15.2.0-12ubuntu1 [22.4 MB] 163s Get:27 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc-15 ppc64el 15.2.0-12ubuntu1 [530 kB] 163s Get:28 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc-powerpc64le-linux-gnu ppc64el 4:15.2.0-4ubuntu1 [1220 B] 163s Get:29 http://ftpmaster.internal/ubuntu resolute/main ppc64el gcc ppc64el 4:15.2.0-4ubuntu1 [5032 B] 163s Get:30 http://ftpmaster.internal/ubuntu resolute/main ppc64el libstdc++-15-dev ppc64el 15.2.0-12ubuntu1 [2747 kB] 165s Get:31 http://ftpmaster.internal/ubuntu resolute/main ppc64el g++-15-powerpc64le-linux-gnu ppc64el 15.2.0-12ubuntu1 [13.0 MB] 171s Get:32 http://ftpmaster.internal/ubuntu resolute/main ppc64el g++-15 ppc64el 15.2.0-12ubuntu1 [25.3 kB] 171s Get:33 http://ftpmaster.internal/ubuntu resolute/main ppc64el g++-powerpc64le-linux-gnu ppc64el 4:15.2.0-4ubuntu1 [970 B] 171s Get:34 http://ftpmaster.internal/ubuntu resolute/main ppc64el g++ ppc64el 4:15.2.0-4ubuntu1 [1092 B] 171s Get:35 http://ftpmaster.internal/ubuntu resolute/main ppc64el build-essential ppc64el 12.12ubuntu2 [5256 B] 171s Get:36 http://ftpmaster.internal/ubuntu resolute/main ppc64el libdebhelper-perl all 13.28ubuntu1 [97.4 kB] 171s Get:37 http://ftpmaster.internal/ubuntu resolute/main ppc64el libtool all 2.5.4-9 [169 kB] 171s Get:38 http://ftpmaster.internal/ubuntu resolute/main ppc64el dh-autoreconf all 21 [12.5 kB] 171s Get:39 http://ftpmaster.internal/ubuntu resolute/main ppc64el libarchive-zip-perl all 1.68-1 [90.2 kB] 171s Get:40 http://ftpmaster.internal/ubuntu resolute/main ppc64el libfile-stripnondeterminism-perl all 1.15.0-1build1 [20.6 kB] 171s Get:41 http://ftpmaster.internal/ubuntu resolute/main ppc64el dh-strip-nondeterminism all 1.15.0-1build1 [5110 B] 171s Get:42 http://ftpmaster.internal/ubuntu resolute/main ppc64el debugedit ppc64el 1:5.2-3build1 [57.3 kB] 171s Get:43 http://ftpmaster.internal/ubuntu resolute/main ppc64el dwz ppc64el 0.16-2 [142 kB] 171s Get:44 http://ftpmaster.internal/ubuntu resolute/main ppc64el gettext ppc64el 0.23.2-1 [1177 kB] 171s Get:45 http://ftpmaster.internal/ubuntu resolute/main ppc64el intltool-debian all 0.35.0+20060710.6build1 [24.1 kB] 171s Get:46 http://ftpmaster.internal/ubuntu resolute/main ppc64el po-debconf all 1.0.22 [215 kB] 171s Get:47 http://ftpmaster.internal/ubuntu resolute/main ppc64el debhelper all 13.28ubuntu1 [916 kB] 172s Get:48 http://ftpmaster.internal/ubuntu resolute/universe ppc64el dh-apport all 2.33.1-0ubuntu3 [20.2 kB] 172s Get:49 http://ftpmaster.internal/ubuntu resolute/main ppc64el golang-1.25-src all 1.25.0-0ubuntu1 [23.0 MB] 177s Get:50 http://ftpmaster.internal/ubuntu resolute/main ppc64el golang-1.25-go ppc64el 1.25.0-0ubuntu1 [16.1 MB] 180s Get:51 http://ftpmaster.internal/ubuntu resolute/main ppc64el golang-src all 2:1.25~1 [5206 B] 180s Get:52 http://ftpmaster.internal/ubuntu resolute/main ppc64el golang-go ppc64el 2:1.25~1 [44.1 kB] 180s Get:53 http://ftpmaster.internal/ubuntu resolute/main ppc64el dh-golang all 1.63build1 [25.0 kB] 180s Fetched 110 MB in 45s (2436 kB/s) 180s Selecting previously unselected package m4. 180s (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 ... 82008 files and directories currently installed.) 180s Preparing to unpack .../00-m4_1.4.20-2_ppc64el.deb ... 180s Unpacking m4 (1.4.20-2) ... 180s Selecting previously unselected package autoconf. 180s Preparing to unpack .../01-autoconf_2.72-3.1ubuntu1_all.deb ... 180s Unpacking autoconf (2.72-3.1ubuntu1) ... 180s Selecting previously unselected package autotools-dev. 180s Preparing to unpack .../02-autotools-dev_20240727.1_all.deb ... 180s Unpacking autotools-dev (20240727.1) ... 181s Selecting previously unselected package automake. 181s Preparing to unpack .../03-automake_1%3a1.18.1-3build1_all.deb ... 181s Unpacking automake (1:1.18.1-3build1) ... 181s Selecting previously unselected package autopoint. 181s Preparing to unpack .../04-autopoint_0.23.2-1_all.deb ... 181s Unpacking autopoint (0.23.2-1) ... 181s Selecting previously unselected package libc-dev-bin. 181s Preparing to unpack .../05-libc-dev-bin_2.42-2ubuntu5_ppc64el.deb ... 181s Unpacking libc-dev-bin (2.42-2ubuntu5) ... 181s Selecting previously unselected package linux-libc-dev:ppc64el. 181s Preparing to unpack .../06-linux-libc-dev_6.18.0-9.9_ppc64el.deb ... 181s Unpacking linux-libc-dev:ppc64el (6.18.0-9.9) ... 181s Selecting previously unselected package libcrypt-dev:ppc64el. 181s Preparing to unpack .../07-libcrypt-dev_1%3a4.5.1-1_ppc64el.deb ... 181s Unpacking libcrypt-dev:ppc64el (1:4.5.1-1) ... 181s Selecting previously unselected package rpcsvc-proto. 181s Preparing to unpack .../08-rpcsvc-proto_1.4.3-1build1_ppc64el.deb ... 181s Unpacking rpcsvc-proto (1.4.3-1build1) ... 181s Selecting previously unselected package libc6-dev:ppc64el. 181s Preparing to unpack .../09-libc6-dev_2.42-2ubuntu5_ppc64el.deb ... 181s Unpacking libc6-dev:ppc64el (2.42-2ubuntu5) ... 181s Selecting previously unselected package libisl23:ppc64el. 181s Preparing to unpack .../10-libisl23_0.27-1build1_ppc64el.deb ... 181s Unpacking libisl23:ppc64el (0.27-1build1) ... 181s Selecting previously unselected package libmpc3:ppc64el. 181s Preparing to unpack .../11-libmpc3_1.3.1-2_ppc64el.deb ... 181s Unpacking libmpc3:ppc64el (1.3.1-2) ... 181s Selecting previously unselected package cpp-15-powerpc64le-linux-gnu. 181s Preparing to unpack .../12-cpp-15-powerpc64le-linux-gnu_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking cpp-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package cpp-15. 181s Preparing to unpack .../13-cpp-15_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking cpp-15 (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package cpp-powerpc64le-linux-gnu. 181s Preparing to unpack .../14-cpp-powerpc64le-linux-gnu_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 181s Unpacking cpp-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 181s Selecting previously unselected package cpp. 181s Preparing to unpack .../15-cpp_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 181s Unpacking cpp (4:15.2.0-4ubuntu1) ... 181s Selecting previously unselected package libcc1-0:ppc64el. 181s Preparing to unpack .../16-libcc1-0_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libcc1-0:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libgomp1:ppc64el. 181s Preparing to unpack .../17-libgomp1_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libgomp1:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libitm1:ppc64el. 181s Preparing to unpack .../18-libitm1_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libitm1:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libasan8:ppc64el. 181s Preparing to unpack .../19-libasan8_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libasan8:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package liblsan0:ppc64el. 181s Preparing to unpack .../20-liblsan0_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking liblsan0:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libtsan2:ppc64el. 181s Preparing to unpack .../21-libtsan2_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libtsan2:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libubsan1:ppc64el. 181s Preparing to unpack .../22-libubsan1_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libubsan1:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libquadmath0:ppc64el. 181s Preparing to unpack .../23-libquadmath0_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libquadmath0:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package libgcc-15-dev:ppc64el. 181s Preparing to unpack .../24-libgcc-15-dev_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking libgcc-15-dev:ppc64el (15.2.0-12ubuntu1) ... 181s Selecting previously unselected package gcc-15-powerpc64le-linux-gnu. 181s Preparing to unpack .../25-gcc-15-powerpc64le-linux-gnu_15.2.0-12ubuntu1_ppc64el.deb ... 181s Unpacking gcc-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 182s Selecting previously unselected package gcc-15. 182s Preparing to unpack .../26-gcc-15_15.2.0-12ubuntu1_ppc64el.deb ... 182s Unpacking gcc-15 (15.2.0-12ubuntu1) ... 182s Selecting previously unselected package gcc-powerpc64le-linux-gnu. 182s Preparing to unpack .../27-gcc-powerpc64le-linux-gnu_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 182s Unpacking gcc-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 182s Selecting previously unselected package gcc. 182s Preparing to unpack .../28-gcc_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 182s Unpacking gcc (4:15.2.0-4ubuntu1) ... 182s Selecting previously unselected package libstdc++-15-dev:ppc64el. 182s Preparing to unpack .../29-libstdc++-15-dev_15.2.0-12ubuntu1_ppc64el.deb ... 182s Unpacking libstdc++-15-dev:ppc64el (15.2.0-12ubuntu1) ... 182s Selecting previously unselected package g++-15-powerpc64le-linux-gnu. 182s Preparing to unpack .../30-g++-15-powerpc64le-linux-gnu_15.2.0-12ubuntu1_ppc64el.deb ... 182s Unpacking g++-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 182s Selecting previously unselected package g++-15. 182s Preparing to unpack .../31-g++-15_15.2.0-12ubuntu1_ppc64el.deb ... 182s Unpacking g++-15 (15.2.0-12ubuntu1) ... 182s Selecting previously unselected package g++-powerpc64le-linux-gnu. 182s Preparing to unpack .../32-g++-powerpc64le-linux-gnu_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 182s Unpacking g++-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 182s Selecting previously unselected package g++. 182s Preparing to unpack .../33-g++_4%3a15.2.0-4ubuntu1_ppc64el.deb ... 182s Unpacking g++ (4:15.2.0-4ubuntu1) ... 182s Selecting previously unselected package build-essential. 182s Preparing to unpack .../34-build-essential_12.12ubuntu2_ppc64el.deb ... 182s Unpacking build-essential (12.12ubuntu2) ... 182s Selecting previously unselected package libdebhelper-perl. 182s Preparing to unpack .../35-libdebhelper-perl_13.28ubuntu1_all.deb ... 182s Unpacking libdebhelper-perl (13.28ubuntu1) ... 182s Selecting previously unselected package libtool. 182s Preparing to unpack .../36-libtool_2.5.4-9_all.deb ... 182s Unpacking libtool (2.5.4-9) ... 182s Selecting previously unselected package dh-autoreconf. 182s Preparing to unpack .../37-dh-autoreconf_21_all.deb ... 182s Unpacking dh-autoreconf (21) ... 182s Selecting previously unselected package libarchive-zip-perl. 182s Preparing to unpack .../38-libarchive-zip-perl_1.68-1_all.deb ... 182s Unpacking libarchive-zip-perl (1.68-1) ... 182s Selecting previously unselected package libfile-stripnondeterminism-perl. 182s Preparing to unpack .../39-libfile-stripnondeterminism-perl_1.15.0-1build1_all.deb ... 182s Unpacking libfile-stripnondeterminism-perl (1.15.0-1build1) ... 182s Selecting previously unselected package dh-strip-nondeterminism. 182s Preparing to unpack .../40-dh-strip-nondeterminism_1.15.0-1build1_all.deb ... 182s Unpacking dh-strip-nondeterminism (1.15.0-1build1) ... 182s Selecting previously unselected package debugedit. 182s Preparing to unpack .../41-debugedit_1%3a5.2-3build1_ppc64el.deb ... 182s Unpacking debugedit (1:5.2-3build1) ... 182s Selecting previously unselected package dwz. 182s Preparing to unpack .../42-dwz_0.16-2_ppc64el.deb ... 182s Unpacking dwz (0.16-2) ... 182s Selecting previously unselected package gettext. 182s Preparing to unpack .../43-gettext_0.23.2-1_ppc64el.deb ... 182s Unpacking gettext (0.23.2-1) ... 182s Selecting previously unselected package intltool-debian. 182s Preparing to unpack .../44-intltool-debian_0.35.0+20060710.6build1_all.deb ... 182s Unpacking intltool-debian (0.35.0+20060710.6build1) ... 182s Selecting previously unselected package po-debconf. 182s Preparing to unpack .../45-po-debconf_1.0.22_all.deb ... 182s Unpacking po-debconf (1.0.22) ... 182s Selecting previously unselected package debhelper. 182s Preparing to unpack .../46-debhelper_13.28ubuntu1_all.deb ... 182s Unpacking debhelper (13.28ubuntu1) ... 183s Selecting previously unselected package dh-apport. 183s Preparing to unpack .../47-dh-apport_2.33.1-0ubuntu3_all.deb ... 183s Unpacking dh-apport (2.33.1-0ubuntu3) ... 183s Selecting previously unselected package golang-1.25-src. 183s Preparing to unpack .../48-golang-1.25-src_1.25.0-0ubuntu1_all.deb ... 183s Unpacking golang-1.25-src (1.25.0-0ubuntu1) ... 185s Selecting previously unselected package golang-1.25-go. 185s Preparing to unpack .../49-golang-1.25-go_1.25.0-0ubuntu1_ppc64el.deb ... 185s Unpacking golang-1.25-go (1.25.0-0ubuntu1) ... 185s Selecting previously unselected package golang-src. 185s Preparing to unpack .../50-golang-src_2%3a1.25~1_all.deb ... 185s Unpacking golang-src (2:1.25~1) ... 185s Selecting previously unselected package golang-go:ppc64el. 185s Preparing to unpack .../51-golang-go_2%3a1.25~1_ppc64el.deb ... 185s Unpacking golang-go:ppc64el (2:1.25~1) ... 185s Selecting previously unselected package dh-golang. 185s Preparing to unpack .../52-dh-golang_1.63build1_all.deb ... 185s Unpacking dh-golang (1.63build1) ... 185s Setting up libarchive-zip-perl (1.68-1) ... 185s Setting up libdebhelper-perl (13.28ubuntu1) ... 185s Setting up linux-libc-dev:ppc64el (6.18.0-9.9) ... 185s Setting up m4 (1.4.20-2) ... 185s Setting up libgomp1:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up dh-apport (2.33.1-0ubuntu3) ... 185s Setting up autotools-dev (20240727.1) ... 185s Setting up rpcsvc-proto (1.4.3-1build1) ... 185s Setting up libquadmath0:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up libmpc3:ppc64el (1.3.1-2) ... 185s Setting up autopoint (0.23.2-1) ... 185s Setting up autoconf (2.72-3.1ubuntu1) ... 185s Setting up libubsan1:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up dwz (0.16-2) ... 185s Setting up golang-1.25-src (1.25.0-0ubuntu1) ... 185s Setting up libcrypt-dev:ppc64el (1:4.5.1-1) ... 185s Setting up libasan8:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up debugedit (1:5.2-3build1) ... 185s Setting up libtsan2:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up libisl23:ppc64el (0.27-1build1) ... 185s Setting up libc-dev-bin (2.42-2ubuntu5) ... 185s Setting up golang-src (2:1.25~1) ... 185s Setting up libcc1-0:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up liblsan0:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up libitm1:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up automake (1:1.18.1-3build1) ... 185s update-alternatives: using /usr/bin/automake-1.18 to provide /usr/bin/automake (automake) in auto mode 185s Setting up libfile-stripnondeterminism-perl (1.15.0-1build1) ... 185s Setting up golang-1.25-go (1.25.0-0ubuntu1) ... 185s Setting up gettext (0.23.2-1) ... 185s Setting up libgcc-15-dev:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up golang-go:ppc64el (2:1.25~1) ... 185s Setting up intltool-debian (0.35.0+20060710.6build1) ... 185s Setting up cpp-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 185s Setting up dh-strip-nondeterminism (1.15.0-1build1) ... 185s Setting up cpp-15 (15.2.0-12ubuntu1) ... 185s Setting up libc6-dev:ppc64el (2.42-2ubuntu5) ... 185s Setting up cpp-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 185s Setting up gcc-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 185s Setting up po-debconf (1.0.22) ... 185s Setting up gcc-15 (15.2.0-12ubuntu1) ... 185s Setting up libstdc++-15-dev:ppc64el (15.2.0-12ubuntu1) ... 185s Setting up gcc-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 185s Setting up cpp (4:15.2.0-4ubuntu1) ... 185s Setting up g++-15-powerpc64le-linux-gnu (15.2.0-12ubuntu1) ... 185s Setting up libtool (2.5.4-9) ... 185s Setting up gcc (4:15.2.0-4ubuntu1) ... 185s Setting up dh-autoreconf (21) ... 185s Setting up g++-15 (15.2.0-12ubuntu1) ... 185s Setting up g++-powerpc64le-linux-gnu (4:15.2.0-4ubuntu1) ... 185s Setting up debhelper (13.28ubuntu1) ... 185s Setting up g++ (4:15.2.0-4ubuntu1) ... 185s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 185s Setting up build-essential (12.12ubuntu2) ... 185s Setting up dh-golang (1.63build1) ... 185s Processing triggers for man-db (2.13.1-1) ... 187s Processing triggers for install-info (7.2-5) ... 187s Processing triggers for libc-bin (2.42-2ubuntu5) ... 188s autopkgtest [11:50:32]: test command1: ./debian/tests/test 188s autopkgtest [11:50:32]: test command1: [----------------------- 230s === RUN TestRunSignal 230s === RUN TestRunSignal/Send_SIGINT_exits 230s INFO Starting WSL Pro Service version Dev 230s === RUN TestRunSignal/Send_SIGTERM_exits 230s INFO Starting WSL Pro Service version Dev 230s --- PASS: TestRunSignal (0.20s) 230s --- PASS: TestRunSignal/Send_SIGINT_exits (0.10s) 230s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.10s) 230s === RUN TestRun 230s === PAUSE TestRun 230s === CONT TestRun 230s === RUN TestRun/Run_and_exit_successfully 230s === PAUSE TestRun/Run_and_exit_successfully 230s === RUN TestRun/Run_and_return_error 230s === PAUSE TestRun/Run_and_return_error 230s === RUN TestRun/Run_and_return_usage_error 230s === PAUSE TestRun/Run_and_return_usage_error 230s === RUN TestRun/Run_and_usage_error_only_does_not_fail 230s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 230s === CONT TestRun/Run_and_exit_successfully 230s === CONT TestRun/Run_and_return_usage_error 230s INFO Starting WSL Pro Service version Dev 230s INFO Starting WSL Pro Service version Dev 230s ERROR context.Background Error requested 230s === CONT TestRun/Run_and_return_error 230s INFO Starting WSL Pro Service version Dev 230s === CONT TestRun/Run_and_usage_error_only_does_not_fail 230s INFO Starting WSL Pro Service version Dev 230s ERROR context.Background Error requested 230s --- PASS: TestRun (0.00s) 230s --- PASS: TestRun/Run_and_return_usage_error (0.10s) 230s --- PASS: TestRun/Run_and_exit_successfully (0.10s) 230s --- PASS: TestRun/Run_and_return_error (0.10s) 230s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.10s) 230s PASS 230s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 0.412s 244s === RUN TestHelp 244s --- PASS: TestHelp (0.00s) 244s === RUN TestCompletion 244s --- PASS: TestCompletion (0.00s) 244s === RUN TestVersion 244s --- PASS: TestVersion (0.00s) 244s === RUN TestConfigBadArg 244s --- PASS: TestConfigBadArg (0.00s) 244s === RUN TestConfigArg 244s --- PASS: TestConfigArg (0.00s) 244s === RUN TestConfigAutoDetect 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 244s --- PASS: TestConfigAutoDetect (0.00s) 244s === RUN TestNoUsageError 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 244s --- PASS: TestNoUsageError (0.00s) 244s === RUN TestUsageError 244s === PAUSE TestUsageError 244s === RUN TestCanQuitWhenExecute 244s === PAUSE TestCanQuitWhenExecute 244s === RUN TestCanQuitTwice 244s === PAUSE TestCanQuitTwice 244s === RUN TestAppCanQuitWithoutExecute 244s === PAUSE TestAppCanQuitWithoutExecute 244s === RUN TestAppRunFailsOnComponentsCreationAndQuit 244s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 244s === RUN TestAppGetRootCmd 244s === PAUSE TestAppGetRootCmd 244s === RUN TestWithProMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithProMock (0.00s) 244s === RUN TestWithWslPathMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithWslPathMock (0.00s) 244s === RUN TestWithWslInfoMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithWslInfoMock (0.00s) 244s === RUN TestWithCmdExeMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithCmdExeMock (0.00s) 244s === CONT TestUsageError 244s === CONT TestAppCanQuitWithoutExecute 244s service_test.go:190: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 244s --- SKIP: TestAppCanQuitWithoutExecute (0.00s) 244s === CONT TestAppGetRootCmd 244s --- PASS: TestAppGetRootCmd (0.00s) 244s === CONT TestCanQuitTwice 244s --- PASS: TestUsageError (0.00s) 244s === CONT TestCanQuitWhenExecute 244s time="2026-02-05T11:51:14Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35907" 244s time="2026-02-05T11:51:14Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build3440462316/b385/wsl-pro-service.yaml" 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:74 New() Building new daemon" 244s time="2026-02-05T11:51:14Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44115" 244s time="2026-02-05T11:51:14Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build3440462316/b385/wsl-pro-service.yaml" 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 244s time="2026-02-05T11:51:14Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:74 New() Building new daemon" 244s time="2026-02-05T11:51:20Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 244s time="2026-02-05T11:51:20Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 244s time="2026-02-05T11:51:20Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5893" 244s time="2026-02-05T11:51:20Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 244s time="2026-02-05T11:51:20Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 244s time="2026-02-05T11:51:20Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5893" 244s time="2026-02-05T11:51:20Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:20Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:21Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:21Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:35907" 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 244s time="2026-02-05T11:51:22Z" level=warning msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:194 (*Daemon).serveOnce() Daemon: disconnected from Windows host: could not start serving: could not connect: could not connect to GRPC service: rpc error: code = Unavailable desc = connection error: desc = \"transport: Error while dialing: dial tcp 127.0.0.1:35907: connect: connection refused\"" 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s --- PASS: TestCanQuitWhenExecute (7.95s) 244s === CONT TestAppRunFailsOnComponentsCreationAndQuit 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33395" 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:74 New() Building new daemon" 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:44115" 244s time="2026-02-05T11:51:22Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.ProAttachCmd requests" 244s time="2026-02-05T11:51:22Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.LandscapeConfigCmd requests" 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:275 (*mockWSLInstanceService).Connected() MockWindowsAgent: Connected ready" 244s time="2026-02-05T11:51:25Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/streams/server.go:146 (*Server).Serve() Server: sent preface messages to all streams" 244s time="2026-02-05T11:51:25Z" level=warning msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:196 (*Daemon).serveOnce() Daemon: disconnected from Windows host" 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 244s time="2026-02-05T11:51:25Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:25Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:326 (*mockWSLInstanceService).LandscapeConfigCommands() MockWindowsAgent: LandscapeConfigCommands ready" 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/testutils/mock_agent.go:300 (*mockWSLInstanceService).ProAttachmentCommands() MockWindowsAgent: ProAttachmentCommands ready" 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:25Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:25Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s --- PASS: TestCanQuitTwice (10.44s) 244s time="2026-02-05T11:51:25Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.p3humO/build.Rnb/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 244s time="2026-02-05T11:51:25Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.p3humO/build.Rnb/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 244s time="2026-02-05T11:51:25Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.p3humO/build.Rnb/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 244s time="2026-02-05T11:51:27Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 244s time="2026-02-05T11:51:27Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 244s time="2026-02-05T11:51:27Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5893" 244s time="2026-02-05T11:51:28Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 244s time="2026-02-05T11:51:28Z" level=info msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 244s time="2026-02-05T11:51:28Z" level=debug msg="/tmp/autopkgtest.p3humO/build.Rnb/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 244s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (5.81s) 244s PASS 244s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 13.780s 244s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 244s === RUN TestApplyProToken 244s === PAUSE TestApplyProToken 244s === RUN TestApplyLandscapeConfig 244s === PAUSE TestApplyLandscapeConfig 244s === RUN TestWithProMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithProMock (0.00s) 244s === RUN TestWithLandscapeConfigMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithLandscapeConfigMock (0.00s) 244s === RUN TestWithWslPathMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithWslPathMock (0.00s) 244s === RUN TestWithWslInfoMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithWslInfoMock (0.00s) 244s === RUN TestWithCmdExeMock 244s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 244s --- SKIP: TestWithCmdExeMock (0.00s) 244s === CONT TestApplyProToken 244s === RUN TestApplyProToken/Success_detaching 244s === PAUSE TestApplyProToken/Success_detaching 244s === RUN TestApplyProToken/Error_calling_pro_detach 244s === PAUSE TestApplyProToken/Error_calling_pro_detach 244s === RUN TestApplyProToken/Error_calling_pro_attach 244s === PAUSE TestApplyProToken/Error_calling_pro_attach 244s === RUN TestApplyProToken/Success_attaching 244s === PAUSE TestApplyProToken/Success_attaching 244s === CONT TestApplyProToken/Success_detaching 244s === CONT TestApplyLandscapeConfig 244s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 244s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 244s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 244s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 244s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 244s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 244s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 244s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 244s === CONT TestApplyProToken/Success_attaching 244s time="2026-02-05T11:51:16Z" level=info msg="ApplyProToken: Received empty token: detaching" 244s time="2026-02-05T11:51:16Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 244s === CONT TestApplyProToken/Error_calling_pro_attach 244s time="2026-02-05T11:51:18Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 244s === CONT TestApplyProToken/Error_calling_pro_detach 244s time="2026-02-05T11:51:20Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 244s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 244s time="2026-02-05T11:51:22Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 244s --- PASS: TestApplyProToken (0.00s) 244s --- PASS: TestApplyProToken/Success_detaching (2.41s) 244s --- PASS: TestApplyProToken/Success_attaching (4.28s) 244s --- PASS: TestApplyProToken/Error_calling_pro_detach (2.39s) 244s --- PASS: TestApplyProToken/Error_calling_pro_attach (4.36s) 244s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 244s time="2026-02-05T11:51:22Z" level=info msg="ApplyLandscapeConfig: received config: registering" 244s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 244s time="2026-02-05T11:51:25Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 244s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 244s time="2026-02-05T11:51:25Z" level=info msg="ApplyLandscapeConfig: received config: registering" 244s --- PASS: TestApplyLandscapeConfig (0.00s) 244s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (2.44s) 244s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (2.44s) 244s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (1.48s) 244s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (1.67s) 244s PASS 244s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 10.789s 244s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 378s === RUN TestNew 378s === PAUSE TestNew 378s === RUN TestServe 378s === PAUSE TestServe 378s === RUN TestServeAndQuit 378s === PAUSE TestServeAndQuit 378s === RUN TestRetryLogic 378s === PAUSE TestRetryLogic 378s === RUN TestReconnection 378s === PAUSE TestReconnection 378s === RUN TestWithProMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithProMock (0.00s) 378s === RUN TestWithWslPathMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslPathMock (0.00s) 378s === RUN TestWithWslInfoMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslInfoMock (0.00s) 378s === RUN TestWithCmdExeMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithCmdExeMock (0.00s) 378s === CONT TestNew 378s === RUN TestNew/Success 378s === PAUSE TestNew/Success 378s === RUN TestNew/Error_when_WslPath_returns_error 378s === PAUSE TestNew/Error_when_WslPath_returns_error 378s === CONT TestServeAndQuit 378s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 378s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 378s === RUN TestServeAndQuit/Success_with_graceful_quit 378s === PAUSE TestServeAndQuit/Success_with_graceful_quit 378s === RUN TestServeAndQuit/Success_with_forceful_quit 378s === PAUSE TestServeAndQuit/Success_with_forceful_quit 378s === RUN TestServeAndQuit/Success_with_double_quit 378s === PAUSE TestServeAndQuit/Success_with_double_quit 378s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 378s === CONT TestNew/Success 378s time="2026-02-05T11:51:28Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:28Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35183" 378s time="2026-02-05T11:51:28Z" level=debug msg="Building new daemon" 378s === CONT TestServe 378s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 378s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 378s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 378s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 378s === RUN TestServe/No_connection_because_the_port_file_has_port_0 378s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 378s === RUN TestServe/No_connection_because_there_are_no_certificates 378s === PAUSE TestServe/No_connection_because_there_are_no_certificates 378s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 378s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 378s === RUN TestServe/No_connection_because_the_port_file_is_empty 378s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 378s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 378s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 378s === RUN TestServe/No_connection_because_there_is_no_server 378s === PAUSE TestServe/No_connection_because_there_is_no_server 378s === RUN TestServe/Error_because_the_context_is_pre-cancelled 378s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 378s === RUN TestServe/Error_because_the_notifier_returns_an_error 378s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 378s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 378s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 378s === RUN TestServe/Success 378s === PAUSE TestServe/Success 378s === RUN TestServe/Success_with_systemd_notifier_returning_true 378s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 378s === RUN TestServe/Success_with_a_broken_Landscape_config 378s === PAUSE TestServe/Success_with_a_broken_Landscape_config 378s === CONT TestNew/Error_when_WslPath_returns_error 378s time="2026-02-05T11:51:31Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:31Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:31Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:31Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:31Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:31Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s === CONT TestServeAndQuit/Success_with_double_quit 378s time="2026-02-05T11:51:31Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38607" 378s time="2026-02-05T11:51:31Z" level=debug msg="Building new daemon" 378s === CONT TestReconnection 378s === RUN TestReconnection/Success_connecting_after_failing_to_connect 378s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 378s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 378s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 378s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 378s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 378s === CONT TestRetryLogic 378s === RUN TestRetryLogic/Without_retries 378s === PAUSE TestRetryLogic/Without_retries 378s === RUN TestRetryLogic/With_the_context_pre-cancelled 378s === PAUSE TestRetryLogic/With_the_context_pre-cancelled 378s === RUN TestRetryLogic/With_the_context_cancelled_while_waiting 378s === PAUSE TestRetryLogic/With_the_context_cancelled_while_waiting 378s === RUN TestRetryLogic/When_max_attempts_are_exhausted 378s === PAUSE TestRetryLogic/When_max_attempts_are_exhausted 378s === RUN TestRetryLogic/Error_only_when_action_errors 378s === PAUSE TestRetryLogic/Error_only_when_action_errors 378s === CONT TestServeAndQuit/Success_with_forceful_quit 378s --- PASS: TestNew (0.00s) 378s --- PASS: TestNew/Success (3.70s) 378s --- PASS: TestNew/Error_when_WslPath_returns_error (3.86s) 378s time="2026-02-05T11:51:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45365" 378s time="2026-02-05T11:51:35Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:35Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:51:35Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:35Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:35Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:51:38Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38607" 378s time="2026-02-05T11:51:38Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:38Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:51:38Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:38Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:40Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:51:40Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:40Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:40Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:40Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:51:40Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:40Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:40Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:40Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:40Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:40Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:40Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:40Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:40Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:51:40Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:51:40Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:40Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:40Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:40Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:40Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:40Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:40Z" level=debug msg="All connections have now ended." 378s === CONT TestServeAndQuit/Success_with_graceful_quit 378s time="2026-02-05T11:51:40Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39303" 378s time="2026-02-05T11:51:40Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:40Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45365" 378s time="2026-02-05T11:51:40Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:40Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:51:40Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:40Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:42Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:42Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:42Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:42Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:42Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:42Z" level=info msg="Stopping active requests." 378s time="2026-02-05T11:51:42Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:42Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:42Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:51:42Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:51:42Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:42Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:42Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:42Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 378s time="2026-02-05T11:51:42Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37127" 378s time="2026-02-05T11:51:42Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:42Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:51:42Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:42Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:42Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:42Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:51:43Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39303" 378s time="2026-02-05T11:51:43Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:43Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:51:44Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:44Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:45Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:45Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:45Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:45Z" 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_exist717113129/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist717113129/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 378s time="2026-02-05T11:51:45Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:45Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:45Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:45Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:45Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:45Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:45Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:45Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:45Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:45Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:51:45Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:51:45Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:45Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:45Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:45Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s === CONT TestServe/No_connection_because_there_is_no_server 378s --- PASS: TestServeAndQuit (0.00s) 378s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (3.70s) 378s --- PASS: TestServeAndQuit/Success_with_double_quit (8.69s) 378s --- PASS: TestServeAndQuit/Success_with_forceful_quit (6.92s) 378s --- PASS: TestServeAndQuit/Success_with_graceful_quit (4.85s) 378s time="2026-02-05T11:51:45Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37473" 378s time="2026-02-05T11:51:45Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:46Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:46Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:46Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/Success_with_a_broken_Landscape_config 378s time="2026-02-05T11:51:46Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46215" 378s time="2026-02-05T11:51:46Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:47Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:47Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:47Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:48Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:48Z" level=warning msg="Could not ensure valid Landscape configuration: could not ensure valid Landscape configuration: read /tmp/TestServeSuccess_with_a_broken_Landscape_config2299778885/001/etc/landscape/client.conf: is a directory" 378s time="2026-02-05T11:51:48Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:48Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:37473" 378s time="2026-02-05T11:51:48Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:48Z" 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:37473: connect: connection refused\"" 378s time="2026-02-05T11:51:48Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:49Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:49Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:49Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/Success_with_systemd_notifier_returning_true 378s time="2026-02-05T11:51:49Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45417" 378s time="2026-02-05T11:51:49Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:49Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:46215" 378s time="2026-02-05T11:51:49Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:49Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:49Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:50Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:50Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:50Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:50Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:51Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:51:51Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:51Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:51Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:51Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:51:52Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45417" 378s time="2026-02-05T11:51:52Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:52Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:51:52Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:52Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:52Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:52Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:52Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:52Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:52Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:52Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s === CONT TestServe/Success 378s time="2026-02-05T11:51:52Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:52Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:52Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41857" 378s time="2026-02-05T11:51:52Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:54Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:54Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:54Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:54Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:55Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:55Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:55Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:55Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:55Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:55Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:55Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:55Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:51:55Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:51:55Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:55Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:55Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:55Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 378s time="2026-02-05T11:51:55Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45377" 378s time="2026-02-05T11:51:55Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:56Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:41857" 378s time="2026-02-05T11:51:56Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:51:56Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:51:56Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:51:57Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:51:57Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:57Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:57Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:58Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:51:58Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:51:58Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:51:58Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:58Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:58Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/Error_because_the_notifier_returns_an_error 378s time="2026-02-05T11:51:58Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34189" 378s time="2026-02-05T11:51:58Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:51:59Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:51:59Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:51:59Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:51:59Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:51:59Z" level=debug msg="All connections have now ended." 378s time="2026-02-05T11:51:59Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s === CONT TestServe/Error_because_the_context_is_pre-cancelled 378s time="2026-02-05T11:51:59Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:59Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:59Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36851" 378s time="2026-02-05T11:51:59Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:01Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 378s time="2026-02-05T11:52:01Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:01Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:01Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 378s time="2026-02-05T11:52:01Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38979" 378s time="2026-02-05T11:52:01Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:02Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:02Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:02Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 378s time="2026-02-05T11:52:02Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37501" 378s time="2026-02-05T11:52:02Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:06Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:06Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:06Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:07Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:07Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:07Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:07Z" 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" 378s time="2026-02-05T11:52:07Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:08Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38979" 378s time="2026-02-05T11:52:08Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_3587326551/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 378s time="2026-02-05T11:52:08Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:08Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:08Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:08Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_the_port_file_is_empty 378s time="2026-02-05T11:52:08Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44195" 378s time="2026-02-05T11:52:08Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:08Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:08Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:08Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_the_port_file_has_port_0 378s time="2026-02-05T11:52:08Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44069" 378s time="2026-02-05T11:52:08Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:13Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:13Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:13Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:13Z" 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" 378s time="2026-02-05T11:52:13Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:13Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:13Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:13Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:13Z" 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" 378s time="2026-02-05T11:52:13Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:14Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:14Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:14Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_there_are_no_certificates 378s time="2026-02-05T11:52:14Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45357" 378s time="2026-02-05T11:52:14Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:14Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:14Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:14Z" level=debug msg="All connections have now ended." 378s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 378s time="2026-02-05T11:52:14Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46355" 378s time="2026-02-05T11:52:14Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:19Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:19Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:19Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:19Z" 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" 378s time="2026-02-05T11:52:19Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:19Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:19Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:19Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:20Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:20Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:20Z" level=debug msg="All connections have now ended." 378s === CONT TestReconnection/Success_connecting_after_failing_to_connect 378s time="2026-02-05T11:52:20Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:21Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45357" 378s time="2026-02-05T11:52:21Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates1589835658/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 378s time="2026-02-05T11:52:21Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:22Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:22Z" level=info msg="Waiting for active requests to close." 378s time="2026-02-05T11:52:22Z" level=debug msg="All connections have now ended." 378s === CONT TestRetryLogic/Without_retries 378s --- PASS: TestServe (0.00s) 378s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (3.44s) 378s --- PASS: TestServe/No_connection_because_there_is_no_server (4.11s) 378s --- PASS: TestServe/Success_with_a_broken_Landscape_config (6.52s) 378s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (6.18s) 378s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (3.22s) 378s --- PASS: TestServe/Success (6.58s) 378s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (3.00s) 378s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (3.66s) 378s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (6.66s) 378s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (5.81s) 378s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (5.76s) 378s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (5.92s) 378s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (5.78s) 378s --- PASS: TestServe/No_connection_because_there_are_no_certificates (8.06s) 378s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 378s time="2026-02-05T11:52:23Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:24Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:52:24Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:24Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:24Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:24Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:52:24Z" 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_connect3368088033/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect3368088033/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 378s time="2026-02-05T11:52:24Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:24Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:52:25Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33315" 378s time="2026-02-05T11:52:25Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:25Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:52:27Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43129" 378s time="2026-02-05T11:52:27Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:52:27Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:27Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:27Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:27Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:52:28Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33315" 378s time="2026-02-05T11:52:28Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:52:28Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:52:28Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:52:28Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:52:30Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43129" 378s time="2026-02-05T11:52:30Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:52:30Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:52:30Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:52:30Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:52:31Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:52:31Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:52:31Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:52:31Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:52:31Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:31Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:31Z" level=info msg="Stopping active requests." 378s time="2026-02-05T11:52:31Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:31Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:31Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:52:31Z" level=info msg="Reconnecting to Windows host in 2 seconds" 378s time="2026-02-05T11:52:31Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:52:31Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:52:31Z" level=debug msg="All connections have now ended." 378s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 378s time="2026-02-05T11:52:31Z" level=debug msg="Building new daemon" 378s time="2026-02-05T11:52:32Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:52:32Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:52:32Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:52:32Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:52:35Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38095" 378s time="2026-02-05T11:52:35Z" level=debug msg="Ready state sent to systemd" 378s time="2026-02-05T11:52:35Z" level=debug msg="Checking cloud-init status" 378s time="2026-02-05T11:52:35Z" level=debug msg="No Landscape configuration detected: nothing to do" 378s time="2026-02-05T11:52:35Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:35Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:52:37Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38095" 378s time="2026-02-05T11:52:37Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:52:37Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:52:37Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:52:37Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:52:38Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:52:38Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:52:38Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:52:38Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:52:39Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:39Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 378s time="2026-02-05T11:52:39Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:52:39Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:52:39Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:39Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:39Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36397" 378s time="2026-02-05T11:52:40Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:52:40Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:52:41Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:36397" 378s time="2026-02-05T11:52:41Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:52:41Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:52:41Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:52:41Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:52:43Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:52:43Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:52:43Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:52:43Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:52:43Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:43Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:52:43Z" level=info msg="Stopping active requests." 378s time="2026-02-05T11:52:43Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:43Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:52:43Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:52:43Z" level=info msg="Reconnecting to Windows host in 2 seconds" 378s time="2026-02-05T11:52:43Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:52:43Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:52:43Z" level=debug msg="All connections have now ended." 378s === CONT TestRetryLogic/When_max_attempts_are_exhausted 378s === CONT TestRetryLogic/Error_only_when_action_errors 378s === CONT TestRetryLogic/With_the_context_cancelled_while_waiting 378s === CONT TestRetryLogic/With_the_context_pre-cancelled 378s --- PASS: TestRetryLogic (0.00s) 378s --- PASS: TestRetryLogic/Without_retries (0.70s) 378s --- PASS: TestRetryLogic/When_max_attempts_are_exhausted (0.42s) 378s --- PASS: TestRetryLogic/Error_only_when_action_errors (0.00s) 378s --- PASS: TestRetryLogic/With_the_context_cancelled_while_waiting (0.03s) 378s --- PASS: TestRetryLogic/With_the_context_pre-cancelled (0.00s) 378s time="2026-02-05T11:53:37Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 378s time="2026-02-05T11:53:37Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:53:37Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:53:37Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45805" 378s time="2026-02-05T11:53:37Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:37Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:37Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:38Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:43129" 378s time="2026-02-05T11:53:38Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:53:38Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:53:38Z" 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:43129: connect: connection refused\"" 378s time="2026-02-05T11:53:38Z" level=info msg="Reconnecting to Windows host in 1 seconds" 378s time="2026-02-05T11:53:38Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:53:39Z" level=info msg="Daemon: connecting to Windows Agent from PID 6989" 378s time="2026-02-05T11:53:39Z" level=debug msg="Updated systemd status to \"Connecting\"" 378s time="2026-02-05T11:53:40Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:45805" 378s time="2026-02-05T11:53:40Z" level=info msg="Daemon: completed connection to Windows Agent" 378s time="2026-02-05T11:53:40Z" level=debug msg="Updated systemd status to \"Connected\"" 378s time="2026-02-05T11:53:40Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 378s time="2026-02-05T11:53:40Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 378s time="2026-02-05T11:53:41Z" level=debug msg="Server: sent preface messages to all streams" 378s time="2026-02-05T11:53:41Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:53:41Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:53:41Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:53:41Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:41Z" level=info msg="Stopping daemon requested." 378s time="2026-02-05T11:53:41Z" level=info msg="Stopping active requests." 378s time="2026-02-05T11:53:41Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:41Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:53:41Z" level=warning msg="Daemon: disconnected from Windows host" 378s time="2026-02-05T11:53:41Z" level=info msg="Reconnecting to Windows host in 2 seconds" 378s time="2026-02-05T11:53:41Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 378s time="2026-02-05T11:53:41Z" level=debug msg="Updated systemd status to \"Stopped\"" 378s time="2026-02-05T11:53:41Z" level=debug msg="All connections have now ended." 378s --- PASS: TestReconnection (0.00s) 378s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (10.66s) 378s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (12.52s) 378s --- PASS: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (78.77s) 378s PASS 378s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 133.738s 378s === RUN TestConnect 378s === PAUSE TestConnect 378s === RUN TestSendAndRecv 378s --- PASS: TestSendAndRecv (0.41s) 378s === RUN TestServe 378s === PAUSE TestServe 378s === RUN TestStop 378s === PAUSE TestStop 378s === RUN TestWithProMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithProMock (0.00s) 378s === RUN TestWithWslPathMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslPathMock (0.00s) 378s === RUN TestWithWslInfoMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslInfoMock (0.00s) 378s === RUN TestWithCmdExeMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithCmdExeMock (0.00s) 378s === CONT TestConnect 378s === RUN TestConnect/Success 378s === CONT TestStop 378s === PAUSE TestConnect/Success 378s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 378s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 378s === CONT TestServe 378s time="2026-02-05T11:51:31Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35139" 378s time="2026-02-05T11:51:31Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42043" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: Connected ready" 378s time="2026-02-05T11:51:33Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 378s time="2026-02-05T11:51:39Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:39Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:39Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s --- PASS: TestServe (8.76s) 378s === CONT TestConnect/Success 378s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 378s time="2026-02-05T11:51:44Z" level=warning msg="Streamserver: could not gather info after command completion: could not obtain pro status: pro status: /usr/bin/bash: error: context canceled.\n Stdout: \n Stderr: " 378s time="2026-02-05T11:51:44Z" level=warning msg="Streamserver: could not stream back info after command completion: EOF" 378s time="2026-02-05T11:51:44Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 378s --- PASS: TestStop (13.01s) 378s time="2026-02-05T11:51:44Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 378s time="2026-02-05T11:51:44Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 378s --- PASS: TestConnect (0.00s) 378s --- PASS: TestConnect/Success (0.30s) 378s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.02s) 378s PASS 378s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 29.489s 378s === RUN TestNew 378s === PAUSE TestNew 378s === RUN TestInfo 378s === PAUSE TestInfo 378s === RUN TestWslDistroName 378s === PAUSE TestWslDistroName 378s === RUN TestUserProfileDir 378s === PAUSE TestUserProfileDir 378s === RUN TestProStatus 378s === PAUSE TestProStatus 378s === RUN TestProAttach 378s === PAUSE TestProAttach 378s === RUN TestProDetach 378s === PAUSE TestProDetach 378s === RUN TestLandscapeEnable 378s === PAUSE TestLandscapeEnable 378s === RUN TestWindowsHostAddress 378s === PAUSE TestWindowsHostAddress 378s === RUN TestLandscapeDisable 378s === PAUSE TestLandscapeDisable 378s === RUN TestEnsureValidLandscapeConfig 378s === PAUSE TestEnsureValidLandscapeConfig 378s === RUN TestRealBackend 378s === PAUSE TestRealBackend 378s === RUN TestWithProMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithProMock (0.00s) 378s === RUN TestWithLandscapeConfigMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithLandscapeConfigMock (0.00s) 378s === RUN TestWithWslPathMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslPathMock (0.00s) 378s === RUN TestWithWslInfoMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithWslInfoMock (0.00s) 378s === RUN TestWithCmdExeMock 378s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 378s --- SKIP: TestWithCmdExeMock (0.00s) 378s === CONT TestNew 378s === RUN TestNew/Return_a_new_system 378s === PAUSE TestNew/Return_a_new_system 378s === RUN TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 378s === PAUSE TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 378s === CONT TestNew/Return_a_new_system 378s === CONT TestRealBackend 378s === CONT TestWslDistroName 378s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 378s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 378s === RUN TestWslDistroName/Success_using_wslpath 378s === PAUSE TestWslDistroName/Success_using_wslpath 378s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 378s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 378s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 378s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 378s === CONT TestProDetach 378s === RUN TestProDetach/success_on_unattached_distro 378s === PAUSE TestProDetach/success_on_unattached_distro 378s === RUN TestProDetach/success_on_attached_distro 378s === PAUSE TestProDetach/success_on_attached_distro 378s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 378s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 378s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 378s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 378s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 378s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 378s === CONT TestEnsureValidLandscapeConfig 378s === RUN TestEnsureValidLandscapeConfig/Regular_with_additional_keys 378s === PAUSE TestEnsureValidLandscapeConfig/Regular_with_additional_keys 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 378s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === RUN TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 378s === PAUSE TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 378s === RUN TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 378s === PAUSE TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 378s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 378s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 378s === RUN TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 378s === PAUSE TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 378s === RUN TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 378s === PAUSE TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 378s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 378s === RUN TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 378s === PAUSE TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 378s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 378s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 378s === RUN TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 378s === PAUSE TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 378s === RUN TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 378s === PAUSE TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 378s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 378s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 378s === CONT TestLandscapeDisable 378s === RUN TestLandscapeDisable/Success 378s === PAUSE TestLandscapeDisable/Success 378s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 378s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 378s === CONT TestWindowsHostAddress 378s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 378s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 378s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 378s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 378s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 378s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 378s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 378s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 378s === RUN TestWindowsHostAddress/Without_NAT 378s === PAUSE TestWindowsHostAddress/Without_NAT 378s === RUN TestWindowsHostAddress/With_NAT 378s === PAUSE TestWindowsHostAddress/With_NAT 378s === CONT TestLandscapeEnable 378s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 378s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 378s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === RUN TestLandscapeEnable/Refresh_computer_title_if_changed 378s === PAUSE TestLandscapeEnable/Refresh_computer_title_if_changed 378s === RUN TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 378s === PAUSE TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 378s === RUN TestLandscapeEnable/Rerun_landscape_even_without_modifications 378s === PAUSE TestLandscapeEnable/Rerun_landscape_even_without_modifications 378s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 378s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 378s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 378s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 378s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path 378s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path 378s === RUN TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 378s === PAUSE TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 378s === RUN TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 378s === PAUSE TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 378s === RUN TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 378s === PAUSE TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 378s === RUN TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 378s === PAUSE TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 378s === RUN TestLandscapeEnable/Regular_with_additional_keys 378s === PAUSE TestLandscapeEnable/Regular_with_additional_keys 378s === RUN TestLandscapeEnable/Do_not_modify_other_sections_and_keys 378s === PAUSE TestLandscapeEnable/Do_not_modify_other_sections_and_keys 378s === RUN TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 378s === PAUSE TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 378s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 378s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 378s === CONT TestUserProfileDir 378s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 378s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 378s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 378s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 378s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 378s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 378s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 378s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 378s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 378s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 378s === RUN TestUserProfileDir/Error_on_wslpath_error 378s === PAUSE TestUserProfileDir/Error_on_wslpath_error 378s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 378s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 378s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 378s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 378s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 378s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 378s === RUN TestUserProfileDir/Error_on_cmd.exe_error 378s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 378s === RUN TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 378s === PAUSE TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 378s === CONT TestProAttach 378s === RUN TestProAttach/success 378s === PAUSE TestProAttach/success 378s === RUN TestProAttach/error_on_'pro_attach'_error 378s === PAUSE TestProAttach/error_on_'pro_attach'_error 378s === CONT TestProStatus 378s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 378s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 378s === RUN TestProStatus/error_on_'pro_attach'_error 378s === PAUSE TestProStatus/error_on_'pro_attach'_error 378s === RUN TestProStatus/success_on_unattached_distro 378s === PAUSE TestProStatus/success_on_unattached_distro 378s === RUN TestProStatus/success_on_attached_distro 378s === PAUSE TestProStatus/success_on_attached_distro 378s --- PASS: TestRealBackend (0.00s) 378s === CONT TestInfo 378s === RUN TestInfo/Error_when_pro_status_command_fails 378s === PAUSE TestInfo/Error_when_pro_status_command_fails 378s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 378s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 378s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 378s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 378s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 378s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 378s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 378s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 378s === RUN TestInfo/Success 378s === PAUSE TestInfo/Success 378s === RUN TestInfo/Error_when_WslDistroName_fails 378s === PAUSE TestInfo/Error_when_WslDistroName_fails 378s === CONT TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 378s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 378s === CONT TestProDetach/success_on_unattached_distro 378s --- PASS: TestNew (0.00s) 378s --- PASS: TestNew/Return_a_new_system (0.00s) 378s --- PASS: TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) (0.01s) 378s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 378s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 378s === CONT TestWslDistroName/Success_using_wslpath 378s === CONT TestEnsureValidLandscapeConfig/Regular_with_additional_keys 378s --- PASS: TestWslDistroName (0.00s) 378s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.00s) 378s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (2.64s) 378s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (2.34s) 378s --- PASS: TestWslDistroName/Success_using_wslpath (2.25s) 378s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 378s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 378s === NAME TestEnsureValidLandscapeConfig/Regular_with_additional_keys 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/regular_with_additional_keys 378s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 378s === CONT TestProDetach/success_on_attached_distro 378s === CONT TestLandscapeDisable/Success 378s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 378s --- PASS: TestProDetach (0.00s) 378s --- PASS: TestProDetach/success_on_unattached_distro (2.92s) 378s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (2.15s) 378s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (2.29s) 378s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (1.96s) 378s --- PASS: TestProDetach/success_on_attached_distro (1.96s) 378s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_due_whitespace_changes 378s === CONT TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 378s === CONT TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_transform_windows_ssl_certificate_empty_path 378s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 378s === NAME TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_modify_other_sections_and_keys 378s === CONT TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 378s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 378s === CONT TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 378s === CONT TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 378s === NAME TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/appends_any_required_fields_-_no_ssl 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 378s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 378s === CONT TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 378s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_without_modifications 378s === CONT TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/refresh_computer_title_if_changed 378s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === NAME TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/reformat_landscape_config_to_proper_ini 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 378s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 378s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path_with_forward_slash 378s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 378s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 378s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 378s --- PASS: TestEnsureValidLandscapeConfig (0.00s) 378s --- PASS: TestEnsureValidLandscapeConfig/Regular_with_additional_keys (4.63s) 378s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes (1.95s) 378s --- PASS: TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path (0.01s) 378s --- PASS: TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys (4.19s) 378s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path (4.74s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed (0.02s) 378s --- PASS: TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created (0.01s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path (2.15s) 378s --- PASS: TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl (1.88s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read (0.01s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist (2.17s) 378s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications (2.44s) 378s --- PASS: TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed (2.26s) 378s --- PASS: TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini (4.06s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name (2.42s) 378s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash (4.93s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section (0.01s) 378s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails (4.14s) 378s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 378s --- PASS: TestLandscapeDisable (0.00s) 378s --- PASS: TestLandscapeDisable/Success (2.11s) 378s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (1.81s) 378s === CONT TestWindowsHostAddress/With_NAT 378s === CONT TestWindowsHostAddress/Without_NAT 378s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 378s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 378s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 378s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 378s --- PASS: TestWindowsHostAddress (0.00s) 378s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (1.78s) 378s --- PASS: TestWindowsHostAddress/With_NAT (1.78s) 378s --- PASS: TestWindowsHostAddress/Without_NAT (1.74s) 378s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (1.52s) 378s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (1.25s) 378s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (1.39s) 378s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 378s === CONT TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 378s === CONT TestLandscapeEnable/Do_not_modify_other_sections_and_keys 378s === CONT TestLandscapeEnable/Regular_with_additional_keys 378s === NAME TestLandscapeEnable/Do_not_modify_other_sections_and_keys 378s system_test.go:526: testdata/TestLandscapeEnable/golden/do_not_modify_other_sections_and_keys 378s === CONT TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 378s === NAME TestLandscapeEnable/Regular_with_additional_keys 378s system_test.go:526: testdata/TestLandscapeEnable/golden/regular_with_additional_keys 378s === CONT TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 378s === NAME TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 378s system_test.go:526: testdata/TestLandscapeEnable/golden/appends_any_required_fields_-_no_ssl 378s === CONT TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 378s === CONT TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 378s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path 378s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 378s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 378s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path 378s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path 378s === CONT TestLandscapeEnable/Rerun_landscape_even_without_modifications 378s === CONT TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 378s === NAME TestLandscapeEnable/Rerun_landscape_even_without_modifications 378s system_test.go:526: testdata/TestLandscapeEnable/golden/rerun_landscape_even_without_modifications 378s === CONT TestLandscapeEnable/Refresh_computer_title_if_changed 378s === NAME TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 378s system_test.go:526: testdata/TestLandscapeEnable/golden/reformat_landscape_config_to_proper_ini 378s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 378s === NAME TestLandscapeEnable/Refresh_computer_title_if_changed 378s system_test.go:526: testdata/TestLandscapeEnable/golden/refresh_computer_title_if_changed 378s === CONT TestProAttach/success 378s === CONT TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 378s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 378s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path_with_forward_slash 378s === CONT TestUserProfileDir/Error_on_cmd.exe_error 378s --- PASS: TestLandscapeEnable (0.00s) 378s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (1.65s) 378s --- PASS: TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section (0.00s) 378s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (3.32s) 378s --- PASS: TestLandscapeEnable/Do_not_modify_other_sections_and_keys (2.37s) 378s --- PASS: TestLandscapeEnable/Regular_with_additional_keys (2.50s) 378s --- PASS: TestLandscapeEnable/Appends_any_required_fields_-_no_ssl (1.12s) 378s --- PASS: TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name (1.20s) 378s --- PASS: TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed (0.00s) 378s --- PASS: TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created (1.20s) 378s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (1.06s) 378s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path (2.54s) 378s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed (1.16s) 378s --- PASS: TestLandscapeEnable/Rerun_landscape_even_without_modifications (2.32s) 378s --- PASS: TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini (2.39s) 378s --- PASS: TestLandscapeEnable/Refresh_computer_title_if_changed (1.20s) 378s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash (2.38s) 378s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 378s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 378s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 378s === CONT TestUserProfileDir/Error_on_wslpath_error 378s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 378s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 378s system_test.go:245: Removing default proc/mounts 378s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 378s system_test.go:245: Removing default proc/mounts 378s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 378s === CONT TestProAttach/error_on_'pro_attach'_error 378s --- PASS: TestProAttach (0.00s) 378s --- PASS: TestProAttach/success (1.25s) 378s --- PASS: TestProAttach/error_on_'pro_attach'_error (1.17s) 378s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 378s === CONT TestProStatus/success_on_attached_distro 378s === CONT TestProStatus/success_on_unattached_distro 378s --- PASS: TestUserProfileDir (0.00s) 378s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (3.63s) 378s --- PASS: TestUserProfileDir/Error_when_UserProfile_env_var_is_empty (1.18s) 378s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (1.17s) 378s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (2.32s) 378s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (2.38s) 378s --- PASS: TestUserProfileDir/Error_on_wslpath_error (2.32s) 378s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.00s) 378s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (0.00s) 378s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.00s) 378s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (2.40s) 378s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (2.51s) 378s === CONT TestProStatus/error_on_'pro_attach'_error 378s === CONT TestInfo/Error_when_pro_status_command_fails 378s --- PASS: TestProStatus (0.00s) 378s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (1.28s) 378s --- PASS: TestProStatus/success_on_attached_distro (1.18s) 378s --- PASS: TestProStatus/success_on_unattached_distro (1.17s) 378s --- PASS: TestProStatus/error_on_'pro_attach'_error (1.22s) 378s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 378s === CONT TestInfo/Error_when_WslDistroName_fails 378s === CONT TestInfo/Success 378s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 378s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 378s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 378s --- PASS: TestInfo (0.00s) 378s --- PASS: TestInfo/Error_when_pro_status_command_fails (1.21s) 378s --- PASS: TestInfo/Error_when_WslDistroName_fails (1.16s) 378s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (1.21s) 378s --- PASS: TestInfo/Success (1.18s) 378s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (1.17s) 378s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (1.16s) 378s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (1.16s) 378s PASS 378s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 66.917s 378s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 378s autopkgtest [11:53:42]: test command1: -----------------------] 379s autopkgtest [11:53:43]: test command1: - - - - - - - - - - results - - - - - - - - - - 379s command1 PASS 379s autopkgtest [11:53:43]: @@@@@@@@@@@@@@@@@@@@ summary 379s command1 PASS