0s autopkgtest [23:14:48]: starting date and time: 2026-02-06 23:14:48+0000 0s autopkgtest [23:14:48]: git checkout: 4b346b80 nova: make wait_reboot return success even when a no-op 0s autopkgtest [23:14:48]: host juju-7f2275-prod-proposed-migration-environment-2; command line: /home/ubuntu/autopkgtest/runner/autopkgtest --output-dir /tmp/autopkgtest-work._ka5iw5n/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-amd64 --security-groups autopkgtest-juju-7f2275-prod-proposed-migration-environment-2@sto01-33.secgroup --name adt-resolute-amd64-wsl-pro-service-20260206-231448-juju-7f2275-prod-proposed-migration-environment-2-f9f8cea5-60d7-4b51-855d-26f26f709ffa --image adt/ubuntu-resolute-amd64-server --keyname testbed-juju-7f2275-prod-proposed-migration-environment-2 --net-id=net_prod-autopkgtest-workers-amd64 -e TERM=linux --mirror=http://ftpmaster.internal/ubuntu/ 3s Creating nova instance adt-resolute-amd64-wsl-pro-service-20260206-231448-juju-7f2275-prod-proposed-migration-environment-2-f9f8cea5-60d7-4b51-855d-26f26f709ffa from image adt/ubuntu-resolute-amd64-server-20260204.img (UUID fedf54b4-458b-493e-8072-6425c19717b4)... 85s autopkgtest [23:16:13]: testbed dpkg architecture: amd64 85s autopkgtest [23:16:13]: testbed apt version: 3.1.14 85s autopkgtest [23:16:13]: @@@@@@@@@@@@@@@@@@@@ test bed setup 85s autopkgtest [23:16:13]: testbed release detected to be: None 86s autopkgtest [23:16:14]: updating testbed package index (apt update) 86s Get:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease [124 kB] 86s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 86s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 86s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 86s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/restricted Sources [10.7 kB] 86s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse Sources [32.7 kB] 86s Get:7 http://ftpmaster.internal/ubuntu resolute-proposed/universe Sources [1547 kB] 87s Get:8 http://ftpmaster.internal/ubuntu resolute-proposed/main Sources [201 kB] 87s Get:9 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 Packages [266 kB] 87s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main i386 Packages [189 kB] 87s Get:11 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 c-n-f Metadata [6500 B] 87s Get:12 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 Packages [80.4 kB] 87s Get:13 http://ftpmaster.internal/ubuntu resolute-proposed/restricted i386 Packages [3692 B] 87s Get:14 http://ftpmaster.internal/ubuntu resolute-proposed/restricted amd64 c-n-f Metadata [336 B] 87s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/universe i386 Packages [550 kB] 87s Get:16 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 Packages [1433 kB] 87s Get:17 http://ftpmaster.internal/ubuntu resolute-proposed/universe amd64 c-n-f Metadata [36.8 kB] 87s Get:18 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 Packages [28.2 kB] 87s Get:19 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse i386 Packages [4892 B] 87s Get:20 http://ftpmaster.internal/ubuntu resolute-proposed/multiverse amd64 c-n-f Metadata [1104 B] 88s Fetched 4516 kB in 1s (4689 kB/s) 88s Reading package lists... 89s Hit:1 http://ftpmaster.internal/ubuntu resolute-proposed InRelease 89s Hit:2 http://ftpmaster.internal/ubuntu resolute InRelease 89s Hit:3 http://ftpmaster.internal/ubuntu resolute-updates InRelease 89s Hit:4 http://ftpmaster.internal/ubuntu resolute-security InRelease 89s Reading package lists... 89s Reading package lists... 90s Building dependency tree... 90s Reading state information... 90s Calculating upgrade... 90s The following packages will be upgraded: 90s amd64-microcode apt busybox-initramfs busybox-static dmsetup findutils less 90s libapt-pkg7.0 libattr1 libc-bin libc-gconv-modules-extra libc6 90s libdevmapper1.02.1 libdrm-amdgpu1 libdrm-common libdrm2 libgpm2 libkeyutils1 90s libmaxminddb0 libnpth0t64 libsensors-config libsensors5 locales mawk patch 90s pollinate python3-linkify-it python3-markdown-it python3-referencing sed tar 90s 31 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 90s Need to get 14.4 MB of archives. 90s After this operation, 270 kB disk space will be freed. 90s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 findutils amd64 4.10.0-3build2 [307 kB] 90s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 sed amd64 4.9-2build3 [195 kB] 90s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 tar amd64 1.35+dfsg-3.1build2 [257 kB] 90s Get:4 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libc-gconv-modules-extra amd64 2.42-2ubuntu5 [1394 kB] 90s Get:5 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libc6 amd64 2.42-2ubuntu5 [2041 kB] 90s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libc-bin amd64 2.42-2ubuntu5 [702 kB] 90s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 libattr1 amd64 1:2.5.2-3build2 [11.4 kB] 90s Get:8 http://ftpmaster.internal/ubuntu resolute/main amd64 mawk amd64 1.3.4.20260129-1 [133 kB] 90s Get:9 http://ftpmaster.internal/ubuntu resolute/main amd64 libapt-pkg7.0 amd64 3.1.15 [1151 kB] 90s Get:10 http://ftpmaster.internal/ubuntu resolute/main amd64 apt amd64 3.1.15 [1479 kB] 90s Get:11 http://ftpmaster.internal/ubuntu resolute/main amd64 libdevmapper1.02.1 amd64 2:1.02.205-2ubuntu3 [142 kB] 90s Get:12 http://ftpmaster.internal/ubuntu resolute/main amd64 dmsetup amd64 2:1.02.205-2ubuntu3 [79.4 kB] 90s Get:13 http://ftpmaster.internal/ubuntu resolute/main amd64 less amd64 668-1build1 [172 kB] 90s Get:14 http://ftpmaster.internal/ubuntu resolute/main amd64 libkeyutils1 amd64 1.6.3-6ubuntu3 [10.6 kB] 90s Get:15 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 locales all 2.42-2ubuntu5 [4255 kB] 91s Get:16 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-linkify-it all 2.0.3-1ubuntu3 [19.4 kB] 91s Get:17 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-markdown-it all 3.0.0-3build1 [54.4 kB] 91s Get:18 http://ftpmaster.internal/ubuntu resolute/main amd64 busybox-static amd64 1:1.37.0-7ubuntu1 [1034 kB] 91s Get:19 http://ftpmaster.internal/ubuntu resolute/main amd64 libdrm-common all 2.4.131-1 [9774 B] 91s Get:20 http://ftpmaster.internal/ubuntu resolute/main amd64 libdrm2 amd64 2.4.131-1 [42.3 kB] 91s Get:21 http://ftpmaster.internal/ubuntu resolute/main amd64 libgpm2 amd64 1.20.7-12build1 [14.4 kB] 91s Get:22 http://ftpmaster.internal/ubuntu resolute/main amd64 libmaxminddb0 amd64 1.12.2-1build2 [18.9 kB] 91s Get:23 http://ftpmaster.internal/ubuntu resolute/main amd64 libsensors-config all 1:3.6.2-2build1 [6862 B] 91s Get:24 http://ftpmaster.internal/ubuntu resolute/main amd64 libsensors5 amd64 1:3.6.2-2build1 [28.9 kB] 91s Get:25 http://ftpmaster.internal/ubuntu resolute/main amd64 busybox-initramfs amd64 1:1.37.0-7ubuntu1 [191 kB] 91s Get:26 http://ftpmaster.internal/ubuntu resolute/main amd64 libdrm-amdgpu1 amd64 2.4.131-1 [23.2 kB] 91s Get:27 http://ftpmaster.internal/ubuntu resolute/main amd64 libnpth0t64 amd64 1.8-3build1 [9302 B] 91s Get:28 http://ftpmaster.internal/ubuntu resolute/main amd64 patch amd64 2.8-2build1 [95.7 kB] 91s Get:29 http://ftpmaster.internal/ubuntu resolute/main amd64 pollinate all 4.33-4ubuntu5 [14.0 kB] 91s Get:30 http://ftpmaster.internal/ubuntu resolute/main amd64 python3-referencing all 0.36.2-1ubuntu2 [22.2 kB] 91s Get:31 http://ftpmaster.internal/ubuntu resolute/main amd64 amd64-microcode amd64 3.20251202.1ubuntu1 [459 kB] 91s dpkg-preconfigure: unable to re-open stdin: No such file or directory 91s Fetched 14.4 MB in 1s (17.6 MB/s) 91s (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 ... 83957 files and directories currently installed.) 91s Preparing to unpack .../findutils_4.10.0-3build2_amd64.deb ... 91s Unpacking findutils (4.10.0-3build2) over (4.10.0-3build1) ... 91s Setting up findutils (4.10.0-3build2) ... 91s (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 ... 83957 files and directories currently installed.) 91s Preparing to unpack .../sed_4.9-2build3_amd64.deb ... 91s Unpacking sed (4.9-2build3) over (4.9-2build2) ... 91s Setting up sed (4.9-2build3) ... 91s (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 ... 83957 files and directories currently installed.) 91s Preparing to unpack .../tar_1.35+dfsg-3.1build2_amd64.deb ... 91s Unpacking tar (1.35+dfsg-3.1build2) over (1.35+dfsg-3.1build1) ... 91s Setting up tar (1.35+dfsg-3.1build2) ... 91s (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 ... 83957 files and directories currently installed.) 91s Preparing to unpack .../libc-gconv-modules-extra_2.42-2ubuntu5_amd64.deb ... 91s Unpacking libc-gconv-modules-extra:amd64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 91s Setting up libc-gconv-modules-extra:amd64 (2.42-2ubuntu5) ... 91s (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 ... 83957 files and directories currently installed.) 91s Preparing to unpack .../libc6_2.42-2ubuntu5_amd64.deb ... 91s Unpacking libc6:amd64 (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 91s Setting up libc6:amd64 (2.42-2ubuntu5) ... 92s (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 ... 83957 files and directories currently installed.) 92s Preparing to unpack .../libc-bin_2.42-2ubuntu5_amd64.deb ... 92s Unpacking libc-bin (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 92s Setting up libc-bin (2.42-2ubuntu5) ... 92s (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 ... 83957 files and directories currently installed.) 92s Preparing to unpack .../libattr1_1%3a2.5.2-3build2_amd64.deb ... 92s Unpacking libattr1:amd64 (1:2.5.2-3build2) over (1:2.5.2-3build1) ... 92s Setting up libattr1:amd64 (1:2.5.2-3build2) ... 92s (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 ... 83957 files and directories currently installed.) 92s Preparing to unpack .../00-mawk_1.3.4.20260129-1_amd64.deb ... 92s Unpacking mawk (1.3.4.20260129-1) over (1.3.4.20250131-2) ... 92s Preparing to unpack .../01-libapt-pkg7.0_3.1.15_amd64.deb ... 92s Unpacking libapt-pkg7.0:amd64 (3.1.15) over (3.1.14) ... 92s Preparing to unpack .../02-apt_3.1.15_amd64.deb ... 92s Unpacking apt (3.1.15) over (3.1.14) ... 92s Preparing to unpack .../03-libdevmapper1.02.1_2%3a1.02.205-2ubuntu3_amd64.deb ... 92s Unpacking libdevmapper1.02.1:amd64 (2:1.02.205-2ubuntu3) over (2:1.02.205-2ubuntu2) ... 92s Preparing to unpack .../04-dmsetup_2%3a1.02.205-2ubuntu3_amd64.deb ... 92s Unpacking dmsetup (2:1.02.205-2ubuntu3) over (2:1.02.205-2ubuntu2) ... 92s Preparing to unpack .../05-less_668-1build1_amd64.deb ... 92s Unpacking less (668-1build1) over (668-1) ... 92s Preparing to unpack .../06-libkeyutils1_1.6.3-6ubuntu3_amd64.deb ... 92s Unpacking libkeyutils1:amd64 (1.6.3-6ubuntu3) over (1.6.3-6ubuntu2) ... 92s Preparing to unpack .../07-locales_2.42-2ubuntu5_all.deb ... 92s Unpacking locales (2.42-2ubuntu5) over (2.42-2ubuntu4) ... 92s Preparing to unpack .../08-python3-linkify-it_2.0.3-1ubuntu3_all.deb ... 92s Unpacking python3-linkify-it (2.0.3-1ubuntu3) over (2.0.3-1ubuntu2) ... 92s Preparing to unpack .../09-python3-markdown-it_3.0.0-3build1_all.deb ... 92s Unpacking python3-markdown-it (3.0.0-3build1) over (3.0.0-3) ... 93s Preparing to unpack .../10-busybox-static_1%3a1.37.0-7ubuntu1_amd64.deb ... 93s Unpacking busybox-static (1:1.37.0-7ubuntu1) over (1:1.37.0-4ubuntu1) ... 93s Preparing to unpack .../11-libdrm-common_2.4.131-1_all.deb ... 93s Unpacking libdrm-common (2.4.131-1) over (2.4.129-1) ... 93s Preparing to unpack .../12-libdrm2_2.4.131-1_amd64.deb ... 93s Unpacking libdrm2:amd64 (2.4.131-1) over (2.4.129-1) ... 93s Preparing to unpack .../13-libgpm2_1.20.7-12build1_amd64.deb ... 93s Unpacking libgpm2:amd64 (1.20.7-12build1) over (1.20.7-12) ... 93s Preparing to unpack .../14-libmaxminddb0_1.12.2-1build2_amd64.deb ... 93s Unpacking libmaxminddb0:amd64 (1.12.2-1build2) over (1.12.2-1build1) ... 93s Preparing to unpack .../15-libsensors-config_1%3a3.6.2-2build1_all.deb ... 93s Unpacking libsensors-config (1:3.6.2-2build1) over (1:3.6.2-2) ... 93s Preparing to unpack .../16-libsensors5_1%3a3.6.2-2build1_amd64.deb ... 93s Unpacking libsensors5:amd64 (1:3.6.2-2build1) over (1:3.6.2-2) ... 93s Preparing to unpack .../17-busybox-initramfs_1%3a1.37.0-7ubuntu1_amd64.deb ... 93s Unpacking busybox-initramfs (1:1.37.0-7ubuntu1) over (1:1.37.0-4ubuntu1) ... 93s Preparing to unpack .../18-libdrm-amdgpu1_2.4.131-1_amd64.deb ... 93s Unpacking libdrm-amdgpu1:amd64 (2.4.131-1) over (2.4.129-1) ... 93s Preparing to unpack .../19-libnpth0t64_1.8-3build1_amd64.deb ... 93s Unpacking libnpth0t64:amd64 (1.8-3build1) over (1.8-3) ... 93s Preparing to unpack .../20-patch_2.8-2build1_amd64.deb ... 93s Unpacking patch (2.8-2build1) over (2.8-2) ... 93s Preparing to unpack .../21-pollinate_4.33-4ubuntu5_all.deb ... 93s Unpacking pollinate (4.33-4ubuntu5) over (4.33-4ubuntu4) ... 93s Preparing to unpack .../22-python3-referencing_0.36.2-1ubuntu2_all.deb ... 93s Unpacking python3-referencing (0.36.2-1ubuntu2) over (0.36.2-1ubuntu1) ... 93s Preparing to unpack .../23-amd64-microcode_3.20251202.1ubuntu1_amd64.deb ... 93s Unpacking amd64-microcode (3.20251202.1ubuntu1) over (3.20250708.1ubuntu1) ... 93s Setting up libnpth0t64:amd64 (1.8-3build1) ... 93s Setting up libkeyutils1:amd64 (1.6.3-6ubuntu3) ... 93s Setting up libgpm2:amd64 (1.20.7-12build1) ... 93s Setting up libmaxminddb0:amd64 (1.12.2-1build2) ... 93s Setting up libsensors-config (1:3.6.2-2build1) ... 93s Setting up less (668-1build1) ... 93s Setting up amd64-microcode (3.20251202.1ubuntu1) ... 93s amd64-microcode: microcode will be updated at next boot 93s Setting up locales (2.42-2ubuntu5) ... 93s Generating locales (this might take a while)... 94s en_US.UTF-8... done 94s Generation complete. 94s Setting up pollinate (4.33-4ubuntu5) ... 105s Setting up busybox-static (1:1.37.0-7ubuntu1) ... 105s Setting up patch (2.8-2build1) ... 105s Setting up libsensors5:amd64 (1:3.6.2-2build1) ... 105s Setting up busybox-initramfs (1:1.37.0-7ubuntu1) ... 105s Setting up libdevmapper1.02.1:amd64 (2:1.02.205-2ubuntu3) ... 105s Setting up dmsetup (2:1.02.205-2ubuntu3) ... 105s Setting up python3-linkify-it (2.0.3-1ubuntu3) ... 105s Setting up mawk (1.3.4.20260129-1) ... 105s Setting up libapt-pkg7.0:amd64 (3.1.15) ... 105s Setting up libdrm-common (2.4.131-1) ... 105s Setting up python3-referencing (0.36.2-1ubuntu2) ... 105s Setting up apt (3.1.15) ... 105s Setting up python3-markdown-it (3.0.0-3build1) ... 106s Setting up libdrm2:amd64 (2.4.131-1) ... 106s Setting up libdrm-amdgpu1:amd64 (2.4.131-1) ... 106s Processing triggers for libc-bin (2.42-2ubuntu5) ... 106s Processing triggers for systemd (259-1ubuntu3) ... 106s Processing triggers for man-db (2.13.1-1) ... 107s Processing triggers for install-info (7.2-5) ... 107s Processing triggers for initramfs-tools (0.150ubuntu7) ... 107s update-initramfs: Generating /boot/initrd.img-6.18.0-9-generic 112s autopkgtest [23:16:40]: upgrading testbed (apt dist-upgrade and autopurge) 113s Reading package lists... 113s Building dependency tree... 113s Reading state information... 113s Calculating upgrade... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s Reading package lists... 114s Building dependency tree... 114s Reading state information... 114s Solving dependencies... 114s 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. 114s autopkgtest [23:16:42]: rebooting testbed after setup commands that affected boot 142s autopkgtest [23:17:10]: testbed running kernel: Linux 6.18.0-9-generic #9-Ubuntu SMP PREEMPT_DYNAMIC Mon Jan 12 16:49:02 UTC 2026 144s autopkgtest [23:17:12]: @@@@@@@@@@@@@@@@@@@@ apt-source wsl-pro-service 146s Get:1 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (dsc) [2064 B] 146s Get:2 http://ftpmaster.internal/ubuntu resolute/main wsl-pro-service 0.1.18 (tar) [1790 kB] 146s gpgv: Signature made Tue Jun 10 19:06:57 2025 UTC 146s gpgv: using RSA key 92FE4F8B40CADC4ECCD60C1F5961FDBE9C619809 146s gpgv: Can't check signature: No public key 146s dpkg-source: warning: cannot verify inline signature for ./wsl-pro-service_0.1.18.dsc: no acceptable signature found 146s autopkgtest [23:17:14]: testing package wsl-pro-service version 0.1.18 146s autopkgtest [23:17:14]: build not needed 147s autopkgtest [23:17:15]: test command1: preparing testbed 147s Reading package lists... 147s Building dependency tree... 147s Reading state information... 148s Solving dependencies... 148s The following NEW packages will be installed: 148s autoconf automake autopoint autotools-dev build-essential cpp cpp-15 148s cpp-15-x86-64-linux-gnu cpp-x86-64-linux-gnu debhelper debugedit dh-apport 148s dh-autoreconf dh-golang dh-strip-nondeterminism dwz g++ g++-15 148s g++-15-x86-64-linux-gnu g++-x86-64-linux-gnu gcc gcc-15 148s gcc-15-x86-64-linux-gnu gcc-x86-64-linux-gnu gettext golang-1.25-go 148s golang-1.25-src golang-go golang-src intltool-debian libarchive-zip-perl 148s libasan8 libc-dev-bin libc6-dev libcc1-0 libcrypt-dev libdebhelper-perl 148s libfile-stripnondeterminism-perl libgcc-15-dev libgomp1 libhwasan0 libisl23 148s libitm1 liblsan0 libmpc3 libquadmath0 libstdc++-15-dev libtool libtsan2 148s libubsan1 linux-libc-dev m4 po-debconf rpcsvc-proto 148s 0 upgraded, 54 newly installed, 0 to remove and 0 not upgraded. 148s Need to get 120 MB of archives. 148s After this operation, 482 MB of additional disk space will be used. 148s Get:1 http://ftpmaster.internal/ubuntu resolute/main amd64 m4 amd64 1.4.20-2 [217 kB] 148s Get:2 http://ftpmaster.internal/ubuntu resolute/main amd64 autoconf all 2.72-3.1ubuntu1 [384 kB] 148s Get:3 http://ftpmaster.internal/ubuntu resolute/main amd64 autotools-dev all 20240727.1build1 [43.4 kB] 148s Get:4 http://ftpmaster.internal/ubuntu resolute/main amd64 automake all 1:1.18.1-3build1 [582 kB] 148s Get:5 http://ftpmaster.internal/ubuntu resolute/main amd64 autopoint all 0.23.2-1 [620 kB] 148s Get:6 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libc-dev-bin amd64 2.42-2ubuntu5 [23.3 kB] 148s Get:7 http://ftpmaster.internal/ubuntu resolute/main amd64 linux-libc-dev amd64 6.18.0-9.9 [1860 kB] 148s Get:8 http://ftpmaster.internal/ubuntu resolute/main amd64 libcrypt-dev amd64 1:4.5.1-1 [122 kB] 148s Get:9 http://ftpmaster.internal/ubuntu resolute/main amd64 rpcsvc-proto amd64 1.4.3-1build1 [68.3 kB] 148s Get:10 http://ftpmaster.internal/ubuntu resolute-proposed/main amd64 libc6-dev amd64 2.42-2ubuntu5 [2206 kB] 148s Get:11 http://ftpmaster.internal/ubuntu resolute/main amd64 libisl23 amd64 0.27-1build1 [691 kB] 148s Get:12 http://ftpmaster.internal/ubuntu resolute/main amd64 libmpc3 amd64 1.3.1-2 [54.8 kB] 148s Get:13 http://ftpmaster.internal/ubuntu resolute/main amd64 cpp-15-x86-64-linux-gnu amd64 15.2.0-12ubuntu1 [12.9 MB] 148s Get:14 http://ftpmaster.internal/ubuntu resolute/main amd64 cpp-15 amd64 15.2.0-12ubuntu1 [1034 B] 148s Get:15 http://ftpmaster.internal/ubuntu resolute/main amd64 cpp-x86-64-linux-gnu amd64 4:15.2.0-4ubuntu1 [5746 B] 148s Get:16 http://ftpmaster.internal/ubuntu resolute/main amd64 cpp amd64 4:15.2.0-4ubuntu1 [22.4 kB] 148s Get:17 http://ftpmaster.internal/ubuntu resolute/main amd64 libcc1-0 amd64 15.2.0-12ubuntu1 [47.4 kB] 148s Get:18 http://ftpmaster.internal/ubuntu resolute/main amd64 libgomp1 amd64 15.2.0-12ubuntu1 [151 kB] 148s Get:19 http://ftpmaster.internal/ubuntu resolute/main amd64 libitm1 amd64 15.2.0-12ubuntu1 [29.5 kB] 149s Get:20 http://ftpmaster.internal/ubuntu resolute/main amd64 libasan8 amd64 15.2.0-12ubuntu1 [3070 kB] 149s Get:21 http://ftpmaster.internal/ubuntu resolute/main amd64 liblsan0 amd64 15.2.0-12ubuntu1 [1360 kB] 149s Get:22 http://ftpmaster.internal/ubuntu resolute/main amd64 libtsan2 amd64 15.2.0-12ubuntu1 [2757 kB] 149s Get:23 http://ftpmaster.internal/ubuntu resolute/main amd64 libubsan1 amd64 15.2.0-12ubuntu1 [1210 kB] 149s Get:24 http://ftpmaster.internal/ubuntu resolute/main amd64 libhwasan0 amd64 15.2.0-12ubuntu1 [1685 kB] 149s Get:25 http://ftpmaster.internal/ubuntu resolute/main amd64 libquadmath0 amd64 15.2.0-12ubuntu1 [153 kB] 149s Get:26 http://ftpmaster.internal/ubuntu resolute/main amd64 libgcc-15-dev amd64 15.2.0-12ubuntu1 [2866 kB] 149s Get:27 http://ftpmaster.internal/ubuntu resolute/main amd64 gcc-15-x86-64-linux-gnu amd64 15.2.0-12ubuntu1 [25.4 MB] 150s Get:28 http://ftpmaster.internal/ubuntu resolute/main amd64 gcc-15 amd64 15.2.0-12ubuntu1 [530 kB] 150s Get:29 http://ftpmaster.internal/ubuntu resolute/main amd64 gcc-x86-64-linux-gnu amd64 4:15.2.0-4ubuntu1 [1208 B] 150s Get:30 http://ftpmaster.internal/ubuntu resolute/main amd64 gcc amd64 4:15.2.0-4ubuntu1 [5024 B] 150s Get:31 http://ftpmaster.internal/ubuntu resolute/main amd64 libstdc++-15-dev amd64 15.2.0-12ubuntu1 [2553 kB] 150s Get:32 http://ftpmaster.internal/ubuntu resolute/main amd64 g++-15-x86-64-linux-gnu amd64 15.2.0-12ubuntu1 [14.4 MB] 150s Get:33 http://ftpmaster.internal/ubuntu resolute/main amd64 g++-15 amd64 15.2.0-12ubuntu1 [25.3 kB] 150s Get:34 http://ftpmaster.internal/ubuntu resolute/main amd64 g++-x86-64-linux-gnu amd64 4:15.2.0-4ubuntu1 [966 B] 150s Get:35 http://ftpmaster.internal/ubuntu resolute/main amd64 g++ amd64 4:15.2.0-4ubuntu1 [1100 B] 150s Get:36 http://ftpmaster.internal/ubuntu resolute/main amd64 build-essential amd64 12.12ubuntu2 [5256 B] 150s Get:37 http://ftpmaster.internal/ubuntu resolute/main amd64 libdebhelper-perl all 13.28ubuntu1 [97.4 kB] 150s Get:38 http://ftpmaster.internal/ubuntu resolute/main amd64 libtool all 2.5.4-9 [169 kB] 150s Get:39 http://ftpmaster.internal/ubuntu resolute/main amd64 dh-autoreconf all 21+nmu1 [11.9 kB] 150s Get:40 http://ftpmaster.internal/ubuntu resolute/main amd64 libarchive-zip-perl all 1.68-1 [90.2 kB] 150s Get:41 http://ftpmaster.internal/ubuntu resolute/main amd64 libfile-stripnondeterminism-perl all 1.15.0-1build1 [20.6 kB] 150s Get:42 http://ftpmaster.internal/ubuntu resolute/main amd64 dh-strip-nondeterminism all 1.15.0-1build1 [5110 B] 150s Get:43 http://ftpmaster.internal/ubuntu resolute/main amd64 debugedit amd64 1:5.2-3build1 [48.8 kB] 150s Get:44 http://ftpmaster.internal/ubuntu resolute/main amd64 dwz amd64 0.16-2build1 [113 kB] 150s Get:45 http://ftpmaster.internal/ubuntu resolute/main amd64 gettext amd64 0.23.2-1 [1019 kB] 150s Get:46 http://ftpmaster.internal/ubuntu resolute/main amd64 intltool-debian all 0.35.0+20060710.6build1 [24.1 kB] 150s Get:47 http://ftpmaster.internal/ubuntu resolute/main amd64 po-debconf all 1.0.22 [215 kB] 150s Get:48 http://ftpmaster.internal/ubuntu resolute/main amd64 debhelper all 13.28ubuntu1 [916 kB] 150s Get:49 http://ftpmaster.internal/ubuntu resolute/universe amd64 dh-apport all 2.33.1-0ubuntu3 [20.2 kB] 150s Get:50 http://ftpmaster.internal/ubuntu resolute/main amd64 golang-1.25-src all 1.25.0-0ubuntu1 [23.0 MB] 151s Get:51 http://ftpmaster.internal/ubuntu resolute/main amd64 golang-1.25-go amd64 1.25.0-0ubuntu1 [18.0 MB] 151s Get:52 http://ftpmaster.internal/ubuntu resolute/main amd64 golang-src all 2:1.25~1 [5206 B] 151s Get:53 http://ftpmaster.internal/ubuntu resolute/main amd64 golang-go amd64 2:1.25~1 [44.1 kB] 151s Get:54 http://ftpmaster.internal/ubuntu resolute/main amd64 dh-golang all 1.63build1 [25.0 kB] 151s Fetched 120 MB in 3s (35.3 MB/s) 151s Selecting previously unselected package m4. 152s (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 ... 83962 files and directories currently installed.) 152s Preparing to unpack .../00-m4_1.4.20-2_amd64.deb ... 152s Unpacking m4 (1.4.20-2) ... 152s Selecting previously unselected package autoconf. 152s Preparing to unpack .../01-autoconf_2.72-3.1ubuntu1_all.deb ... 152s Unpacking autoconf (2.72-3.1ubuntu1) ... 152s Selecting previously unselected package autotools-dev. 152s Preparing to unpack .../02-autotools-dev_20240727.1build1_all.deb ... 152s Unpacking autotools-dev (20240727.1build1) ... 152s Selecting previously unselected package automake. 152s Preparing to unpack .../03-automake_1%3a1.18.1-3build1_all.deb ... 152s Unpacking automake (1:1.18.1-3build1) ... 152s Selecting previously unselected package autopoint. 152s Preparing to unpack .../04-autopoint_0.23.2-1_all.deb ... 152s Unpacking autopoint (0.23.2-1) ... 152s Selecting previously unselected package libc-dev-bin. 152s Preparing to unpack .../05-libc-dev-bin_2.42-2ubuntu5_amd64.deb ... 152s Unpacking libc-dev-bin (2.42-2ubuntu5) ... 152s Selecting previously unselected package linux-libc-dev:amd64. 152s Preparing to unpack .../06-linux-libc-dev_6.18.0-9.9_amd64.deb ... 152s Unpacking linux-libc-dev:amd64 (6.18.0-9.9) ... 152s Selecting previously unselected package libcrypt-dev:amd64. 152s Preparing to unpack .../07-libcrypt-dev_1%3a4.5.1-1_amd64.deb ... 152s Unpacking libcrypt-dev:amd64 (1:4.5.1-1) ... 152s Selecting previously unselected package rpcsvc-proto. 152s Preparing to unpack .../08-rpcsvc-proto_1.4.3-1build1_amd64.deb ... 152s Unpacking rpcsvc-proto (1.4.3-1build1) ... 152s Selecting previously unselected package libc6-dev:amd64. 152s Preparing to unpack .../09-libc6-dev_2.42-2ubuntu5_amd64.deb ... 152s Unpacking libc6-dev:amd64 (2.42-2ubuntu5) ... 152s Selecting previously unselected package libisl23:amd64. 152s Preparing to unpack .../10-libisl23_0.27-1build1_amd64.deb ... 152s Unpacking libisl23:amd64 (0.27-1build1) ... 152s Selecting previously unselected package libmpc3:amd64. 152s Preparing to unpack .../11-libmpc3_1.3.1-2_amd64.deb ... 152s Unpacking libmpc3:amd64 (1.3.1-2) ... 152s Selecting previously unselected package cpp-15-x86-64-linux-gnu. 152s Preparing to unpack .../12-cpp-15-x86-64-linux-gnu_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking cpp-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package cpp-15. 152s Preparing to unpack .../13-cpp-15_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking cpp-15 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package cpp-x86-64-linux-gnu. 152s Preparing to unpack .../14-cpp-x86-64-linux-gnu_4%3a15.2.0-4ubuntu1_amd64.deb ... 152s Unpacking cpp-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 152s Selecting previously unselected package cpp. 152s Preparing to unpack .../15-cpp_4%3a15.2.0-4ubuntu1_amd64.deb ... 152s Unpacking cpp (4:15.2.0-4ubuntu1) ... 152s Selecting previously unselected package libcc1-0:amd64. 152s Preparing to unpack .../16-libcc1-0_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libcc1-0:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libgomp1:amd64. 152s Preparing to unpack .../17-libgomp1_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libgomp1:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libitm1:amd64. 152s Preparing to unpack .../18-libitm1_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libitm1:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libasan8:amd64. 152s Preparing to unpack .../19-libasan8_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libasan8:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package liblsan0:amd64. 152s Preparing to unpack .../20-liblsan0_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking liblsan0:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libtsan2:amd64. 152s Preparing to unpack .../21-libtsan2_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libtsan2:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libubsan1:amd64. 152s Preparing to unpack .../22-libubsan1_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libubsan1:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libhwasan0:amd64. 152s Preparing to unpack .../23-libhwasan0_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libhwasan0:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libquadmath0:amd64. 152s Preparing to unpack .../24-libquadmath0_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libquadmath0:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package libgcc-15-dev:amd64. 152s Preparing to unpack .../25-libgcc-15-dev_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking libgcc-15-dev:amd64 (15.2.0-12ubuntu1) ... 152s Selecting previously unselected package gcc-15-x86-64-linux-gnu. 152s Preparing to unpack .../26-gcc-15-x86-64-linux-gnu_15.2.0-12ubuntu1_amd64.deb ... 152s Unpacking gcc-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 153s Selecting previously unselected package gcc-15. 153s Preparing to unpack .../27-gcc-15_15.2.0-12ubuntu1_amd64.deb ... 153s Unpacking gcc-15 (15.2.0-12ubuntu1) ... 153s Selecting previously unselected package gcc-x86-64-linux-gnu. 153s Preparing to unpack .../28-gcc-x86-64-linux-gnu_4%3a15.2.0-4ubuntu1_amd64.deb ... 153s Unpacking gcc-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 153s Selecting previously unselected package gcc. 153s Preparing to unpack .../29-gcc_4%3a15.2.0-4ubuntu1_amd64.deb ... 153s Unpacking gcc (4:15.2.0-4ubuntu1) ... 153s Selecting previously unselected package libstdc++-15-dev:amd64. 153s Preparing to unpack .../30-libstdc++-15-dev_15.2.0-12ubuntu1_amd64.deb ... 153s Unpacking libstdc++-15-dev:amd64 (15.2.0-12ubuntu1) ... 153s Selecting previously unselected package g++-15-x86-64-linux-gnu. 153s Preparing to unpack .../31-g++-15-x86-64-linux-gnu_15.2.0-12ubuntu1_amd64.deb ... 153s Unpacking g++-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 153s Selecting previously unselected package g++-15. 153s Preparing to unpack .../32-g++-15_15.2.0-12ubuntu1_amd64.deb ... 153s Unpacking g++-15 (15.2.0-12ubuntu1) ... 153s Selecting previously unselected package g++-x86-64-linux-gnu. 153s Preparing to unpack .../33-g++-x86-64-linux-gnu_4%3a15.2.0-4ubuntu1_amd64.deb ... 153s Unpacking g++-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 153s Selecting previously unselected package g++. 153s Preparing to unpack .../34-g++_4%3a15.2.0-4ubuntu1_amd64.deb ... 153s Unpacking g++ (4:15.2.0-4ubuntu1) ... 153s Selecting previously unselected package build-essential. 153s Preparing to unpack .../35-build-essential_12.12ubuntu2_amd64.deb ... 153s Unpacking build-essential (12.12ubuntu2) ... 153s Selecting previously unselected package libdebhelper-perl. 153s Preparing to unpack .../36-libdebhelper-perl_13.28ubuntu1_all.deb ... 153s Unpacking libdebhelper-perl (13.28ubuntu1) ... 153s Selecting previously unselected package libtool. 153s Preparing to unpack .../37-libtool_2.5.4-9_all.deb ... 153s Unpacking libtool (2.5.4-9) ... 153s Selecting previously unselected package dh-autoreconf. 153s Preparing to unpack .../38-dh-autoreconf_21+nmu1_all.deb ... 153s Unpacking dh-autoreconf (21+nmu1) ... 153s Selecting previously unselected package libarchive-zip-perl. 153s Preparing to unpack .../39-libarchive-zip-perl_1.68-1_all.deb ... 153s Unpacking libarchive-zip-perl (1.68-1) ... 153s Selecting previously unselected package libfile-stripnondeterminism-perl. 153s Preparing to unpack .../40-libfile-stripnondeterminism-perl_1.15.0-1build1_all.deb ... 153s Unpacking libfile-stripnondeterminism-perl (1.15.0-1build1) ... 153s Selecting previously unselected package dh-strip-nondeterminism. 153s Preparing to unpack .../41-dh-strip-nondeterminism_1.15.0-1build1_all.deb ... 153s Unpacking dh-strip-nondeterminism (1.15.0-1build1) ... 153s Selecting previously unselected package debugedit. 153s Preparing to unpack .../42-debugedit_1%3a5.2-3build1_amd64.deb ... 153s Unpacking debugedit (1:5.2-3build1) ... 153s Selecting previously unselected package dwz. 153s Preparing to unpack .../43-dwz_0.16-2build1_amd64.deb ... 153s Unpacking dwz (0.16-2build1) ... 153s Selecting previously unselected package gettext. 153s Preparing to unpack .../44-gettext_0.23.2-1_amd64.deb ... 153s Unpacking gettext (0.23.2-1) ... 153s Selecting previously unselected package intltool-debian. 153s Preparing to unpack .../45-intltool-debian_0.35.0+20060710.6build1_all.deb ... 153s Unpacking intltool-debian (0.35.0+20060710.6build1) ... 153s Selecting previously unselected package po-debconf. 153s Preparing to unpack .../46-po-debconf_1.0.22_all.deb ... 153s Unpacking po-debconf (1.0.22) ... 153s Selecting previously unselected package debhelper. 153s Preparing to unpack .../47-debhelper_13.28ubuntu1_all.deb ... 153s Unpacking debhelper (13.28ubuntu1) ... 153s Selecting previously unselected package dh-apport. 153s Preparing to unpack .../48-dh-apport_2.33.1-0ubuntu3_all.deb ... 153s Unpacking dh-apport (2.33.1-0ubuntu3) ... 153s Selecting previously unselected package golang-1.25-src. 153s Preparing to unpack .../49-golang-1.25-src_1.25.0-0ubuntu1_all.deb ... 153s Unpacking golang-1.25-src (1.25.0-0ubuntu1) ... 154s Selecting previously unselected package golang-1.25-go. 154s Preparing to unpack .../50-golang-1.25-go_1.25.0-0ubuntu1_amd64.deb ... 154s Unpacking golang-1.25-go (1.25.0-0ubuntu1) ... 154s Selecting previously unselected package golang-src. 154s Preparing to unpack .../51-golang-src_2%3a1.25~1_all.deb ... 154s Unpacking golang-src (2:1.25~1) ... 154s Selecting previously unselected package golang-go:amd64. 154s Preparing to unpack .../52-golang-go_2%3a1.25~1_amd64.deb ... 154s Unpacking golang-go:amd64 (2:1.25~1) ... 154s Selecting previously unselected package dh-golang. 154s Preparing to unpack .../53-dh-golang_1.63build1_all.deb ... 154s Unpacking dh-golang (1.63build1) ... 154s Setting up libarchive-zip-perl (1.68-1) ... 154s Setting up libdebhelper-perl (13.28ubuntu1) ... 154s Setting up linux-libc-dev:amd64 (6.18.0-9.9) ... 154s Setting up m4 (1.4.20-2) ... 154s Setting up libgomp1:amd64 (15.2.0-12ubuntu1) ... 154s Setting up dh-apport (2.33.1-0ubuntu3) ... 154s Setting up autotools-dev (20240727.1build1) ... 154s Setting up rpcsvc-proto (1.4.3-1build1) ... 154s Setting up libquadmath0:amd64 (15.2.0-12ubuntu1) ... 154s Setting up libmpc3:amd64 (1.3.1-2) ... 154s Setting up autopoint (0.23.2-1) ... 154s Setting up autoconf (2.72-3.1ubuntu1) ... 154s Setting up libubsan1:amd64 (15.2.0-12ubuntu1) ... 154s Setting up dwz (0.16-2build1) ... 154s Setting up golang-1.25-src (1.25.0-0ubuntu1) ... 154s Setting up libhwasan0:amd64 (15.2.0-12ubuntu1) ... 154s Setting up libcrypt-dev:amd64 (1:4.5.1-1) ... 154s Setting up libasan8:amd64 (15.2.0-12ubuntu1) ... 154s Setting up debugedit (1:5.2-3build1) ... 154s Setting up libtsan2:amd64 (15.2.0-12ubuntu1) ... 154s Setting up libisl23:amd64 (0.27-1build1) ... 154s Setting up libc-dev-bin (2.42-2ubuntu5) ... 154s Setting up golang-src (2:1.25~1) ... 154s Setting up libcc1-0:amd64 (15.2.0-12ubuntu1) ... 154s Setting up liblsan0:amd64 (15.2.0-12ubuntu1) ... 154s Setting up libitm1:amd64 (15.2.0-12ubuntu1) ... 154s Setting up automake (1:1.18.1-3build1) ... 154s update-alternatives: using /usr/bin/automake-1.18 to provide /usr/bin/automake (automake) in auto mode 154s Setting up libfile-stripnondeterminism-perl (1.15.0-1build1) ... 154s Setting up golang-1.25-go (1.25.0-0ubuntu1) ... 154s Setting up gettext (0.23.2-1) ... 154s Setting up libgcc-15-dev:amd64 (15.2.0-12ubuntu1) ... 154s Setting up golang-go:amd64 (2:1.25~1) ... 154s Setting up cpp-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 154s Setting up intltool-debian (0.35.0+20060710.6build1) ... 154s Setting up gcc-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 154s Setting up dh-strip-nondeterminism (1.15.0-1build1) ... 154s Setting up cpp-15 (15.2.0-12ubuntu1) ... 154s Setting up libc6-dev:amd64 (2.42-2ubuntu5) ... 154s Setting up cpp-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 154s Setting up gcc-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 154s Setting up po-debconf (1.0.22) ... 154s Setting up gcc-15 (15.2.0-12ubuntu1) ... 154s Setting up libstdc++-15-dev:amd64 (15.2.0-12ubuntu1) ... 154s Setting up cpp (4:15.2.0-4ubuntu1) ... 154s Setting up g++-15-x86-64-linux-gnu (15.2.0-12ubuntu1) ... 154s Setting up libtool (2.5.4-9) ... 154s Setting up gcc (4:15.2.0-4ubuntu1) ... 154s Setting up dh-autoreconf (21+nmu1) ... 154s Setting up g++-x86-64-linux-gnu (4:15.2.0-4ubuntu1) ... 154s Setting up g++-15 (15.2.0-12ubuntu1) ... 154s Setting up debhelper (13.28ubuntu1) ... 154s Setting up g++ (4:15.2.0-4ubuntu1) ... 154s update-alternatives: using /usr/bin/g++ to provide /usr/bin/c++ (c++) in auto mode 154s Setting up build-essential (12.12ubuntu2) ... 154s Setting up dh-golang (1.63build1) ... 154s Processing triggers for man-db (2.13.1-1) ... 155s Processing triggers for install-info (7.2-5) ... 155s Processing triggers for libc-bin (2.42-2ubuntu5) ... 156s autopkgtest [23:17:24]: test command1: ./debian/tests/test 156s autopkgtest [23:17:24]: test command1: [----------------------- 181s === RUN TestRunSignal 181s === RUN TestRunSignal/Send_SIGINT_exits 181s INFO Starting WSL Pro Service version Dev 181s === RUN TestRunSignal/Send_SIGTERM_exits 181s INFO Starting WSL Pro Service version Dev 181s --- PASS: TestRunSignal (0.20s) 181s --- PASS: TestRunSignal/Send_SIGINT_exits (0.10s) 181s --- PASS: TestRunSignal/Send_SIGTERM_exits (0.10s) 181s === RUN TestRun 181s === PAUSE TestRun 181s === CONT TestRun 181s === RUN TestRun/Run_and_exit_successfully 181s === PAUSE TestRun/Run_and_exit_successfully 181s === RUN TestRun/Run_and_return_error 181s === PAUSE TestRun/Run_and_return_error 181s === RUN TestRun/Run_and_return_usage_error 181s === PAUSE TestRun/Run_and_return_usage_error 181s === RUN TestRun/Run_and_usage_error_only_does_not_fail 181s === PAUSE TestRun/Run_and_usage_error_only_does_not_fail 181s === CONT TestRun/Run_and_exit_successfully 181s === CONT TestRun/Run_and_return_usage_error 181s INFO Starting WSL Pro Service version Dev 181s INFO Starting WSL Pro Service version Dev 181s === CONT TestRun/Run_and_usage_error_only_does_not_fail 181s INFO Starting WSL Pro Service version Dev 181s ERROR context.Background Error requested 181s === CONT TestRun/Run_and_return_error 181s INFO Starting WSL Pro Service version Dev 181s ERROR context.Background Error requested 181s --- PASS: TestRun (0.00s) 181s --- PASS: TestRun/Run_and_exit_successfully (0.10s) 181s --- PASS: TestRun/Run_and_return_usage_error (0.10s) 181s --- PASS: TestRun/Run_and_usage_error_only_does_not_fail (0.10s) 181s --- PASS: TestRun/Run_and_return_error (0.10s) 181s PASS 181s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service 0.405s 190s === RUN TestHelp 190s --- PASS: TestHelp (0.00s) 190s === RUN TestCompletion 190s --- PASS: TestCompletion (0.00s) 190s === RUN TestVersion 190s --- PASS: TestVersion (0.00s) 190s === RUN TestConfigBadArg 190s --- PASS: TestConfigBadArg (0.00s) 190s === RUN TestConfigArg 190s --- PASS: TestConfigArg (0.00s) 190s === RUN TestConfigAutoDetect 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 190s --- PASS: TestConfigAutoDetect (0.00s) 190s === RUN TestNoUsageError 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 190s --- PASS: TestNoUsageError (0.00s) 190s === RUN TestUsageError 190s === PAUSE TestUsageError 190s === RUN TestCanQuitWhenExecute 190s === PAUSE TestCanQuitWhenExecute 190s === RUN TestCanQuitTwice 190s === PAUSE TestCanQuitTwice 190s === RUN TestAppCanQuitWithoutExecute 190s === PAUSE TestAppCanQuitWithoutExecute 190s === RUN TestAppRunFailsOnComponentsCreationAndQuit 190s === PAUSE TestAppRunFailsOnComponentsCreationAndQuit 190s === RUN TestAppGetRootCmd 190s === PAUSE TestAppGetRootCmd 190s === RUN TestWithProMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithProMock (0.00s) 190s === RUN TestWithWslPathMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithWslPathMock (0.00s) 190s === RUN TestWithWslInfoMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithWslInfoMock (0.00s) 190s === RUN TestWithCmdExeMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithCmdExeMock (0.00s) 190s === CONT TestUsageError 190s === CONT TestAppCanQuitWithoutExecute 190s service_test.go:190: This test is skipped because it is flaky. There is no way to guarantee Quit has been called before run. 190s --- SKIP: TestAppCanQuitWithoutExecute (0.00s) 190s === CONT TestAppGetRootCmd 190s --- PASS: TestAppGetRootCmd (0.00s) 190s === CONT TestAppRunFailsOnComponentsCreationAndQuit 190s --- PASS: TestUsageError (0.00s) 190s === CONT TestCanQuitTwice 190s time="2026-02-06T23:17:49Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:36173" 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:74 New() Building new daemon" 190s time="2026-02-06T23:17:49Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:43277" 190s time="2026-02-06T23:17:49Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build2857803461/b386/wsl-pro-service.yaml" 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 190s time="2026-02-06T23:17:49Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:74 New() Building new daemon" 190s time="2026-02-06T23:17:52Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 190s time="2026-02-06T23:17:52Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 190s time="2026-02-06T23:17:52Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5850" 190s time="2026-02-06T23:17:52Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 190s time="2026-02-06T23:17:52Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 190s time="2026-02-06T23:17:52Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5850" 190s time="2026-02-06T23:17:52Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:52Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:54Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s --- PASS: TestAppRunFailsOnComponentsCreationAndQuit (4.14s) 190s === CONT TestCanQuitWhenExecute 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:76 NewMockWindowsAgent.func1() MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:34379" 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/config.go:53 initViperConfig() Using configuration file: /tmp/go-build2857803461/b386/wsl-pro-service.yaml" 190s time="2026-02-06T23:17:54Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/cmd/wsl-pro-service/service/service.go:64 New.func1() Debug mode is enabled" 190s time="2026-02-06T23:17:54Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:74 New() Building new daemon" 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:43277" 190s time="2026-02-06T23:17:54Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 190s time="2026-02-06T23:17:54Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.ProAttachCmd requests" 190s time="2026-02-06T23:17:54Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/streams/server.go:191 (*handlingLoop[...]).run() Stopping serving agentapi.LandscapeConfigCmd requests" 190s time="2026-02-06T23:17:55Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/streams/server.go:146 (*Server).Serve() Server: sent preface messages to all streams" 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:326 (*mockWSLInstanceService).LandscapeConfigCommands() MockWindowsAgent: LandscapeConfigCommands ready" 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:300 (*mockWSLInstanceService).ProAttachmentCommands() MockWindowsAgent: ProAttachmentCommands ready" 190s time="2026-02-06T23:17:55Z" level=warning msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:196 (*Daemon).serveOnce() Daemon: disconnected from Windows host" 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 190s time="2026-02-06T23:17:55Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:55Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/testutils/mock_agent.go:275 (*mockWSLInstanceService).Connected() MockWindowsAgent: Connected ready" 190s time="2026-02-06T23:17:55Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:55Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:55Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:55Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:55Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s --- PASS: TestCanQuitTwice (5.94s) 190s time="2026-02-06T23:17:56Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:55 (*System).syncWithCloudInit() Checking cloud-init status" 190s time="2026-02-06T23:17:56Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/system/landscape.go:45 (*System).EnsureValidLandscapeConfig() No Landscape configuration detected: nothing to do" 190s time="2026-02-06T23:17:56Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:163 (*Daemon).serveOnce() Daemon: connecting to Windows Agent from PID 5850" 190s time="2026-02-06T23:17:57Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:282 (*Daemon).connect() Daemon: starting connection to Windows Agent via 127.0.0.1:34379" 190s time="2026-02-06T23:17:57Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:183 (*Daemon).serveOnce() Daemon: completed connection to Windows Agent" 190s time="2026-02-06T23:17:57Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/streams/server.go:196 (*handlingLoop[...]).run() Started serving agentapi.ProAttachCmd requests" 190s time="2026-02-06T23:17:57Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/streams/server.go:196 (*handlingLoop[...]).run() Started serving agentapi.LandscapeConfigCmd requests" 190s time="2026-02-06T23:17:57Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:57Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:57Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:57Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:57Z" level=warning msg="context.Background rpc error: code = Canceled desc = context canceled" func=github.com/ubuntu/decorate.LogOnErrorContext file="/tmp/autopkgtest.Fey4oQ/build.YHT/src/vendor/github.com/ubuntu/decorate/decorate.go:31" 190s time="2026-02-06T23:17:58Z" level=warning msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:194 (*Daemon).serveOnce() Daemon: disconnected from Windows host: could not serve: could not send first Connnected message: EOF" 190s time="2026-02-06T23:17:58Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:144 (*Daemon).Serve.func2() Reconnecting to Windows host in 1 seconds" 190s time="2026-02-06T23:17:58Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s time="2026-02-06T23:17:58Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:215 (*Daemon).Quit() Stopping daemon requested." 190s time="2026-02-06T23:17:58Z" level=info msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:221 (*Daemon).Quit() Waiting for active requests to close." 190s time="2026-02-06T23:17:58Z" level=debug msg="/tmp/autopkgtest.Fey4oQ/build.YHT/src/internal/daemon/daemon.go:229 (*Daemon).Quit() All connections have now ended." 190s --- PASS: TestCanQuitWhenExecute (4.50s) 190s PASS 190s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/cmd/wsl-pro-service/service 8.653s 190s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/generate/doc [no test files] 190s === RUN TestApplyProToken 190s === PAUSE TestApplyProToken 190s === RUN TestApplyLandscapeConfig 190s === PAUSE TestApplyLandscapeConfig 190s === RUN TestWithProMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithProMock (0.00s) 190s === RUN TestWithLandscapeConfigMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithLandscapeConfigMock (0.00s) 190s === RUN TestWithWslPathMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithWslPathMock (0.00s) 190s === RUN TestWithWslInfoMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithWslInfoMock (0.00s) 190s === RUN TestWithCmdExeMock 190s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 190s --- SKIP: TestWithCmdExeMock (0.00s) 190s === CONT TestApplyProToken 190s === CONT TestApplyLandscapeConfig 190s === RUN TestApplyLandscapeConfig/Success_disabling_Landscape 190s === PAUSE TestApplyLandscapeConfig/Success_disabling_Landscape 190s === RUN TestApplyLandscapeConfig/Error_calling_landscape_disable 190s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_disable 190s === RUN TestApplyLandscapeConfig/Error_calling_landscape_enable 190s === PAUSE TestApplyLandscapeConfig/Error_calling_landscape_enable 190s === RUN TestApplyLandscapeConfig/Success_enabling_Landscape 190s === PAUSE TestApplyLandscapeConfig/Success_enabling_Landscape 190s === CONT TestApplyLandscapeConfig/Success_disabling_Landscape 190s === RUN TestApplyProToken/Error_calling_pro_attach 190s === PAUSE TestApplyProToken/Error_calling_pro_attach 190s === RUN TestApplyProToken/Success_attaching 190s === PAUSE TestApplyProToken/Success_attaching 190s === RUN TestApplyProToken/Success_detaching 190s === PAUSE TestApplyProToken/Success_detaching 190s === RUN TestApplyProToken/Error_calling_pro_detach 190s === PAUSE TestApplyProToken/Error_calling_pro_detach 190s === CONT TestApplyLandscapeConfig/Success_enabling_Landscape 190s time="2026-02-06T23:17:50Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 190s time="2026-02-06T23:17:50Z" level=info msg="ApplyLandscapeConfig: received config: registering" 190s === CONT TestApplyProToken/Error_calling_pro_attach 190s time="2026-02-06T23:17:52Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 190s === CONT TestApplyProToken/Error_calling_pro_detach 190s time="2026-02-06T23:17:52Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 190s === CONT TestApplyProToken/Success_detaching 190s time="2026-02-06T23:17:53Z" level=info msg="ApplyProToken: Received empty token: detaching" 190s === CONT TestApplyProToken/Success_attaching 190s time="2026-02-06T23:17:54Z" level=info msg="ApplyProToken: Received token \"12**bc\": attaching" 190s === CONT TestApplyLandscapeConfig/Error_calling_landscape_enable 190s time="2026-02-06T23:17:54Z" level=info msg="ApplyLandscapeConfig: received config: registering" 190s === CONT TestApplyLandscapeConfig/Error_calling_landscape_disable 190s time="2026-02-06T23:17:55Z" level=info msg="ApplyLandscapeConfig: received empty config: disabling" 190s --- PASS: TestApplyProToken (0.00s) 190s --- PASS: TestApplyProToken/Error_calling_pro_detach (1.36s) 190s --- PASS: TestApplyProToken/Error_calling_pro_attach (2.62s) 190s --- PASS: TestApplyProToken/Success_detaching (1.12s) 190s --- PASS: TestApplyProToken/Success_attaching (2.16s) 190s --- PASS: TestApplyLandscapeConfig (0.00s) 190s --- PASS: TestApplyLandscapeConfig/Success_enabling_Landscape (1.21s) 190s --- PASS: TestApplyLandscapeConfig/Success_disabling_Landscape (1.39s) 190s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_enable (1.25s) 190s --- PASS: TestApplyLandscapeConfig/Error_calling_landscape_disable (0.96s) 190s PASS 190s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/commandservice 6.101s 190s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/consts [no test files] 294s === RUN TestNew 294s === PAUSE TestNew 294s === RUN TestServe 294s === PAUSE TestServe 294s === RUN TestServeAndQuit 294s === PAUSE TestServeAndQuit 294s === RUN TestRetryLogic 294s === PAUSE TestRetryLogic 294s === RUN TestReconnection 294s === PAUSE TestReconnection 294s === RUN TestWithProMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithProMock (0.00s) 294s === RUN TestWithWslPathMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslPathMock (0.00s) 294s === RUN TestWithWslInfoMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslInfoMock (0.00s) 294s === RUN TestWithCmdExeMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithCmdExeMock (0.00s) 294s === CONT TestNew 294s === RUN TestNew/Success 294s === PAUSE TestNew/Success 294s === RUN TestNew/Error_when_WslPath_returns_error 294s === PAUSE TestNew/Error_when_WslPath_returns_error 294s === CONT TestNew/Success 294s time="2026-02-06T23:17:57Z" level=debug msg="Building new daemon" 294s === CONT TestServeAndQuit 294s === RUN TestServeAndQuit/Success_with_graceful_quit 294s === PAUSE TestServeAndQuit/Success_with_graceful_quit 294s === RUN TestServeAndQuit/Success_with_forceful_quit 294s === PAUSE TestServeAndQuit/Success_with_forceful_quit 294s === RUN TestServeAndQuit/Success_with_double_quit 294s === PAUSE TestServeAndQuit/Success_with_double_quit 294s === RUN TestServeAndQuit/Error_due_to_quitting_before_serving 294s === PAUSE TestServeAndQuit/Error_due_to_quitting_before_serving 294s === CONT TestServeAndQuit/Success_with_graceful_quit 294s time="2026-02-06T23:17:57Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46179" 294s time="2026-02-06T23:17:57Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:17:59Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:17:59Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:17:59Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:17:59Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:17:59Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s === CONT TestServe 294s === RUN TestServe/No_connection_because_cannot_read_root_CA_certificate_file 294s === PAUSE TestServe/No_connection_because_cannot_read_root_CA_certificate_file 294s === RUN TestServe/Success_with_systemd_notifier_returning_true 294s === PAUSE TestServe/Success_with_systemd_notifier_returning_true 294s === RUN TestServe/No_connection_because_the_port_file_is_empty 294s === PAUSE TestServe/No_connection_because_the_port_file_is_empty 294s === RUN TestServe/No_connection_because_the_port_file_has_port_0 294s === PAUSE TestServe/No_connection_because_the_port_file_has_port_0 294s === RUN TestServe/No_connection_because_the_port_file_has_a_negative_port 294s === PAUSE TestServe/No_connection_because_the_port_file_has_a_negative_port 294s === RUN TestServe/Error_because_the_context_is_pre-cancelled 294s === PAUSE TestServe/Error_because_the_context_is_pre-cancelled 294s === RUN TestServe/Error_because_the_notifier_returns_an_error 294s === PAUSE TestServe/Error_because_the_notifier_returns_an_error 294s === RUN TestServe/Error_because_WindowsHostAddress_returns_an_error 294s === PAUSE TestServe/Error_because_WindowsHostAddress_returns_an_error 294s === RUN TestServe/Success 294s === PAUSE TestServe/Success 294s === RUN TestServe/Success_with_a_broken_Landscape_config 294s === PAUSE TestServe/Success_with_a_broken_Landscape_config 294s === RUN TestServe/No_connection_because_the_port_file_does_not_exist 294s === PAUSE TestServe/No_connection_because_the_port_file_does_not_exist 294s === RUN TestServe/No_connection_because_the_port_file_has_a_bad_port 294s === PAUSE TestServe/No_connection_because_the_port_file_has_a_bad_port 294s === RUN TestServe/No_connection_because_there_is_no_server 294s === PAUSE TestServe/No_connection_because_there_is_no_server 294s === RUN TestServe/No_connection_because_there_are_no_certificates 294s === PAUSE TestServe/No_connection_because_there_are_no_certificates 294s === CONT TestNew/Error_when_WslPath_returns_error 294s time="2026-02-06T23:17:59Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:00Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:46179" 294s time="2026-02-06T23:18:00Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:00Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:00Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:00Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:01Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s --- PASS: TestNew (0.00s) 294s --- PASS: TestNew/Success (2.23s) 294s --- PASS: TestNew/Error_when_WslPath_returns_error (1.83s) 294s === CONT TestServeAndQuit/Error_due_to_quitting_before_serving 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38297" 294s time="2026-02-06T23:18:01Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:01Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:01Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:01Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:01Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:01Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:01Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:01Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:01Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:01Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:01Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s === CONT TestReconnection 294s === RUN TestReconnection/Success_connecting_after_failing_to_connect 294s === PAUSE TestReconnection/Success_connecting_after_failing_to_connect 294s === RUN TestReconnection/Success_connecting_after_previous_connection_dropped 294s === PAUSE TestReconnection/Success_connecting_after_previous_connection_dropped 294s === RUN TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 294s === PAUSE TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 294s === CONT TestRetryLogic 294s === RUN TestRetryLogic/When_max_attempts_are_exhausted 294s === PAUSE TestRetryLogic/When_max_attempts_are_exhausted 294s === RUN TestRetryLogic/Error_only_when_action_errors 294s === PAUSE TestRetryLogic/Error_only_when_action_errors 294s === RUN TestRetryLogic/Without_retries 294s === PAUSE TestRetryLogic/Without_retries 294s === RUN TestRetryLogic/With_the_context_pre-cancelled 294s === PAUSE TestRetryLogic/With_the_context_pre-cancelled 294s === RUN TestRetryLogic/With_the_context_cancelled_while_waiting 294s === PAUSE TestRetryLogic/With_the_context_cancelled_while_waiting 294s === CONT TestServeAndQuit/Success_with_double_quit 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42825" 294s time="2026-02-06T23:18:01Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:03Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:03Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:03Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:03Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:03Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s === CONT TestServeAndQuit/Success_with_forceful_quit 294s time="2026-02-06T23:18:03Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40479" 294s time="2026-02-06T23:18:03Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:04Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:04Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:04Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:04Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:04Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:05Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:42825" 294s time="2026-02-06T23:18:05Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:05Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:05Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:05Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:05Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:05Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:05Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:05Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:05Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:06Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40479" 294s time="2026-02-06T23:18:06Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:06Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:06Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:06Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:06Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:07Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:07Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:07Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:07Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:07Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:07Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:07Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:07Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:07Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:07Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:07Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:07Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:07Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:07Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_cannot_read_root_CA_certificate_file 294s time="2026-02-06T23:18:07Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:39005" 294s time="2026-02-06T23:18:07Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:07Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:07Z" level=info msg="Stopping active requests." 294s time="2026-02-06T23:18:07Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:07Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:07Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:07Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:07Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:07Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s --- PASS: TestServeAndQuit (0.00s) 294s --- PASS: TestServeAndQuit/Success_with_graceful_quit (4.30s) 294s --- PASS: TestServeAndQuit/Error_due_to_quitting_before_serving (2.08s) 294s --- PASS: TestServeAndQuit/Success_with_double_quit (5.38s) 294s --- PASS: TestServeAndQuit/Success_with_forceful_quit (3.66s) 294s === CONT TestServe/Error_because_WindowsHostAddress_returns_an_error 294s time="2026-02-06T23:18:07Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35377" 294s time="2026-02-06T23:18:07Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:08Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:08Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:08Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:08Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:08Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:08Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:09Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:39005" 294s time="2026-02-06T23:18:09Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_cannot_read_root_CA_certificate_3576123047/001/mnt/d/Users/TestUser/.ubuntupro/certs/ca_cert.pem: no such file or directory" 294s time="2026-02-06T23:18:09Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:09Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:09Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:09Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_there_are_no_certificates 294s time="2026-02-06T23:18:09Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44539" 294s time="2026-02-06T23:18:09Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:09Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:09Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:09Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_there_is_no_server 294s time="2026-02-06T23:18:09Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40545" 294s time="2026-02-06T23:18:09Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:10Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:10Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:10Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:11Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:11Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:11Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44539" 294s time="2026-02-06T23:18:11Z" level=warning msg="Daemon: could not connect to Windows Agent: open /tmp/TestServeNo_connection_because_there_are_no_certificates1085588769/001/mnt/d/Users/TestUser/.ubuntupro/certs/client_cert.pem: no such file or directory" 294s time="2026-02-06T23:18:11Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:11Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40545" 294s time="2026-02-06T23:18:11Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:11Z" level=warning msg="Daemon: disconnected from Windows host: could not start serving: could not connect: could not connect to GRPC service: rpc error: code = Unavailable desc = connection error: desc = \"transport: Error while dialing: dial tcp 127.0.0.1:40545: connect: connection refused\"" 294s time="2026-02-06T23:18:11Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:11Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:11Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:11Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_the_port_file_has_a_bad_port 294s time="2026-02-06T23:18:11Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:46289" 294s time="2026-02-06T23:18:11Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:12Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:12Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:12Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_the_port_file_does_not_exist 294s time="2026-02-06T23:18:12Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45229" 294s time="2026-02-06T23:18:12Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:12Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:12Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:12Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:12Z" 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" 294s time="2026-02-06T23:18:12Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:13Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:13Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:13Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:13Z" 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_exist2936075735/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestServeNo_connection_because_the_port_file_does_not_exist2936075735/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 294s time="2026-02-06T23:18:13Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:13Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:13Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:13Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/Success_with_a_broken_Landscape_config 294s time="2026-02-06T23:18:13Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35203" 294s time="2026-02-06T23:18:13Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:14Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:14Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:14Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/Success 294s time="2026-02-06T23:18:14Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:41733" 294s time="2026-02-06T23:18:14Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:15Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:15Z" level=warning msg="Could not ensure valid Landscape configuration: could not ensure valid Landscape configuration: read /tmp/TestServeSuccess_with_a_broken_Landscape_config4294669666/001/etc/landscape/client.conf: is a directory" 294s time="2026-02-06T23:18:15Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:15Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:15Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:35203" 294s time="2026-02-06T23:18:15Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:15Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:15Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:15Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:15Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:16Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:16Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:41733" 294s time="2026-02-06T23:18:16Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:16Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:16Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:16Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:16Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:18Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:18Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:18Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:18Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:18Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s === CONT TestServe/No_connection_because_the_port_file_has_a_negative_port 294s time="2026-02-06T23:18:18Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:35361" 294s time="2026-02-06T23:18:18Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:18Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:18Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:18Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:18Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:18Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s === CONT TestServe/Error_because_the_notifier_returns_an_error 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:18Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:18Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33173" 294s time="2026-02-06T23:18:18Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:19Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:19Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:19Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:19Z" 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" 294s time="2026-02-06T23:18:19Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:19Z" level=warning msg="Daemon: couldn't update systemd status to \"Stopped\": mock error" 294s time="2026-02-06T23:18:19Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:19Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:19Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/Error_because_the_context_is_pre-cancelled 294s time="2026-02-06T23:18:19Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33433" 294s time="2026-02-06T23:18:19Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:20Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:20Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:20Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_the_port_file_is_empty 294s time="2026-02-06T23:18:20Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37221" 294s time="2026-02-06T23:18:20Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:20Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:20Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:20Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/No_connection_because_the_port_file_has_port_0 294s time="2026-02-06T23:18:20Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42001" 294s time="2026-02-06T23:18:20Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:21Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:21Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:21Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:21Z" level=warning msg="Daemon: could not connect to Windows Agent: could not get address: could not parse port from \"\": could not split address: missing port in address" 294s time="2026-02-06T23:18:21Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:22Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:22Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:22Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:22Z" 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" 294s time="2026-02-06T23:18:22Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:22Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:22Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:22Z" level=debug msg="All connections have now ended." 294s === CONT TestServe/Success_with_systemd_notifier_returning_true 294s time="2026-02-06T23:18:22Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40461" 294s time="2026-02-06T23:18:22Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:23Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:23Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:23Z" level=debug msg="All connections have now ended." 294s === CONT TestReconnection/Success_connecting_after_failing_to_connect 294s time="2026-02-06T23:18:23Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:25Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:25Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:25Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:25Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:25Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:26Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:26Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:26Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:26Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:26Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:26Z" 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_connect312205716/001/mnt/d/Users/TestUser/.ubuntupro/.address\": open /tmp/TestReconnectionSuccess_connecting_after_failing_to_connect312205716/001/mnt/d/Users/TestUser/.ubuntupro/.address: no such file or directory" 294s time="2026-02-06T23:18:26Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:26Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:26Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:44871" 294s time="2026-02-06T23:18:26Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40461" 294s time="2026-02-06T23:18:26Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:26Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:26Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:26Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:27Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:27Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:28Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:28Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:28Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:28Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:28Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:44871" 294s time="2026-02-06T23:18:28Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:28Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:28Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:28Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:29Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:29Z" level=info msg="Waiting for active requests to close." 294s time="2026-02-06T23:18:29Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:29Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:29Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:29Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:29Z" level=debug msg="All connections have now ended." 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s --- PASS: TestServe (0.00s) 294s --- PASS: TestServe/Error_because_WindowsHostAddress_returns_an_error (2.03s) 294s --- PASS: TestServe/No_connection_because_cannot_read_root_CA_certificate_file (2.30s) 294s --- PASS: TestServe/No_connection_because_there_are_no_certificates (2.29s) 294s --- PASS: TestServe/No_connection_because_there_is_no_server (2.46s) 294s --- PASS: TestServe/No_connection_because_the_port_file_has_a_bad_port (2.14s) 294s --- PASS: TestServe/No_connection_because_the_port_file_does_not_exist (2.27s) 294s --- PASS: TestServe/Success_with_a_broken_Landscape_config (4.16s) 294s --- PASS: TestServe/Success (4.35s) 294s --- PASS: TestServe/Error_because_the_notifier_returns_an_error (0.96s) 294s --- PASS: TestServe/No_connection_because_the_port_file_has_a_negative_port (1.96s) 294s --- PASS: TestServe/Error_because_the_context_is_pre-cancelled (1.21s) 294s --- PASS: TestServe/No_connection_because_the_port_file_is_empty (2.82s) 294s --- PASS: TestServe/No_connection_because_the_port_file_has_port_0 (2.94s) 294s --- PASS: TestServe/Success_with_systemd_notifier_returning_true (6.60s) 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s === CONT TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped 294s time="2026-02-06T23:18:29Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:29Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:29Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:29Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:29Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:29Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:29Z" level=info msg="Stopping active requests." 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:29Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:29Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:29Z" level=info msg="Reconnecting to Windows host in 2 seconds" 294s time="2026-02-06T23:18:29Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:29Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:29Z" level=debug msg="All connections have now ended." 294s === CONT TestReconnection/Success_connecting_after_previous_connection_dropped 294s time="2026-02-06T23:18:29Z" level=debug msg="Building new daemon" 294s time="2026-02-06T23:18:32Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:33827" 294s time="2026-02-06T23:18:32Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:32Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:32Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:32Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:32Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:33Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:42601" 294s time="2026-02-06T23:18:33Z" level=debug msg="Ready state sent to systemd" 294s time="2026-02-06T23:18:33Z" level=debug msg="Checking cloud-init status" 294s time="2026-02-06T23:18:33Z" level=debug msg="No Landscape configuration detected: nothing to do" 294s time="2026-02-06T23:18:33Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:33Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:33Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33827" 294s time="2026-02-06T23:18:33Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:33Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:33Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:33Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:34Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:42601" 294s time="2026-02-06T23:18:34Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:34Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:34Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:34Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:35Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:35Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:35Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:36Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:36Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:36Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:36Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 294s time="2026-02-06T23:18:36Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:18:36Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:36Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:38309" 294s time="2026-02-06T23:18:37Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:18:37Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:18:38Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:38309" 294s time="2026-02-06T23:18:38Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:18:38Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:18:38Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:18:38Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:18:39Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:18:39Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:39Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:39Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:39Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:39Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:18:39Z" level=info msg="Stopping active requests." 294s time="2026-02-06T23:18:39Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:39Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:39Z" level=warning msg="Daemon: disconnected from Windows host" 294s time="2026-02-06T23:18:39Z" level=info msg="Reconnecting to Windows host in 2 seconds" 294s time="2026-02-06T23:18:39Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:18:39Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:18:39Z" level=debug msg="All connections have now ended." 294s === CONT TestRetryLogic/When_max_attempts_are_exhausted 294s === CONT TestRetryLogic/With_the_context_pre-cancelled 294s === CONT TestRetryLogic/With_the_context_cancelled_while_waiting 294s === CONT TestRetryLogic/Without_retries 294s === CONT TestRetryLogic/Error_only_when_action_errors 294s --- PASS: TestRetryLogic (0.00s) 294s --- PASS: TestRetryLogic/When_max_attempts_are_exhausted (0.42s) 294s --- PASS: TestRetryLogic/With_the_context_pre-cancelled (0.00s) 294s --- PASS: TestRetryLogic/With_the_context_cancelled_while_waiting (0.03s) 294s --- PASS: TestRetryLogic/Without_retries (0.71s) 294s --- PASS: TestRetryLogic/Error_only_when_action_errors (0.00s) 294s time="2026-02-06T23:19:40Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 294s time="2026-02-06T23:19:40Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:19:40Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:19:40Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:40801" 294s time="2026-02-06T23:19:40Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:40Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:40Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:40Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:33827" 294s time="2026-02-06T23:19:40Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:19:40Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:19:40Z" 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:33827: connect: connection refused\"" 294s time="2026-02-06T23:19:40Z" level=info msg="Reconnecting to Windows host in 1 seconds" 294s time="2026-02-06T23:19:40Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:19:41Z" level=info msg="Daemon: connecting to Windows Agent from PID 6920" 294s time="2026-02-06T23:19:41Z" level=debug msg="Updated systemd status to \"Connecting\"" 294s time="2026-02-06T23:19:42Z" level=info msg="Daemon: starting connection to Windows Agent via 127.0.0.1:40801" 294s time="2026-02-06T23:19:42Z" level=info msg="Daemon: completed connection to Windows Agent" 294s time="2026-02-06T23:19:42Z" level=debug msg="Updated systemd status to \"Connected\"" 294s time="2026-02-06T23:19:42Z" level=debug msg="Started serving agentapi.ProAttachCmd requests" 294s time="2026-02-06T23:19:42Z" level=debug msg="Started serving agentapi.LandscapeConfigCmd requests" 294s time="2026-02-06T23:19:42Z" level=debug msg="Server: sent preface messages to all streams" 294s time="2026-02-06T23:19:42Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:19:42Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:19:42Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:19:42Z" level=warning msg="Daemon: disconnected from Windows host: serve error: could not receive ProAttachCmd: rpc error: code = Unavailable desc = error reading from server: EOF" 294s time="2026-02-06T23:19:42Z" level=info msg="Reconnecting to Windows host in 2 seconds" 294s time="2026-02-06T23:19:42Z" level=debug msg="Updated systemd status to \"Not connected: waiting to retry\"" 294s time="2026-02-06T23:19:42Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:42Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:42Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:19:42Z" level=info msg="Stopping daemon requested." 294s time="2026-02-06T23:19:42Z" level=info msg="Stopping active requests." 294s time="2026-02-06T23:19:42Z" level=debug msg="Updated systemd status to \"Stopped\"" 294s time="2026-02-06T23:19:42Z" level=debug msg="All connections have now ended." 294s --- PASS: TestReconnection (0.00s) 294s --- PASS: TestReconnection/Success_connecting_after_failing_to_connect (6.12s) 294s --- PASS: TestReconnection/Success_connecting_after_previous_connection_dropped (9.62s) 294s --- PASS: TestReconnection/Success_connecting_after_previous_long-lived_connection_dropped (73.21s) 294s PASS 294s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/daemon 105.021s 294s === RUN TestConnect 294s === PAUSE TestConnect 294s === RUN TestSendAndRecv 294s --- PASS: TestSendAndRecv (0.40s) 294s === RUN TestServe 294s === PAUSE TestServe 294s === RUN TestStop 294s === PAUSE TestStop 294s === RUN TestWithProMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithProMock (0.00s) 294s === RUN TestWithWslPathMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslPathMock (0.00s) 294s === RUN TestWithWslInfoMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslInfoMock (0.00s) 294s === RUN TestWithCmdExeMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithCmdExeMock (0.00s) 294s === CONT TestConnect 294s === RUN TestConnect/Success 294s === PAUSE TestConnect/Success 294s === RUN TestConnect/Error_dialing_an_address_that_is_not_serving 294s === PAUSE TestConnect/Error_dialing_an_address_that_is_not_serving 294s === CONT TestServe 294s === CONT TestConnect/Success 294s time="2026-02-06T23:18:00Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:37519" 294s === CONT TestConnect/Error_dialing_an_address_that_is_not_serving 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:01Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:05Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:05Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:05Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s --- PASS: TestServe (5.13s) 294s === CONT TestStop 294s time="2026-02-06T23:18:05Z" level=info msg="MockWindowsAgent: Windows-agent mock serving on 127.0.0.1:45701" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: LandscapeConfigCommands ready" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: Connected ready" 294s time="2026-02-06T23:18:06Z" level=info msg="MockWindowsAgent: ProAttachmentCommands ready" 294s time="2026-02-06T23:18:17Z" 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: " 294s time="2026-02-06T23:18:17Z" level=warning msg="Streamserver: could not stream back info after command completion: EOF" 294s time="2026-02-06T23:18:17Z" level=warning msg="context.Background MockWindowsAgent: LandscapeConfigCommands stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:17Z" level=warning msg="context.Background MockWindowsAgent: Connected stopped: rpc error: code = Canceled desc = context canceled" 294s time="2026-02-06T23:18:17Z" level=warning msg="context.Background MockWindowsAgent: ProAttachmentCommands stopped: rpc error: code = Canceled desc = context canceled" 294s --- PASS: TestStop (11.51s) 294s --- PASS: TestConnect (0.00s) 294s --- PASS: TestConnect/Success (0.30s) 294s --- PASS: TestConnect/Error_dialing_an_address_that_is_not_serving (20.00s) 294s PASS 294s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/streams 20.721s 294s === RUN TestNew 294s === PAUSE TestNew 294s === RUN TestInfo 294s === PAUSE TestInfo 294s === RUN TestWslDistroName 294s === PAUSE TestWslDistroName 294s === RUN TestUserProfileDir 294s === PAUSE TestUserProfileDir 294s === RUN TestProStatus 294s === PAUSE TestProStatus 294s === RUN TestProAttach 294s === PAUSE TestProAttach 294s === RUN TestProDetach 294s === PAUSE TestProDetach 294s === RUN TestLandscapeEnable 294s === PAUSE TestLandscapeEnable 294s === RUN TestWindowsHostAddress 294s === PAUSE TestWindowsHostAddress 294s === RUN TestLandscapeDisable 294s === PAUSE TestLandscapeDisable 294s === RUN TestEnsureValidLandscapeConfig 294s === PAUSE TestEnsureValidLandscapeConfig 294s === RUN TestRealBackend 294s === PAUSE TestRealBackend 294s === RUN TestWithProMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithProMock (0.00s) 294s === RUN TestWithLandscapeConfigMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithLandscapeConfigMock (0.00s) 294s === RUN TestWithWslPathMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslPathMock (0.00s) 294s === RUN TestWithWslInfoMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithWslInfoMock (0.00s) 294s === RUN TestWithCmdExeMock 294s mock_executables.go:650: Skipped because it is not a real test, but rather a mocked executable 294s --- SKIP: TestWithCmdExeMock (0.00s) 294s === CONT TestNew 294s === RUN TestNew/Return_a_new_system 294s === PAUSE TestNew/Return_a_new_system 294s === RUN TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 294s === CONT TestProDetach 294s === RUN TestProDetach/error_on_'pro_detach'_error_and_some_reason 294s === PAUSE TestProDetach/error_on_'pro_detach'_error_and_some_reason 294s === RUN TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 294s === PAUSE TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 294s === RUN TestProDetach/success_on_unattached_distro 294s === PAUSE TestProDetach/success_on_unattached_distro 294s === RUN TestProDetach/success_on_attached_distro 294s === PAUSE TestProDetach/success_on_attached_distro 294s === RUN TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 294s === PAUSE TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 294s === PAUSE TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 294s === CONT TestProAttach 294s === RUN TestProAttach/success 294s === PAUSE TestProAttach/success 294s === RUN TestProAttach/error_on_'pro_attach'_error 294s === PAUSE TestProAttach/error_on_'pro_attach'_error 294s === CONT TestUserProfileDir 294s === RUN TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 294s === PAUSE TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 294s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 294s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 294s === CONT TestProStatus 294s === RUN TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 294s === PAUSE TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 294s === RUN TestProStatus/success_on_unattached_distro 294s === RUN TestUserProfileDir/Error_when_cmd.exe_does_not_exist 294s === PAUSE TestProStatus/success_on_unattached_distro 294s === PAUSE TestUserProfileDir/Error_when_cmd.exe_does_not_exist 294s === RUN TestProStatus/success_on_attached_distro 294s === RUN TestUserProfileDir/Error_on_cmd.exe_error 294s === PAUSE TestProStatus/success_on_attached_distro 294s === PAUSE TestUserProfileDir/Error_on_cmd.exe_error 294s === RUN TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 294s === PAUSE TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 294s === RUN TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 294s === PAUSE TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 294s === RUN TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 294s === PAUSE TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 294s === RUN TestUserProfileDir/Error_on_wslpath_error 294s === RUN TestProStatus/error_on_'pro_attach'_returning_bad_output 294s === PAUSE TestProStatus/error_on_'pro_attach'_returning_bad_output 294s === RUN TestProStatus/error_on_'pro_attach'_error 294s === PAUSE TestProStatus/error_on_'pro_attach'_error 294s === PAUSE TestUserProfileDir/Error_on_wslpath_error 294s === RUN TestUserProfileDir/Success_with_cached_cmd.exe_path 294s === PAUSE TestUserProfileDir/Success_with_cached_cmd.exe_path 294s === RUN TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 294s === PAUSE TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 294s === CONT TestWslDistroName 294s === RUN TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 294s === PAUSE TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 294s === RUN TestWslDistroName/Success_using_wslpath 294s === PAUSE TestWslDistroName/Success_using_wslpath 294s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 294s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 294s === RUN TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 294s === PAUSE TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 294s === CONT TestInfo 294s === RUN TestInfo/Error_when_pro_status_output_cannot_be_parsed 294s === PAUSE TestInfo/Error_when_pro_status_output_cannot_be_parsed 294s === RUN TestInfo/Error_when_/etc/os-release_cannot_be_read 294s === PAUSE TestInfo/Error_when_/etc/os-release_cannot_be_read 294s === RUN TestInfo/Error_whem_/etc/os-release_returns_bad_contents 294s === PAUSE TestInfo/Error_whem_/etc/os-release_returns_bad_contents 294s === RUN TestInfo/Error_when_hostname_cannot_be_obtained 294s === PAUSE TestInfo/Error_when_hostname_cannot_be_obtained 294s === RUN TestInfo/Success 294s === PAUSE TestInfo/Success 294s === RUN TestInfo/Error_when_WslDistroName_fails 294s === PAUSE TestInfo/Error_when_WslDistroName_fails 294s === RUN TestInfo/Error_when_pro_status_command_fails 294s === PAUSE TestInfo/Error_when_pro_status_command_fails 294s === CONT TestLandscapeDisable 294s === RUN TestLandscapeDisable/Success 294s === PAUSE TestLandscapeDisable/Success 294s === RUN TestLandscapeDisable/Error_when_the_landscape-config_command_fails 294s === PAUSE TestLandscapeDisable/Error_when_the_landscape-config_command_fails 294s === CONT TestRealBackend 294s --- PASS: TestRealBackend (0.00s) 294s === CONT TestWindowsHostAddress 294s === RUN TestWindowsHostAddress/Without_NAT 294s === PAUSE TestWindowsHostAddress/Without_NAT 294s === RUN TestWindowsHostAddress/With_NAT 294s === PAUSE TestWindowsHostAddress/With_NAT 294s === RUN TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 294s === PAUSE TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 294s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 294s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 294s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 294s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 294s === RUN TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 294s === PAUSE TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 294s === CONT TestEnsureValidLandscapeConfig 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 294s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === RUN TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 294s === PAUSE TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 294s === RUN TestEnsureValidLandscapeConfig/Regular_with_additional_keys 294s === PAUSE TestEnsureValidLandscapeConfig/Regular_with_additional_keys 294s === RUN TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 294s === PAUSE TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 294s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 294s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 294s === RUN TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 294s === PAUSE TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 294s === RUN TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 294s === PAUSE TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 294s === RUN TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 294s === PAUSE TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 294s === RUN TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 294s === PAUSE TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 294s === RUN TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 294s === PAUSE TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 294s === RUN TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 294s === PAUSE TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 294s === RUN TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 294s === RUN TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 294s === PAUSE TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 294s === CONT TestLandscapeEnable 294s === RUN TestLandscapeEnable/Do_not_modify_other_sections_and_keys 294s === PAUSE TestLandscapeEnable/Do_not_modify_other_sections_and_keys 294s === RUN TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 294s === PAUSE TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 294s === RUN TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 294s === PAUSE TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 294s === RUN TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 294s === PAUSE TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 294s === RUN TestLandscapeEnable/Rerun_landscape_even_without_modifications 294s === PAUSE TestLandscapeEnable/Rerun_landscape_even_without_modifications 294s === RUN TestLandscapeEnable/Regular_with_additional_keys 294s === PAUSE TestLandscapeEnable/Regular_with_additional_keys 294s === RUN TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 294s === PAUSE TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 294s === RUN TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 294s === PAUSE TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 294s === RUN TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 294s === PAUSE TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 294s === RUN TestLandscapeEnable/Error_when_the_landscape-config_command_fails 294s === PAUSE TestLandscapeEnable/Error_when_the_landscape-config_command_fails 294s === RUN TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 294s === PAUSE TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 294s === RUN TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 294s === PAUSE TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 294s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path 294s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path 294s === RUN TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === PAUSE TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === RUN TestLandscapeEnable/Refresh_computer_title_if_changed 294s === PAUSE TestLandscapeEnable/Refresh_computer_title_if_changed 294s === RUN TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 294s === PAUSE TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 294s === CONT TestProDetach/error_on_'pro_detach'_error_and_some_reason 294s === CONT TestNew/Return_a_new_system 294s === CONT TestProDetach/success_on_unattached_distro 294s === CONT TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason 294s === CONT TestProDetach/success_on_attached_distro 294s === CONT TestProAttach/success 294s === CONT TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) 294s --- PASS: TestNew (0.00s) 294s --- PASS: TestNew/Return_a_new_system (0.00s) 294s --- PASS: TestNew/Ignore_errors_when_the_Landscape_config_validation_failed_(only_warnings) (0.00s) 294s === CONT TestProDetach/error_on_'pro_detach'_error_with_bad_JSON 294s === CONT TestProAttach/error_on_'pro_attach'_error 294s --- PASS: TestProDetach (0.00s) 294s --- PASS: TestProDetach/success_on_unattached_distro (1.01s) 294s --- PASS: TestProDetach/error_on_'pro_detach'_error_and_some_reason (1.02s) 294s --- PASS: TestProDetach/success_on_attached_distro (0.91s) 294s --- PASS: TestProDetach/error_on_'pro_detach'_returning_error_and_no_reason (1.01s) 294s --- PASS: TestProDetach/error_on_'pro_detach'_error_with_bad_JSON (1.67s) 294s === CONT TestProStatus/success_on_unattached_distro 294s --- PASS: TestProAttach (0.00s) 294s --- PASS: TestProAttach/success (1.38s) 294s --- PASS: TestProAttach/error_on_'pro_attach'_error (1.19s) 294s === CONT TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts 294s === CONT TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME 294s === CONT TestProStatus/error_on_'pro_attach'_error 294s === CONT TestProStatus/error_on_'pro_attach'_returning_bad_output 294s === CONT TestProStatus/success_on_attached_distro 294s === CONT TestInfo/Error_when_pro_status_output_cannot_be_parsed 294s --- PASS: TestProStatus (0.00s) 294s --- PASS: TestProStatus/success_on_unattached_distro (1.28s) 294s --- PASS: TestProStatus/error_on_'pro_attach'_error (1.28s) 294s --- PASS: TestProStatus/error_on_'pro_attach'_returning_bad_output (1.01s) 294s --- PASS: TestProStatus/success_on_attached_distro (1.03s) 294s === CONT TestUserProfileDir/Success_with_a_single_9P_filesystem_mount 294s === CONT TestUserProfileDir/Success_with_cached_cmd.exe_path 294s === CONT TestUserProfileDir/Error_on_wslpath_error 294s === CONT TestUserProfileDir/Error_when_UserProfile_env_var_is_empty 294s === CONT TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts 294s === CONT TestUserProfileDir/Error_when_wslpath_returns_a_bad_path 294s === CONT TestUserProfileDir/Error_on_cmd.exe_error 294s === CONT TestUserProfileDir/Error_when_cmd.exe_does_not_exist 294s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts 294s system_test.go:245: Removing default proc/mounts 294s === CONT TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts 294s system_test.go:245: Removing default proc/mounts 294s === CONT TestLandscapeDisable/Success 294s --- PASS: TestUserProfileDir (0.00s) 294s --- PASS: TestUserProfileDir/Success_with_multiple_9P_filesystem_mounts (2.26s) 294s --- PASS: TestUserProfileDir/Success_with_a_single_9P_filesystem_mount (2.70s) 294s --- PASS: TestUserProfileDir/Success_with_cached_cmd.exe_path (2.84s) 294s --- PASS: TestUserProfileDir/Error_when_UserProfile_env_var_is_empty (1.25s) 294s --- PASS: TestUserProfileDir/Error_on_wslpath_error (2.73s) 294s --- PASS: TestUserProfileDir/Success_with_multiple_types_of_filesystem_mounts (1.82s) 294s --- PASS: TestUserProfileDir/Error_when_wslpath_returns_a_bad_path (1.45s) 294s --- PASS: TestUserProfileDir/Error_when_cmd.exe_does_not_exist (0.00s) 294s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_Windows_FS_in_/proc/mounts (0.00s) 294s --- PASS: TestUserProfileDir/Error_finding_cmd.exe_because_there_is_no_/proc/mounts (0.00s) 294s --- PASS: TestUserProfileDir/Error_on_cmd.exe_error (0.69s) 294s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text 294s === CONT TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails 294s === CONT TestWslDistroName/Success_using_wslpath 294s === CONT TestWindowsHostAddress/Without_NAT 294s --- PASS: TestWslDistroName (0.00s) 294s --- PASS: TestWslDistroName/Success_reading_from_WSL_DISTRO_NAME (0.00s) 294s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_returns_bad_text (1.04s) 294s --- PASS: TestWslDistroName/Error_when_WSL_DISTRO_NAME_is_empty_and_wslpath_fails (1.05s) 294s --- PASS: TestWslDistroName/Success_using_wslpath (1.02s) 294s === CONT TestInfo/Error_when_pro_status_command_fails 294s === CONT TestInfo/Error_when_WslDistroName_fails 294s === CONT TestInfo/Success 294s === CONT TestInfo/Error_when_hostname_cannot_be_obtained 294s === CONT TestInfo/Error_whem_/etc/os-release_returns_bad_contents 294s === CONT TestInfo/Error_when_/etc/os-release_cannot_be_read 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist 294s --- PASS: TestInfo (0.00s) 294s --- PASS: TestInfo/Error_when_pro_status_output_cannot_be_parsed (1.17s) 294s --- PASS: TestInfo/Error_when_pro_status_command_fails (0.70s) 294s --- PASS: TestInfo/Error_when_WslDistroName_fails (0.81s) 294s --- PASS: TestInfo/Success (0.82s) 294s --- PASS: TestInfo/Error_when_hostname_cannot_be_obtained (0.74s) 294s --- PASS: TestInfo/Error_whem_/etc/os-release_returns_bad_contents (0.76s) 294s --- PASS: TestInfo/Error_when_/etc/os-release_cannot_be_read (0.68s) 294s === CONT TestLandscapeDisable/Error_when_the_landscape-config_command_fails 294s === CONT TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created 294s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP 294s --- PASS: TestLandscapeDisable (0.00s) 294s --- PASS: TestLandscapeDisable/Success (0.86s) 294s --- PASS: TestLandscapeDisable/Error_when_the_landscape-config_command_fails (0.63s) 294s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed 294s === CONT TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist 294s === CONT TestWindowsHostAddress/Error_when_wslinfo_returns_an_error 294s === CONT TestWindowsHostAddress/With_NAT 294s === CONT TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path 294s --- PASS: TestWindowsHostAddress (0.00s) 294s --- PASS: TestWindowsHostAddress/Without_NAT (0.95s) 294s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_has_an_ill-formed_IP (0.66s) 294s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_is_ill-formed (0.67s) 294s --- PASS: TestWindowsHostAddress/Error_with_NAT_when_/proc/net/route_does_not_exist (0.64s) 294s --- PASS: TestWindowsHostAddress/Error_when_wslinfo_returns_an_error (0.63s) 294s --- PASS: TestWindowsHostAddress/With_NAT (0.65s) 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed 294s === CONT TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_transform_windows_ssl_certificate_empty_path 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read 294s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 294s === CONT TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 294s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_due_whitespace_changes 294s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 294s === NAME TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_modify_other_sections_and_keys 294s === CONT TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 294s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name 294s === NAME TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/appends_any_required_fields_-_no_ssl 294s === CONT TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails 294s === CONT TestEnsureValidLandscapeConfig/Regular_with_additional_keys 294s === CONT TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 294s === NAME TestEnsureValidLandscapeConfig/Regular_with_additional_keys 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/regular_with_additional_keys 294s === CONT TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 294s === NAME TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/do_not_rerun_landscape_without_modifications 294s === CONT TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/refresh_computer_title_if_changed 294s === CONT TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === NAME TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/reformat_landscape_config_to_proper_ini 294s === CONT TestLandscapeEnable/Do_not_modify_other_sections_and_keys 294s === NAME TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash 294s system_test.go:768: testdata/TestEnsureValidLandscapeConfig/golden/transform_windows_ssl_certificate_path_with_forward_slash 294s === CONT TestLandscapeEnable/Error_when_the_landscape-config_command_fails 294s --- PASS: TestEnsureValidLandscapeConfig (0.00s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape_user_does_not_exist (0.67s) 294s --- PASS: TestEnsureValidLandscapeConfig/No_Landscape_configuration_means_no_landscape_command_nor_config_created (0.01s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_cannot_be_parsed (0.01s) 294s --- PASS: TestEnsureValidLandscapeConfig/Do_not_transform_Windows_SSL_certificate_empty_path (0.00s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_new_config_do_not_have_client_section (0.00s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_config_file_cannot_be_read (0.00s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_failing_to_override_the_SSL_certficate_path (0.66s) 294s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_due_whitespace_changes (0.65s) 294s --- PASS: TestEnsureValidLandscapeConfig/Do_not_modify_other_sections_and_keys (1.28s) 294s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path (1.37s) 294s --- PASS: TestEnsureValidLandscapeConfig/Appends_any_required_fields_-_no_ssl (0.69s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_can_not_get_WSL_Distro_name (0.65s) 294s --- PASS: TestEnsureValidLandscapeConfig/Error_when_the_landscape-config_command_fails (1.27s) 294s --- PASS: TestEnsureValidLandscapeConfig/Regular_with_additional_keys (1.36s) 294s --- PASS: TestEnsureValidLandscapeConfig/Do_not_rerun_landscape_without_modifications (0.68s) 294s --- PASS: TestEnsureValidLandscapeConfig/Refresh_computer_title_if_changed (0.60s) 294s --- PASS: TestEnsureValidLandscapeConfig/Reformat_Landscape_config_to_proper_ini (1.31s) 294s --- PASS: TestEnsureValidLandscapeConfig/Transform_Windows_SSL_certificate_path_with_forward_slash (1.24s) 294s === NAME TestLandscapeEnable/Do_not_modify_other_sections_and_keys 294s system_test.go:526: testdata/TestLandscapeEnable/golden/do_not_modify_other_sections_and_keys 294s === CONT TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed 294s === CONT TestLandscapeEnable/Refresh_computer_title_if_changed 294s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 294s === NAME TestLandscapeEnable/Refresh_computer_title_if_changed 294s system_test.go:526: testdata/TestLandscapeEnable/golden/refresh_computer_title_if_changed 294s === CONT TestLandscapeEnable/Transform_Windows_SSL_certificate_path 294s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash 294s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path_with_forward_slash 294s === CONT TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist 294s === CONT TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name 294s === NAME TestLandscapeEnable/Transform_Windows_SSL_certificate_path 294s system_test.go:526: testdata/TestLandscapeEnable/golden/transform_windows_ssl_certificate_path 294s === CONT TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created 294s === CONT TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section 294s === CONT TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 294s === CONT TestLandscapeEnable/Regular_with_additional_keys 294s system_test.go:526: testdata/TestLandscapeEnable/golden/regular_with_additional_keys 294s === CONT TestLandscapeEnable/Rerun_landscape_even_without_modifications 294s === NAME TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini 294s system_test.go:526: testdata/TestLandscapeEnable/golden/reformat_landscape_config_to_proper_ini 294s === CONT TestLandscapeEnable/Appends_any_required_fields_-_no_ssl 294s system_test.go:526: testdata/TestLandscapeEnable/golden/appends_any_required_fields_-_no_ssl 294s === CONT TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path 294s === NAME TestLandscapeEnable/Rerun_landscape_even_without_modifications 294s system_test.go:526: testdata/TestLandscapeEnable/golden/rerun_landscape_even_without_modifications 294s === CONT TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed 294s --- PASS: TestLandscapeEnable (0.00s) 294s --- PASS: TestLandscapeEnable/Do_not_modify_other_sections_and_keys (1.40s) 294s --- PASS: TestLandscapeEnable/Error_when_the_config_file_cannot_be_renamed (0.62s) 294s --- PASS: TestLandscapeEnable/Error_when_the_landscape-config_command_fails (1.31s) 294s --- PASS: TestLandscapeEnable/Refresh_computer_title_if_changed (0.66s) 294s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path_with_forward_slash (1.27s) 294s --- PASS: TestLandscapeEnable/Error_when_the_Landscape_user_does_not_exist (0.63s) 294s --- PASS: TestLandscapeEnable/Transform_Windows_SSL_certificate_path (1.35s) 294s --- PASS: TestLandscapeEnable/Error_when_the_can_not_get_WSL_Distro_name (0.70s) 294s --- PASS: TestLandscapeEnable/Error_when_the_new_config_do_not_have_client_section (0.00s) 294s --- PASS: TestLandscapeEnable/Error_when_the_config_directory_cannot_be_created (0.65s) 294s --- PASS: TestLandscapeEnable/Regular_with_additional_keys (1.27s) 294s --- PASS: TestLandscapeEnable/Reformat_Landscape_config_to_proper_ini (1.35s) 294s --- PASS: TestLandscapeEnable/Appends_any_required_fields_-_no_ssl (0.75s) 294s --- PASS: TestLandscapeEnable/Rerun_landscape_even_without_modifications (1.31s) 294s --- PASS: TestLandscapeEnable/Error_when_the_new_config_cannot_be_parsed (0.00s) 294s --- PASS: TestLandscapeEnable/Error_when_failing_to_override_the_SSL_certficate_path (0.62s) 294s PASS 294s ok github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/system 34.754s 294s ? github.com/canonical/ubuntu-pro-for-wsl/wsl-pro-service/internal/testutils [no test files] 294s autopkgtest [23:19:42]: test command1: -----------------------] 295s autopkgtest [23:19:43]: test command1: - - - - - - - - - - results - - - - - - - - - - 295s command1 PASS 295s autopkgtest [23:19:43]: @@@@@@@@@@@@@@@@@@@@ summary 295s command1 PASS