rancher-sandbox / rancher-desktop

Container Management and Kubernetes on the Desktop
https://rancherdesktop.io
Apache License 2.0
6.01k stars 283 forks source link

Unable to pull images or access internet when Netskope VPN client is enabled #3346

Open sabeersulaiman opened 2 years ago

sabeersulaiman commented 2 years ago

Actual Behavior

Our org is using Netskope Client for VPN. Whenever I enable the client I cannot pull any images from docker registry. I tried to ping network through lima shell, which also fails with error bad address

Steps to Reproduce

On disabling vpn client and restarting rancher desktop I am able to access network again.

Result

These are the error messages I am getting:

➜  ~ docker pull alpine
Using default tag: latest
Error response from daemon: Get "https://registry-1.docker.io/v2/": dial tcp: lookup registry-1.docker.io on 192.168.5.3:53: read udp 192.168.5.15:42955->192.168.5.3:53: i/o timeout
➜  ~ LIMA_HOME="$HOME/Library/Application Support/rancher-desktop/lima" "/Applications/Rancher Desktop.app/Contents/Resources/resources/darwin/lima/bin/limactl" shell 0
lima-rancher-desktop:/Users/username$ ping google.com
ping: bad address 'google.com'
lima-rancher-desktop:/Users/username$ ping registry-1.docker.io
ping: bad address 'registry-1.docker.io'
lima-rancher-desktop:/Users/username$ curl https://registry-1.docker.io
curl: (6) Could not resolve host: registry-1.docker.io

Expected Behavior

Should be able to pull images and access network.

Additional Information

No response

Rancher Desktop Version

1.6.2

Rancher Desktop K8s Version

nil

Which container engine are you using?

moby (docker cli)

What operating system are you using?

macOS

Operating System / Build Version

Monterey 12.3

What CPU architecture are you using?

arm64 (Apple Silicon)

Linux only: what package format did you use to install Rancher Desktop?

No response

Windows User Only

No response

sabeersulaiman commented 2 years ago

I understand this is hard to debug without the netskope client, if you want me to share any logs or additional info I will be able to.

sabeersulaiman commented 2 years ago

Looks very similar to the issue described here. I was able to pull images after I modified /etc/resolv.conf as below:

nameserver 192.168.5.3
nameserver 8.8.8.8

This still doesn't help access the org network.

Nino-K commented 1 year ago

Hi @sabeersulaiman thanks for filing this issue. Are you able to share some of the lima logs? you can look for them in here less ~/Library/Application\ Support/rancher-desktop/lima/0/ha.stderr.log. Also, can you share the output of traceroute google.com without modifying the resolve.conf (feel free to redact the IP addresses and other sensitive data)? Thanks

sabeersulaiman commented 1 year ago

@Nino-K thanks for taking a look. This is all the logs I can find in ha.stderr.log

{"level":"debug","msg":"Creating iso file /Users/username/Library/Application Support/rancher-desktop/lima/0/cidata.iso","time":"2022-11-16T14:07:56+05:30"}
{"level":"debug","msg":"Using /var/folders/ks/gdbmnh4j6rjckyhf4jz6tqpcb5xnfk/T/diskfs_iso1270490546 as workspace","time":"2022-11-16T14:07:56+05:30"}
{"level":"warning","msg":"field `firmware.legacyBIOS` is not supported for architecture \"aarch64\", ignoring","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"firmware candidates = [/Users/username/.local/share/qemu/edk2-aarch64-code.fd /Applications/Rancher Desktop.app/Contents/Resources/resources/darwin/lima/share/qemu/edk2-aarch64-code.fd /usr/share/AAVMF/AAVMF_CODE.fd /usr/share/qemu-efi-aarch64/QEMU_EFI.fd]","time":"2022-11-16T14:07:57+05:30"}
{"level":"warning","msg":"vdeVMNet is deprecated, use socketVMNet instead (See docs/network.md)","time":"2022-11-16T14:07:57+05:30"}
{"level":"warning","msg":"vdeVMNet is deprecated, use socketVMNet instead (See docs/network.md)","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"OpenSSH version 8.6.1 detected","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"AES accelerator seems available, prioritizing aes128-gcm@openssh.com and aes256-gcm@openssh.com","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"Start udp server listening on: 127.0.0.1:54416","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"Start tcp server listening on: 127.0.0.1:52010","time":"2022-11-16T14:07:57+05:30"}
{"level":"info","msg":"Starting QEMU (hint: to watch the boot progress, see \"/Users/username/Library/Application Support/rancher-desktop/lima/0/serial.log\")","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"qCmd.Args: [/Applications/Rancher Desktop.app/Contents/Resources/resources/darwin/lima/bin/qemu-system-aarch64 -m 6144 -cpu host -machine virt,accel=hvf -smp 6,sockets=1,cores=6,threads=1 -drive if=pflash,format=raw,readonly=on,file=/Applications/Rancher Desktop.app/Contents/Resources/resources/darwin/lima/share/qemu/edk2-aarch64-code.fd -boot order=d,splash-time=0,menu=on -drive file=/Users/username/Library/Application Support/rancher-desktop/lima/0/basedisk,media=cdrom,readonly=on -drive file=/Users/username/Library/Application Support/rancher-desktop/lima/0/diffdisk,if=virtio -cdrom /Users/username/Library/Application Support/rancher-desktop/lima/0/cidata.iso -netdev user,id=net0,net=192.168.5.0/24,dhcpstart=192.168.5.15,hostfwd=tcp:127.0.0.1:51871-:22 -device virtio-net-pci,netdev=net0,mac=52:55:55:e8:bc:ec -netdev vde,id=net1,sock=/private/var/run/rancher-desktop-shared.ctl -device virtio-net-pci,netdev=net1,mac=52:55:55:2c:2e:dc -netdev vde,id=net2,sock=/private/var/run/rancher-desktop-bridged_en0.ctl -device virtio-net-pci,netdev=net2,mac=52:55:55:2d:09:74 -device virtio-rng-pci -display none -vga none -device ramfb -device qemu-xhci,id=usb-bus -device usb-kbd,bus=usb-bus.0 -device usb-mouse,bus=usb-bus.0 -parallel none -chardev socket,id=char-serial,path=/Users/username/Library/Application Support/rancher-desktop/lima/0/serial.sock,server=on,wait=off,logfile=/Users/username/Library/Application Support/rancher-desktop/lima/0/serial.log -serial chardev:char-serial -chardev socket,id=char-qmp,path=/Users/username/Library/Application Support/rancher-desktop/lima/0/qmp.sock,server=on,wait=off -qmp chardev:char-qmp -name lima-0 -pidfile /Users/username/Library/Application Support/rancher-desktop/lima/0/qemu.pid]","time":"2022-11-16T14:07:57+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 5: \"ssh\"","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:07:57+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"ssh: connect to host 127.0.0.1 port 51871: Connection refused\\r\\n\", err=failed to execute script \"ssh\": stdout=\"\", stderr=\"ssh: connect to host 127.0.0.1 port 51871: Connection refused\\r\\n\": exit status 255","time":"2022-11-16T14:07:57+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 5: \"ssh\"","time":"2022-11-16T14:08:07+05:30"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-16T14:08:07+05:30"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:07+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: Connection closed by remote host\\r\\nConnection closed by 127.0.0.1 port 51871\\r\\n\", err=failed to execute script \"ssh\": stdout=\"\", stderr=\"kex_exchange_identification: Connection closed by remote host\\r\\nConnection closed by 127.0.0.1 port 51871\\r\\n\": exit status 255","time":"2022-11-16T14:08:07+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 5: \"ssh\"","time":"2022-11-16T14:08:17+05:30"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-16T14:08:17+05:30"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:17+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: Connection closed by remote host\\r\\nConnection closed by 127.0.0.1 port 51871\\r\\n\", err=failed to execute script \"ssh\": stdout=\"\", stderr=\"kex_exchange_identification: Connection closed by remote host\\r\\nConnection closed by 127.0.0.1 port 51871\\r\\n\": exit status 255","time":"2022-11-16T14:08:17+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 5: \"ssh\"","time":"2022-11-16T14:08:27+05:30"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-16T14:08:27+05:30"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:27+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The essential requirement 1 of 5 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 2 of 5: \"user session is ready for ssh\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing script \"user session is ready for ssh\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"user session is ready for ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"+ timeout 30s bash -c 'until sudo diff -q /run/lima-ssh-ready /mnt/lima-cidata/meta-data 2\u003e/dev/null; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The essential requirement 2 of 5 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 3 of 5: \"sshfs binary to be installed\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing script \"sshfs binary to be installed\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"sshfs binary to be installed\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"stdout=\"/usr/bin/sshfs\\n\", stderr=\"+ timeout 30s bash -c 'until command -v sshfs; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The essential requirement 3 of 5 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 4 of 5: \"/etc/fuse.conf (/etc/fuse3.conf) to contain \\\"user_allow_other\\\"\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing script \"/etc/fuse.conf (/etc/fuse3.conf) to contain \\\"user_allow_other\\\"\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"/etc/fuse.conf (/etc/fuse3.conf) to contain \\\"user_allow_other\\\"\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"+ timeout 30s bash -c 'until grep -q ^user_allow_other /etc/fuse*.conf; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The essential requirement 4 of 5 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Waiting for the essential requirement 5 of 5: \"the guest agent to be running\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing script \"the guest agent to be running\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"the guest agent to be running\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"+ sock=/run/lima-guestagent.sock\\n+ timeout 30s bash -c 'until [ -S \\\"/run/lima-guestagent.sock\\\" ]; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The essential requirement 5 of 5 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Mounting \"/Users/username/Library/Caches/rancher-desktop/k3s\" on \"/Users/username/Library/Caches/rancher-desktop/k3s\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for preparing sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- mkdir -p /Users/username/Library/Caches/rancher-desktop/k3s]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Chosen driver \"openssh-sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Using OpenSSH SFTP Server \"/usr/libexec/sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for remote sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- sshfs :/Users/username/Library/Caches/rancher-desktop/k3s /Users/username/Library/Caches/rancher-desktop/k3s -o slave -o ro -o allow_other]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"starting sftp server for /Users/username/Library/Caches/rancher-desktop/k3s","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing OpenSSH SFTP Server: /usr/libexec/sftp-server [/usr/libexec/sftp-server -e -d /Users/username/Library/Caches/rancher-desktop/k3s -R]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"waiting for remote ready","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"generated script \"wait-for-remote-ready\" with map map[Dir:/Users/username/Library/Caches/rancher-desktop/k3s MaxTrial:30]: \"#!/bin/sh\\nset -eu\\ndir=\\\"/Users/username/Library/Caches/rancher-desktop/k3s\\\"\\nmax_trial=\\\"30\\\"\\nLANG=C\\nLC_ALL=C\\nexport LANG LC_ALL\\ni=0\\nwhile : ; do\\n  # FIXME: not really robust\\n  if mount | grep \\\"on ${dir}\\\" | egrep -qw \\\"fuse.sshfs|osxfuse\\\"; then\\n    echo '{\\\"return\\\":{}}'\\n    exit 0\\n  fi\\n  sleep 1\\n  if [ $i -ge ${max_trial} ]; then\\n    echo \u003e\u00262 \\\"sshfs does not seem to be mounted on ${dir}\\\"\\n    exit 1\\n  fi\\n  i=$((i + 1))\\ndone\\n\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"wait-for-remote-ready\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/sh]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executed script \"wait-for-remote-ready\", stdout=\"{\\\"return\\\":{}}\\n\", stderr=\"\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Mounting \"/Users/username/Library/Logs/rancher-desktop\" on \"/Users/username/Library/Logs/rancher-desktop\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for preparing sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- mkdir -p /Users/username/Library/Logs/rancher-desktop]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Chosen driver \"openssh-sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Using OpenSSH SFTP Server \"/usr/libexec/sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for remote sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- sshfs :/Users/username/Library/Logs/rancher-desktop /Users/username/Library/Logs/rancher-desktop -o slave -o allow_other]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"starting sftp server for /Users/username/Library/Logs/rancher-desktop","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing OpenSSH SFTP Server: /usr/libexec/sftp-server [/usr/libexec/sftp-server -e -d /Users/username/Library/Logs/rancher-desktop]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"waiting for remote ready","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"generated script \"wait-for-remote-ready\" with map map[Dir:/Users/username/Library/Logs/rancher-desktop MaxTrial:30]: \"#!/bin/sh\\nset -eu\\ndir=\\\"/Users/username/Library/Logs/rancher-desktop\\\"\\nmax_trial=\\\"30\\\"\\nLANG=C\\nLC_ALL=C\\nexport LANG LC_ALL\\ni=0\\nwhile : ; do\\n  # FIXME: not really robust\\n  if mount | grep \\\"on ${dir}\\\" | egrep -qw \\\"fuse.sshfs|osxfuse\\\"; then\\n    echo '{\\\"return\\\":{}}'\\n    exit 0\\n  fi\\n  sleep 1\\n  if [ $i -ge ${max_trial} ]; then\\n    echo \u003e\u00262 \\\"sshfs does not seem to be mounted on ${dir}\\\"\\n    exit 1\\n  fi\\n  i=$((i + 1))\\ndone\\n\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"wait-for-remote-ready\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/sh]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executed script \"wait-for-remote-ready\", stdout=\"{\\\"return\\\":{}}\\n\", stderr=\"\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Mounting \"/Users/username\" on \"/Users/username\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for preparing sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- mkdir -p /Users/username]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Chosen driver \"openssh-sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Using OpenSSH SFTP Server \"/usr/libexec/sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for remote sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- sshfs :/Users/username /Users/username -o slave -o allow_other]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"starting sftp server for /Users/username","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing OpenSSH SFTP Server: /usr/libexec/sftp-server [/usr/libexec/sftp-server -e -d /Users/username]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"waiting for remote ready","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"generated script \"wait-for-remote-ready\" with map map[Dir:/Users/username MaxTrial:30]: \"#!/bin/sh\\nset -eu\\ndir=\\\"/Users/username\\\"\\nmax_trial=\\\"30\\\"\\nLANG=C\\nLC_ALL=C\\nexport LANG LC_ALL\\ni=0\\nwhile : ; do\\n  # FIXME: not really robust\\n  if mount | grep \\\"on ${dir}\\\" | egrep -qw \\\"fuse.sshfs|osxfuse\\\"; then\\n    echo '{\\\"return\\\":{}}'\\n    exit 0\\n  fi\\n  sleep 1\\n  if [ $i -ge ${max_trial} ]; then\\n    echo \u003e\u00262 \\\"sshfs does not seem to be mounted on ${dir}\\\"\\n    exit 1\\n  fi\\n  i=$((i + 1))\\ndone\\n\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"wait-for-remote-ready\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/sh]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executed script \"wait-for-remote-ready\", stdout=\"{\\\"return\\\":{}}\\n\", stderr=\"\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Mounting \"/tmp/rancher-desktop\" on \"/tmp/rancher-desktop\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for preparing sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- mkdir -p /tmp/rancher-desktop]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Chosen driver \"openssh-sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Using OpenSSH SFTP Server \"/usr/libexec/sftp-server\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for remote sshfs: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- sshfs :/tmp/rancher-desktop /tmp/rancher-desktop -o slave -o allow_other]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"starting sftp server for /tmp/rancher-desktop","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing OpenSSH SFTP Server: /usr/libexec/sftp-server [/usr/libexec/sftp-server -e -d /tmp/rancher-desktop]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"waiting for remote ready","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"generated script \"wait-for-remote-ready\" with map map[Dir:/tmp/rancher-desktop MaxTrial:30]: \"#!/bin/sh\\nset -eu\\ndir=\\\"/tmp/rancher-desktop\\\"\\nmax_trial=\\\"30\\\"\\nLANG=C\\nLC_ALL=C\\nexport LANG LC_ALL\\ni=0\\nwhile : ; do\\n  # FIXME: not really robust\\n  if mount | grep \\\"on ${dir}\\\" | egrep -qw \\\"fuse.sshfs|osxfuse\\\"; then\\n    echo '{\\\"return\\\":{}}'\\n    exit 0\\n  fi\\n  sleep 1\\n  if [ $i -ge ${max_trial} ]; then\\n    echo \u003e\u00262 \\\"sshfs does not seem to be mounted on ${dir}\\\"\\n    exit 1\\n  fi\\n  i=$((i + 1))\\ndone\\n\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"wait-for-remote-ready\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/sh]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executed script \"wait-for-remote-ready\", stdout=\"{\\\"return\\\":{}}\\n\", stderr=\"\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Waiting for the final requirement 1 of 1: \"boot scripts must have finished\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"Forwarding unix sockets","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing script \"boot scripts must have finished\"","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Forwarding \"/var/run/docker.sock\" (guest) to \"/Users/username/.rd/docker.sock\" (host)","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"executing ssh for script \"boot scripts must have finished\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -p 51871 127.0.0.1 -- /bin/bash]","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"stdout=\"\", stderr=\"+ timeout 30s bash -c 'until sudo diff -q /run/lima-boot-done /mnt/lima-cidata/meta-data 2\u003e/dev/null; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"The final requirement 1 of 1 is satisfied","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Forwarding \"/run/lima-guestagent.sock\" (guest) to \"/Users/username/Library/Application Support/rancher-desktop/lima/0/ga.sock\" (host)","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"guest agent info: \u0026{LocalPorts:[{IP:0.0.0.0 Port:22} {IP::: Port:22}]}","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"guest agent event: {Time:2022-11-16 08:38:27.663920552 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:22} {IP::: Port:22}] LocalPortsRemoved:[] Errors:[]}","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Not forwarding TCP 0.0.0.0:22","time":"2022-11-16T14:08:28+05:30"}
{"level":"info","msg":"Not forwarding TCP [::]:22","time":"2022-11-16T14:08:28+05:30"}
{"level":"debug","msg":"guest agent event: {Time:2022-11-16 08:38:30.669230262 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:6379} {IP::: Port:6379}] LocalPortsRemoved:[] Errors:[]}","time":"2022-11-16T14:08:31+05:30"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:6379 to 0.0.0.0:6379","time":"2022-11-16T14:08:31+05:30"}
{"level":"info","msg":"Forwarding TCP from [::]:6379 to 0.0.0.0:6379","time":"2022-11-16T14:08:31+05:30"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -T -O forward -L 0.0.0.0:6379:[::]:6379 -N -f -p 51871 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 6379 (negligible if already forwarded)","time":"2022-11-16T14:08:31+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 46497\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t A\n","time":"2022-11-16T20:37:55+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 28032\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t AAAA\n","time":"2022-11-16T20:37:55+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:63412: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:37:55+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:54631: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:37:55+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 45197\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;auth.docker.io.\tIN\t A\n","time":"2022-11-16T20:38:01+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 23313\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;auth.docker.io.\tIN\t AAAA\n","time":"2022-11-16T20:38:01+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:64081: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:38:01+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:50560: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:38:01+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 3332\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;auth.docker.io.\tIN\t A\n","time":"2022-11-16T20:38:06+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 61160\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;auth.docker.io.\tIN\t AAAA\n","time":"2022-11-16T20:38:06+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:62606: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:38:06+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:51488: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:38:06+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 59018\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t A\n","time":"2022-11-16T20:48:28+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 50227\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t AAAA\n","time":"2022-11-16T20:48:28+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:51817: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:48:28+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:54145: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:48:28+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 59977\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t A\n","time":"2022-11-16T20:48:33+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 31109\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;registry-1.docker.io.\tIN\t AAAA\n","time":"2022-11-16T20:48:33+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:58602: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:48:33+05:30"}
{"error":"write udp 127.0.0.1:54416-\u003e127.0.0.1:53856: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-16T20:48:33+05:30"}
panic: read udp 127.0.0.1:54416: recvmsg: software caused connection abort

goroutine 77 [running]:
github.com/lima-vm/lima/pkg/hostagent/dns.listenAndServe.func1()
    /Users/jan/git/lima-and-qemu/src/lima/pkg/hostagent/dns/dns.go:385 +0xc0
created by github.com/lima-vm/lima/pkg/hostagent/dns.listenAndServe
    /Users/jan/git/lima-and-qemu/src/lima/pkg/hostagent/dns/dns.go:382 +0x29c

Output for traceroute google.com from lima:

lima-rancher-desktop:/Users/username$ traceroute google.com
traceroute: bad address 'google.com'

From host:

~ traceroute google.com
traceroute to google.com (142.250.77.142), 64 hops max, 52 byte packets
 1  192.168.1.1 (192.168.1.1)  34.860 ms  4.413 ms  3.109 ms
 2  isp-address (isp)  40.976 ms  4.587 ms  6.451 ms
 3  182.79.20.133 (182.79.20.133)  23.690 ms
    125.18.238.133 (125.18.238.133)  31.377 ms  11.203 ms
 4  116.119.50.115 (116.119.50.115)  76.723 ms
    116.119.94.30 (116.119.94.30)  57.628 ms
    182.79.198.26 (182.79.198.26)  59.554 ms
 5  72.14.205.196 (72.14.205.196)  59.584 ms  13.014 ms  14.737 ms
 6  * * *
 7  108.170.253.97 (108.170.253.97)  60.581 ms
    142.251.55.236 (142.251.55.236)  34.110 ms
    142.251.55.238 (142.251.55.238)  49.963 ms
 8  142.251.55.205 (142.251.55.205)  84.162 ms
    142.251.55.207 (142.251.55.207)  65.185 ms  11.486 ms
 9  74.125.242.145 (74.125.242.145)  50.730 ms
    74.125.242.129 (74.125.242.129)  62.680 ms
    maa05s16-in-f14.1e100.net (142.250.77.142)  47.195 ms
sabeersulaiman commented 1 year ago

Also got these when I restarted rancher desktop:

{"level":"debug","msg":"stdout=\"\", stderr=\"+ timeout 30s bash -c 'until sudo diff -q /run/lima-boot-done /mnt/lima-cidata/meta-data 2\u003e/dev/null; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2022-11-20T21:55:12+05:30"}
{"level":"info","msg":"The final requirement 1 of 1 is satisfied","time":"2022-11-20T21:55:12+05:30"}
{"level":"debug","msg":"guest agent info: \u0026{LocalPorts:[{IP:0.0.0.0 Port:22} {IP::: Port:22}]}","time":"2022-11-20T21:55:12+05:30"}
{"level":"debug","msg":"guest agent event: {Time:2022-11-20 16:25:12.614612173 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:22} {IP::: Port:22}] LocalPortsRemoved:[] Errors:[]}","time":"2022-11-20T21:55:12+05:30"}
{"level":"info","msg":"Not forwarding TCP 0.0.0.0:22","time":"2022-11-20T21:55:12+05:30"}
{"level":"info","msg":"Not forwarding TCP [::]:22","time":"2022-11-20T21:55:12+05:30"}
{"level":"debug","msg":"guest agent event: {Time:2022-11-20 16:25:15.616680507 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:6379} {IP::: Port:6379}] LocalPortsRemoved:[] Errors:[]}","time":"2022-11-20T21:55:15+05:30"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:6379 to 0.0.0.0:6379","time":"2022-11-20T21:55:15+05:30"}
{"level":"info","msg":"Forwarding TCP from [::]:6379 to 0.0.0.0:6379","time":"2022-11-20T21:55:15+05:30"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/username/Library/Application Support/rancher-desktop/lima/_config/user\" -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o NoHostAuthenticationForLocalhost=yes -o GSSAPIAuthentication=no -o PreferredAuthentications=publickey -o Compression=no -o BatchMode=yes -o IdentitiesOnly=yes -o Ciphers=\"^aes128-gcm@openssh.com,aes256-gcm@openssh.com\" -o User=username -o ControlMaster=auto -o ControlPath=\"/Users/username/Library/Application Support/rancher-desktop/lima/0/ssh.sock\" -o ControlPersist=5m -T -O forward -L 0.0.0.0:6379:[::]:6379 -N -f -p 59320 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 6379 (negligible if already forwarded)","time":"2022-11-20T21:55:15+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 16668\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t AAAA\n","time":"2022-11-20T21:56:17+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 16585\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t A\n","time":"2022-11-20T21:56:17+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:49336: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:17+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:49336: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:17+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 16585\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t A\n","time":"2022-11-20T21:56:20+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 16668\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t AAAA\n","time":"2022-11-20T21:56:20+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:49336: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:20+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:49336: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:20+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 37528\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t AAAA\n","time":"2022-11-20T21:56:36+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 37319\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t A\n","time":"2022-11-20T21:56:36+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:57891: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:36+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:57891: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:36+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 37528\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t AAAA\n","time":"2022-11-20T21:56:39+05:30"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 37319\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;google.com.\tIN\t A\n","time":"2022-11-20T21:56:39+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:57891: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:39+05:30"}
{"error":"write udp 127.0.0.1:52315-\u003e127.0.0.1:57891: sendmsg: invalid argument","level":"debug","msg":"handleQuery failed writing DNS reply","time":"2022-11-20T21:56:39+05:30"}
murilobeltrame commented 2 months ago

This also happens to me on Win10. Netspoke client v 117.1.3.2130 Rancher Desktop v 1.9.0

Nino-K commented 1 month ago

@murilobeltrame can you upgrade to 1.15.1 (for windows) and see if you still see the VPN issue?

murilobeltrame commented 1 month ago

Just upgraded and it worked. Thanks!