search

lima-vm / lima

Linux virtual machines, with a focus on running containers
https://lima-vm.io/
Apache License 2.0
15.37k stars 602 forks source link

failed to set up forwarding - Post Ventura upgrade #1366

Open bhano-m opened 1 year ago

bhano-m commented 1 year ago

Description

Hello,

I on Ventura 13.1 with an Intel processor. I use limactl to run docker on my local. Everything worked fine until I upgraded to Ventura.

My application runs on 8080, a custom image that runs on 8090 and a dynamo image (with some bells and whistles to the stock image) which runs on port 8000. I have issues running docker on my local and when I looked into ha.stderr.log, i see the following:


{"level":"debug","msg":"Creating iso file /Users/bhano/.lima/docker/cidata.iso","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"Using /var/folders/lr/71w_r8b926xfc9ctwvg0fwz80000gt/T/diskfs_iso3349425970 as workspace","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"OpenSSH version 9.0.1 detected","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"AES accelerator seems available, prioritizing aes128-gcm@openssh.com and aes256-gcm@openssh.com","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"Start udp server listening on: 127.0.0.1:63196","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"Start tcp server listening on: 127.0.0.1:53708","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"firmware candidates = [/Users/bhano/.local/share/qemu/edk2-x86_64-code.fd /usr/local/share/qemu/edk2-x86_64-code.fd /usr/share/OVMF/OVMF_CODE.fd /usr/share/qemu/ovmf-x86_64-code.bin /usr/share/edk2-ovmf/x64/OVMF_CODE.fd]","time":"2023-02-13T19:42:01-05:00"}
{"level":"info","msg":"Starting QEMU (hint: to watch the boot progress, see \"/Users/bhano/.lima/docker/serial.log\")","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"qCmd.Args: [/usr/local/bin/qemu-system-x86_64 -m 12288 -cpu host -machine q35,accel=hvf -smp 4,sockets=1,cores=4,threads=1 -drive if=pflash,format=raw,readonly=on,file=/usr/local/share/qemu/edk2-x86_64-code.fd -boot order=c,splash-time=0,menu=on -drive file=/Users/bhano/.lima/docker/diffdisk,if=virtio,discard=on -cdrom /Users/bhano/.lima/docker/cidata.iso -netdev user,id=net0,net=192.168.5.0/24,dhcpstart=192.168.5.15,hostfwd=tcp:127.0.0.1:53707-:22 -device virtio-net-pci,netdev=net0,mac=52:55:55:b8:e0:fb -device virtio-rng-pci -display none -device virtio-vga -device virtio-keyboard-pci -device virtio-mouse-pci -device qemu-xhci,id=usb-bus -parallel none -chardev socket,id=char-serial,path=/Users/bhano/.lima/docker/serial.sock,server=on,wait=off,logfile=/Users/bhano/.lima/docker/serial.log -serial chardev:char-serial -virtfs local,mount_tag=mount0,path=/Users/bhano,security_model=mapped-xattr -virtfs local,mount_tag=mount1,path=/tmp/lima,security_model=mapped-xattr -chardev socket,id=char-qmp,path=/Users/bhano/.lima/docker/qmp.sock,server=on,wait=off -qmp chardev:char-qmp -name lima-docker -pidfile /Users/bhano/.lima/docker/qemu.pid]","time":"2023-02-13T19:42:01-05:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:01-05:00"}
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 53707\\r\\n\", err=failed to execute script \"ssh\": stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 53707\\r\\n\": exit status 255","time":"2023-02-13T19:42:19-05:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2023-02-13T19:42:29-05:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2023-02-13T19:42:29-05:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:30-05:00"}
{"level":"debug","msg":"stdout=\"\", stderr=\"\", err=\u003cnil\u003e","time":"2023-02-13T19:42:31-05:00"}
{"level":"info","msg":"The essential requirement 1 of 3 is satisfied","time":"2023-02-13T19:42:31-05:00"}
{"level":"info","msg":"Waiting for the essential requirement 2 of 3: \"user session is ready for ssh\"","time":"2023-02-13T19:42:31-05:00"}
{"level":"debug","msg":"executing script \"user session is ready for ssh\"","time":"2023-02-13T19:42:31-05:00"}
{"level":"debug","msg":"executing ssh for script \"user session is ready for ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:31-05:00"}
{"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=failed to execute script \"user session is ready for ssh\": 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\": exit status 255","time":"2023-02-13T19:42:32-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 8510\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 1\n\n;; OPT PSEUDOSECTION:\n; EDNS: version 0; flags: ; udp: 1472\n\n;; QUESTION SECTION:\n;get.docker.com.\tIN\t A\n","time":"2023-02-13T19:42:33-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 3251\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 1\n\n;; OPT PSEUDOSECTION:\n; EDNS: version 0; flags: ; udp: 1472\n\n;; QUESTION SECTION:\n;get.docker.com.\tIN\t AAAA\n","time":"2023-02-13T19:42:33-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 48183\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;get.docker.com.\tIN\t A\n","time":"2023-02-13T19:42:33-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 53918\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;get.docker.com.\tIN\t AAAA\n","time":"2023-02-13T19:42:33-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 43610\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 21118\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:42:34-05:00"}
{"error":"lookup _http._tcp.security.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 43610\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:42:34-05:00"}
{"error":"lookup _http._tcp.archive.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 21118\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NXDOMAIN, id: 43610\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t188\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 17116\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;security.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 29958\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;security.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NOERROR, id: 21118\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t140\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 18731\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 30301\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:42:34-05:00"}
{"level":"info","msg":"Waiting for the essential requirement 2 of 3: \"user session is ready for ssh\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing script \"user session is ready for ssh\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing ssh for script \"user session is ready for ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:42-05:00"}
{"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":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"The essential requirement 2 of 3 is satisfied","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Waiting for the essential requirement 3 of 3: \"the guest agent to be running\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing script \"the guest agent to be running\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing ssh for script \"the guest agent to be running\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:42-05:00"}
{"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":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"The essential requirement 3 of 3 is satisfied","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Waiting for the optional requirement 1 of 1: \"user probe 1/1\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"Forwarding unix sockets","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing script \"user probe 1/1\"","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Forwarding \"/run/user/506/docker.sock\" (guest) to \"/Users/bhano/.lima/docker/sock/docker.sock\" (host)","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"executing ssh for script \"user probe 1/1\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Forwarding \"/run/lima-guestagent.sock\" (guest) to \"/Users/bhano/.lima/docker/ga.sock\" (host)","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"guest agent info: \u0026{LocalPorts:[{IP:127.0.0.53 Port:53} {IP:0.0.0.0 Port:22} {IP::: Port:22}]}","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 00:42:41.836154356 +0000 UTC LocalPortsAdded:[{IP:127.0.0.53 Port:53} {IP:0.0.0.0 Port:22} {IP::: Port:22}] LocalPortsRemoved:[] Errors:[]}","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Not forwarding TCP 127.0.0.53:53","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Not forwarding TCP 0.0.0.0:22","time":"2023-02-13T19:42:42-05:00"}
{"level":"info","msg":"Not forwarding TCP [::]:22","time":"2023-02-13T19:42:42-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 1241\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;ntp.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:42:47-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 49240\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;ntp.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:42:47-05:00"}
{"level":"debug","msg":"stdout=\"\", stderr=\"+ timeout 30s bash -c 'until command -v docker \u003e/dev/null 2\u003e\u00261; do sleep 3; done'\\n+ echo 'docker is not installed yet'\\ndocker is not installed yet\\n+ exit 1\\n\", err=failed to execute script \"user probe 1/1\": stdout=\"\", stderr=\"+ timeout 30s bash -c 'until command -v docker \u003e/dev/null 2\u003e\u00261; do sleep 3; done'\\n+ echo 'docker is not installed yet'\\ndocker is not installed yet\\n+ exit 1\\n\": exit status 1","time":"2023-02-13T19:43:12-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 8124\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:12-05:00"}
{"error":"lookup _http._tcp.archive.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:12-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 8124\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:12-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NOERROR, id: 8124\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t101\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:43:13-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 28604\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:43:13-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 15660\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:13-05:00"}
{"level":"info","msg":"Waiting for the optional requirement 1 of 1: \"user probe 1/1\"","time":"2023-02-13T19:43:22-05:00"}
{"level":"debug","msg":"executing script \"user probe 1/1\"","time":"2023-02-13T19:43:22-05:00"}
{"level":"debug","msg":"executing ssh for script \"user probe 1/1\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:43:22-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 7939\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;download.docker.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 32343\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;download.docker.com.\tIN\t A\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 43516\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 50889\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 20944\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"error":"lookup _http._tcp.archive.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 43516\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"error":"lookup _https._tcp.download.docker.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:26-05:00"}
{"error":"lookup _http._tcp.security.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 20944\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 50889\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NOERROR, id: 43516\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t88\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:43:26-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NXDOMAIN, id: 20944\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\ndocker.com.\t605\tIN\tSOA\tns-207.awsdns-25.com. awsdns-hostmaster.amazon.com. 1 7200 900 1209600 86400\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 36439\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NXDOMAIN, id: 50889\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.security.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t135\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 20592\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 57913\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;security.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 54629\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;download.docker.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 56666\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;security.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:43:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 7033\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 1739\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n","time":"2023-02-13T19:43:29-05:00"}
{"error":"lookup _http._tcp.archive.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 7033\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:43:29-05:00"}
{"error":"lookup _https._tcp.download.docker.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 1739\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NOERROR, id: 7033\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t85\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 19668\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NXDOMAIN, id: 1739\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_https._tcp.download.docker.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\ndocker.com.\t603\tIN\tSOA\tns-207.awsdns-25.com. awsdns-hostmaster.amazon.com. 1 7200 900 1209600 86400\n","time":"2023-02-13T19:43:29-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 51380\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;download.docker.com.\tIN\t AAAA\n","time":"2023-02-13T19:43:30-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 29833\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:44:05-05:00"}
{"error":"lookup _http._tcp.archive.ubuntu.com. on 10.228.32.20:53: no such host","level":"debug","msg":"handleQuery lookup SRV failed","time":"2023-02-13T19:44:05-05:00"}
{"level":"debug","msg":"handleDefault for ;; opcode: QUERY, status: NOERROR, id: 29833\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n","time":"2023-02-13T19:44:05-05:00"}
{"level":"debug","msg":"handleDefault truncating reply: ;; opcode: QUERY, status: NOERROR, id: 29833\n;; flags: qr rd ra; QUERY: 1, ANSWER: 0, AUTHORITY: 1, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;_http._tcp.archive.ubuntu.com.\tIN\t SRV\n\n;; AUTHORITY SECTION:\nubuntu.com.\t49\tIN\tSOA\tns1.canonical.com. hostmaster.canonical.com. 2018056338 10800 3600 604800 3600\n","time":"2023-02-13T19:44:05-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 17455\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t AAAA\n","time":"2023-02-13T19:44:05-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 23483\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;archive.ubuntu.com.\tIN\t A\n","time":"2023-02-13T19:44:05-05:00"}
{"level":"debug","msg":"stdout=\"9016\\n\", stderr=\"+ timeout 30s bash -c 'until command -v docker \u003e/dev/null 2\u003e\u00261; do sleep 3; done'\\n+ timeout 30s bash -c 'until pgrep rootlesskit; do sleep 3; done'\\n\", err=\u003cnil\u003e","time":"2023-02-13T19:44:11-05:00"}
{"level":"info","msg":"The optional requirement 1 of 1 is satisfied","time":"2023-02-13T19:44:11-05:00"}
{"level":"info","msg":"Waiting for the final requirement 1 of 1: \"boot scripts must have finished\"","time":"2023-02-13T19:44:11-05:00"}
{"level":"debug","msg":"executing script \"boot scripts must have finished\"","time":"2023-02-13T19:44:11-05:00"}
{"level":"debug","msg":"executing ssh for script \"boot scripts must have finished\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -p 53707 127.0.0.1 -- /bin/bash]","time":"2023-02-13T19:44:11-05:00"}
{"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":"2023-02-13T19:44:14-05:00"}
{"level":"info","msg":"The final requirement 1 of 1 is satisfied","time":"2023-02-13T19:44:14-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 55043\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:23-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 35295\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t A\n","time":"2023-02-13T19:48:23-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 6948\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:23-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 49477\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:23-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 54113\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:23-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 17280\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:24-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 65462\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:24-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 717\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:24-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 19842\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:24-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 30133\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:24-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 15526\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:25-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 7682\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:25-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 62986\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:25-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 17367\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 18002\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:26-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 59396\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:27-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 19864\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:28-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 54297\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:29-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 562\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:30-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 8660\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:30-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 39113\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:32-05:00"}
{"level":"debug","msg":"handleQuery received DNS query: ;; opcode: QUERY, status: NOERROR, id: 48546\n;; flags: rd; QUERY: 1, ANSWER: 0, AUTHORITY: 0, ADDITIONAL: 0\n\n;; QUESTION SECTION:\n;<REDACTED>.\tIN\t AAAA\n","time":"2023-02-13T19:48:33-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 00:48:58.090467929 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:8000} {IP:0.0.0.0 Port:8090} {IP::: Port:8000} {IP::: Port:8090}] LocalPortsRemoved:[] Errors:[]}","time":"2023-02-13T19:48:57-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8000 to 127.0.0.1:8000","time":"2023-02-13T19:48:57-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8090 to 127.0.0.1:8090","time":"2023-02-13T19:48:58-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8000 to 127.0.0.1:8000","time":"2023-02-13T19:48:58-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8000:[::]:8000 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8000 (negligible if already forwarded)","time":"2023-02-13T19:48:58-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8090 to 127.0.0.1:8090","time":"2023-02-13T19:48:58-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8090:[::]:8090 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8090 (negligible if already forwarded)","time":"2023-02-13T19:48:58-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 00:49:01.095535038 +0000 UTC LocalPortsAdded:[{IP::: Port:8080} {IP:0.0.0.0 Port:8080}] LocalPortsRemoved:[] Errors:[]}","time":"2023-02-13T19:49:00-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8080 to 127.0.0.1:8080","time":"2023-02-13T19:49:00-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8080 to 127.0.0.1:8080","time":"2023-02-13T19:49:01-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8080:0.0.0.0:8080 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8080 (negligible if already forwarded)","time":"2023-02-13T19:49:01-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 01:02:34.099035155 +0000 UTC LocalPortsAdded:[] LocalPortsRemoved:[{IP::: Port:8090} {IP:0.0.0.0 Port:8080} {IP::: Port:8080} {IP::: Port:8000} {IP:0.0.0.0 Port:8000} {IP:0.0.0.0 Port:8090}] Errors:[]}","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8090 to 127.0.0.1:8090","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8080 to 127.0.0.1:8080","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8080 to 127.0.0.1:8080","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8000 to 127.0.0.1:8000","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8000 to 127.0.0.1:8000","time":"2023-02-13T20:02:34-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8090 to 127.0.0.1:8090","time":"2023-02-13T20:02:34-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 01:06:19.092756136 +0000 UTC LocalPortsAdded:[{IP:0.0.0.0 Port:8000} {IP:0.0.0.0 Port:8080} {IP:0.0.0.0 Port:8090} {IP::: Port:8000} {IP::: Port:8080} {IP::: Port:8090}] LocalPortsRemoved:[] Errors:[]}","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8000 to 127.0.0.1:8000","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8080 to 127.0.0.1:8080","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from 0.0.0.0:8090 to 127.0.0.1:8090","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8000 to 127.0.0.1:8000","time":"2023-02-13T20:06:19-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8000:[::]:8000 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8000 (negligible if already forwarded)","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8080 to 127.0.0.1:8080","time":"2023-02-13T20:06:19-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8080:[::]:8080 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8080 (negligible if already forwarded)","time":"2023-02-13T20:06:19-05:00"}
{"level":"info","msg":"Forwarding TCP from [::]:8090 to 127.0.0.1:8090","time":"2023-02-13T20:06:19-05:00"}
{"error":"failed to run [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -T -O forward -L 127.0.0.1:8090:[::]:8090 -N -f -p 53707 127.0.0.1 --]: \"\": exit status 255","level":"warning","msg":"failed to set up forwarding tcp port 8090 (negligible if already forwarded)","time":"2023-02-13T20:06:19-05:00"}
{"level":"debug","msg":"guest agent event: {Time:2023-02-14 01:23:19.097826945 +0000 UTC LocalPortsAdded:[] LocalPortsRemoved:[{IP:0.0.0.0 Port:8080} {IP::: Port:8000} {IP::: Port:8090} {IP:0.0.0.0 Port:8090} {IP::: Port:8080} {IP:0.0.0.0 Port:8000}] Errors:[]}","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8080 to 127.0.0.1:8080","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8000 to 127.0.0.1:8000","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8090 to 127.0.0.1:8090","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8090 to 127.0.0.1:8090","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from [::]:8080 to 127.0.0.1:8080","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Stopping forwarding TCP from 0.0.0.0:8000 to 127.0.0.1:8000","time":"2023-02-13T20:23:19-05:00"}
{"level":"info","msg":"Received SIGINT, shutting down the host agent","time":"2023-02-13T20:23:59-05:00"}
{"level":"info","msg":"Shutting down the host agent","time":"2023-02-13T20:23:59-05:00"}
{"level":"debug","msg":"Stop forwarding unix sockets","time":"2023-02-13T20:23:59-05:00"}
{"level":"info","msg":"Stopping forwarding \"/run/user/506/docker.sock\" (guest) to \"/Users/bhano/.lima/docker/sock/docker.sock\" (host)","time":"2023-02-13T20:23:59-05:00"}
{"level":"info","msg":"Stopping forwarding \"/run/lima-guestagent.sock\" (guest) to \"/Users/bhano/.lima/docker/ga.sock\" (host)","time":"2023-02-13T20:23:59-05:00"}
{"level":"debug","msg":"shutting down the SSH master","time":"2023-02-13T20:23:59-05:00"}
{"level":"debug","msg":"executing ssh for exiting the master: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/bhano/.lima/_config/user\" -o IdentityFile=\"/Users/bhano/.ssh/id_ed25519\" -o IdentityFile=\"/Users/bhano/.ssh/id_rsa\" -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=bhano -o ControlMaster=auto -o ControlPath=\"/Users/bhano/.lima/docker/ssh.sock\" -o ControlPersist=5m -O exit -p 53707 127.0.0.1]","time":"2023-02-13T20:23:59-05:00"}
{"level":"info","msg":"Shutting down QEMU with ACPI","time":"2023-02-13T20:23:59-05:00"}
{"level":"info","msg":"Sending QMP system_powerdown command","time":"2023-02-13T20:23:59-05:00"}
{"error":null,"level":"info","msg":"QEMU has exited","time":"2023-02-13T20:24:03-05:00"}

My docker-compose.yml

version: '3'
services:
  my-app:
    image: my-app:1.0-SNAPSHOT
    environment:
      - APP_VERSION=0.1-SNAPSHOT
      - LOG_LEVEL=INFO
    cap_add:
      - SYS_PTRACE
    security_opt:
      - seccomp:unconfined
    expose:
      - "8080/tcp"
    ports:
      - "8080:8080/tcp"
    depends_on:
    - dynamo-service
    - data-info
    links:
      - dynamo-service
      - data-info
  dynamo-service:
    image: dynamodb-local:0.1.0
    expose:
      - "8000/tcp"
    ports:
      - "8000:8000/tcp"
    volumes:
      - .:/data/dynamodb-local
  data-info:
    image: mock-data:0.1.0
    environment:
      - SERVER_PORT=8090
    expose:
      - "8090/tcp"
    ports:
      - "8090:8090/tcp"

Can someone please help me with this.

bhano-m commented 1 year ago 
➜  ~ brew info qemu
==> qemu: stable 7.2.0 (bottled), HEAD

➜  ~ brew info lima
==> lima: stable 0.14.2 (bottled), HEAD
ozandogrultan commented 1 year ago

Hi @bhano-m I'm facing the same issue. Could you be able to fix it?