- Notifications
You must be signed in to change notification settings - Fork924
Description
Is there an existing issue for this?
- I have searched the existing issues
Current Behavior
When connected via VS Code Desktop, if I need to reconnect for some reason (e.g. reloading the window, changing folder, network disconnection), VSCode will fully disconnect after reconnecting (usually after 30s-2m) and not automatically reconnect. The Coder agent logs show what looks like the SSH session being terminated, and an error will appear on VSCode with "Cannot reconnect. Please reload the window" shortly afterwards. The connection indicator will continue to show the remote is connected (and the latency will still update).
Reconnectingagain after this things work as expected. So seems like possibly an issue with an existing connection being reused & then terminated during a cleanup.
This has only started happening after we upgraded from 2.20.3.
Relevant Log Output
2025-06-24 00:33:54.319 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:33:54.371 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:33:54.400 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:4ms2025-06-24 00:33:56.185 [debu] batch updating metadata2025-06-24 00:33:56.204 [debu] batch update metadatacomplete2025-06-24 00:33:57.056 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:37491 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:33:59.082 [debu] net.tailnet: adding new peer peer_id=5becc1dd-94cd-40bb-a14f-d91dd41efb26 key_id=[6LpOR] node="&{ID:nodeid:60bf00bf967c6d3a StableID: Name: User:userid:0 Sharer:userid:0 Key:nodekey:e8ba4e44d22987e4d1e5a1e50a98371701c4c18e67e21b7c072b1ac2b9c48738 KeyExpiry:0001-01-01 00:00:00 +0000 UTC KeySignature:[] Machine:mkey:0000000000000000000000000000000000000000000000000000000000000000 DiscoKey:discokey:2358e03db4ea20288fe79d7a920d7bb6231bcc371bdf1e59adf5fff0db7adc17 Addresses:[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5/128] AllowedIPs:[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5/128] Endpoints:[10.50.50.127:51829] DERP:127.3.3.40:999 Hostinfo:{ж:0xc002cb4800} Created:2025-06-24 10:33:59.082819527 +1000 AEST m=+37.558356372 Cap:0 Tags:[] PrimaryRoutes:[] LastSeen:<nil> Online:<nil> KeepAlive:false MachineAuthorized:false Capabilities:[] UnsignedPeerAPIOnly:false ComputedName: computedHostIfDifferent: ComputedNameWithHost: DataPlaneAuditLogID: Expired:false SelfNodeV4MasqAddrForThisPeer:<nil> IsWireGuardOnly:false}"2025-06-24 00:33:59.083 [debu] net.tailnet: updating engine network map network_map="netmap: self: [A6ACS] auth=machine-unknown u=? [fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf/128 fd60:627a:a42b:469c:960a:7c1a:bb4f:4ddf/128]\n [L9LgG] d:887f54b04cb0f66f D999 fd7a:115c:a1e0:4eff:9745:622e:fc9:1040/128 : 10.10.10.180:35729\n [6LpOR] d:2358e03db4ea2028 D999 fd7a:115c:a1e0:487a:8d78:5310:5379:11d5/128 : 10.50.50.127:51829\n"2025-06-24 00:33:59.083 [debu] net.tailnet.net.wgengine: [v1] magicsock: got updated network map; 2 peers2025-06-24 00:33:59.083 [debu] net.tailnet.net.wgengine: wgengine: Reconfig: configuring userspace WireGuard config (with 2/2 peers)2025-06-24 00:33:59.083 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - UAPI: Created2025-06-24 00:33:59.083 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - UAPI: Updating endpoint2025-06-24 00:33:59.084 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - UAPI: Removing all allowedips2025-06-24 00:33:59.084 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - UAPI: Adding allowedip2025-06-24 00:33:59.084 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - UAPI: Updating persistent keepalive interval2025-06-24 00:33:59.084 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Starting2025-06-24 00:33:59.084 [debu] net.tailnet.net.wgengine: [v1] wgengine: Reconfigdone2025-06-24 00:33:59.137 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Received handshake initiation2025-06-24 00:33:59.138 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake response2025-06-24 00:33:59.138 [debu] net.tailnet.net.wgengine: [v1] magicsock: derp routefor [6LpOR]set to derp-999 (shared home)2025-06-24 00:33:59.144 [debu] net.tailnet.net.wgengine: magicsock: disco: node [6LpOR] d:2358e03db4ea2028 now using 10.50.50.127:518292025-06-24 00:33:59.145 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Receiving keepalive packet// This is the"first" connection to the machine2025-06-24 00:33:59.189 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5]:63970 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:12025-06-24 00:33:59.189 [info] ssh-server: started serving connection remote_addr=[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5]:63970 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 listen_addr={}2025-06-24 00:33:59.260 [info] ssh-server: handling ssh session remote_addr=[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5]:63970 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 id=1755b9b2-9496-4267-92ff-201e4f6cc8ba2025-06-24 00:33:59.261 [debu] reporting connection payload="connection:{id:\"\\x17U\\xb9\\xb2\\x94\\x96Bg\\x92\\xff\\x1eOlȺ\" action:CONNECT type:VSCODE timestamp:{seconds:1750725239 nanos:260849359} ip:\"fd7a:115c:a1e0:487a:8d78:5310:5379:11d5\"}"2025-06-24 00:33:59.285 [debu] successfully reported connection payload="connection:{id:\"\\x17U\\xb9\\xb2\\x94\\x96Bg\\x92\\xff\\x1eOlȺ\" action:CONNECT type:VSCODE timestamp:{seconds:1750725239 nanos:260849359} ip:\"fd7a:115c:a1e0:487a:8d78:5310:5379:11d5\"}"2025-06-24 00:34:00.889 [debu] got stats callback2025-06-24 00:34:00.889 [debu] computing stats report2025-06-24 00:34:00.889 [debu] starting peer latency measurementfor stats2025-06-24 00:34:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:34:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:34:00.896 [debu] collecting agent metricsfor stats2025-06-24 00:34:02.185 [debu] batch updating metadata2025-06-24 00:34:02.210 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:37406 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:02.273 [debu] batch update metadatacomplete2025-06-24 00:34:02.540 [debu] ssh-server:local port forward destination_host=127.0.0.1 destination_port=400452025-06-24 00:34:02.566 [debu] ssh-server:local port forward destination_host=127.0.0.1 destination_port=400452025-06-24 00:34:07.319 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:38130 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:08.186 [debu] batch updating metadata2025-06-24 00:34:08.206 [debu] batch update metadatacomplete2025-06-24 00:34:09.185 [debu] batch updating metadata2025-06-24 00:34:09.203 [debu] batch update metadatacomplete2025-06-24 00:34:12.433 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:22629 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:13.185 [debu] batch updating metadata2025-06-24 00:34:13.213 [debu] batch update metadatacomplete2025-06-24 00:34:16.648 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:34:16.700 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:34:16.733 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:8ms2025-06-24 00:34:17.572 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:34057 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:21.185 [debu] batch updating metadata2025-06-24 00:34:21.207 [debu] batch update metadatacomplete2025-06-24 00:34:22.651 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:22175 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:24.532 [debu] net.tailnet: marked peer lost peer_id=5becc1dd-94cd-40bb-a14f-d91dd41efb262025-06-24 00:34:26.185 [debu] batch updating metadata2025-06-24 00:34:26.204 [debu] batch update metadatacomplete2025-06-24 00:34:27.766 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:57821 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:30.185 [debu] batch updating metadata2025-06-24 00:34:30.202 [debu] batch update metadatacomplete2025-06-24 00:34:30.889 [debu] got stats callback2025-06-24 00:34:30.889 [debu] computing stats report2025-06-24 00:34:30.889 [debu] starting peer latency measurementfor stats2025-06-24 00:34:30.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:34:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:34:30.891 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:34:32.850 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:24679 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:34.241 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending keepalive packet2025-06-24 00:34:35.185 [debu] batch updating metadata2025-06-24 00:34:35.202 [debu] batch update metadatacomplete2025-06-24 00:34:35.890 [debu] collecting agent metricsfor stats2025-06-24 00:34:37.559 [debu] net.tailnet: adding new peer peer_id=a211df7c-f55a-413a-b96e-1495226ef8bf key_id=[rPyUr] node="&{ID:nodeid:2b9df02547e27eb StableID: Name: User:userid:0 Sharer:userid:0 Key:nodekey:acfc94ae6be3b3d355d8d3d84ab9ecac77b802b38a3161031d2eb421478c7031 KeyExpiry:0001-01-01 00:00:00 +0000 UTC KeySignature:[] Machine:mkey:0000000000000000000000000000000000000000000000000000000000000000 DiscoKey:discokey:27d38ce85eaef7ed2177ff1b32ede3f16314efa1520afd5024b824e1cdf2ec62 Addresses:[fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814/128] AllowedIPs:[fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814/128] Endpoints:[10.50.50.127:50437] DERP:127.3.3.40:999 Hostinfo:{ж:0xc0036f7400} Created:2025-06-24 10:34:37.55902887 +1000 AEST m=+76.034565715 Cap:0 Tags:[] PrimaryRoutes:[] LastSeen:<nil> Online:<nil> KeepAlive:false MachineAuthorized:false Capabilities:[] UnsignedPeerAPIOnly:false ComputedName: computedHostIfDifferent: ComputedNameWithHost: DataPlaneAuditLogID: Expired:false SelfNodeV4MasqAddrForThisPeer:<nil> IsWireGuardOnly:false}"2025-06-24 00:34:37.559 [debu] net.tailnet: updating engine network map network_map="netmap: self: [A6ACS] auth=machine-unknown u=? [fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf/128 fd60:627a:a42b:469c:960a:7c1a:bb4f:4ddf/128]\n [L9LgG] d:887f54b04cb0f66f D999 fd7a:115c:a1e0:4eff:9745:622e:fc9:1040/128 : 10.10.10.180:35729\n [6LpOR] d:2358e03db4ea2028 D999 fd7a:115c:a1e0:487a:8d78:5310:5379:11d5/128 : 10.50.50.127:51829\n [rPyUr] d:27d38ce85eaef7ed D999 fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814/128 : 10.50.50.127:50437\n"2025-06-24 00:34:37.559 [debu] net.tailnet.net.wgengine: [v1] magicsock: got updated network map; 3 peers2025-06-24 00:34:37.559 [debu] net.tailnet.net.wgengine: wgengine: Reconfig: configuring userspace WireGuard config (with 3/3 peers)2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - UAPI: Created2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - UAPI: Updating endpoint2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - UAPI: Removing all allowedips2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - UAPI: Adding allowedip2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - UAPI: Updating persistent keepalive interval2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Starting2025-06-24 00:34:37.560 [debu] net.tailnet.net.wgengine: [v1] wgengine: Reconfigdone2025-06-24 00:34:37.613 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Received handshake initiation2025-06-24 00:34:37.613 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Sending handshake response2025-06-24 00:34:37.614 [debu] net.tailnet.net.wgengine: [v1] magicsock: derp routefor [rPyUr]set to derp-999 (shared home)2025-06-24 00:34:37.621 [debu] net.tailnet.net.wgengine: magicsock: disco: node [rPyUr] d:27d38ce85eaef7ed now using 10.50.50.127:504372025-06-24 00:34:37.624 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Receiving keepalive packet// This is the"reconnection" to the machine2025-06-24 00:34:37.701 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814]:59152 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:12025-06-24 00:34:37.702 [info] ssh-server: started serving connection remote_addr=[fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814]:59152 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 listen_addr={}2025-06-24 00:34:37.769 [info] ssh-server: handling ssh session remote_addr=[fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814]:59152 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 id=ee91e415-706a-473c-8e46-6cd715e78a272025-06-24 00:34:37.770 [debu] reporting connection payload="connection:{id:\"\\xee\\x91\\xe4\\x15pjG<\\x8eFl\\xd7\\x15\\xe7\\x8a'\" action:CONNECT type:VSCODE timestamp:{seconds:1750725277 nanos:769591785} ip:\"fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814\"}"2025-06-24 00:34:37.792 [debu] successfully reported connection payload="connection:{id:\"\\xee\\x91\\xe4\\x15pjG<\\x8eFl\\xd7\\x15\\xe7\\x8a'\" action:CONNECT type:VSCODE timestamp:{seconds:1750725277 nanos:769591785} ip:\"fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814\"}"2025-06-24 00:34:37.943 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:61811 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:38.420 [debu] ssh-server:local port forward destination_host=127.0.0.1 destination_port=425472025-06-24 00:34:38.443 [debu] ssh-server:local port forward destination_host=127.0.0.1 destination_port=425472025-06-24 00:34:41.370 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:34:41.423 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:34:41.447 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:3ms2025-06-24 00:34:42.185 [debu] batch updating metadata2025-06-24 00:34:42.203 [debu] batch update metadatacomplete2025-06-24 00:34:43.026 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:32029 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:43.193 [debu] batch updating metadata2025-06-24 00:34:43.212 [debu] batch update metadatacomplete2025-06-24 00:34:46.186 [debu] batch updating metadata2025-06-24 00:34:46.203 [debu] batch update metadatacomplete2025-06-24 00:34:48.102 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:42150 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:48.185 [debu] batch updating metadata2025-06-24 00:34:48.211 [debu] batch update metadatacomplete2025-06-24 00:34:51.185 [debu] batch updating metadata2025-06-24 00:34:51.204 [debu] batch update metadatacomplete2025-06-24 00:34:53.180 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:33028 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:34:53.186 [debu] batch updating metadata2025-06-24 00:34:53.204 [debu] batch update metadatacomplete2025-06-24 00:34:56.185 [debu] batch updating metadata2025-06-24 00:34:56.203 [debu] batch update metadatacomplete2025-06-24 00:34:58.185 [debu] batch updating metadata2025-06-24 00:34:58.202 [debu] batch update metadatacomplete2025-06-24 00:34:58.255 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:28940 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:00.899 [debu] got stats callback2025-06-24 00:35:00.899 [debu] computing stats report2025-06-24 00:35:00.899 [debu] starting peer latency measurementfor stats2025-06-24 00:35:00.899 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:35:00.899 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:35:00.899 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:35:00.901 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:35:01.186 [debu] batch updating metadata2025-06-24 00:35:01.206 [debu] batch update metadatacomplete2025-06-24 00:35:03.366 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:48205 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:04.185 [debu] batch updating metadata2025-06-24 00:35:04.205 [debu] batch update metadatacomplete2025-06-24 00:35:05.900 [debu] collecting agent metricsfor stats2025-06-24 00:35:07.035 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:35:07.087 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:35:07.106 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:1ms2025-06-24 00:35:07.185 [debu] batch updating metadata2025-06-24 00:35:07.203 [debu] batch update metadatacomplete2025-06-24 00:35:08.457 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:64220 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:09.185 [debu] batch updating metadata2025-06-24 00:35:09.203 [debu] batch update metadatacomplete2025-06-24 00:35:13.185 [debu] batch updating metadata2025-06-24 00:35:13.207 [debu] batch update metadatacomplete2025-06-24 00:35:13.585 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:58638 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:14.185 [debu] batch updating metadata2025-06-24 00:35:14.202 [debu] batch update metadatacomplete2025-06-24 00:35:18.185 [debu] batch updating metadata2025-06-24 00:35:18.203 [debu] batch update metadatacomplete2025-06-24 00:35:18.759 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:31091 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:19.186 [debu] batch updating metadata2025-06-24 00:35:19.202 [debu] batch update metadatacomplete2025-06-24 00:35:23.849 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:30013 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:25.185 [debu] batch updating metadata2025-06-24 00:35:25.201 [debu] batch update metadatacomplete2025-06-24 00:35:28.973 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:61909 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:30.288 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:35:30.339 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:35:30.366 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:5ms2025-06-24 00:35:30.889 [debu] got stats callback2025-06-24 00:35:30.889 [debu] computing stats report2025-06-24 00:35:30.889 [debu] starting peer latency measurementfor stats2025-06-24 00:35:30.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:35:30.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:35:30.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:35:30.901 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:35:31.185 [debu] batch updating metadata2025-06-24 00:35:31.203 [debu] batch update metadatacomplete2025-06-24 00:35:34.081 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Received handshake initiation2025-06-24 00:35:34.081 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Sending handshake response2025-06-24 00:35:34.086 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Receiving keepalive packet2025-06-24 00:35:34.090 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:29033 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:35.891 [debu] collecting agent metricsfor stats2025-06-24 00:35:37.185 [debu] batch updating metadata2025-06-24 00:35:37.200 [debu] batch update metadatacomplete2025-06-24 00:35:39.199 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:61760 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:41.185 [debu] batch updating metadata2025-06-24 00:35:41.203 [debu] batch update metadatacomplete2025-06-24 00:35:42.185 [debu] batch updating metadata2025-06-24 00:35:42.203 [debu] batch update metadatacomplete2025-06-24 00:35:44.267 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:19179 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:47.185 [debu] batch updating metadata2025-06-24 00:35:47.201 [debu] batch update metadatacomplete2025-06-24 00:35:49.367 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:31282 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:50.991 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:35:51.042 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:35:51.057 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:1ms2025-06-24 00:35:53.185 [debu] batch updating metadata2025-06-24 00:35:53.200 [debu] batch update metadatacomplete2025-06-24 00:35:54.447 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:52977 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:35:58.185 [debu] batch updating metadata2025-06-24 00:35:58.203 [debu] batch update metadatacomplete2025-06-24 00:35:59.528 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:44017 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:00.889 [debu] got stats callback2025-06-24 00:36:00.889 [debu] computing stats report2025-06-24 00:36:00.889 [debu] starting peer latency measurementfor stats2025-06-24 00:36:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:36:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:36:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:36:00.891 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:36:04.185 [debu] batch updating metadata2025-06-24 00:36:04.203 [debu] batch update metadatacomplete2025-06-24 00:36:04.625 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:17413 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:05.890 [debu] collecting agent metricsfor stats2025-06-24 00:36:09.185 [debu] batch updating metadata2025-06-24 00:36:09.207 [debu] batch update metadatacomplete2025-06-24 00:36:09.700 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:43284 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:14.766 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:45695 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:15.185 [debu] batch updating metadata2025-06-24 00:36:15.201 [debu] batch update metadatacomplete2025-06-24 00:36:15.685 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:36:15.736 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:36:15.755 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:3ms2025-06-24 00:36:19.853 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:24952 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:20.185 [debu] batch updating metadata2025-06-24 00:36:20.200 [debu] batch update metadatacomplete2025-06-24 00:36:21.185 [debu] batch updating metadata2025-06-24 00:36:21.206 [debu] batch update metadatacomplete2025-06-24 00:36:24.944 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:23521 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:25.185 [debu] batch updating metadata2025-06-24 00:36:25.200 [debu] batch update metadatacomplete2025-06-24 00:36:27.185 [debu] batch updating metadata2025-06-24 00:36:27.201 [debu] batch update metadatacomplete2025-06-24 00:36:30.061 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:25013 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:30.889 [debu] got stats callback2025-06-24 00:36:30.889 [debu] computing stats report2025-06-24 00:36:30.889 [debu] starting peer latency measurementfor stats2025-06-24 00:36:30.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:36:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:36:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:36:30.902 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:36:31.185 [debu] batch updating metadata2025-06-24 00:36:31.201 [debu] batch update metadatacomplete2025-06-24 00:36:32.185 [debu] batch updating metadata2025-06-24 00:36:32.202 [debu] batch update metadatacomplete2025-06-24 00:36:35.144 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:37598 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:35.890 [debu] collecting agent metricsfor stats2025-06-24 00:36:37.185 [debu] batch updating metadata2025-06-24 00:36:37.203 [debu] batch update metadatacomplete2025-06-24 00:36:37.629 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Received handshake initiation2025-06-24 00:36:37.629 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Sending handshake response2025-06-24 00:36:37.660 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Receiving keepalive packet2025-06-24 00:36:40.223 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:33324 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:41.723 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:36:41.774 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:36:41.790 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:1ms2025-06-24 00:36:43.185 [debu] batch updating metadata2025-06-24 00:36:43.202 [debu] batch update metadatacomplete2025-06-24 00:36:45.300 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:56622 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:48.185 [debu] batch updating metadata2025-06-24 00:36:48.203 [debu] batch update metadatacomplete2025-06-24 00:36:50.384 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:49855 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:36:54.185 [debu] batch updating metadata2025-06-24 00:36:54.203 [debu] batch update metadatacomplete2025-06-24 00:36:55.456 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:60364 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:00.185 [debu] batch updating metadata2025-06-24 00:37:00.204 [debu] batch update metadatacomplete2025-06-24 00:37:00.534 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:45127 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:00.889 [debu] got stats callback2025-06-24 00:37:00.889 [debu] computing stats report2025-06-24 00:37:00.889 [debu] starting peer latency measurementfor stats2025-06-24 00:37:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:37:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:37:00.889 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:37:00.891 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:37:02.465 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:04.560 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:37:04.610 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:37:04.634 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:3ms2025-06-24 00:37:05.614 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:35500 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:05.890 [debu] collecting agent metricsfor stats2025-06-24 00:37:06.185 [debu] batch updating metadata2025-06-24 00:37:06.204 [debu] batch update metadatacomplete2025-06-24 00:37:07.620 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 2)2025-06-24 00:37:07.620 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:10.705 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:34858 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:12.185 [debu] batch updating metadata2025-06-24 00:37:12.202 [debu] batch update metadatacomplete2025-06-24 00:37:12.715 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 2)2025-06-24 00:37:12.715 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation// This is when remote stops respondingin VS Code2025-06-24 00:37:15.073 [debu] ssh-server: cmdCancel: sending SIGHUP to process and children remote_addr=[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5]:63970 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 id=1755b9b2-9496-4267-92ff-201e4f6cc8ba pid=60792025-06-24 00:37:15.073 [info] ssh-server: ssh connectioncomplete remote_addr=<nil> local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 error="read tcp [fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1: operation timed out"2025-06-24 00:37:15.089 [info] ssh-server: ssh session returned remote_addr=[fd7a:115c:a1e0:487a:8d78:5310:5379:11d5]:63970 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 id=1755b9b2-9496-4267-92ff-201e4f6cc8ba error="signal: hangup" process_exit_code=-1 exit_code=2552025-06-24 00:37:15.089 [debu] reporting connection payload="connection:{id:\"\\x17U\\xb9\\xb2\\x94\\x96Bg\\x92\\xff\\x1eOlȺ\" action:DISCONNECT type:VSCODE timestamp:{seconds:1750725435 nanos:89156873} ip:\"fd7a:115c:a1e0:487a:8d78:5310:5379:11d5\" status_code:255 reason:\"process exited with error status: -1\"}"2025-06-24 00:37:15.109 [debu] successfully reported connection payload="connection:{id:\"\\x17U\\xb9\\xb2\\x94\\x96Bg\\x92\\xff\\x1eOlȺ\" action:DISCONNECT type:VSCODE timestamp:{seconds:1750725435 nanos:89156873} ip:\"fd7a:115c:a1e0:487a:8d78:5310:5379:11d5\" status_code:255 reason:\"process exited with error status: -1\"}"2025-06-24 00:37:15.775 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:27483 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:17.185 [debu] batch updating metadata2025-06-24 00:37:17.202 [debu] batch update metadatacomplete2025-06-24 00:37:17.864 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 3)2025-06-24 00:37:17.864 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:20.837 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:21660 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:23.023 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 4)2025-06-24 00:37:23.023 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:23.185 [debu] batch updating metadata2025-06-24 00:37:23.202 [debu] batch update metadatacomplete2025-06-24 00:37:25.107 [debu] net.tailnet.net.wgengine: wg: [v2] [rPyUr] - Sending keepalive packet2025-06-24 00:37:25.911 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:53043 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:26.356 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:37:26.406 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:37:26.427 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:2ms2025-06-24 00:37:28.169 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 5)2025-06-24 00:37:28.169 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:29.185 [debu] batch updating metadata2025-06-24 00:37:29.202 [debu] batch update metadatacomplete2025-06-24 00:37:30.889 [debu] got stats callback2025-06-24 00:37:30.889 [debu] computing stats report2025-06-24 00:37:30.889 [debu] starting peer latency measurementfor stats2025-06-24 00:37:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814): sending disco ping to [rPyUr] ...2025-06-24 00:37:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:4eff:9745:622e:fc9:1040): sending disco ping to [L9LgG] ...2025-06-24 00:37:30.890 [debu] net.tailnet.net.wgengine: ping(fd7a:115c:a1e0:487a:8d78:5310:5379:11d5): sending disco ping to [6LpOR] ...2025-06-24 00:37:30.900 [debu] net.tailnet.net.wgengine: [unexpected] magicsock: derp-999 does not know about peer [6LpOR], removing route2025-06-24 00:37:30.977 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:22348 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:33.190 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 6)2025-06-24 00:37:33.191 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:34.185 [debu] batch updating metadata2025-06-24 00:37:34.203 [debu] batch update metadatacomplete2025-06-24 00:37:35.862 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Received handshake initiation2025-06-24 00:37:35.862 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Sending handshake response2025-06-24 00:37:35.865 [debu] net.tailnet.net.wgengine: wg: [v2] [L9LgG] - Receiving keepalive packet2025-06-24 00:37:35.890 [debu] collecting agent metricsfor stats2025-06-24 00:37:36.122 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:4eff:9745:622e:fc9:1040]:56792 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:42025-06-24 00:37:38.455 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 7)2025-06-24 00:37:38.455 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:40.185 [debu] batch updating metadata2025-06-24 00:37:40.206 [debu] batch update metadatacomplete2025-06-24 00:37:42.649 [debu] net.tailnet: adding new peer peer_id=311c59d5-ea56-4f92-87ab-79b155c5ace9 key_id=[bdyfl] node="&{ID:nodeid:212a776459b7c73c StableID: Name: User:userid:0 Sharer:userid:0 Key:nodekey:6ddc9f957a7c4c52d62354fa77664553fffc2c63318a50bc84dbafa54b599649 KeyExpiry:0001-01-01 00:00:00 +0000 UTC KeySignature:[] Machine:mkey:0000000000000000000000000000000000000000000000000000000000000000 DiscoKey:discokey:7ed0b6ea6afe2f3544afa1092ff20f031e9b8a6c00408aac97e13ae818d54333 Addresses:[fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab/128] AllowedIPs:[fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab/128] Endpoints:[10.50.50.127:53301] DERP:127.3.3.40:999 Hostinfo:{ж:0xc004b11400} Created:2025-06-24 10:37:42.649926353 +1000 AEST m=+261.125463196 Cap:0 Tags:[] PrimaryRoutes:[] LastSeen:<nil> Online:<nil> KeepAlive:false MachineAuthorized:false Capabilities:[] UnsignedPeerAPIOnly:false ComputedName: computedHostIfDifferent: ComputedNameWithHost: DataPlaneAuditLogID: Expired:false SelfNodeV4MasqAddrForThisPeer:<nil> IsWireGuardOnly:false}"2025-06-24 00:37:42.650 [debu] net.tailnet: updating engine network map network_map="netmap: self: [A6ACS] auth=machine-unknown u=? [fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf/128 fd60:627a:a42b:469c:960a:7c1a:bb4f:4ddf/128]\n [L9LgG] d:887f54b04cb0f66f D999 fd7a:115c:a1e0:4eff:9745:622e:fc9:1040/128 : 10.10.10.180:35729\n [6LpOR] d:2358e03db4ea2028 D999 fd7a:115c:a1e0:487a:8d78:5310:5379:11d5/128 : 10.50.50.127:51829\n [rPyUr] d:27d38ce85eaef7ed D999 fd7a:115c:a1e0:458e:9f4a:3d33:4db7:4814/128 : 10.50.50.127:50437\n [bdyfl] d:7ed0b6ea6afe2f35 D999 fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab/128 : 10.50.50.127:53301\n"2025-06-24 00:37:42.650 [debu] net.tailnet.net.wgengine: [v1] magicsock: got updated network map; 4 peers2025-06-24 00:37:42.650 [debu] net.tailnet.net.wgengine: wgengine: Reconfig: configuring userspace WireGuard config (with 4/4 peers)2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - UAPI: Created2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - UAPI: Updating endpoint2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - UAPI: Removing all allowedips2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - UAPI: Adding allowedip2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - UAPI: Updating persistent keepalive interval2025-06-24 00:37:42.677 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - Starting2025-06-24 00:37:42.688 [debu] net.tailnet.net.wgengine: [v1] wgengine: Reconfigdone2025-06-24 00:37:42.706 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - Received handshake initiation2025-06-24 00:37:42.706 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - Sending handshake response2025-06-24 00:37:42.710 [debu] net.tailnet.net.wgengine: [v1] magicsock: derp routefor [bdyfl]set to derp-999 (shared home)2025-06-24 00:37:42.713 [debu] net.tailnet.net.wgengine: magicsock: disco: node [bdyfl] d:7ed0b6ea6afe2f35 now using 10.50.50.127:533012025-06-24 00:37:42.720 [debu] net.tailnet.net.wgengine: wg: [v2] [bdyfl] - Receiving keepalive packet2025-06-24 00:37:43.471 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 8)2025-06-24 00:37:43.471 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:43.646 [info] net.tailnet.tcp: accepted connection src=[fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab]:49700 dst=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:12025-06-24 00:37:43.646 [info] ssh-server: started serving connection remote_addr=[fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab]:49700 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 listen_addr={}2025-06-24 00:37:43.737 [info] ssh-server: handling ssh session remote_addr=[fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab]:49700 local_addr=[fd7a:115c:a1e0:469c:960a:7c1a:bb4f:4ddf]:1 id=98d5f028-6016-44ef-b760-f03c185852012025-06-24 00:37:43.738 [debu] reporting connection payload="connection:{id:\"\\x98\\xd5\\xf0(`\\x16D\\xef\\xb7`\\xf0<\\x18XR\\x01\" action:CONNECT type:VSCODE timestamp:{seconds:1750725463 nanos:737688634} ip:\"fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab\"}"2025-06-24 00:37:43.759 [debu] successfully reported connection payload="connection:{id:\"\\x98\\xd5\\xf0(`\\x16D\\xef\\xb7`\\xf0<\\x18XR\\x01\" action:CONNECT type:VSCODE timestamp:{seconds:1750725463 nanos:737688634} ip:\"fd7a:115c:a1e0:48fc:a942:1ccb:5ada:88ab\"}"2025-06-24 00:37:44.555 [debu] ssh-server:local port forward destination_host=127.0.0.1 destination_port=381932025-06-24 00:37:46.185 [debu] batch updating metadata2025-06-24 00:37:46.208 [debu] batch update metadatacomplete2025-06-24 00:37:46.471 [debu] net.tailnet.net.wgengine: netcheck: empty probe plan;do we have STUN regions?2025-06-24 00:37:46.521 [debu] net.tailnet.net.wgengine: netcheck: [v1] measuring ICMP latency of coder (999): no addressfor node 999b2025-06-24 00:37:46.545 [debu] net.tailnet.net.wgengine: netcheck: [v1] report: udp=false icmpv4=false v6=false v6os=true mapvarydest= hair= portmap= derp=999 derpdist=999v4:3ms2025-06-24 00:37:48.563 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Handshake did notcomplete after 5 seconds, retrying (try 9)2025-06-24 00:37:48.563 [debu] net.tailnet.net.wgengine: wg: [v2] [6LpOR] - Sending handshake initiation2025-06-24 00:37:51.185 [debu] batch updating metadata2025-06-24 00:37:51.202 [debu] batch update metadatacomplete
Expected Behavior
When reconnecting, the new session shouldn't be immediately terminated.
Steps to Reproduce
- Create a fresh connection to machine via VS Code desktop
- Reload the window or change the window folder
- Wait several minutes for the connection to be terminated
Environment
- Host OS: Windows 11
- Remote OS: Amazon Linux 2023
- Coder version: v2.23.1
Additional Context
The issue is new (previously worked fine)