vz: Has been stuck in Waiting for the essential requirement 1 of 3: "ssh" on Start lima

[kj-creater]

Description

{"level":"info","msg":"Replacing \"http_proxy\" value \"http://127.0.0.1:7890\" with \"http://192.168.5.2:7890\"","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"Replacing \"https_proxy\" value \"http://127.0.0.1:7890\" with \"http://192.168.5.2:7890\"","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"Creating iso file /Users/xxx/.lima/oracle/cidata.iso","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"Using /var/folders/56/5j82q2lx34vcm7zxrp_m11hh0000gn/T/diskfs_iso3912373468 as workspace","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"OpenSSH version 9.0.1 detected","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"AES accelerator seems available, prioritizing aes128-gcm@openssh.com and aes256-gcm@openssh.com","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"Starting VZ (hint: to watch the boot progress, see \"/Users/xxx/.lima/oracle/serial.log\")","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"Start tcp server listening on: 127.0.0.1:49936","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"Setting up Rosetta share","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"Start udp server listening on: 127.0.0.1:54440","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"[VZ] - vm state change: \"VirtualMachineStateStarting\"","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"new connection from  to ","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"[VZ] - vm state change: running","time":"2022-11-24T19:59:23+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T19:59:23+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T19:59:23+08:00"}
2022/11/24 19:59:26 tcpproxy: for incoming conn 127.0.0.1:49937, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: no route
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T19:59:26+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T19:59:36+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T19:59:36+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T19:59:36+08:00"}
2022/11/24 19:59:36 tcpproxy: for incoming conn 127.0.0.1:49957, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T19:59:36+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T19:59:46+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T19:59:46+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T19:59:46+08:00"}
2022/11/24 19:59:46 tcpproxy: for incoming conn 127.0.0.1:49958, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T19:59:46+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T19:59:57+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T19:59:57+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T19:59:57+08:00"}
2022/11/24 19:59:57 tcpproxy: for incoming conn 127.0.0.1:49959, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T19:59:57+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:07+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:07+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:07+08:00"}
2022/11/24 20:00:07 tcpproxy: for incoming conn 127.0.0.1:49960, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:07+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:17+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:17+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:17+08:00"}
2022/11/24 20:00:17 tcpproxy: for incoming conn 127.0.0.1:49961, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:17+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:27+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:27+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:27+08:00"}
2022/11/24 20:00:27 tcpproxy: for incoming conn 127.0.0.1:49962, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:27+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:37+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:37+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:37+08:00"}
2022/11/24 20:00:37 tcpproxy: for incoming conn 127.0.0.1:49963, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:37+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:47+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:47+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:47+08:00"}
2022/11/24 20:00:47 tcpproxy: for incoming conn 127.0.0.1:49964, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:47+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:00:57+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:00:57+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:00:57+08:00"}
2022/11/24 20:00:57 tcpproxy: for incoming conn 127.0.0.1:49969, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:00:57+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:07+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:07+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:07+08:00"}
2022/11/24 20:01:07 tcpproxy: for incoming conn 127.0.0.1:49974, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:07+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:17+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:17+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:17+08:00"}
2022/11/24 20:01:17 tcpproxy: for incoming conn 127.0.0.1:49975, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:17+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:27+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:27+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:27+08:00"}
2022/11/24 20:01:27 tcpproxy: for incoming conn 127.0.0.1:49982, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:27+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.57:123: i/o timeout)","time":"2022-11-24T20:01:30+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:37+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:37+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:37+08:00"}
2022/11/24 20:01:37 tcpproxy: for incoming conn 127.0.0.1:49989, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:37+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.56:123: i/o timeout)","time":"2022-11-24T20:01:40+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:47+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:47+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:47+08:00"}
2022/11/24 20:01:47 tcpproxy: for incoming conn 127.0.0.1:49992, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:47+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:01:57+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:01:57+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:01:57+08:00"}
2022/11/24 20:01:57 tcpproxy: for incoming conn 127.0.0.1:49993, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:01:57+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:07+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:07+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:07+08:00"}
2022/11/24 20:02:07 tcpproxy: for incoming conn 127.0.0.1:49994, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:07+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:17+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:17+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:17+08:00"}
2022/11/24 20:02:17 tcpproxy: for incoming conn 127.0.0.1:50009, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:17+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:27+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:27+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:27+08:00"}
2022/11/24 20:02:27 tcpproxy: for incoming conn 127.0.0.1:50010, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:27+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.56:123: i/o timeout)","time":"2022-11-24T20:02:28+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:37+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:37+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:37+08:00"}
2022/11/24 20:02:37 tcpproxy: for incoming conn 127.0.0.1:50013, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:37+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:47+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:47+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:47+08:00"}
2022/11/24 20:02:47 tcpproxy: for incoming conn 127.0.0.1:50024, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:47+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:02:57+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:02:57+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:02:57+08:00"}
2022/11/24 20:02:57 tcpproxy: for incoming conn 127.0.0.1:50029, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:02:57+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.56:123: i/o timeout)","time":"2022-11-24T20:03:01+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:07+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:07+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:07+08:00"}
2022/11/24 20:03:07 tcpproxy: for incoming conn 127.0.0.1:50034, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:07+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:17+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:17+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:17+08:00"}
2022/11/24 20:03:17 tcpproxy: for incoming conn 127.0.0.1:50049, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:17+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:27+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:27+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:27+08:00"}
2022/11/24 20:03:27 tcpproxy: for incoming conn 127.0.0.1:50050, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:27+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.56:123: i/o timeout)","time":"2022-11-24T20:03:33+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:37+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:37+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:37+08:00"}
2022/11/24 20:03:37 tcpproxy: for incoming conn 127.0.0.1:50051, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:37+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:47+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:47+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:47+08:00"}
2022/11/24 20:03:47 tcpproxy: for incoming conn 127.0.0.1:50068, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:47+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:03:57+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:03:57+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:03:57+08:00"}
2022/11/24 20:03:57 tcpproxy: for incoming conn 127.0.0.1:50069, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:03:57+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:07+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:07+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:07+08:00"}
2022/11/24 20:04:08 tcpproxy: for incoming conn 127.0.0.1:50070, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:08+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:18+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:18+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:18+08:00"}
2022/11/24 20:04:18 tcpproxy: for incoming conn 127.0.0.1:50089, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:18+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:28+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:28+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:28+08:00"}
2022/11/24 20:04:28 tcpproxy: for incoming conn 127.0.0.1:50090, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:28+08:00"}
{"level":"debug","msg":"Stopping udp proxy (read udp 185.125.190.56:123: i/o timeout)","time":"2022-11-24T20:04:37+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:38+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:38+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:38+08:00"}
2022/11/24 20:04:38 tcpproxy: for incoming conn 127.0.0.1:50096, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:38+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:48+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:48+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:48+08:00"}
2022/11/24 20:04:48 tcpproxy: for incoming conn 127.0.0.1:50108, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:48+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:04:58+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:04:58+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:04:58+08:00"}
2022/11/24 20:04:58 tcpproxy: for incoming conn 127.0.0.1:50111, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:04:58+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:08+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:08+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:08+08:00"}
2022/11/24 20:05:08 tcpproxy: for incoming conn 127.0.0.1:50124, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:08+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:18+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:18+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:18+08:00"}
2022/11/24 20:05:18 tcpproxy: for incoming conn 127.0.0.1:50127, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:18+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:28+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:28+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:28+08:00"}
2022/11/24 20:05:28 tcpproxy: for incoming conn 127.0.0.1:50130, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:28+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:38+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:38+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:38+08:00"}
2022/11/24 20:05:38 tcpproxy: for incoming conn 127.0.0.1:50135, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:38+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:48+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:48+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:48+08:00"}
2022/11/24 20:05:48 tcpproxy: for incoming conn 127.0.0.1:50136, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:48+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:05:58+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:05:58+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:05:58+08:00"}
2022/11/24 20:05:58 tcpproxy: for incoming conn 127.0.0.1:50143, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:05:58+08:00"}
{"level":"info","msg":"Waiting for the essential requirement 1 of 3: \"ssh\"","time":"2022-11-24T20:06:08+08:00"}
{"level":"debug","msg":"executing script \"ssh\"","time":"2022-11-24T20:06:08+08:00"}
{"level":"debug","msg":"executing ssh for script \"ssh\": /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -p 49935 127.0.0.1 -- /bin/bash]","time":"2022-11-24T20:06:08+08:00"}
2022/11/24 20:06:08 tcpproxy: for incoming conn 127.0.0.1:50158, error dialing "192.168.5.15:22": connect tcp 192.168.5.15:22: connection was refused
{"level":"debug","msg":"stdout=\"\", stderr=\"kex_exchange_identification: read: Connection reset by peer\\r\\nConnection reset by 127.0.0.1 port 49935\\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 49935\\r\\n\": exit status 255","time":"2022-11-24T20:06:08+08:00"}
{"level":"info","msg":"Received SIGINT, shutting down the host agent","time":"2022-11-24T20:06:16+08:00"}
{"level":"info","msg":"Shutting down the host agent","time":"2022-11-24T20:06:16+08:00"}
{"level":"debug","msg":"shutting down the SSH master","time":"2022-11-24T20:06:16+08:00"}
{"level":"debug","msg":"executing ssh for exiting the master: /usr/bin/ssh [ssh -F /dev/null -o IdentityFile=\"/Users/xxx/.lima/_config/user\" -o IdentityFile=\"/Users/xxx/.ssh/github_rsa\" -o IdentityFile=\"/Users/xxx/.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=xxx -o ControlMaster=auto -o ControlPath=\"/Users/xxx/.lima/oracle/ssh.sock\" -o ControlPersist=5m -O exit -p 49935 127.0.0.1]","time":"2022-11-24T20:06:16+08:00"}
{"error":"failed to execute `ssh -O exit -p 49935 127.0.0.1`, out=\"Control socket connect(/Users/xxx/.lima/oracle/ssh.sock): No such file or directory\\r\\n\": exit status 255","level":"warning","msg":"failed to exit SSH master","time":"2022-11-24T20:06:16+08:00"}
{"level":"info","msg":"Shutting down VZ","time":"2022-11-24T20:06:16+08:00"}
panic: runtime/cgo: misuse of an invalid Handle

goroutine 1 [running]:
runtime/cgo.Handle.Value(...)
	/opt/homebrew/Cellar/go/1.19.3/libexec/src/runtime/cgo/handle.go:124
github.com/Code-Hex/vz/v3.changeStateOnObserver(0x7, 0x1048c3ee8?)
	/Users/xxx/.cache/go/pkg/mod/github.com/!code-!hex/vz/v3@v3.0.1/virtualization.go:158 +0xec
github.com/Code-Hex/vz/v3._Cfunc_stopWithCompletionHandler(0x600002e35ee0, 0x600003b3f300, 0x140000421d8)
	_cgo_gotypes.go:1942 +0x34
github.com/Code-Hex/vz/v3.(*VirtualMachine).Stop.func1(0x14000050180, 0x140004f27d0?)
	/Users/xxx/.cache/go/pkg/mod/github.com/!code-!hex/vz/v3@v3.0.1/virtualization.go:330 +0xbc
github.com/Code-Hex/vz/v3.(*VirtualMachine).Stop(0x140001fe000?)
	/Users/xxx/.cache/go/pkg/mod/github.com/!code-!hex/vz/v3@v3.0.1/virtualization.go:330 +0xe8
github.com/lima-vm/lima/pkg/vz.(*LimaVzDriver).Stop(0x1400012e3c0, {0x14000000004?, 0x140005e3a18?})
	/Users/xxx/Developer/git/lima/pkg/vz/vz_driver_darwin.go:69 +0x78
github.com/lima-vm/lima/pkg/hostagent.(*HostAgent).Run(0x14000122000, {0x1052ad9b0?, 0x140001ac008})
	/Users/xxx/Developer/git/lima/pkg/hostagent/hostagent.go:295 +0x6fc
main.hostagentAction(0x14000300600, {0x1400018e870, 0x1, 0x5?})
	/Users/xxx/Developer/git/lima/cmd/limactl/hostagent.go:99 +0x650
github.com/spf13/cobra.(*Command).execute(0x14000300600, {0x1400018e820, 0x5, 0x5})
	/Users/xxx/.cache/go/pkg/mod/github.com/spf13/cobra@v1.6.1/command.go:916 +0x5c8
github.com/spf13/cobra.(*Command).ExecuteC(0x1400024c600)
	/Users/xxx/.cache/go/pkg/mod/github.com/spf13/cobra@v1.6.1/command.go:1044 +0x35c
github.com/spf13/cobra.(*Command).Execute(...)
	/Users/xxx/.cache/go/pkg/mod/github.com/spf13/cobra@v1.6.1/command.go:968
main.main()
	/Users/xxx/Developer/git/lima/cmd/limactl/main.go:23 +0x20

oracle-vz.zip

OS: macOS 13.0.1 M1

[balajiv113]

I just tried this template, it works fine for me.
I am running macOS 13.1 Beta M1

Have you tried from source (or) the release build ?

[kj-creater]

I tried to release and compile v0.14.0-beta.1, and the problem is the same. What can I do to help this issue?

[balajiv113]

Is running limactl start template://experimental/vz working ??

[abiosoft]

I actually do experience something similar and I suspect it is related to GVisor network.

I have only experienced a frozen startup once or twice, but what I do experience more frequently is frozen SSH sessions. When it happens, everything still works with the exception of SSH and everything linked to it e.g. port forwarding.

I am still unable to pin-point the cause, and it does happen with multiple distros including the default vz template.

[balajiv113]

I actually do experience something similar and I suspect it is related to GVisor network.

I have only experienced a frozen startup once or twice, but what I do experience more frequently is frozen SSH sessions. When it happens, everything still works with the exception of SSH and everything linked to it e.g. port forwarding.

I am still unable to pin-point the cause, and it does happen with multiple distros including the default vz template.

Ah !! That's bad.
I haven't tested on long running yet. Will give a try.

There might be a very slight possibility that the issue is related to dgram sockpair that is created as well.

[kj-creater]

I tested template://experimental/vz and using this template to customize CPU, Memory and Disk and got different results

[balajiv113]

@kj-creater - Thanks for the video. i was able to reproduce this issue.

Looks like the disk size is too low for vm to start even. I was able to reproduce this same issue with qemu driver as well with disk size being 2GiB. Please increase the disk size to maybe 5GiB. This worked fine for me.

[Code-Hex]

I have this issue and I believe the same reason with @abiosoft

I suspect it is related to GVisor network.

This hang has not occurred in network communication without gvisor-tap-vsock (e.g. examples in vz repository)

[spacedub]

Facing this as well.

These seem related:

• error dialing "192.168.5.15:22" when creating profile with vm-type=vz abiosoft/colima#533 which mentions a possible timing issue with gvisor
• Stuck waiting for ssh -- tcpproxy no route #1293 which is probably a duplicate

FWIW, while tinkering with start / stop, I managed to SIGSEGV:

INFO[0000] Using the existing instance "default"
INFO[0000] Attempting to download the nerdctl archive from "https://github.com/containerd/nerdctl/releases/download/v1.1.0/nerdctl-full-1.1.0-linux-arm64.tar.gz"  digest="sha256:3b613a1be5a24460c44bb93a3609b790ada94e06efd1a86467d45bec7da8b449"
INFO[0000] Using cache "/Users/dmp/Library/Caches/lima/download/by-url-sha256/c69be86b3e48430e3d687d54361cf15b90e2c067fae6a294ca6292d41f42bf0e/data"
INFO[0000] [hostagent] Starting VZ (hint: to watch the boot progress, see "/Users/dmp/.codecomet/run/vm/default/serial.log")
INFO[0000] [hostagent] Setting up Rosetta share
INFO[0000] SSH Local Port: 60022
INFO[0000] [hostagent] panic: runtime error: invalid memory address or nil pointer dereference
INFO[0000] [hostagent] [signal SIGSEGV: segmentation violation code=0x2 addr=0x20 pc=0x104964cdc]
INFO[0000] [hostagent] goroutine 132 [running]:
INFO[0000] [hostagent] github.com/containers/gvisor-tap-vsock/pkg/tap.(*Switch).Accept(0x14000156000, {0x104f48ed8, 0x1400060c080}, {0x104f50910, 0x140000ca1f0})
INFO[0000] [hostagent] 	/Users/dmp/go/pkg/mod/github.com/containers/gvisor-tap-vsock@v0.4.1-0.20220920072955-5b1aff8ba743/pkg/tap/switch.go:83
INFO[0000] [hostagent]  +
INFO[0000] [hostagent] github.com/containers/gvisor-tap-vsock/pkg/virtualnetwork.(*VirtualNetwork).AcceptBess(...)
INFO[0000] [hostagent] 	/Users/dmp/go/pkg/mod/github.com/containers/gvisor-tap-vsock@v0.4.1-0.20220920072955-5b1aff8ba743/pkg/virtualnetwork/bess.go:9
INFO[0000] [hostagent] github.com/lima-vm/lima/pkg/networks.run.func1()
INFO[0000] [hostagent] 	/Users/dmp/Projects/GitHub/codecomet/isovaline/dependencies/lima-vm/lima/pkg/networks/gvisor.go:90 +0x64
INFO[0000] [hostagent] golang.org/x/sync/errgroup.(*Group).Go.func1()
INFO[0000] [hostagent] 	/Users/dmp/go/pkg/mod/golang.org/x/sync@v0.1.0/errgroup/errgroup.go:75 +0x5c
INFO[0000] [hostagent] created by
INFO[0000] [hostagent] :72 +0xa4
FATA[0000] host agent process has exited: exit status 2